builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1460984969.36 results: success (0) buildid: 20160418041220 builduid: 67275313bdf040c59e1cf5f1ed73f070 revision: 54303363802794f3c7fbc23d886965f5c5495335 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:29.362827) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:29.363214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-18 06:09:29.363482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-18 06:09:30.375015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-18 06:09:30.375268) ========= 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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-18 06:09:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-04-18 06:09:30 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201862 ========= master_lag: 3.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-18 06:09:33.636781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:33.637089) ========= 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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.027579 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:33.720670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 06:09:33.721066) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 54303363802794f3c7fbc23d886965f5c5495335 --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 54303363802794f3c7fbc23d886965f5c5495335 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-18 06:09:33,853 truncating revision to first 12 chars 2016-04-18 06:09:33,853 Setting DEBUG logging. 2016-04-18 06:09:33,854 attempt 1/10 2016-04-18 06:09:33,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/543033638027?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 06:09:34,600 unpacking tar archive at: fx-team-543033638027/testing/mozharness/ program finished with exit code 0 elapsedTime=1.207479 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 06:09:34.954624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:34.954952) ========= script_repo_revision: 54303363802794f3c7fbc23d886965f5c5495335 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:34.955372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:34.955643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 06:09:34.970872) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-04-18 06:09:34.980554) ========= /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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:09:35 INFO - MultiFileLogger online at 20160418 06:09:35 in /builds/slave/test 06:09:35 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 06:09:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:09:35 INFO - {'append_to_log': False, 06:09:35 INFO - 'base_work_dir': '/builds/slave/test', 06:09:35 INFO - 'blob_upload_branch': 'Fx-Team', 06:09:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:09:35 INFO - 'branch': 'Fx-Team', 06:09:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:09:35 INFO - 'config_files': ('talos/mac_config.py',), 06:09:35 INFO - 'default_actions': ('clobber', 06:09:35 INFO - 'read-buildbot-config', 06:09:35 INFO - 'download-and-extract', 06:09:35 INFO - 'populate-webroot', 06:09:35 INFO - 'create-virtualenv', 06:09:35 INFO - 'install', 06:09:35 INFO - 'run-tests'), 06:09:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:09:35 INFO - 'download_minidump_stackwalk': True, 06:09:35 INFO - 'download_symbols': 'ondemand', 06:09:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:09:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:09:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:09:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:09:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:09:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:09:35 INFO - 'installer_path': 'installer.exe', 06:09:35 INFO - 'log_level': 'info', 06:09:35 INFO - 'log_name': 'talos', 06:09:35 INFO - 'log_to_console': True, 06:09:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:09:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:09:35 INFO - 'opt_config_files': (), 06:09:35 INFO - 'pip_index': False, 06:09:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:09:35 INFO - 'cmd': ('bash', 06:09:35 INFO - '-c', 06:09:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:09:35 INFO - 'enabled': True, 06:09:35 INFO - 'halt_on_failure': False, 06:09:35 INFO - 'name': 'check_screen_resolution'},), 06:09:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:09:35 INFO - 'cmd': ('bash', 06:09:35 INFO - '-c', 06:09:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:09:35 INFO - 'enabled': True, 06:09:35 INFO - 'halt_on_failure': False, 06:09:35 INFO - 'name': 'check_screen_resolution'},), 06:09:35 INFO - 'run_cmd_checks_enabled': True, 06:09:35 INFO - 'sps_profile': False, 06:09:35 INFO - 'sps_profile_interval': 0, 06:09:35 INFO - 'suite': 'dromaeojs', 06:09:35 INFO - 'system_bits': '32', 06:09:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:09:35 INFO - 'title': 't-yosemite-r7-0026', 06:09:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:09:35 INFO - 'use_talos_json': True, 06:09:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:09:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:09:35 INFO - 'work_dir': 'build'} 06:09:35 INFO - ##### 06:09:35 INFO - ##### Running clobber step. 06:09:35 INFO - ##### 06:09:35 INFO - Running pre-action listener: _resource_record_pre_action 06:09:35 INFO - Running main action method: clobber 06:09:35 INFO - rmtree: /builds/slave/test/build 06:09:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:09:36 INFO - Running post-action listener: _resource_record_post_action 06:09:36 INFO - ##### 06:09:36 INFO - ##### Running read-buildbot-config step. 06:09:36 INFO - ##### 06:09:36 INFO - Running pre-action listener: _resource_record_pre_action 06:09:36 INFO - Running main action method: read_buildbot_config 06:09:36 INFO - Using buildbot properties: 06:09:36 INFO - { 06:09:36 INFO - "project": "", 06:09:36 INFO - "product": "firefox", 06:09:36 INFO - "script_repo_revision": "production", 06:09:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:09:36 INFO - "repository": "", 06:09:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:09:36 INFO - "buildid": "20160418041220", 06:09:36 INFO - "pgo_build": "False", 06:09:36 INFO - "basedir": "/builds/slave/test", 06:09:36 INFO - "buildnumber": 629, 06:09:36 INFO - "slavename": "t-yosemite-r7-0026", 06:09:36 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:09:36 INFO - "platform": "yosemite_r7", 06:09:36 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:09:36 INFO - "branch": "fx-team", 06:09:36 INFO - "repo_path": "integration/fx-team", 06:09:36 INFO - "revision": "54303363802794f3c7fbc23d886965f5c5495335", 06:09:36 INFO - "stage_platform": "macosx64", 06:09:36 INFO - "builduid": "67275313bdf040c59e1cf5f1ed73f070", 06:09:36 INFO - "slavebuilddir": "test" 06:09:36 INFO - } 06:09:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:09:36 INFO - Running post-action listener: _resource_record_post_action 06:09:36 INFO - ##### 06:09:36 INFO - ##### Running download-and-extract step. 06:09:36 INFO - ##### 06:09:36 INFO - Running pre-action listener: _resource_record_pre_action 06:09:36 INFO - Running main action method: download_and_extract 06:09:36 INFO - mkdir: /builds/slave/test/build/tests 06:09:36 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')]} 06:09:36 INFO - https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:09:44 INFO - Downloaded 1199 bytes. 06:09:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:09:44 INFO - Using the following test package requirements: 06:09:44 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:09:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:09:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:09:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'jsshell-mac.zip'], 06:09:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:09:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:09:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:09:44 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:09:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:09:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:09:44 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:09:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:09:44 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')]} 06:09:44 INFO - https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:09:52 INFO - Downloaded 18032130 bytes. 06:09:52 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'] 06:09:52 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 06:09:55 INFO - Return code: 0 06:09:55 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 06:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:55 INFO - https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:09:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:09:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:09:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:09:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:10:00 INFO - Downloaded 18032130 bytes. 06:10:00 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'] 06:10:00 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 06:10:03 INFO - Return code: 0 06:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:03 INFO - https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:10:04 INFO - Downloaded 10841076 bytes. 06:10:04 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'] 06:10:04 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 06:10:04 INFO - Return code: 0 06:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:04 INFO - https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:10:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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 06:10:08 INFO - Downloaded 109847427 bytes. 06:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:08 INFO - mkdir: /builds/slave/test/properties 06:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:08 INFO - Contents: 06:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:10:09 INFO - Running post-action listener: _resource_record_post_action 06:10:09 INFO - Running post-action listener: set_extra_try_arguments 06:10:09 INFO - ##### 06:10:09 INFO - ##### Running populate-webroot step. 06:10:09 INFO - ##### 06:10:09 INFO - Running pre-action listener: _resource_record_pre_action 06:10:09 INFO - Running main action method: populate_webroot 06:10:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:09 INFO - '--tppagecycles', 06:10:09 INFO - '7'], 06:10:09 INFO - 'tests': ['tsvgm']}}, 06:10:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:10:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:10:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['damp', 'tps']}, 06:10:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'tests': ['damp', 'tps']}, 06:10:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['dromaeo_dom']}, 06:10:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:10:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['a11yr', 06:10:09 INFO - 'ts_paint', 06:10:09 INFO - 'tpaint', 06:10:09 INFO - 'sessionrestore', 06:10:09 INFO - 'sessionrestore_no_auto_restore', 06:10:09 INFO - 'tabpaint']}, 06:10:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:10:09 INFO - 'ts_paint', 06:10:09 INFO - 'tpaint', 06:10:09 INFO - 'sessionrestore', 06:10:09 INFO - 'sessionrestore_no_auto_restore', 06:10:09 INFO - 'tabpaint']}, 06:10:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:10:09 INFO - 'ts_paint', 06:10:09 INFO - 'tpaint', 06:10:09 INFO - 'sessionrestore', 06:10:09 INFO - 'sessionrestore_no_auto_restore', 06:10:09 INFO - 'tabpaint']}, 06:10:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:10:09 INFO - 'ts_paint', 06:10:09 INFO - 'tpaint', 06:10:09 INFO - 'sessionrestore', 06:10:09 INFO - 'sessionrestore_no_auto_restore', 06:10:09 INFO - 'tabpaint']}, 06:10:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['a11yr', 06:10:09 INFO - 'ts_paint', 06:10:09 INFO - 'tpaint', 06:10:09 INFO - 'sessionrestore', 06:10:09 INFO - 'sessionrestore_no_auto_restore', 06:10:09 INFO - 'tabpaint']}, 06:10:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['a11yr', 06:10:09 INFO - 'ts_paint', 06:10:09 INFO - 'tpaint', 06:10:09 INFO - 'sessionrestore', 06:10:09 INFO - 'sessionrestore_no_auto_restore', 06:10:09 INFO - 'tabpaint']}, 06:10:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['tsvgx', 06:10:09 INFO - 'tsvgr_opacity', 06:10:09 INFO - 'tart', 06:10:09 INFO - 'tscrollx', 06:10:09 INFO - 'cart']}, 06:10:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:10:09 INFO - 'tsvgr_opacity', 06:10:09 INFO - 'tart', 06:10:09 INFO - 'tscrollx', 06:10:09 INFO - 'cart']}, 06:10:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'talos_options': ['--disable-e10s'], 06:10:09 INFO - 'tests': ['tp5o']}, 06:10:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'tests': ['tp5o']}, 06:10:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'talos_options': ['--disable-e10s', 06:10:09 INFO - '--xperf_path', 06:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:09 INFO - 'tests': ['tp5n']}, 06:10:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:09 INFO - 'talos_options': ['--xperf_path', 06:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:09 INFO - 'tests': ['tp5n']}}, 06:10:09 INFO - 'talos.zip': {'path': '', 06:10:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:09 INFO - Running post-action listener: _resource_record_post_action 06:10:09 INFO - ##### 06:10:09 INFO - ##### Running create-virtualenv step. 06:10:09 INFO - ##### 06:10:09 INFO - Running pre-action listener: _resource_record_pre_action 06:10:09 INFO - Running main action method: create_virtualenv 06:10:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:09 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 06:10:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:09 INFO - Using real prefix '/tools/python27' 06:10:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:12 INFO - Installing pip.................done. 06:10:12 INFO - Return code: 0 06:10:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10:12 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')]} 06:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:12 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')]} 06:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:12 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:12 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 06:10:12 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 06:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:12 INFO - 'HOME': '/Users/cltbld', 06:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:12 INFO - 'LOGNAME': 'cltbld', 06:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:12 INFO - 'MOZ_NO_REMOTE': '1', 06:10:12 INFO - 'NO_EM_RESTART': '1', 06:10:12 INFO - 'PAGER': '/bin/cat', 06:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:12 INFO - 'PWD': '/builds/slave/test', 06:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:12 INFO - 'SHELL': '/bin/bash', 06:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:12 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:12 INFO - 'USER': 'cltbld', 06:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:12 INFO - 'XPC_FLAGS': '0x0', 06:10:12 INFO - 'XPC_SERVICE_NAME': '0', 06:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:13 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 06:10:13 INFO - Cleaning up... 06:10:13 INFO - Return code: 0 06:10:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:10:13 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')]} 06:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:13 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')]} 06:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:13 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:13 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 06:10:13 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 06:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:13 INFO - 'HOME': '/Users/cltbld', 06:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:13 INFO - 'LOGNAME': 'cltbld', 06:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:13 INFO - 'MOZ_NO_REMOTE': '1', 06:10:13 INFO - 'NO_EM_RESTART': '1', 06:10:13 INFO - 'PAGER': '/bin/cat', 06:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:13 INFO - 'PWD': '/builds/slave/test', 06:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:13 INFO - 'SHELL': '/bin/bash', 06:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:13 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:13 INFO - 'USER': 'cltbld', 06:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:13 INFO - 'XPC_FLAGS': '0x0', 06:10:13 INFO - 'XPC_SERVICE_NAME': '0', 06:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:13 INFO - Downloading/unpacking psutil>=0.7.1 06:10:13 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 06:10:13 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 06:10:13 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 06:10:13 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 06:10:13 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 06:10:13 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 06:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:16 INFO - Installing collected packages: psutil 06:10:16 INFO - Running setup.py install for psutil 06:10:16 INFO - building 'psutil._psutil_osx' extension 06:10:16 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 06:10:17 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 06:10:17 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 06:10:17 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 06:10:17 INFO - building 'psutil._psutil_posix' extension 06:10:17 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 06:10:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:10:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:10:17 INFO - ^ 06:10:17 INFO - 1 warning generated. 06:10:17 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 06:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:17 INFO - Successfully installed psutil 06:10:17 INFO - Cleaning up... 06:10:17 INFO - Return code: 0 06:10:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:17 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:17 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 06:10:17 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 06:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:17 INFO - 'HOME': '/Users/cltbld', 06:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:17 INFO - 'LOGNAME': 'cltbld', 06:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:17 INFO - 'MOZ_NO_REMOTE': '1', 06:10:17 INFO - 'NO_EM_RESTART': '1', 06:10:17 INFO - 'PAGER': '/bin/cat', 06:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:17 INFO - 'PWD': '/builds/slave/test', 06:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:17 INFO - 'SHELL': '/bin/bash', 06:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:17 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:17 INFO - 'USER': 'cltbld', 06:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:17 INFO - 'XPC_FLAGS': '0x0', 06:10:17 INFO - 'XPC_SERVICE_NAME': '0', 06:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:10:17 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 06:10:17 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 06:10:17 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 06:10:17 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 06:10:17 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 06:10:17 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 06:10:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:10:20 INFO - Installing collected packages: mozsystemmonitor 06:10:20 INFO - Running setup.py install for mozsystemmonitor 06:10:20 INFO - Successfully installed mozsystemmonitor 06:10:20 INFO - Cleaning up... 06:10:20 INFO - Return code: 0 06:10:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:10:20 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')]} 06:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:20 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')]} 06:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:20 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:20 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 06:10:20 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 06:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:20 INFO - 'HOME': '/Users/cltbld', 06:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:20 INFO - 'LOGNAME': 'cltbld', 06:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:20 INFO - 'MOZ_NO_REMOTE': '1', 06:10:20 INFO - 'NO_EM_RESTART': '1', 06:10:20 INFO - 'PAGER': '/bin/cat', 06:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:20 INFO - 'PWD': '/builds/slave/test', 06:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:20 INFO - 'SHELL': '/bin/bash', 06:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:20 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:20 INFO - 'USER': 'cltbld', 06:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:20 INFO - 'XPC_FLAGS': '0x0', 06:10:20 INFO - 'XPC_SERVICE_NAME': '0', 06:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:10:20 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 06:10:20 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 06:10:20 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 06:10:20 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 06:10:20 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 06:10:20 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 06:10:23 INFO - Downloading blobuploader-1.2.4.tar.gz 06:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:10:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:10:23 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 06:10:23 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 06:10:23 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 06:10:23 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 06:10:23 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 06:10:23 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 06:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:10:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:24 INFO - Downloading docopt-0.6.1.tar.gz 06:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:10:24 INFO - Installing collected packages: blobuploader, requests, docopt 06:10:24 INFO - Running setup.py install for blobuploader 06:10:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:10:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:10:24 INFO - Running setup.py install for requests 06:10:25 INFO - Running setup.py install for docopt 06:10:25 INFO - Successfully installed blobuploader requests docopt 06:10:25 INFO - Cleaning up... 06:10:25 INFO - Return code: 0 06:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:25 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:25 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 06:10:25 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 06:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:25 INFO - 'HOME': '/Users/cltbld', 06:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:25 INFO - 'LOGNAME': 'cltbld', 06:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:25 INFO - 'MOZ_NO_REMOTE': '1', 06:10:25 INFO - 'NO_EM_RESTART': '1', 06:10:25 INFO - 'PAGER': '/bin/cat', 06:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:25 INFO - 'PWD': '/builds/slave/test', 06:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:25 INFO - 'SHELL': '/bin/bash', 06:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:25 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:25 INFO - 'USER': 'cltbld', 06:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:25 INFO - 'XPC_FLAGS': '0x0', 06:10:25 INFO - 'XPC_SERVICE_NAME': '0', 06:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-M5ByFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:25 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-jzuKKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-bZbrCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-1bjxRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-V5pco6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HJCp0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-W1cShQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qq_Ggw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-K7Vyeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-NlNdRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0AFVgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-mUCZmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-bwHtE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Z_ZxHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0Etrlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-nwKOzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Xj8q_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:10:27 INFO - Running setup.py install for manifestparser 06:10:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:10:27 INFO - Running setup.py install for mozcrash 06:10:27 INFO - Running setup.py install for mozdebug 06:10:28 INFO - Running setup.py install for mozdevice 06:10:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Running setup.py install for mozfile 06:10:28 INFO - Running setup.py install for mozhttpd 06:10:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Running setup.py install for mozinfo 06:10:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Running setup.py install for mozInstall 06:10:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:10:28 INFO - Running setup.py install for mozleak 06:10:28 INFO - Running setup.py install for mozlog 06:10:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:10:29 INFO - Running setup.py install for moznetwork 06:10:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:10:29 INFO - Running setup.py install for mozprocess 06:10:29 INFO - Running setup.py install for mozprofile 06:10:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:10:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:10:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:10:29 INFO - Running setup.py install for mozrunner 06:10:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:10:29 INFO - Running setup.py install for mozscreenshot 06:10:29 INFO - Running setup.py install for moztest 06:10:30 INFO - Running setup.py install for mozversion 06:10:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:10:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:10:30 INFO - Cleaning up... 06:10:30 INFO - Return code: 0 06:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:30 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:30 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 06:10:30 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 06:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:30 INFO - 'HOME': '/Users/cltbld', 06:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:30 INFO - 'LOGNAME': 'cltbld', 06:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:30 INFO - 'MOZ_NO_REMOTE': '1', 06:10:30 INFO - 'NO_EM_RESTART': '1', 06:10:30 INFO - 'PAGER': '/bin/cat', 06:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:30 INFO - 'PWD': '/builds/slave/test', 06:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:30 INFO - 'SHELL': '/bin/bash', 06:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:30 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:30 INFO - 'USER': 'cltbld', 06:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:30 INFO - 'XPC_FLAGS': '0x0', 06:10:30 INFO - 'XPC_SERVICE_NAME': '0', 06:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-tOcw44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:30 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)) 06:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-TcOQPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:30 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)) 06:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7aYPgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:30 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)) 06:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-XlQiJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:30 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)) 06:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:30 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-4B3Bk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-pytj8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Sm0K_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-QfOofg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-4J2ysY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-KtyhsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LYZb_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-E6lRLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-klIjZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-T7b_ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:31 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)) 06:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-33Cwio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:32 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)) 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qRzS4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:32 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)) 06:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-zuemOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:32 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)) 06:10:32 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)) 06:10:32 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)) 06:10:32 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)) 06:10:32 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)) 06:10:32 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)) 06:10:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10:34 INFO - Downloading blessings-1.6.tar.gz 06:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:34 INFO - Installing collected packages: blessings 06:10:34 INFO - Running setup.py install for blessings 06:10:34 INFO - Successfully installed blessings 06:10:34 INFO - Cleaning up... 06:10:35 INFO - Return code: 0 06:10:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:35 INFO - Reading from file tmpfile_stdout 06:10:35 INFO - Current package versions: 06:10:35 INFO - blessings == 1.6 06:10:35 INFO - blobuploader == 1.2.4 06:10:35 INFO - docopt == 0.6.1 06:10:35 INFO - manifestparser == 1.1 06:10:35 INFO - mozInstall == 1.12 06:10:35 INFO - mozcrash == 0.17 06:10:35 INFO - mozdebug == 0.1 06:10:35 INFO - mozdevice == 0.48 06:10:35 INFO - mozfile == 1.2 06:10:35 INFO - mozhttpd == 0.7 06:10:35 INFO - mozinfo == 0.9 06:10:35 INFO - mozleak == 0.1 06:10:35 INFO - mozlog == 3.1 06:10:35 INFO - moznetwork == 0.27 06:10:35 INFO - mozprocess == 0.22 06:10:35 INFO - mozprofile == 0.28 06:10:35 INFO - mozrunner == 6.11 06:10:35 INFO - mozscreenshot == 0.1 06:10:35 INFO - mozsystemmonitor == 0.0 06:10:35 INFO - moztest == 0.7 06:10:35 INFO - mozversion == 1.4 06:10:35 INFO - psutil == 3.1.1 06:10:35 INFO - requests == 1.2.3 06:10:35 INFO - wsgiref == 0.1.2 06:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:35 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')]} 06:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 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')]} 06:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:35 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 06:10:35 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 06:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:35 INFO - 'HOME': '/Users/cltbld', 06:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:35 INFO - 'LOGNAME': 'cltbld', 06:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:35 INFO - 'MOZ_NO_REMOTE': '1', 06:10:35 INFO - 'NO_EM_RESTART': '1', 06:10:35 INFO - 'PAGER': '/bin/cat', 06:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:35 INFO - 'PWD': '/builds/slave/test', 06:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:35 INFO - 'SHELL': '/bin/bash', 06:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:35 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:35 INFO - 'USER': 'cltbld', 06:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:35 INFO - 'XPC_FLAGS': '0x0', 06:10:35 INFO - 'XPC_SERVICE_NAME': '0', 06:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 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)) 06:10:35 INFO - Cleaning up... 06:10:35 INFO - Return code: 0 06:10:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10:35 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')]} 06:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 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')]} 06:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:35 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:35 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 06:10:35 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 06:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:35 INFO - 'HOME': '/Users/cltbld', 06:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:35 INFO - 'LOGNAME': 'cltbld', 06:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:35 INFO - 'MOZ_NO_REMOTE': '1', 06:10:35 INFO - 'NO_EM_RESTART': '1', 06:10:35 INFO - 'PAGER': '/bin/cat', 06:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:35 INFO - 'PWD': '/builds/slave/test', 06:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:35 INFO - 'SHELL': '/bin/bash', 06:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:35 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:35 INFO - 'USER': 'cltbld', 06:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:35 INFO - 'XPC_FLAGS': '0x0', 06:10:35 INFO - 'XPC_SERVICE_NAME': '0', 06:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:35 INFO - Downloading/unpacking jsonschema 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:10:38 INFO - Downloading/unpacking functools32 (from jsonschema) 06:10:38 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 06:10:38 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 06:10:38 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 06:10:38 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 06:10:38 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 06:10:38 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 06:10:39 INFO - Downloading functools32-3.2.3-2.tar.gz 06:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:10:39 INFO - warning: no files found matching '*.txt' 06:10:39 INFO - no previously-included directories found matching 'build' 06:10:39 INFO - no previously-included directories found matching 'dist' 06:10:39 INFO - no previously-included directories found matching '.git*' 06:10:39 INFO - Installing collected packages: jsonschema, functools32 06:10:39 INFO - Running setup.py install for functools32 06:10:39 INFO - warning: no files found matching '*.txt' 06:10:39 INFO - no previously-included directories found matching 'build' 06:10:39 INFO - no previously-included directories found matching 'dist' 06:10:39 INFO - no previously-included directories found matching '.git*' 06:10:39 INFO - Successfully installed jsonschema functools32 06:10:39 INFO - Cleaning up... 06:10:39 INFO - Return code: 0 06:10:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:10:39 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')]} 06:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:39 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')]} 06:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:39 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 0x104db8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dc8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb350daf280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, '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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 06:10:39 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 06:10:39 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 06:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:39 INFO - 'HOME': '/Users/cltbld', 06:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:39 INFO - 'LOGNAME': 'cltbld', 06:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:39 INFO - 'MOZ_NO_REMOTE': '1', 06:10:39 INFO - 'NO_EM_RESTART': '1', 06:10:39 INFO - 'PAGER': '/bin/cat', 06:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:39 INFO - 'PWD': '/builds/slave/test', 06:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:39 INFO - 'SHELL': '/bin/bash', 06:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:10:39 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:39 INFO - 'USER': 'cltbld', 06:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:39 INFO - 'XPC_FLAGS': '0x0', 06:10:39 INFO - 'XPC_SERVICE_NAME': '0', 06:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:39 INFO - Downloading/unpacking flake8 06:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:10:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:10:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:10:43 INFO - no previously-included directories found matching 'docs/_build' 06:10:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:10:43 INFO - Running setup.py install for pep8 06:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:10:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:10:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:10:43 INFO - no previously-included directories found matching 'docs/_build' 06:10:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:10:43 INFO - Cleaning up... 06:10:43 INFO - Return code: 0 06:10:43 INFO - Running post-action listener: _resource_record_post_action 06:10:43 INFO - Running post-action listener: _start_resource_monitoring 06:10:43 INFO - Starting resource monitoring. 06:10:43 INFO - ##### 06:10:43 INFO - ##### Running install step. 06:10:43 INFO - ##### 06:10:43 INFO - Running pre-action listener: _resource_record_pre_action 06:10:43 INFO - Running main action method: install 06:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:44 INFO - Reading from file tmpfile_stdout 06:10:44 INFO - Detecting whether we're running mozinstall >=1.0... 06:10:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:10:44 INFO - Reading from file tmpfile_stdout 06:10:44 INFO - Output received: 06:10:44 INFO - Usage: mozinstall [options] installer 06:10:44 INFO - Options: 06:10:44 INFO - -h, --help show this help message and exit 06:10:44 INFO - -d DEST, --destination=DEST 06:10:44 INFO - Directory to install application into. [default: 06:10:44 INFO - "/builds/slave/test"] 06:10:44 INFO - --app=APP Application being installed. [default: firefox] 06:10:44 INFO - mkdir: /builds/slave/test/build/application 06:10:44 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'] 06:10:44 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 06:11:18 INFO - Reading from file tmpfile_stdout 06:11:18 INFO - Output received: 06:11:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:11:18 INFO - Running post-action listener: _resource_record_post_action 06:11:18 INFO - ##### 06:11:18 INFO - ##### Running run-tests step. 06:11:18 INFO - ##### 06:11:18 INFO - Running pre-action listener: _resource_record_pre_action 06:11:18 INFO - Running main action method: run_tests 06:11:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:11:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:11:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:11:18 INFO - 2016-04-18 06:11:18.199 screenresolution[1646:8030] starting screenresolution argv=screenresolution get 06:11:18 INFO - 2016-04-18 06:11:18.202 screenresolution[1646:8030] Display 0: 1600x1200x32@60 06:11:18 INFO - 2016-04-18 06:11:18.209 screenresolution[1647:8034] starting screenresolution argv=screenresolution list 06:11:18 INFO - Available Modes on Display 0 06:11:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:11:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:11:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:11:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:11:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:11:18 INFO - Intel Iris: 06:11:18 INFO - Chipset Model: Intel Iris 06:11:18 INFO - Type: GPU 06:11:18 INFO - Bus: Built-In 06:11:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:11:18 INFO - Vendor: Intel (0x8086) 06:11:18 INFO - Device ID: 0x0a2e 06:11:18 INFO - Revision ID: 0x0009 06:11:18 INFO - Displays: 06:11:18 INFO - Display: 06:11:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:11:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:11:18 INFO - Display Serial Number: 1600x1200 60 06:11:18 INFO - Main Display: Yes 06:11:18 INFO - Mirror: Off 06:11:18 INFO - Online: Yes 06:11:18 INFO - Rotation: Supported 06:11:18 INFO - Return code: 0 06:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:11:18 INFO - Python 2.7.3 06:11:18 INFO - Return code: 0 06:11:18 INFO - grabbing minidump binary from tooltool 06:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:11:18 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 0x104c57e00>, '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 0x104a80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c52b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:11:18 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 06:11:18 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 06:11:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:11:18 INFO - Return code: 0 06:11:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:11:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:11:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:11:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:11:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:11:19 INFO - Return code: 0 06:11:19 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/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 06:11:19 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/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 06:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wv1ZlgoSSc/Render', 06:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:19 INFO - 'HOME': '/Users/cltbld', 06:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:19 INFO - 'LOGNAME': 'cltbld', 06:11:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:11:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:19 INFO - 'MOZ_NO_REMOTE': '1', 06:11:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:11:19 INFO - 'NO_EM_RESTART': '1', 06:11:19 INFO - 'PAGER': '/bin/cat', 06:11:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:19 INFO - 'PWD': '/builds/slave/test', 06:11:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:19 INFO - 'SHELL': '/bin/bash', 06:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O9HnfbMpPO/Listeners', 06:11:19 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 06:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:19 INFO - 'USER': 'cltbld', 06:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:19 INFO - 'XPC_FLAGS': '0x0', 06:11:19 INFO - 'XPC_SERVICE_NAME': '0', 06:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:19 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/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 06:11:19 INFO - mozversion application_buildid: 20160418041220 06:11:19 INFO - mozversion application_changeset: 54303363802794f3c7fbc23d886965f5c5495335 06:11:19 INFO - mozversion application_display_name: Nightly 06:11:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:11:19 INFO - mozversion application_name: Firefox 06:11:19 INFO - mozversion application_remotingname: firefox 06:11:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:11:19 INFO - mozversion application_vendor: Mozilla 06:11:19 INFO - mozversion application_version: 48.0a1 06:11:19 INFO - mozversion platform_buildid: 20160418041220 06:11:19 INFO - mozversion platform_changeset: 54303363802794f3c7fbc23d886965f5c5495335 06:11:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:11:19 INFO - mozversion platform_version: 48.0a1 06:11:19 INFO - using testdate: 1460985079 06:11:19 INFO - actual date: 1460985079 06:11:19 INFO - starting webserver on 'localhost:49277' 06:11:19 INFO - SUITE-START | Running 2 tests 06:11:19 INFO - TEST-START | dromaeo_css 06:11:19 INFO - operating with platform_type : mac_ 06:11:19 INFO - Initialising browser for dromaeo_css test... 06:11:19 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpIaPvgX/profile http://localhost:49277/getInfo.html) 06:11:22 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 06:11:22 INFO - PROCESS | 1665 | colorDepth:24 06:11:22 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 06:11:22 INFO - PROCESS | 1665 | __metrics 06:11:22 INFO - PROCESS | 1665 | 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" 06:11:22 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:11:22 INFO - TEST-INFO | 1665: exit 0 06:11:22 INFO - Browser initialized. 06:11:22 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:22 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpIaPvgX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:34 INFO - PROCESS | 1667 | RSS: Main: 237326336 06:11:34 INFO - PROCESS | 1667 | 06:12:26 INFO - PROCESS | 1667 | 1460985146523 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] 06:14:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 06:14:38 INFO - PROCESS | 1667 | RSS: Main: 322109440 06:14:38 INFO - PROCESS | 1667 | 06:17:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 06:17:41 INFO - PROCESS | 1667 | RSS: Main: 380837888 06:17:41 INFO - PROCESS | 1667 | 06:20:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 06:20:44 INFO - PROCESS | 1667 | RSS: Main: 376692736 06:20:44 INFO - PROCESS | 1667 | 06:23:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 06:23:46 INFO - PROCESS | 1667 | RSS: Main: 377634816 06:23:46 INFO - PROCESS | 1667 | 06:26:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 06:26:50 INFO - PROCESS | 1667 | RSS: Main: 347967488 06:26:50 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 06:29:54 INFO - PROCESS | 1667 | RSS: Main: 381337600 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | __start_tp_report 06:29:54 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:29:54 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:29:54 INFO - PROCESS | 1667 | |i|pagename|runs| 06:29:54 INFO - PROCESS | 1667 | |0;dojo.html;3140.6859314068597;3428.485727140927;3447.2933048725013;3465.977536626695;3491.266833964869;5574.414686457924;5603.019471592465;5615.775368985241;5621.943780562198;5634.267545219121;5575.442455754433;5634.7182640867995;5638.154276858473;5643.717814109299;5653.067243904751;5131.4098878628965;5148.665336753099;5181.663191892534;5188.221766734982;5256.342957130359;5240.371155461331;5246.449122842104;5252.894942101156;5253.395859476152;5266.789328426858;5170.069387510247;5212.895742085156;5214;5216;5303.7348132593215;5202.115640341132;5238.528532432099;5244.842654720364;5251;5308.575313974873;5069.340985671876;5108.2848401223855;5121.769520371555;5154.845354639367;5184.27420161174;5513.751881165317;5525.917111243334;5544.889102217973;5586.190002449663;5598.216249725042;6131.110988906628;6143.96928015357;6161.260648722137;6168.383161683841;6174.59865108771;6068.696565171724;6112.572119951606;6170.7223174957235;6196.87606247877;6238.189035425366;4838.371011768448;5735.713214339266;5738.483536481654;5770.365259821417;5794.65232086072;6171.907421388682;6176.814695559051;6190.690465476709;6191.81424557264;6193.194884664965;5522.7573795895605;5839.591228614041;5938.168656388109;5994;6053.636781793107;6169.5064394848305;6169.753209871555;6173.043178307369;6185.721642526097;6199.783007594803;6087.208662873798;6128.233970753656;6144.109104179958;6149.7847575334645;6157.2611286645;6033.818985430444;6122.581127188433;6179.84550386235;6204.751809927642;6216.285127210338;3853.402722578005;4441.357392351546;4837.637177211724;4857.392825896763;4934.185859333242;4339.544347843431;4348.021695118637;4348.304271316574;4361.869143925687;4389.692721509464;5486.204500347428;5570.220169176318;5581.944180558224;5587.106063029895;5590.329160500684;6103.6032657877095;6120.142398366865;6149.8155055347515;6159.106929495288;6192.8761424771255;5564.443555644403;5565.693886836263;5572.136318870582;5589.105743081088;5589.888202235932;5216.165413533817;5287.391949925731;5289.735513224324;5305.230741542455;5305.787768489217;6169.81490555284;6231.563790534619;6241;6245.7189426476825;6256.5307601930035;6118.877622447615;6144.41628045335;6163.3528479509005;6179.938200618116;6183.721732522137;6113.111460343502;6161.921663708923;6205.627662340274;6206.72069756871;6242.094896240111;6101.398774955092;6109.708332504907;6133.793750436688;6138.419052470106;6143.174139895698;6174.135621012972;6184.196054512884;6199.938000619936;6202.131701561695;6210.503159747119;5895.557833162444;5999.340072592098;6024.216851809237;6045.425684559959;6081.331053584191;5801.82594522165;5993.640381577119;6010.188624535632;6034.064719968412;6064.9393506066135;5862.355140934579;5865.794697185578;5866.149408335853;5874.471297583238;5881.676507792113;5794.681292528951;5907.675077870758;6038.154658347923;6054.243219597551;6091.817245482643;5889.587728858939;5890.676012819336;5895.587308888336;5903.2916050072545;5916.970415147896 06:29:54 INFO - PROCESS | 1667 | |1;ext.html;525.4902744337993;531.9707416092115;540.3920589336996;543.1825103219654;555.4362322242924;24779.628305575407;29535.556966645516;29544.852275738616;37054.25891482169;38275.80862095686;41600.791996040054;42413.15173696524;42436.363454548205;42452.363214551806;42506.574934250646;9534.618615255382;9781.559829807677;9783.021697830196;9788.90211097887;9829.55766990487;8538.70114545991;8798.51608161551;9221;9482.762930926712;11908.642740717793;11646.301221926711;11823.231489953125;11825.46785394655;11828.053755699566;11862.110341724361;11671.124665650068;11757.176997610171;11763;11787.469563869647;11796.528138874435;8520.70177543783;8812.647494100229;8821.426607270507;11384.316940983568;11735.23720958135;37376.065598359986;37964;37995.24009519822;37996.24007519862;38077;3192.0314107879663;3206.3106432117206;3269.96730032699;3276.1318250663594;3415.334009868077;26682.33294167642;27425.588616170775;27825;27898.88404463819;28481.430371392456;2720.5919112133142;2737.671479422462;2739.58906164075;2761.986190069057;2792.176307989148;459051.7047414775;461314;462508;463250;467004;58500.707496462244;58833;58837;58880.705596471744;58883.70558147182;62385;62549.37450625526;62629.373706263264;62649.686751566864;62690;16211.432599858948;16453.424130155625;16478.67042659164;16479.83520164807;16482.75275870863;11652.941735291439;12838.9358053211;12890;12927.353632318347;12947.611571652866;13823.861761382257;15486.612834679223;15989;16006.199690015686;16011.679766404606;5109.616778741609;5252.632315737862;6119.143319935212;6122.326544080148;6146.323904370515;861.5132450165762;966.1980556138388;1017.6285655735603;1037.4138611684375;1061.5594528270835;23263.53472930532;25879.988601766756;27536.862315688693;27944.580831287545;28255;1074.9301295415773;1105.9225854190129;1127.4475507001673;1140.1961617059953;1212.6240865331774;12618.55835045769;14942.850571494364;14960.251987400805;15038.398464061314;15281.6179595511;560711;571056;576944;577288;579023;49832;58557.121643175386;60012.69993650004;60065.39934600598;60135;1458.7009663019055;1465.4211586423517;1470.4338829550486;1479.6300924769023;1480.2154857925316;23951.640725389483;28816.855915720287;28835.423291534473;29295;29471.852640737518;39801.80099099486;47581.762091189325;47994;48138.75930620325;48140.03719925652;484149;488187;488393;488408;488705;36357.63642363648;36370.4544431839;36581.26837463183;37258;37338.8133059333;42260.788696057556;42273;43988.34017489676;44381.11237775291;44643.33035004543;35249;37020.44469333016;37307.626923730415;38097.23805523929;38103.80948095242;27472;31960.360792783547;34266.31467370688;34520.82739586286;34742.47886281657;33950.49074263839;34695.65304346924;35149.47275790916;35425.82287088548;35508.46737298891;31154.688453115177;31603.683963160995;32034.839825801653;32067.518987214742;32077.358452830347;23532.882335588896;23692.52614947657;24174.03303867896;24540.87729561341;24581.754182457946 06:29:54 INFO - PROCESS | 1667 | |2;jquery.html;393.65161831778886;396.0534322968105;398.8564116917911;402.1855742122202;406.37012630422856;19646.90176549117;20002;20404.591908161845;20427.693584596243;21199.364019079454;20289.898550507227;20728.68906966393;21444.46388840276;21456.570868582618;21487.462813429673;4642.117997580466;5461.317335333083;5462.8361149165585;5465.480779325978;5490.6431081979745;5394.109971854659;5473.06957817172;5538.723063846812;5931.436513531229;5936.168936348915;5614.9438505615035;5873.618214816023;5902.675352855613;5908.4091590841;5932.851678708045;5730.656160630376;5830.883382332372;5844.473997340238;5855.882882342351;5865.677387743651;5644.887102257973;5874.588778785486;5882.6470411775;5887.0580707086665;5888.175655408247;13571.796423053662;13889;20032.499187520283;25285.494290114093;25352.732363381758;2052.6715725484;2160.503084290622;2194.8353873459555;2239.902447800582;2462.150558057467;10185.541650625739;10433.791324173473;10462.47687615616;12220.816687749602;14371.993960422775;1639.506956987761;1732.9826701732948;1756.1394916490956;1769.504538729158;1799.136414521024;98404;107294;116221;118378;119256;10157.187425005981;11296.667483092508;11337.582802149731;11430.771384572263;11604.941975290238;15156.545303640687;15293.235338233044;15293.847061529465;15295.464658737113;15312.617184570252;7182.569045857265;8511.276541493919;8734.86897696535;8820.294376449869;8843.557822108869;8374.832503349899;8408.83182336362;8424.368172386972;8588.828223435496;8597.742067737978;3818.0073180973145;4625.95374046262;4648.628109751212;4688.624910007259;4730.385049943554;1781.2785821741957;1804.7022241330033;1882.623475304917;1903.961920761577;1970.4384250488542;786.1627366854282;945.5555888732284;992.5583115513672;1007.496251874063;1106.0819519798547;18489.68878890139;19144.234230630896;19440.90279548593;19895.801041989685;20314.898425508072;967.3035414501547;978.3396207559869;1006.4011912911806;1024.7335692719946;1027.0961553832728;10553.788924221473;10824.891751082547;10853;10861.239713219999;10879.456027198608;590210;590735;603719;604726;605196;98595;120695;121990;122589;125777;958.2477754962321;959.1655259923772;992.2558081438921;993.7416271769248;1017.8676772019738;17414.564635883697;17931.193096310435;18028.909855451162;18134.909325453817;18406.72389914179;49912;49979.75010124926;50516;50699.746501267255;50984;70480.29519704737;71733.28266717475;73198.26801732127;73603;75037;7768.339691126317;7971.681132754625;8052.436329456882;8151.225633564802;8412.915870841458;9233.630654773733;11462.713432164262;12344.567940122053;12762.553310634083;12765.8085128725;10574.629887953884;10879.564817407216;10926.890731092906;11218.158638102012;11423.428828558373;8432.53621050848;9400.529973501434;9492.335536512377;10769.407682577534;11145;11389.316641001566;11547.422628868691;11630.929174789095;11651.708707282047;11719.355435451133;8163.061247956561;8210.055843578066;8238.217369349903;8436;8463.28062114727;10441.895581044093;11267.774644507228;11524.654260372203;11573.768524629628;11583.478743456397 06:29:54 INFO - PROCESS | 1667 | |3;mootools.html;1419.8722115009648;1599.8800089993254;1603.5429902477792;1843.972340414893;1972.3984184823623;7895.40784441167;8591.570421478924;8796.604152813123;8820.558972051396;8821.206091451768;8431.241188293052;8648.56757162141;8658.956705216466;8660.696875609356;8665.133486651332;2159.524904521003;2384.8688322142275;2430.562498750224;2455.177515532299;2486.6021436570154;2469.4320306329555;2488.191337815208;2488.464980029293;2488.713797913236;2489.8755062246905;2389.9641505377435;2458.754124587545;2459.557279689664;2460.7047154341503;2460.753924607543;2118.3962570667286;2350.3301559055585;2434.7565243475688;2440.548498527778;2442.6458163566185;2434.6104623260194;2449.326435230308;2464.8890799914047;2467.346153269385;2472.43134079161;8569.785755356104;8616.138386161396;8618.956905215433;8651.221390074861;8659;5171.7672704728375;5339.332583427072;5357.491038351351;5363.892722145574;5364.168553874117;2970.287131088523;3511.91220219494;3552.467129930505;3641.6904563112166;3644.9817750911343;1018.6638409324979;1037.6990672704906;1039.9168066554657;1043.342694102718;1049.375621505203;11602.187846850724;11638.70903227426;11643.767124657545;11662.70843228926;11667.416629168592;4156.815307637369;4647.3029045643425;4647.978129513673;4901.313816065754;4906.31311616374;9553.092456216647;9778.75553111178;9792.139493496214;9798.167155791694;9799.412035277906;5380.757865896044;5386.057439947994;5396.028714831368;5396.379416367168;5430.185472179126;4382.824687012484;4573.81704731807;4778.880527986758;4912.606991440676;4947;3333.7333013358875;3910.667593254548;4005.0988527581644;4025.255327764373;4037.6366127048705;1322.9338533073308;1323.6558494791232;1327.396034804162;1340.544214966916;1343.603636927109;783.4554984285867;814.8818421328874;897.3180382909036;898.9235914947172;935.6397786851975;5512.80705175317;5657.688827114466;5702.144678298206;5747;5860.677662728591;822.8601137806587;940.7262725714552;943.2454036770556;951.177231694593;989.8762654668167;3328.617209020945;3650.5254316938626;3845.8846234613006;3846.4038074098557;3856.614338566177;10343.37939723619;10714;10853.728656783644;10860.67417977462;10866.130709543218;10824;10827.296225745302;10831;10833.67498975032;10848.566057357775;7977.282044616012;8134;8291.170882911661;8291.8341633167;8303.377246706401;5325.4940780625775;5463.399026107046;5611.186377975089;5639;5694.4590263924865;9813.558389872616;9892.406455612687;9928.404295742279;9933.453660048766;9950.253730970351;9654.806903862023;10164.288499805238;10180;10194.847077293698;10228.07947284748;6097.96334623124;6466.902996454963;6710.396064354231;6959.19969203548;7073.328033836778;8238.588070596566;8270.627821747916;8368.037675667376;8377.994640643163;8394.622241999003;6833.838247497838;6957.130358705162;7315.48791584584;7345.77962661121;7496.325330720043;7087.3267039631155;7190.856182876418;7208.56748595086;7291.781246562611;7302.96348518254;6699.196096468455;6909.619970901648;6910.997905303803;6913.654317284217;6930.445564354739;4671.486136524912;4732.361131247238;4783.234682450791;4897.510248975074;4920.6555541111775;4765.380500534909;4789.61683065347;4831.903361932812;4837.564619184291;4916.680415772963 06:29:54 INFO - PROCESS | 1667 | |4;prototype.html;290.9476294267032;309.3256700393142;326.46948708348935;329.2181069958848;330.632997372916;5078.368966189174;5371.194320851864;5871.559633027524;5924.259467566554;5926.851828704284;5582.330120385559;5767.8269651910405;5775.104858746901;5776.249087618614;5791.768329266824;3712.313222053915;3748.700103991674;4397.274449715793;4432.180046691356;4435.889102772432;4163.877092180865;4433;4440.689151759379;4443.133588950156;4449.822007119711;4337.609615134637;4342.935980684737;4344.695871289011;4362.738235705852;4368.694191406603;4361.6510679145595;4361.672874534423;4367.323064924942;4369.890752731191;4399.098184872094;3413.76103672743;3595.676389124991;3707.6663100321102;3749.850005999757;3795.6394142556687;5577.490129441727;5578.776848926079;5583.190437386596;5590.91613625796;5625.5218306444;4508.008238187594;4874.368595396452;4931.865670895678;4998.450170481244;5068.290439338495;5876.471117599393;6078.939210607881;6158.938410615926;6176.258848938111;6197.752089916398;3458.723302135823;4105.363668631367;4121.340585506305;4126.400367768287;4127.360259159835;6129.233845769234;6506.154199953976;6506.837329066764;6506.934930650727;6518.93481065188;4171.457710497616;4190.182914331737;4198.979005105016;4210.263203939298;4217.536071032184;3659.9451008234896;3733.4586484960073;4257.063446041866;4281.293586558183;4302.7848607569495;5012.273220383024;5014.674046186986;5015.172496538104;5016.623753218523;5026.5621173730715;5924.9703751480965;5962.850928726816;6120.479759220427;6240.968795155995;6245.781397651152;1393.9233342166278;1420.3382043009497;1423.8077859489044;1425.8788003019858;1427.5645927991854;898.6630013744846;961.5048250151178;971.6404930175739;972.9464879431557;975.0395860077817;4456.75487848165;5457.399686034533;5692.57305702074;5724.8799404324745;5776.277965254343;5520.806771762969;6230.816144932448;6348.952422850178;6370.140031095835;6413.422791948747;5647.519960803295;5678.545716342683;5703.828885133453;5727.627704199297;5729.226554415184;3253.5282384054653;3313.353895990307;3360.8151551664405;3362.529245905575;3378.7297016239136;5801.216835727208;5942.841145976579;6224.354649274041;6621.404073633396;6634.535582509178;5717;6048.818535443944;6343.728092322332;6367.4906007519285;6524.902126468107;5477.7821077769895;6620.933790662128;6646.767363142267;6646.90029649546;6658;5440.374356949002;5785.4214578541805;6316.463100636497;6321.652309123042;6346.238451385863;5769.451902069297;6185.072239164161;6197.194364732736;6238.438540531374;6263.937360626335;5691.345495268097;6553.705083271359;6604.405603495708;6634.635095069818;6636.27001029896;4072.714909956393;4186.644135248538;4199.265128602544;4201.432806571196;4204.012057166502;5060.898782024413;5371.838844834505;6005.6396616203165;6287.30839607652;6317.052442133717;5210.687358758487;5974.37269086757;6160.260768707604;6168.660723660062;6171.783987560414;4826.8793280168275;6072.453479186895;6131.509479241739;6134.969325153345;6137.925862974051;5954.255718035246;5962.4633782959745;5974.820755377345;5984.700764961647;5985;5825.970870145622;6126.448619624077;6130.172426722335;6142.447179753844;6144.907826382519;5971.910421343597;5974.2830860297045;5974.880502390015;6001.669908155093;6015.248093988252 06:29:54 INFO - PROCESS | 1667 | |5;yui.html;603.6016229288668;649.6881496881497;712.8004158835528;741.933226009659;747.409546458298;14789.408423663053;14840.332185051671;15260.694786104285;15276.618084547878;15871.761923571155;14505.274736263198;14568.635784105376;14575.708485830277;14593;14608.123512589253;715.8317795318096;915.3866909170855;922.8246633139682;929.1776777551881;929.590979968815;685.0683071023404;702.3117345001901;914.9542522873829;915.158054589779;915.5102020419077;929.2473096791587;936.7845395559026;943.9669611563596;944.4097439100562;947.3179310896144;753.6307209467376;772.2856357868949;927.7309580221728;937.0582564522646;942.9622815087388;709.0569542508451;711.6441779110445;715.2382712411318;716.3051839715467;716.845878136198;14932.32804523799;15056.247187640574;15066.924665376602;15072.171030593314;15127.168005759679;12136.15046946714;12346.629601111981;12415.93792031034;12496.687582810411;12671.809922851164;9751.268654850914;10063.597456101747;10125;10177.338472999232;10866.239363244576;3457.775244609092;3498.930021399558;3521.0493166845063;3535.2045789697368;3611.7652352596997;87582.81042973977;89558.5522072392;89596.99999999935;90011.54994225052;90367.09632903653;9499;9541.952290238505;9724.805503889882;9797.902020979842;9847;21838.454038648844;21868.01593928277;21870.23454179096;21925.122995080335;21953.121875125136;7474.252574742591;7544.040208235432;7660.578668173304;7678.270564296383;7698.884516732253;3979.263836190314;3999.6200360965663;4058.817353219112;4081.9387709184384;4172.8122234498915;3508.561429821272;3622.4747411625694;3626.9093272668392;3642.307961487309;3644.9817750911075;550.6530885542082;556.2157358125024;615.1265203411167;644.9613023218621;645.5771469687362;537.2726733025925;563.9859003524945;575.602834044508;601.7021574320652;603.4026313949158;7006.8438707613695;7637.236276372319;7821.374290056782;7832;7988.320992715684;488.30172852820806;538.6253687607135;540.6080591571158;575.7610591604521;613.5919613457002;3619.8552057917386;3692.2246328270826;3707.3882809336696;3764.5106136202667;3782.394816829294;84402.57798710967;87447.56276218579;87564.12435875688;88053;94085.059149409;55904.72047639817;73609.63195184097;76627.46745065067;78475.21524784679;81145;56255;60721.39278607246;62822.685886570274;63386;70862;7135.322144396274;7667.539947603162;7743.806404839924;7779.844403112019;8214.178582141738;33188.33623327471;36079.27841443209;39195;40931.7953410243;41761;48009.7997550064;48362;62089.68955155195;62415;64191.67904160449;11357.204995650225;11441.14191435629;11610.24533405326;11675.88324116782;11968.222065565711;9823.410595364301;11759.76480470403;11843.881561184622;11944.761104777683;12962.481500740241;9116.498592577473;10192.694219173436;10520.421376824348;11319.320840749582;12150.21023633461;11037.503312351124;11082.556697732;11422.428878555873;11604.245724027911;11737.530498779954;10763.192760542834;10776.353418794897;10845;10921.017108460277;10986.121110311316;9414.95292523533;9671.419714817133;9676.419414835133;9680.661176858775;9783.608655653694;9097.29942618417;9155.496447695441;9558.665446709332;9599.088086631758;9842.409455432697 06:29:54 INFO - PROCESS | 1667 | __end_tp_report 06:29:54 INFO - PROCESS | 1667 | __start_cc_report 06:29:54 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1224 06:29:54 INFO - PROCESS | 1667 | __end_cc_report 06:29:54 INFO - PROCESS | 1667 | __startTimestamp1460986194303__endTimestamp 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:29:54 INFO - PROCESS | 1667 | Number of tests: 6 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5659.55 Median:5874.47 stddev:633.60 (10.8%) stddev-sans-first:603.94 06:29:54 INFO - PROCESS | 1667 | Values: 3140.7 3428.5 3447.3 3466.0 3491.3 5574.4 5603.0 5615.8 5621.9 5634.3 5575.4 5634.7 5638.2 5643.7 5653.1 5131.4 5148.7 5181.7 5188.2 5256.3 5240.4 5246.4 5252.9 5253.4 5266.8 5170.1 5212.9 5214.0 5216.0 5303.7 5202.1 5238.5 5244.8 5251.0 5308.6 5069.3 5108.3 5121.8 5154.8 5184.3 5513.8 5525.9 5544.9 5586.2 5598.2 6131.1 6144.0 6161.3 6168.4 6174.6 6068.7 6112.6 6170.7 6196.9 6238.2 4838.4 5735.7 5738.5 5770.4 5794.7 6171.9 6176.8 6190.7 6191.8 6193.2 5522.8 5839.6 5938.2 5994.0 6053.6 6169.5 6169.8 6173.0 6185.7 6199.8 6087.2 6128.2 6144.1 6149.8 6157.3 6033.8 6122.6 6179.8 6204.8 6216.3 3853.4 4441.4 4837.6 4857.4 4934.2 4339.5 4348.0 4348.3 4361.9 4389.7 5486.2 5570.2 5581.9 5587.1 5590.3 6103.6 6120.1 6149.8 6159.1 6192.9 5564.4 5565.7 5572.1 5589.1 5589.9 5216.2 5287.4 5289.7 5305.2 5305.8 6169.8 6231.6 6241.0 6245.7 6256.5 6118.9 6144.4 6163.4 6179.9 6183.7 6113.1 6161.9 6205.6 6206.7 6242.1 6101.4 6109.7 6133.8 6138.4 6143.2 6174.1 6184.2 6199.9 6202.1 6210.5 5895.6 5999.3 6024.2 6045.4 6081.3 5801.8 5993.6 6010.2 6034.1 6064.9 5862.4 5865.8 5866.1 5874.5 5881.7 5794.7 5907.7 6038.2 6054.2 6091.8 5889.6 5890.7 5895.6 5903.3 5917.0 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:64209.92 Median:34945.98 stddev:135894.78 (388.9%) stddev-sans-first:136191.88 06:29:54 INFO - PROCESS | 1667 | Values: 525.5 532.0 540.4 543.2 555.4 24779.6 29535.6 29544.9 37054.3 38275.8 41600.8 42413.2 42436.4 42452.4 42506.6 9534.6 9781.6 9783.0 9788.9 9829.6 8538.7 8798.5 9221.0 9482.8 11908.6 11646.3 11823.2 11825.5 11828.1 11862.1 11671.1 11757.2 11763.0 11787.5 11796.5 8520.7 8812.6 8821.4 11384.3 11735.2 37376.1 37964.0 37995.2 37996.2 38077.0 3192.0 3206.3 3270.0 3276.1 3415.3 26682.3 27425.6 27825.0 27898.9 28481.4 2720.6 2737.7 2739.6 2762.0 2792.2 459051.7 461314.0 462508.0 463250.0 467004.0 58500.7 58833.0 58837.0 58880.7 58883.7 62385.0 62549.4 62629.4 62649.7 62690.0 16211.4 16453.4 16478.7 16479.8 16482.8 11652.9 12838.9 12890.0 12927.4 12947.6 13823.9 15486.6 15989.0 16006.2 16011.7 5109.6 5252.6 6119.1 6122.3 6146.3 861.5 966.2 1017.6 1037.4 1061.6 23263.5 25880.0 27536.9 27944.6 28255.0 1074.9 1105.9 1127.4 1140.2 1212.6 12618.6 14942.9 14960.3 15038.4 15281.6 560711.0 571056.0 576944.0 577288.0 579023.0 49832.0 58557.1 60012.7 60065.4 60135.0 1458.7 1465.4 1470.4 1479.6 1480.2 23951.6 28816.9 28835.4 29295.0 29471.9 39801.8 47581.8 47994.0 48138.8 48140.0 484149.0 488187.0 488393.0 488408.0 488705.0 36357.6 36370.5 36581.3 37258.0 37338.8 42260.8 42273.0 43988.3 44381.1 44643.3 35249.0 37020.4 37307.6 38097.2 38103.8 27472.0 31960.4 34266.3 34520.8 34742.5 33950.5 34695.7 35149.5 35425.8 35508.5 31154.7 31603.7 32034.8 32067.5 32077.4 23532.9 23692.5 24174.0 24540.9 24581.8 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:34169.15 Median:2217.37 stddev:99556.77 (4489.9%) stddev-sans-first:99803.75 06:29:54 INFO - PROCESS | 1667 | Values: 393.7 396.1 398.9 402.2 406.4 19646.9 20002.0 20404.6 20427.7 21199.4 20289.9 20728.7 21444.5 21456.6 21487.5 4642.1 5461.3 5462.8 5465.5 5490.6 5394.1 5473.1 5538.7 5931.4 5936.2 5614.9 5873.6 5902.7 5908.4 5932.9 5730.7 5830.9 5844.5 5855.9 5865.7 5644.9 5874.6 5882.6 5887.1 5888.2 13571.8 13889.0 20032.5 25285.5 25352.7 2052.7 2160.5 2194.8 2239.9 2462.2 10185.5 10433.8 10462.5 12220.8 14372.0 1639.5 1733.0 1756.1 1769.5 1799.1 98404.0 107294.0 116221.0 118378.0 119256.0 10157.2 11296.7 11337.6 11430.8 11604.9 15156.5 15293.2 15293.8 15295.5 15312.6 7182.6 8511.3 8734.9 8820.3 8843.6 8374.8 8408.8 8424.4 8588.8 8597.7 3818.0 4626.0 4648.6 4688.6 4730.4 1781.3 1804.7 1882.6 1904.0 1970.4 786.2 945.6 992.6 1007.5 1106.1 18489.7 19144.2 19440.9 19895.8 20314.9 967.3 978.3 1006.4 1024.7 1027.1 10553.8 10824.9 10853.0 10861.2 10879.5 590210.0 590735.0 603719.0 604726.0 605196.0 98595.0 120695.0 121990.0 122589.0 125777.0 958.2 959.2 992.3 993.7 1017.9 17414.6 17931.2 18028.9 18134.9 18406.7 49912.0 49979.8 50516.0 50699.7 50984.0 70480.3 71733.3 73198.3 73603.0 75037.0 7768.3 7971.7 8052.4 8151.2 8412.9 9233.6 11462.7 12344.6 12762.6 12765.8 10574.6 10879.6 10926.9 11218.2 11423.4 8432.5 9400.5 9492.3 10769.4 11145.0 11389.3 11547.4 11630.9 11651.7 11719.4 8163.1 8210.1 8238.2 8436.0 8463.3 10441.9 11267.8 11524.7 11573.8 11583.5 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5644.49 Median:4914.64 stddev:3167.50 (64.5%) stddev-sans-first:3160.48 06:29:54 INFO - PROCESS | 1667 | Values: 1419.9 1599.9 1603.5 1844.0 1972.4 7895.4 8591.6 8796.6 8820.6 8821.2 8431.2 8648.6 8659.0 8660.7 8665.1 2159.5 2384.9 2430.6 2455.2 2486.6 2469.4 2488.2 2488.5 2488.7 2489.9 2390.0 2458.8 2459.6 2460.7 2460.8 2118.4 2350.3 2434.8 2440.5 2442.6 2434.6 2449.3 2464.9 2467.3 2472.4 8569.8 8616.1 8619.0 8651.2 8659.0 5171.8 5339.3 5357.5 5363.9 5364.2 2970.3 3511.9 3552.5 3641.7 3645.0 1018.7 1037.7 1039.9 1043.3 1049.4 11602.2 11638.7 11643.8 11662.7 11667.4 4156.8 4647.3 4648.0 4901.3 4906.3 9553.1 9778.8 9792.1 9798.2 9799.4 5380.8 5386.1 5396.0 5396.4 5430.2 4382.8 4573.8 4778.9 4912.6 4947.0 3333.7 3910.7 4005.1 4025.3 4037.6 1322.9 1323.7 1327.4 1340.5 1343.6 783.5 814.9 897.3 898.9 935.6 5512.8 5657.7 5702.1 5747.0 5860.7 822.9 940.7 943.2 951.2 989.9 3328.6 3650.5 3845.9 3846.4 3856.6 10343.4 10714.0 10853.7 10860.7 10866.1 10824.0 10827.3 10831.0 10833.7 10848.6 7977.3 8134.0 8291.2 8291.8 8303.4 5325.5 5463.4 5611.2 5639.0 5694.5 9813.6 9892.4 9928.4 9933.5 9950.3 9654.8 10164.3 10180.0 10194.8 10228.1 6098.0 6466.9 6710.4 6959.2 7073.3 8238.6 8270.6 8368.0 8378.0 8394.6 6833.8 6957.1 7315.5 7345.8 7496.3 7087.3 7190.9 7208.6 7291.8 7303.0 6699.2 6909.6 6911.0 6913.7 6930.4 4671.5 4732.4 4783.2 4897.5 4920.7 4765.4 4789.6 4831.9 4837.6 4916.7 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4978.16 Median:5698.20 stddev:1547.17 (27.2%) stddev-sans-first:1510.98 06:29:54 INFO - PROCESS | 1667 | Values: 290.9 309.3 326.5 329.2 330.6 5078.4 5371.2 5871.6 5924.3 5926.9 5582.3 5767.8 5775.1 5776.2 5791.8 3712.3 3748.7 4397.3 4432.2 4435.9 4163.9 4433.0 4440.7 4443.1 4449.8 4337.6 4342.9 4344.7 4362.7 4368.7 4361.7 4361.7 4367.3 4369.9 4399.1 3413.8 3595.7 3707.7 3749.9 3795.6 5577.5 5578.8 5583.2 5590.9 5625.5 4508.0 4874.4 4931.9 4998.5 5068.3 5876.5 6078.9 6158.9 6176.3 6197.8 3458.7 4105.4 4121.3 4126.4 4127.4 6129.2 6506.2 6506.8 6506.9 6518.9 4171.5 4190.2 4199.0 4210.3 4217.5 3659.9 3733.5 4257.1 4281.3 4302.8 5012.3 5014.7 5015.2 5016.6 5026.6 5925.0 5962.9 6120.5 6241.0 6245.8 1393.9 1420.3 1423.8 1425.9 1427.6 898.7 961.5 971.6 972.9 975.0 4456.8 5457.4 5692.6 5724.9 5776.3 5520.8 6230.8 6349.0 6370.1 6413.4 5647.5 5678.5 5703.8 5727.6 5729.2 3253.5 3313.4 3360.8 3362.5 3378.7 5801.2 5942.8 6224.4 6621.4 6634.5 5717.0 6048.8 6343.7 6367.5 6524.9 5477.8 6620.9 6646.8 6646.9 6658.0 5440.4 5785.4 6316.5 6321.7 6346.2 5769.5 6185.1 6197.2 6238.4 6263.9 5691.3 6553.7 6604.4 6634.6 6636.3 4072.7 4186.6 4199.3 4201.4 4204.0 5060.9 5371.8 6005.6 6287.3 6317.1 5210.7 5974.4 6160.3 6168.7 6171.8 4826.9 6072.5 6131.5 6135.0 6137.9 5954.3 5962.5 5974.8 5984.7 5985.0 5826.0 6126.4 6130.2 6142.4 6144.9 5971.9 5974.3 5974.9 6001.7 6015.2 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17437.63 Median:602.55 stddev:24556.82 (4075.5%) stddev-sans-first:24593.17 06:29:54 INFO - PROCESS | 1667 | Values: 603.6 649.7 712.8 741.9 747.4 14789.4 14840.3 15260.7 15276.6 15871.8 14505.3 14568.6 14575.7 14593.0 14608.1 715.8 915.4 922.8 929.2 929.6 685.1 702.3 915.0 915.2 915.5 929.2 936.8 944.0 944.4 947.3 753.6 772.3 927.7 937.1 943.0 709.1 711.6 715.2 716.3 716.8 14932.3 15056.2 15066.9 15072.2 15127.2 12136.2 12346.6 12415.9 12496.7 12671.8 9751.3 10063.6 10125.0 10177.3 10866.2 3457.8 3498.9 3521.0 3535.2 3611.8 87582.8 89558.6 89597.0 90011.5 90367.1 9499.0 9542.0 9724.8 9797.9 9847.0 21838.5 21868.0 21870.2 21925.1 21953.1 7474.3 7544.0 7660.6 7678.3 7698.9 3979.3 3999.6 4058.8 4081.9 4172.8 3508.6 3622.5 3626.9 3642.3 3645.0 550.7 556.2 615.1 645.0 645.6 537.3 564.0 575.6 601.7 603.4 7006.8 7637.2 7821.4 7832.0 7988.3 488.3 538.6 540.6 575.8 613.6 3619.9 3692.2 3707.4 3764.5 3782.4 84402.6 87447.6 87564.1 88053.0 94085.1 55904.7 73609.6 76627.5 78475.2 81145.0 56255.0 60721.4 62822.7 63386.0 70862.0 7135.3 7667.5 7743.8 7779.8 8214.2 33188.3 36079.3 39195.0 40931.8 41761.0 48009.8 48362.0 62089.7 62415.0 64191.7 11357.2 11441.1 11610.2 11675.9 11968.2 9823.4 11759.8 11843.9 11944.8 12962.5 9116.5 10192.7 10520.4 11319.3 12150.2 11037.5 11082.6 11422.4 11604.2 11737.5 10763.2 10776.4 10845.0 10921.0 10986.1 9415.0 9671.4 9676.4 9680.7 9783.6 9097.3 9155.5 9558.7 9599.1 9842.4 06:29:54 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:29:54 INFO - PROCESS | 1667 | 06:29:54 INFO - TEST-INFO | 1667: exit 0 06:29:54 INFO - TEST-OK | dromaeo_css | took 1114886ms 06:29:54 INFO - TEST-START | kraken 06:29:54 INFO - operating with platform_type : mac_ 06:29:54 INFO - Initialising browser for kraken test... 06:29:54 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpNqkflV/profile http://localhost:49277/getInfo.html) 06:29:57 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 06:29:57 INFO - PROCESS | 1677 | colorDepth:24 06:29:57 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 06:29:57 INFO - PROCESS | 1677 | __metrics 06:29:57 INFO - PROCESS | 1677 | 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" 06:29:57 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:29:57 INFO - TEST-INFO | 1677: exit 0 06:29:57 INFO - Browser initialized. 06:29:57 INFO - Running cycle 1/1 for kraken test... 06:29:57 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpNqkflV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:09 INFO - PROCESS | 1679 | RSS: Main: 237522944 06:30:09 INFO - PROCESS | 1679 | 06:30:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 06:30:13 INFO - PROCESS | 1679 | RSS: Main: 286752768 06:30:13 INFO - PROCESS | 1679 | 06:30:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 06:30:16 INFO - PROCESS | 1679 | RSS: Main: 298713088 06:30:16 INFO - PROCESS | 1679 | 06:30:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 06:30:20 INFO - PROCESS | 1679 | RSS: Main: 383913984 06:30:20 INFO - PROCESS | 1679 | 06:30:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 06:30:23 INFO - PROCESS | 1679 | RSS: Main: 286961664 06:30:23 INFO - PROCESS | 1679 | 06:30:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:26 INFO - PROCESS | 1679 | RSS: Main: 291508224 06:30:26 INFO - PROCESS | 1679 | 06:30:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:29 INFO - PROCESS | 1679 | RSS: Main: 326905856 06:30:29 INFO - PROCESS | 1679 | 06:30:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:32 INFO - PROCESS | 1679 | RSS: Main: 329551872 06:30:32 INFO - PROCESS | 1679 | 06:30:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 06:30:36 INFO - PROCESS | 1679 | RSS: Main: 327856128 06:30:36 INFO - PROCESS | 1679 | 06:30:37 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:38 INFO - PROCESS | 1679 | RSS: Main: 319778816 06:30:38 INFO - PROCESS | 1679 | 06:30:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:30:41 INFO - PROCESS | 1679 | RSS: Main: 327512064 06:30:41 INFO - PROCESS | 1679 | 06:30:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:30:43 INFO - PROCESS | 1679 | RSS: Main: 329777152 06:30:43 INFO - PROCESS | 1679 | 06:30:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:30:47 INFO - PROCESS | 1679 | RSS: Main: 334315520 06:30:47 INFO - PROCESS | 1679 | 06:30:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:30:50 INFO - PROCESS | 1679 | RSS: Main: 331653120 06:30:50 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 06:30:52 INFO - PROCESS | 1679 | RSS: Main: 395767808 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | __start_tp_report 06:30:52 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 06:30:52 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 06:30:52 INFO - PROCESS | 1679 | |i|pagename|runs| 06:30:52 INFO - PROCESS | 1679 | |0;ai-astar;113;108;110;113;113;113;119;113;119;163 06:30:52 INFO - PROCESS | 1679 | |1;audio-beat-detection;158;115;145;168;120;145;142;120;169;119 06:30:52 INFO - PROCESS | 1679 | |2;audio-dft;184;185;184;186;186;184;183;181;185;184 06:30:52 INFO - PROCESS | 1679 | |3;audio-fft;72;87;86;92;55;57;61;77;85;56 06:30:52 INFO - PROCESS | 1679 | |4;audio-oscillator;90;105;138;77;78;78;143;110;91;126 06:30:52 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;85;86;84;86;84;87;87;88;84 06:30:52 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;92;95;93;99;140;95;94;94;93 06:30:52 INFO - PROCESS | 1679 | |7;imaging-desaturate;84;86;86;84;83;87;83;81;86;83 06:30:52 INFO - PROCESS | 1679 | |8;json-parse-financial;60;59;58;58;57;58;58;78;55;80 06:30:52 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;66;73;72;76;68;69;68;67;67 06:30:52 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;80;82;82;81;83;82;81;83;83 06:30:52 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;137;137;138;139;137;140;134;138;176;139 06:30:52 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;169;175;213;193;178;174;219;213;172;168 06:30:52 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;69;68;70;70;70;69;70;66;69 06:30:52 INFO - PROCESS | 1679 | __end_tp_report 06:30:52 INFO - PROCESS | 1679 | __start_cc_report 06:30:52 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,2000 06:30:52 INFO - PROCESS | 1679 | __end_cc_report 06:30:52 INFO - PROCESS | 1679 | __startTimestamp1460986252841__endTimestamp 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | ------- Summary: start ------- 06:30:52 INFO - PROCESS | 1679 | Number of tests: 14 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:118.40 Median:113.00 stddev:16.04 (14.2%) stddev-sans-first:16.89 06:30:52 INFO - PROCESS | 1679 | Values: 113.0 108.0 110.0 113.0 113.0 113.0 119.0 113.0 119.0 163.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:20.73 (14.3%) stddev-sans-first:20.95 06:30:52 INFO - PROCESS | 1679 | Values: 158.0 115.0 145.0 168.0 120.0 145.0 142.0 120.0 169.0 119.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.48 (0.8%) stddev-sans-first:1.56 06:30:52 INFO - PROCESS | 1679 | Values: 184.0 185.0 184.0 186.0 186.0 184.0 183.0 181.0 185.0 184.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:72.80 Median:81.00 stddev:14.53 (17.9%) stddev-sans-first:15.41 06:30:52 INFO - PROCESS | 1679 | Values: 72.0 87.0 86.0 92.0 55.0 57.0 61.0 77.0 85.0 56.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:77.50 stddev:25.04 (32.3%) stddev-sans-first:26.07 06:30:52 INFO - PROCESS | 1679 | Values: 90.0 105.0 138.0 77.0 78.0 78.0 143.0 110.0 91.0 126.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:1.60 (1.8%) stddev-sans-first:1.50 06:30:52 INFO - PROCESS | 1679 | Values: 88.0 85.0 86.0 84.0 86.0 84.0 87.0 87.0 88.0 84.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:94.00 stddev:14.65 (15.6%) stddev-sans-first:15.34 06:30:52 INFO - PROCESS | 1679 | Values: 92.0 92.0 95.0 93.0 99.0 140.0 95.0 94.0 94.0 93.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:85.00 stddev:1.89 (2.2%) stddev-sans-first:2.00 06:30:52 INFO - PROCESS | 1679 | Values: 84.0 86.0 86.0 84.0 83.0 87.0 83.0 81.0 86.0 83.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:58.50 stddev:9.01 (15.4%) stddev-sans-first:9.53 06:30:52 INFO - PROCESS | 1679 | Values: 60.0 59.0 58.0 58.0 57.0 58.0 58.0 78.0 55.0 80.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:3.48 (5.1%) stddev-sans-first:3.36 06:30:52 INFO - PROCESS | 1679 | Values: 65.0 66.0 73.0 72.0 76.0 68.0 69.0 68.0 67.0 67.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.05 (1.3%) stddev-sans-first:1.05 06:30:52 INFO - PROCESS | 1679 | Values: 83.0 80.0 82.0 82.0 81.0 83.0 82.0 81.0 83.0 83.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:138.50 stddev:12.23 (8.8%) stddev-sans-first:12.86 06:30:52 INFO - PROCESS | 1679 | Values: 137.0 137.0 138.0 139.0 137.0 140.0 134.0 138.0 176.0 139.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:185.50 stddev:20.32 (11.0%) stddev-sans-first:20.43 06:30:52 INFO - PROCESS | 1679 | Values: 169.0 175.0 213.0 193.0 178.0 174.0 219.0 213.0 172.0 168.0 06:30:52 INFO - PROCESS | 1679 | 06:30:52 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.29 (1.9%) stddev-sans-first:1.32 06:30:52 INFO - PROCESS | 1679 | Values: 68.0 69.0 68.0 70.0 70.0 70.0 69.0 70.0 66.0 69.0 06:30:52 INFO - PROCESS | 1679 | -------- Summary: end -------- 06:30:52 INFO - PROCESS | 1679 | 06:30:53 INFO - TEST-INFO | 1679: exit 0 06:30:53 INFO - TEST-OK | kraken | took 58865ms 06:30:53 INFO - SUITE-END | took 1173s 06:30:54 INFO - Completed test suite (00:19:34) 06:30:54 INFO - javascript benchmark 06:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.6859314068597, 3428.485727140927, 3447.2933048725013, 3465.977536626695, 3491.266833964869, 5574.414686457924, 5603.019471592465, 5615.775368985241, 5621.943780562198, 5634.267545219121, 5575.442455754433, 5634.7182640867995, 5638.154276858473, 5643.717814109299, 5653.067243904751, 5131.4098878628965, 5148.665336753099, 5181.663191892534, 5188.221766734982, 5256.342957130359, 5240.371155461331, 5246.449122842104, 5252.894942101156, 5253.395859476152, 5266.789328426858, 5170.069387510247, 5212.895742085156, 5214.0, 5216.0, 5303.7348132593215, 5202.115640341132, 5238.528532432099, 5244.842654720364, 5251.0, 5308.575313974873, 5069.340985671876, 5108.2848401223855, 5121.769520371555, 5154.845354639367, 5184.27420161174, 5513.751881165317, 5525.917111243334, 5544.889102217973, 5586.190002449663, 5598.216249725042, 6131.110988906628, 6143.96928015357, 6161.260648722137, 6168.383161683841, 6174.59865108771, 6068.696565171724, 6112.572119951606, 6170.7223174957235, 6196.87606247877, 6238.189035425366, 4838.371011768448, 5735.713214339266, 5738.483536481654, 5770.365259821417, 5794.65232086072, 6171.907421388682, 6176.814695559051, 6190.690465476709, 6191.81424557264, 6193.194884664965, 5522.7573795895605, 5839.591228614041, 5938.168656388109, 5994.0, 6053.636781793107, 6169.5064394848305, 6169.753209871555, 6173.043178307369, 6185.721642526097, 6199.783007594803, 6087.208662873798, 6128.233970753656, 6144.109104179958, 6149.7847575334645, 6157.2611286645, 6033.818985430444, 6122.581127188433, 6179.84550386235, 6204.751809927642, 6216.285127210338, 3853.402722578005, 4441.357392351546, 4837.637177211724, 4857.392825896763, 4934.185859333242, 4339.544347843431, 4348.021695118637, 4348.304271316574, 4361.869143925687, 4389.692721509464, 5486.204500347428, 5570.220169176318, 5581.944180558224, 5587.106063029895, 5590.329160500684, 6103.6032657877095, 6120.142398366865, 6149.8155055347515, 6159.106929495288, 6192.8761424771255, 5564.443555644403, 5565.693886836263, 5572.136318870582, 5589.105743081088, 5589.888202235932, 5216.165413533817, 5287.391949925731, 5289.735513224324, 5305.230741542455, 5305.787768489217, 6169.81490555284, 6231.563790534619, 6241.0, 6245.7189426476825, 6256.5307601930035, 6118.877622447615, 6144.41628045335, 6163.3528479509005, 6179.938200618116, 6183.721732522137, 6113.111460343502, 6161.921663708923, 6205.627662340274, 6206.72069756871, 6242.094896240111, 6101.398774955092, 6109.708332504907, 6133.793750436688, 6138.419052470106, 6143.174139895698, 6174.135621012972, 6184.196054512884, 6199.938000619936, 6202.131701561695, 6210.503159747119, 5895.557833162444, 5999.340072592098, 6024.216851809237, 6045.425684559959, 6081.331053584191, 5801.82594522165, 5993.640381577119, 6010.188624535632, 6034.064719968412, 6064.9393506066135, 5862.355140934579, 5865.794697185578, 5866.149408335853, 5874.471297583238, 5881.676507792113, 5794.681292528951, 5907.675077870758, 6038.154658347923, 6054.243219597551, 6091.817245482643, 5889.587728858939, 5890.676012819336, 5895.587308888336, 5903.2916050072545, 5916.970415147896], "value": 5619.260726651793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.4902744337993, 531.9707416092115, 540.3920589336996, 543.1825103219654, 555.4362322242924, 24779.628305575407, 29535.556966645516, 29544.852275738616, 37054.25891482169, 38275.80862095686, 41600.791996040054, 42413.15173696524, 42436.363454548205, 42452.363214551806, 42506.574934250646, 9534.618615255382, 9781.559829807677, 9783.021697830196, 9788.90211097887, 9829.55766990487, 8538.70114545991, 8798.51608161551, 9221.0, 9482.762930926712, 11908.642740717793, 11646.301221926711, 11823.231489953125, 11825.46785394655, 11828.053755699566, 11862.110341724361, 11671.124665650068, 11757.176997610171, 11763.0, 11787.469563869647, 11796.528138874435, 8520.70177543783, 8812.647494100229, 8821.426607270507, 11384.316940983568, 11735.23720958135, 37376.065598359986, 37964.0, 37995.24009519822, 37996.24007519862, 38077.0, 3192.0314107879663, 3206.3106432117206, 3269.96730032699, 3276.1318250663594, 3415.334009868077, 26682.33294167642, 27425.588616170775, 27825.0, 27898.88404463819, 28481.430371392456, 2720.5919112133142, 2737.671479422462, 2739.58906164075, 2761.986190069057, 2792.176307989148, 459051.7047414775, 461314.0, 462508.0, 463250.0, 467004.0, 58500.707496462244, 58833.0, 58837.0, 58880.705596471744, 58883.70558147182, 62385.0, 62549.37450625526, 62629.373706263264, 62649.686751566864, 62690.0, 16211.432599858948, 16453.424130155625, 16478.67042659164, 16479.83520164807, 16482.75275870863, 11652.941735291439, 12838.9358053211, 12890.0, 12927.353632318347, 12947.611571652866, 13823.861761382257, 15486.612834679223, 15989.0, 16006.199690015686, 16011.679766404606, 5109.616778741609, 5252.632315737862, 6119.143319935212, 6122.326544080148, 6146.323904370515, 861.5132450165762, 966.1980556138388, 1017.6285655735603, 1037.4138611684375, 1061.5594528270835, 23263.53472930532, 25879.988601766756, 27536.862315688693, 27944.580831287545, 28255.0, 1074.9301295415773, 1105.9225854190129, 1127.4475507001673, 1140.1961617059953, 1212.6240865331774, 12618.55835045769, 14942.850571494364, 14960.251987400805, 15038.398464061314, 15281.6179595511, 560711.0, 571056.0, 576944.0, 577288.0, 579023.0, 49832.0, 58557.121643175386, 60012.69993650004, 60065.39934600598, 60135.0, 1458.7009663019055, 1465.4211586423517, 1470.4338829550486, 1479.6300924769023, 1480.2154857925316, 23951.640725389483, 28816.855915720287, 28835.423291534473, 29295.0, 29471.852640737518, 39801.80099099486, 47581.762091189325, 47994.0, 48138.75930620325, 48140.03719925652, 484149.0, 488187.0, 488393.0, 488408.0, 488705.0, 36357.63642363648, 36370.4544431839, 36581.26837463183, 37258.0, 37338.8133059333, 42260.788696057556, 42273.0, 43988.34017489676, 44381.11237775291, 44643.33035004543, 35249.0, 37020.44469333016, 37307.626923730415, 38097.23805523929, 38103.80948095242, 27472.0, 31960.360792783547, 34266.31467370688, 34520.82739586286, 34742.47886281657, 33950.49074263839, 34695.65304346924, 35149.47275790916, 35425.82287088548, 35508.46737298891, 31154.688453115177, 31603.683963160995, 32034.839825801653, 32067.518987214742, 32077.358452830347, 23532.882335588896, 23692.52614947657, 24174.03303867896, 24540.87729561341, 24581.754182457946], "value": 19302.96565431645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.65161831778886, 396.0534322968105, 398.8564116917911, 402.1855742122202, 406.37012630422856, 19646.90176549117, 20002.0, 20404.591908161845, 20427.693584596243, 21199.364019079454, 20289.898550507227, 20728.68906966393, 21444.46388840276, 21456.570868582618, 21487.462813429673, 4642.117997580466, 5461.317335333083, 5462.8361149165585, 5465.480779325978, 5490.6431081979745, 5394.109971854659, 5473.06957817172, 5538.723063846812, 5931.436513531229, 5936.168936348915, 5614.9438505615035, 5873.618214816023, 5902.675352855613, 5908.4091590841, 5932.851678708045, 5730.656160630376, 5830.883382332372, 5844.473997340238, 5855.882882342351, 5865.677387743651, 5644.887102257973, 5874.588778785486, 5882.6470411775, 5887.0580707086665, 5888.175655408247, 13571.796423053662, 13889.0, 20032.499187520283, 25285.494290114093, 25352.732363381758, 2052.6715725484, 2160.503084290622, 2194.8353873459555, 2239.902447800582, 2462.150558057467, 10185.541650625739, 10433.791324173473, 10462.47687615616, 12220.816687749602, 14371.993960422775, 1639.506956987761, 1732.9826701732948, 1756.1394916490956, 1769.504538729158, 1799.136414521024, 98404.0, 107294.0, 116221.0, 118378.0, 119256.0, 10157.187425005981, 11296.667483092508, 11337.582802149731, 11430.771384572263, 11604.941975290238, 15156.545303640687, 15293.235338233044, 15293.847061529465, 15295.464658737113, 15312.617184570252, 7182.569045857265, 8511.276541493919, 8734.86897696535, 8820.294376449869, 8843.557822108869, 8374.832503349899, 8408.83182336362, 8424.368172386972, 8588.828223435496, 8597.742067737978, 3818.0073180973145, 4625.95374046262, 4648.628109751212, 4688.624910007259, 4730.385049943554, 1781.2785821741957, 1804.7022241330033, 1882.623475304917, 1903.961920761577, 1970.4384250488542, 786.1627366854282, 945.5555888732284, 992.5583115513672, 1007.496251874063, 1106.0819519798547, 18489.68878890139, 19144.234230630896, 19440.90279548593, 19895.801041989685, 20314.898425508072, 967.3035414501547, 978.3396207559869, 1006.4011912911806, 1024.7335692719946, 1027.0961553832728, 10553.788924221473, 10824.891751082547, 10853.0, 10861.239713219999, 10879.456027198608, 590210.0, 590735.0, 603719.0, 604726.0, 605196.0, 98595.0, 120695.0, 121990.0, 122589.0, 125777.0, 958.2477754962321, 959.1655259923772, 992.2558081438921, 993.7416271769248, 1017.8676772019738, 17414.564635883697, 17931.193096310435, 18028.909855451162, 18134.909325453817, 18406.72389914179, 49912.0, 49979.75010124926, 50516.0, 50699.746501267255, 50984.0, 70480.29519704737, 71733.28266717475, 73198.26801732127, 73603.0, 75037.0, 7768.339691126317, 7971.681132754625, 8052.436329456882, 8151.225633564802, 8412.915870841458, 9233.630654773733, 11462.713432164262, 12344.567940122053, 12762.553310634083, 12765.8085128725, 10574.629887953884, 10879.564817407216, 10926.890731092906, 11218.158638102012, 11423.428828558373, 8432.53621050848, 9400.529973501434, 9492.335536512377, 10769.407682577534, 11145.0, 11389.316641001566, 11547.422628868691, 11630.929174789095, 11651.708707282047, 11719.355435451133, 8163.061247956561, 8210.055843578066, 8238.217369349903, 8436.0, 8463.28062114727, 10441.895581044093, 11267.774644507228, 11524.654260372203, 11573.768524629628, 11583.478743456397], "value": 9397.667176113267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.8722115009648, 1599.8800089993254, 1603.5429902477792, 1843.972340414893, 1972.3984184823623, 7895.40784441167, 8591.570421478924, 8796.604152813123, 8820.558972051396, 8821.206091451768, 8431.241188293052, 8648.56757162141, 8658.956705216466, 8660.696875609356, 8665.133486651332, 2159.524904521003, 2384.8688322142275, 2430.562498750224, 2455.177515532299, 2486.6021436570154, 2469.4320306329555, 2488.191337815208, 2488.464980029293, 2488.713797913236, 2489.8755062246905, 2389.9641505377435, 2458.754124587545, 2459.557279689664, 2460.7047154341503, 2460.753924607543, 2118.3962570667286, 2350.3301559055585, 2434.7565243475688, 2440.548498527778, 2442.6458163566185, 2434.6104623260194, 2449.326435230308, 2464.8890799914047, 2467.346153269385, 2472.43134079161, 8569.785755356104, 8616.138386161396, 8618.956905215433, 8651.221390074861, 8659.0, 5171.7672704728375, 5339.332583427072, 5357.491038351351, 5363.892722145574, 5364.168553874117, 2970.287131088523, 3511.91220219494, 3552.467129930505, 3641.6904563112166, 3644.9817750911343, 1018.6638409324979, 1037.6990672704906, 1039.9168066554657, 1043.342694102718, 1049.375621505203, 11602.187846850724, 11638.70903227426, 11643.767124657545, 11662.70843228926, 11667.416629168592, 4156.815307637369, 4647.3029045643425, 4647.978129513673, 4901.313816065754, 4906.31311616374, 9553.092456216647, 9778.75553111178, 9792.139493496214, 9798.167155791694, 9799.412035277906, 5380.757865896044, 5386.057439947994, 5396.028714831368, 5396.379416367168, 5430.185472179126, 4382.824687012484, 4573.81704731807, 4778.880527986758, 4912.606991440676, 4947.0, 3333.7333013358875, 3910.667593254548, 4005.0988527581644, 4025.255327764373, 4037.6366127048705, 1322.9338533073308, 1323.6558494791232, 1327.396034804162, 1340.544214966916, 1343.603636927109, 783.4554984285867, 814.8818421328874, 897.3180382909036, 898.9235914947172, 935.6397786851975, 5512.80705175317, 5657.688827114466, 5702.144678298206, 5747.0, 5860.677662728591, 822.8601137806587, 940.7262725714552, 943.2454036770556, 951.177231694593, 989.8762654668167, 3328.617209020945, 3650.5254316938626, 3845.8846234613006, 3846.4038074098557, 3856.614338566177, 10343.37939723619, 10714.0, 10853.728656783644, 10860.67417977462, 10866.130709543218, 10824.0, 10827.296225745302, 10831.0, 10833.67498975032, 10848.566057357775, 7977.282044616012, 8134.0, 8291.170882911661, 8291.8341633167, 8303.377246706401, 5325.4940780625775, 5463.399026107046, 5611.186377975089, 5639.0, 5694.4590263924865, 9813.558389872616, 9892.406455612687, 9928.404295742279, 9933.453660048766, 9950.253730970351, 9654.806903862023, 10164.288499805238, 10180.0, 10194.847077293698, 10228.07947284748, 6097.96334623124, 6466.902996454963, 6710.396064354231, 6959.19969203548, 7073.328033836778, 8238.588070596566, 8270.627821747916, 8368.037675667376, 8377.994640643163, 8394.622241999003, 6833.838247497838, 6957.130358705162, 7315.48791584584, 7345.77962661121, 7496.325330720043, 7087.3267039631155, 7190.856182876418, 7208.56748595086, 7291.781246562611, 7302.96348518254, 6699.196096468455, 6909.619970901648, 6910.997905303803, 6913.654317284217, 6930.445564354739, 4671.486136524912, 4732.361131247238, 4783.234682450791, 4897.510248975074, 4920.6555541111775, 4765.380500534909, 4789.61683065347, 4831.903361932812, 4837.564619184291, 4916.680415772963], "value": 4551.2389170543665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.9476294267032, 309.3256700393142, 326.46948708348935, 329.2181069958848, 330.632997372916, 5078.368966189174, 5371.194320851864, 5871.559633027524, 5924.259467566554, 5926.851828704284, 5582.330120385559, 5767.8269651910405, 5775.104858746901, 5776.249087618614, 5791.768329266824, 3712.313222053915, 3748.700103991674, 4397.274449715793, 4432.180046691356, 4435.889102772432, 4163.877092180865, 4433.0, 4440.689151759379, 4443.133588950156, 4449.822007119711, 4337.609615134637, 4342.935980684737, 4344.695871289011, 4362.738235705852, 4368.694191406603, 4361.6510679145595, 4361.672874534423, 4367.323064924942, 4369.890752731191, 4399.098184872094, 3413.76103672743, 3595.676389124991, 3707.6663100321102, 3749.850005999757, 3795.6394142556687, 5577.490129441727, 5578.776848926079, 5583.190437386596, 5590.91613625796, 5625.5218306444, 4508.008238187594, 4874.368595396452, 4931.865670895678, 4998.450170481244, 5068.290439338495, 5876.471117599393, 6078.939210607881, 6158.938410615926, 6176.258848938111, 6197.752089916398, 3458.723302135823, 4105.363668631367, 4121.340585506305, 4126.400367768287, 4127.360259159835, 6129.233845769234, 6506.154199953976, 6506.837329066764, 6506.934930650727, 6518.93481065188, 4171.457710497616, 4190.182914331737, 4198.979005105016, 4210.263203939298, 4217.536071032184, 3659.9451008234896, 3733.4586484960073, 4257.063446041866, 4281.293586558183, 4302.7848607569495, 5012.273220383024, 5014.674046186986, 5015.172496538104, 5016.623753218523, 5026.5621173730715, 5924.9703751480965, 5962.850928726816, 6120.479759220427, 6240.968795155995, 6245.781397651152, 1393.9233342166278, 1420.3382043009497, 1423.8077859489044, 1425.8788003019858, 1427.5645927991854, 898.6630013744846, 961.5048250151178, 971.6404930175739, 972.9464879431557, 975.0395860077817, 4456.75487848165, 5457.399686034533, 5692.57305702074, 5724.8799404324745, 5776.277965254343, 5520.806771762969, 6230.816144932448, 6348.952422850178, 6370.140031095835, 6413.422791948747, 5647.519960803295, 5678.545716342683, 5703.828885133453, 5727.627704199297, 5729.226554415184, 3253.5282384054653, 3313.353895990307, 3360.8151551664405, 3362.529245905575, 3378.7297016239136, 5801.216835727208, 5942.841145976579, 6224.354649274041, 6621.404073633396, 6634.535582509178, 5717.0, 6048.818535443944, 6343.728092322332, 6367.4906007519285, 6524.902126468107, 5477.7821077769895, 6620.933790662128, 6646.767363142267, 6646.90029649546, 6658.0, 5440.374356949002, 5785.4214578541805, 6316.463100636497, 6321.652309123042, 6346.238451385863, 5769.451902069297, 6185.072239164161, 6197.194364732736, 6238.438540531374, 6263.937360626335, 5691.345495268097, 6553.705083271359, 6604.405603495708, 6634.635095069818, 6636.27001029896, 4072.714909956393, 4186.644135248538, 4199.265128602544, 4201.432806571196, 4204.012057166502, 5060.898782024413, 5371.838844834505, 6005.6396616203165, 6287.30839607652, 6317.052442133717, 5210.687358758487, 5974.37269086757, 6160.260768707604, 6168.660723660062, 6171.783987560414, 4826.8793280168275, 6072.453479186895, 6131.509479241739, 6134.969325153345, 6137.925862974051, 5954.255718035246, 5962.4633782959745, 5974.820755377345, 5984.700764961647, 5985.0, 5825.970870145622, 6126.448619624077, 6130.172426722335, 6142.447179753844, 6144.907826382519, 5971.910421343597, 5974.2830860297045, 5974.880502390015, 6001.669908155093, 6015.248093988252], "value": 4475.3547465904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6016229288668, 649.6881496881497, 712.8004158835528, 741.933226009659, 747.409546458298, 14789.408423663053, 14840.332185051671, 15260.694786104285, 15276.618084547878, 15871.761923571155, 14505.274736263198, 14568.635784105376, 14575.708485830277, 14593.0, 14608.123512589253, 715.8317795318096, 915.3866909170855, 922.8246633139682, 929.1776777551881, 929.590979968815, 685.0683071023404, 702.3117345001901, 914.9542522873829, 915.158054589779, 915.5102020419077, 929.2473096791587, 936.7845395559026, 943.9669611563596, 944.4097439100562, 947.3179310896144, 753.6307209467376, 772.2856357868949, 927.7309580221728, 937.0582564522646, 942.9622815087388, 709.0569542508451, 711.6441779110445, 715.2382712411318, 716.3051839715467, 716.845878136198, 14932.32804523799, 15056.247187640574, 15066.924665376602, 15072.171030593314, 15127.168005759679, 12136.15046946714, 12346.629601111981, 12415.93792031034, 12496.687582810411, 12671.809922851164, 9751.268654850914, 10063.597456101747, 10125.0, 10177.338472999232, 10866.239363244576, 3457.775244609092, 3498.930021399558, 3521.0493166845063, 3535.2045789697368, 3611.7652352596997, 87582.81042973977, 89558.5522072392, 89596.99999999935, 90011.54994225052, 90367.09632903653, 9499.0, 9541.952290238505, 9724.805503889882, 9797.902020979842, 9847.0, 21838.454038648844, 21868.01593928277, 21870.23454179096, 21925.122995080335, 21953.121875125136, 7474.252574742591, 7544.040208235432, 7660.578668173304, 7678.270564296383, 7698.884516732253, 3979.263836190314, 3999.6200360965663, 4058.817353219112, 4081.9387709184384, 4172.8122234498915, 3508.561429821272, 3622.4747411625694, 3626.9093272668392, 3642.307961487309, 3644.9817750911075, 550.6530885542082, 556.2157358125024, 615.1265203411167, 644.9613023218621, 645.5771469687362, 537.2726733025925, 563.9859003524945, 575.602834044508, 601.7021574320652, 603.4026313949158, 7006.8438707613695, 7637.236276372319, 7821.374290056782, 7832.0, 7988.320992715684, 488.30172852820806, 538.6253687607135, 540.6080591571158, 575.7610591604521, 613.5919613457002, 3619.8552057917386, 3692.2246328270826, 3707.3882809336696, 3764.5106136202667, 3782.394816829294, 84402.57798710967, 87447.56276218579, 87564.12435875688, 88053.0, 94085.059149409, 55904.72047639817, 73609.63195184097, 76627.46745065067, 78475.21524784679, 81145.0, 56255.0, 60721.39278607246, 62822.685886570274, 63386.0, 70862.0, 7135.322144396274, 7667.539947603162, 7743.806404839924, 7779.844403112019, 8214.178582141738, 33188.33623327471, 36079.27841443209, 39195.0, 40931.7953410243, 41761.0, 48009.7997550064, 48362.0, 62089.68955155195, 62415.0, 64191.67904160449, 11357.204995650225, 11441.14191435629, 11610.24533405326, 11675.88324116782, 11968.222065565711, 9823.410595364301, 11759.76480470403, 11843.881561184622, 11944.761104777683, 12962.481500740241, 9116.498592577473, 10192.694219173436, 10520.421376824348, 11319.320840749582, 12150.21023633461, 11037.503312351124, 11082.556697732, 11422.428878555873, 11604.245724027911, 11737.530498779954, 10763.192760542834, 10776.353418794897, 10845.0, 10921.017108460277, 10986.121110311316, 9414.95292523533, 9671.419714817133, 9676.419414835133, 9680.661176858775, 9783.608655653694, 9097.29942618417, 9155.496447695441, 9558.665446709332, 9599.088086631758, 9842.409455432697], "value": 6704.784227664644, "unit": "score"}], "name": "dromaeo_css", "value": 7199.202843202727, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 110.0, 113.0, 113.0, 113.0, 119.0, 113.0, 119.0, 163.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 115.0, 145.0, 168.0, 120.0, 145.0, 142.0, 120.0, 169.0, 119.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 186.0, 186.0, 184.0, 183.0, 181.0, 185.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 87.0, 86.0, 92.0, 55.0, 57.0, 61.0, 77.0, 85.0, 56.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 138.0, 77.0, 78.0, 78.0, 143.0, 110.0, 91.0, 126.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 84.0, 86.0, 84.0, 87.0, 87.0, 88.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 95.0, 93.0, 99.0, 140.0, 95.0, 94.0, 94.0, 93.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 84.0, 83.0, 87.0, 83.0, 81.0, 86.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 78.0, 55.0, 80.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 73.0, 72.0, 76.0, 68.0, 69.0, 68.0, 67.0, 67.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 82.0, 82.0, 81.0, 83.0, 82.0, 81.0, 83.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 138.0, 139.0, 137.0, 140.0, 134.0, 138.0, 176.0, 139.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 213.0, 193.0, 178.0, 174.0, 219.0, 213.0, 172.0, 168.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 70.0, 70.0, 70.0, 69.0, 70.0, 66.0, 69.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1499.0000000000002, "alertThreshold": 2.0}]} 06:30:54 INFO - Return code: 0 06:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:30:54 ERROR - # TBPL SUCCESS # 06:30:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:30:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:30:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:30:54 INFO - 2016-04-18 06:30:54.147 screenresolution[1684:10432] starting screenresolution argv=screenresolution get 06:30:54 INFO - 2016-04-18 06:30:54.149 screenresolution[1684:10432] Display 0: 1600x1200x32@60 06:30:54 INFO - 2016-04-18 06:30:54.155 screenresolution[1685:10435] starting screenresolution argv=screenresolution list 06:30:54 INFO - Available Modes on Display 0 06:30:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:30:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:30:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:30:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:30:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:30:54 INFO - Intel Iris: 06:30:54 INFO - Chipset Model: Intel Iris 06:30:54 INFO - Type: GPU 06:30:54 INFO - Bus: Built-In 06:30:54 INFO - VRAM (Dynamic, Max): 1536 MB 06:30:54 INFO - Vendor: Intel (0x8086) 06:30:54 INFO - Device ID: 0x0a2e 06:30:54 INFO - Revision ID: 0x0009 06:30:54 INFO - Displays: 06:30:54 INFO - Display: 06:30:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:30:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:30:54 INFO - Display Serial Number: 1600x1200 60 06:30:54 INFO - Main Display: Yes 06:30:54 INFO - Mirror: Off 06:30:54 INFO - Online: Yes 06:30:54 INFO - Rotation: Supported 06:30:54 INFO - Return code: 0 06:30:54 INFO - Running post-action listener: _resource_record_post_action 06:30:54 INFO - Running post-run listener: _resource_record_post_run 06:30:55 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37856768; Write bytes: 693783552; Read time: 413; Write time: 1875 06:30:55 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 387930624; Write bytes: 381572608; Read time: 29651; Write time: 686 06:30:55 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 36070912; Write bytes: 296703488; Read time: 394; Write time: 1153 06:30:55 INFO - Running post-run listener: _upload_blobber_files 06:30:55 INFO - Blob upload gear active. 06:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:30:55 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 06:30:55 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'] 06:30:55 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 06:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:56 INFO - (blobuploader) - INFO - Done attempting. 06:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:57 INFO - (blobuploader) - INFO - Done attempting. 06:30:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:30:57 INFO - Return code: 0 06:30:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:30:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:30:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dec74c03f9e7fee771ac32a99747071a56b700982d588d462a3aa35eae8fd2b57ac1fbfd394a189509313c20aa9869c5ddc298aa2196250d3fa5ab581f56a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a645f1263b1fe18f83c11695781c28160e3800b37d91304358756a5931b61c9b2b0d9042915e8125b75f44a430cba8ed6ecd99794fb8bef06524d7000e315dfc"} 06:30:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:30:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:30:57 INFO - Contents: 06:30:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dec74c03f9e7fee771ac32a99747071a56b700982d588d462a3aa35eae8fd2b57ac1fbfd394a189509313c20aa9869c5ddc298aa2196250d3fa5ab581f56a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a645f1263b1fe18f83c11695781c28160e3800b37d91304358756a5931b61c9b2b0d9042915e8125b75f44a430cba8ed6ecd99794fb8bef06524d7000e315dfc"} 06:30:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:30:57 INFO - Copying logs to upload dir... 06:30:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:30:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.991917 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-04-18 06:30:58.013574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 06:30:58.017044) ========= 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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/6dec74c03f9e7fee771ac32a99747071a56b700982d588d462a3aa35eae8fd2b57ac1fbfd394a189509313c20aa9869c5ddc298aa2196250d3fa5ab581f56a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a645f1263b1fe18f83c11695781c28160e3800b37d91304358756a5931b61c9b2b0d9042915e8125b75f44a430cba8ed6ecd99794fb8bef06524d7000e315dfc"} build_url:https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010561 build_url: 'https://queue.taskcluster.net/v1/task/G-XhTKRMTiC6LOnWt9y1-Q/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/6dec74c03f9e7fee771ac32a99747071a56b700982d588d462a3aa35eae8fd2b57ac1fbfd394a189509313c20aa9869c5ddc298aa2196250d3fa5ab581f56a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a645f1263b1fe18f83c11695781c28160e3800b37d91304358756a5931b61c9b2b0d9042915e8125b75f44a430cba8ed6ecd99794fb8bef06524d7000e315dfc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 06:30:58.044667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 06:30:58.044995) ========= 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.Wv1ZlgoSSc/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.O9HnfbMpPO/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005253 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 06:30:58.096547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 06:30:58.097141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 06:30:58.097497) ========= ========= Total master_lag: 3.25 =========