builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0196 starttime: 1461961003.67 results: success (0) buildid: 20160429104432 builduid: 8f293f0f7a24420a8634ca54cb9117ce revision: cd2ec0f3b56126297a852cebc67cc5443f670593 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.673126) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.673523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.673874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.692085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.692440) ========= 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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-29 13:16:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.7M=0s 2016-04-29 13:16:43 (26.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106837 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.826523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.826805) ========= 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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.020321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:43.876828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-29 13:16:43.877210) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cd2ec0f3b56126297a852cebc67cc5443f670593 --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 cd2ec0f3b56126297a852cebc67cc5443f670593 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-29 13:16:43,951 truncating revision to first 12 chars 2016-04-29 13:16:43,951 Setting DEBUG logging. 2016-04-29 13:16:43,951 attempt 1/10 2016-04-29 13:16:43,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cd2ec0f3b561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 13:16:45,741 unpacking tar archive at: fx-team-cd2ec0f3b561/testing/mozharness/ program finished with exit code 0 elapsedTime=2.024549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-29 13:16:45.918660) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:45.919064) ========= script_repo_revision: cd2ec0f3b56126297a852cebc67cc5443f670593 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:45.919541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:45.919825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:16:45.933111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-29 13:16:45.933412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:16:46 INFO - MultiFileLogger online at 20160429 13:16:46 in /builds/slave/test 13:16:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:16:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:46 INFO - {'append_to_log': False, 13:16:46 INFO - 'base_work_dir': '/builds/slave/test', 13:16:46 INFO - 'blob_upload_branch': 'Fx-Team', 13:16:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:46 INFO - 'branch': 'Fx-Team', 13:16:46 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:46 INFO - 'config_files': ('talos/mac_config.py',), 13:16:46 INFO - 'default_actions': ('clobber', 13:16:46 INFO - 'read-buildbot-config', 13:16:46 INFO - 'download-and-extract', 13:16:46 INFO - 'populate-webroot', 13:16:46 INFO - 'create-virtualenv', 13:16:46 INFO - 'install', 13:16:46 INFO - 'run-tests'), 13:16:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:46 INFO - 'download_minidump_stackwalk': True, 13:16:46 INFO - 'download_symbols': 'ondemand', 13:16:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:46 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:46 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:46 INFO - 'installer_path': 'installer.exe', 13:16:46 INFO - 'log_level': 'info', 13:16:46 INFO - 'log_name': 'talos', 13:16:46 INFO - 'log_to_console': True, 13:16:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:16:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:16:46 INFO - 'opt_config_files': (), 13:16:46 INFO - 'pip_index': False, 13:16:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:16:46 INFO - 'cmd': ('bash', 13:16:46 INFO - '-c', 13:16:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:16:46 INFO - 'enabled': True, 13:16:46 INFO - 'halt_on_failure': False, 13:16:46 INFO - 'name': 'check_screen_resolution'},), 13:16:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:16:46 INFO - 'cmd': ('bash', 13:16:46 INFO - '-c', 13:16:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:16:46 INFO - 'enabled': True, 13:16:46 INFO - 'halt_on_failure': False, 13:16:46 INFO - 'name': 'check_screen_resolution'},), 13:16:46 INFO - 'run_cmd_checks_enabled': True, 13:16:46 INFO - 'sps_profile': False, 13:16:46 INFO - 'sps_profile_interval': 0, 13:16:46 INFO - 'suite': 'dromaeojs-e10s', 13:16:46 INFO - 'system_bits': '32', 13:16:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:46 INFO - 'title': 't-yosemite-r7-0196', 13:16:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:46 INFO - 'use_talos_json': True, 13:16:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:46 INFO - 'work_dir': 'build'} 13:16:46 INFO - ##### 13:16:46 INFO - ##### Running clobber step. 13:16:46 INFO - ##### 13:16:46 INFO - Running pre-action listener: _resource_record_pre_action 13:16:46 INFO - Running main action method: clobber 13:16:46 INFO - rmtree: /builds/slave/test/build 13:16:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:46 INFO - Running post-action listener: _resource_record_post_action 13:16:46 INFO - ##### 13:16:46 INFO - ##### Running read-buildbot-config step. 13:16:46 INFO - ##### 13:16:46 INFO - Running pre-action listener: _resource_record_pre_action 13:16:46 INFO - Running main action method: read_buildbot_config 13:16:46 INFO - Using buildbot properties: 13:16:46 INFO - { 13:16:46 INFO - "project": "", 13:16:46 INFO - "product": "firefox", 13:16:46 INFO - "script_repo_revision": "production", 13:16:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:16:46 INFO - "repository": "", 13:16:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:16:46 INFO - "buildid": "20160429104432", 13:16:46 INFO - "pgo_build": "False", 13:16:46 INFO - "basedir": "/builds/slave/test", 13:16:46 INFO - "buildnumber": 647, 13:16:46 INFO - "slavename": "t-yosemite-r7-0196", 13:16:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:16:46 INFO - "platform": "yosemite_r7", 13:16:46 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 13:16:46 INFO - "branch": "fx-team", 13:16:46 INFO - "repo_path": "integration/fx-team", 13:16:46 INFO - "revision": "cd2ec0f3b56126297a852cebc67cc5443f670593", 13:16:46 INFO - "stage_platform": "macosx64", 13:16:46 INFO - "builduid": "8f293f0f7a24420a8634ca54cb9117ce", 13:16:46 INFO - "slavebuilddir": "test" 13:16:46 INFO - } 13:16:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 13:16:46 INFO - Running post-action listener: _resource_record_post_action 13:16:46 INFO - ##### 13:16:46 INFO - ##### Running download-and-extract step. 13:16:46 INFO - ##### 13:16:46 INFO - Running pre-action listener: _resource_record_pre_action 13:16:46 INFO - Running main action method: download_and_extract 13:16:46 INFO - mkdir: /builds/slave/test/build/tests 13:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:46 INFO - https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 13:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 13:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 13:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 13:16:47 INFO - Downloaded 1199 bytes. 13:16:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 13:16:47 INFO - Using the following test package requirements: 13:16:47 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 13:16:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 13:16:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 13:16:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'jsshell-mac.zip'], 13:16:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 13:16:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 13:16:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 13:16:47 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 13:16:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 13:16:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:16:47 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 13:16:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:47 INFO - https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:16:48 INFO - Downloaded 18124316 bytes. 13:16:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:16:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:16:51 INFO - Return code: 0 13:16:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:51 INFO - https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:16:52 INFO - Downloaded 18124316 bytes. 13:16:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:16:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:16:56 INFO - Return code: 0 13:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:56 INFO - https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:16:57 INFO - Downloaded 10840145 bytes. 13:16:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:16:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:16:57 INFO - Return code: 0 13:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:57 INFO - https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:16:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:16:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:16:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 13:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 13:17:01 INFO - Downloaded 110276504 bytes. 13:17:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:17:01 INFO - mkdir: /builds/slave/test/properties 13:17:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:01 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:01 INFO - Contents: 13:17:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:17:02 INFO - Running post-action listener: _resource_record_post_action 13:17:02 INFO - Running post-action listener: set_extra_try_arguments 13:17:02 INFO - ##### 13:17:02 INFO - ##### Running populate-webroot step. 13:17:02 INFO - ##### 13:17:02 INFO - Running pre-action listener: _resource_record_pre_action 13:17:02 INFO - Running main action method: populate_webroot 13:17:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:02 INFO - '--tppagecycles', 13:17:02 INFO - '7'], 13:17:02 INFO - 'tests': ['tsvgm']}}, 13:17:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['damp', 'tps']}, 13:17:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'tests': ['damp', 'tps']}, 13:17:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['dromaeo_dom']}, 13:17:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['a11yr', 13:17:02 INFO - 'ts_paint', 13:17:02 INFO - 'tpaint', 13:17:02 INFO - 'sessionrestore', 13:17:02 INFO - 'sessionrestore_no_auto_restore', 13:17:02 INFO - 'tabpaint']}, 13:17:02 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:02 INFO - 'ts_paint', 13:17:02 INFO - 'tpaint', 13:17:02 INFO - 'sessionrestore', 13:17:02 INFO - 'sessionrestore_no_auto_restore', 13:17:02 INFO - 'tabpaint']}, 13:17:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:02 INFO - 'ts_paint', 13:17:02 INFO - 'tpaint', 13:17:02 INFO - 'sessionrestore', 13:17:02 INFO - 'sessionrestore_no_auto_restore', 13:17:02 INFO - 'tabpaint']}, 13:17:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:02 INFO - 'ts_paint', 13:17:02 INFO - 'tpaint', 13:17:02 INFO - 'sessionrestore', 13:17:02 INFO - 'sessionrestore_no_auto_restore', 13:17:02 INFO - 'tabpaint']}, 13:17:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['a11yr', 13:17:02 INFO - 'ts_paint', 13:17:02 INFO - 'tpaint', 13:17:02 INFO - 'sessionrestore', 13:17:02 INFO - 'sessionrestore_no_auto_restore', 13:17:02 INFO - 'tabpaint']}, 13:17:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['a11yr', 13:17:02 INFO - 'ts_paint', 13:17:02 INFO - 'tpaint', 13:17:02 INFO - 'sessionrestore', 13:17:02 INFO - 'sessionrestore_no_auto_restore', 13:17:02 INFO - 'tabpaint']}, 13:17:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['tsvgx', 13:17:02 INFO - 'tsvgr_opacity', 13:17:02 INFO - 'tart', 13:17:02 INFO - 'tscrollx', 13:17:02 INFO - 'cart']}, 13:17:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:02 INFO - 'tsvgr_opacity', 13:17:02 INFO - 'tart', 13:17:02 INFO - 'tscrollx', 13:17:02 INFO - 'cart']}, 13:17:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'talos_options': ['--disable-e10s'], 13:17:02 INFO - 'tests': ['tp5o']}, 13:17:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'tests': ['tp5o']}, 13:17:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'talos_options': ['--disable-e10s', 13:17:02 INFO - '--xperf_path', 13:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:02 INFO - 'tests': ['tp5n']}, 13:17:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:02 INFO - 'talos_options': ['--xperf_path', 13:17:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:02 INFO - 'tests': ['tp5n']}}, 13:17:02 INFO - 'talos.zip': {'path': '', 13:17:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:02 INFO - Running post-action listener: _resource_record_post_action 13:17:02 INFO - ##### 13:17:02 INFO - ##### Running create-virtualenv step. 13:17:02 INFO - ##### 13:17:02 INFO - Running pre-action listener: _resource_record_pre_action 13:17:02 INFO - Running main action method: create_virtualenv 13:17:02 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:17:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:02 INFO - Using real prefix '/tools/python27' 13:17:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:02 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:05 INFO - Installing pip.................done. 13:17:05 INFO - Return code: 0 13:17:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:05 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:05 INFO - 'HOME': '/Users/cltbld', 13:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:05 INFO - 'LOGNAME': 'cltbld', 13:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:05 INFO - 'MOZ_NO_REMOTE': '1', 13:17:05 INFO - 'NO_EM_RESTART': '1', 13:17:05 INFO - 'PAGER': '/bin/cat', 13:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:05 INFO - 'PWD': '/builds/slave/test', 13:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:05 INFO - 'SHELL': '/bin/bash', 13:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:05 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:05 INFO - 'USER': 'cltbld', 13:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:05 INFO - 'XPC_FLAGS': '0x0', 13:17:05 INFO - 'XPC_SERVICE_NAME': '0', 13:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:17:06 INFO - Cleaning up... 13:17:06 INFO - Return code: 0 13:17:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:06 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:06 INFO - 'HOME': '/Users/cltbld', 13:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:06 INFO - 'LOGNAME': 'cltbld', 13:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:06 INFO - 'MOZ_NO_REMOTE': '1', 13:17:06 INFO - 'NO_EM_RESTART': '1', 13:17:06 INFO - 'PAGER': '/bin/cat', 13:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:06 INFO - 'PWD': '/builds/slave/test', 13:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:06 INFO - 'SHELL': '/bin/bash', 13:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:06 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:06 INFO - 'USER': 'cltbld', 13:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:06 INFO - 'XPC_FLAGS': '0x0', 13:17:06 INFO - 'XPC_SERVICE_NAME': '0', 13:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:06 INFO - Downloading/unpacking psutil>=0.7.1 13:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:09 INFO - Installing collected packages: psutil 13:17:09 INFO - Running setup.py install for psutil 13:17:09 INFO - building 'psutil._psutil_osx' extension 13:17:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:17:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:17:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:17:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:17:09 INFO - building 'psutil._psutil_posix' extension 13:17:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:17:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:17:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:17:09 INFO - ^ 13:17:09 INFO - 1 warning generated. 13:17:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:17:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:10 INFO - Successfully installed psutil 13:17:10 INFO - Cleaning up... 13:17:10 INFO - Return code: 0 13:17:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:10 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:17:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:10 INFO - 'HOME': '/Users/cltbld', 13:17:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:10 INFO - 'LOGNAME': 'cltbld', 13:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:10 INFO - 'MOZ_NO_REMOTE': '1', 13:17:10 INFO - 'NO_EM_RESTART': '1', 13:17:10 INFO - 'PAGER': '/bin/cat', 13:17:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:10 INFO - 'PWD': '/builds/slave/test', 13:17:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:10 INFO - 'SHELL': '/bin/bash', 13:17:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:10 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:10 INFO - 'USER': 'cltbld', 13:17:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:10 INFO - 'XPC_FLAGS': '0x0', 13:17:10 INFO - 'XPC_SERVICE_NAME': '0', 13:17:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:17:12 INFO - Installing collected packages: mozsystemmonitor 13:17:12 INFO - Running setup.py install for mozsystemmonitor 13:17:13 INFO - Successfully installed mozsystemmonitor 13:17:13 INFO - Cleaning up... 13:17:13 INFO - Return code: 0 13:17:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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', '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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17: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 blobuploader==1.2.4 13:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:13 INFO - 'HOME': '/Users/cltbld', 13:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:13 INFO - 'LOGNAME': 'cltbld', 13:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:13 INFO - 'MOZ_NO_REMOTE': '1', 13:17:13 INFO - 'NO_EM_RESTART': '1', 13:17:13 INFO - 'PAGER': '/bin/cat', 13:17:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:13 INFO - 'PWD': '/builds/slave/test', 13:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:13 INFO - 'SHELL': '/bin/bash', 13:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:13 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:13 INFO - 'USER': 'cltbld', 13:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:13 INFO - 'XPC_FLAGS': '0x0', 13:17:13 INFO - 'XPC_SERVICE_NAME': '0', 13:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:13 INFO - Downloading/unpacking blobuploader==1.2.4 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:15 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:16 INFO - Downloading docopt-0.6.1.tar.gz 13:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:17 INFO - Running setup.py install for blobuploader 13:17:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:17 INFO - Running setup.py install for requests 13:17:17 INFO - Running setup.py install for docopt 13:17:17 INFO - Successfully installed blobuploader requests docopt 13:17:17 INFO - Cleaning up... 13:17:17 INFO - Return code: 0 13:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:17 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:17 INFO - 'HOME': '/Users/cltbld', 13:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:17 INFO - 'LOGNAME': 'cltbld', 13:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:17 INFO - 'MOZ_NO_REMOTE': '1', 13:17:17 INFO - 'NO_EM_RESTART': '1', 13:17:17 INFO - 'PAGER': '/bin/cat', 13:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:17 INFO - 'PWD': '/builds/slave/test', 13:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:17 INFO - 'SHELL': '/bin/bash', 13:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:17 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:17 INFO - 'USER': 'cltbld', 13:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:17 INFO - 'XPC_FLAGS': '0x0', 13:17:17 INFO - 'XPC_SERVICE_NAME': '0', 13:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-o9BKUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-3KW4iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-KmpGM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-2Asbkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-v5AvLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-jicuvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ZeOCGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-xMDNr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:18 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-fSo99K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bquQvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-aF7DKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-BBoQ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Zd_z_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-oH7psk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-_iqGQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ReQtSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-4FmpBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:19 INFO - Running setup.py install for manifestparser 13:17:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:20 INFO - Running setup.py install for mozcrash 13:17:20 INFO - Running setup.py install for mozdebug 13:17:20 INFO - Running setup.py install for mozdevice 13:17:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:20 INFO - Running setup.py install for mozfile 13:17:20 INFO - Running setup.py install for mozhttpd 13:17:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:20 INFO - Running setup.py install for mozinfo 13:17:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:20 INFO - Running setup.py install for mozInstall 13:17:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Running setup.py install for mozleak 13:17:21 INFO - Running setup.py install for mozlog 13:17:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Running setup.py install for moznetwork 13:17:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Running setup.py install for mozprocess 13:17:21 INFO - Running setup.py install for mozprofile 13:17:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:21 INFO - Running setup.py install for mozrunner 13:17:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:22 INFO - Running setup.py install for mozscreenshot 13:17:22 INFO - Running setup.py install for moztest 13:17:22 INFO - Running setup.py install for mozversion 13:17:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:22 INFO - Cleaning up... 13:17:22 INFO - Return code: 0 13:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:22 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:22 INFO - 'HOME': '/Users/cltbld', 13:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:22 INFO - 'LOGNAME': 'cltbld', 13:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:22 INFO - 'MOZ_NO_REMOTE': '1', 13:17:22 INFO - 'NO_EM_RESTART': '1', 13:17:22 INFO - 'PAGER': '/bin/cat', 13:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:22 INFO - 'PWD': '/builds/slave/test', 13:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:22 INFO - 'SHELL': '/bin/bash', 13:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:22 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:22 INFO - 'USER': 'cltbld', 13:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:22 INFO - 'XPC_FLAGS': '0x0', 13:17:22 INFO - 'XPC_SERVICE_NAME': '0', 13:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-RdQ5OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-FF02C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:22 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-g0lc5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-i_WFNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ch54vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Kyw0eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-67RLEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-zU9XnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-rhyN_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-uJKihD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-miPF0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:23 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-QBM8xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ymP3dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-noX2Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-FVjytG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-dcosri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:24 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-0feHtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:26 INFO - Downloading blessings-1.6.tar.gz 13:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:26 INFO - Installing collected packages: blessings 13:17:26 INFO - Running setup.py install for blessings 13:17:27 INFO - Successfully installed blessings 13:17:27 INFO - Cleaning up... 13:17:27 INFO - Return code: 0 13:17:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:27 INFO - Reading from file tmpfile_stdout 13:17:27 INFO - Current package versions: 13:17:27 INFO - blessings == 1.6 13:17:27 INFO - blobuploader == 1.2.4 13:17:27 INFO - docopt == 0.6.1 13:17:27 INFO - manifestparser == 1.1 13:17:27 INFO - mozInstall == 1.12 13:17:27 INFO - mozcrash == 0.17 13:17:27 INFO - mozdebug == 0.1 13:17:27 INFO - mozdevice == 0.48 13:17:27 INFO - mozfile == 1.2 13:17:27 INFO - mozhttpd == 0.7 13:17:27 INFO - mozinfo == 0.9 13:17:27 INFO - mozleak == 0.1 13:17:27 INFO - mozlog == 3.1 13:17:27 INFO - moznetwork == 0.27 13:17:27 INFO - mozprocess == 0.22 13:17:27 INFO - mozprofile == 0.28 13:17:27 INFO - mozrunner == 6.11 13:17:27 INFO - mozscreenshot == 0.1 13:17:27 INFO - mozsystemmonitor == 0.0 13:17:27 INFO - moztest == 0.7 13:17:27 INFO - mozversion == 1.4 13:17:27 INFO - psutil == 3.1.1 13:17:27 INFO - requests == 1.2.3 13:17:27 INFO - wsgiref == 0.1.2 13:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:27 INFO - 'HOME': '/Users/cltbld', 13:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:27 INFO - 'LOGNAME': 'cltbld', 13:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:27 INFO - 'MOZ_NO_REMOTE': '1', 13:17:27 INFO - 'NO_EM_RESTART': '1', 13:17:27 INFO - 'PAGER': '/bin/cat', 13:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:27 INFO - 'PWD': '/builds/slave/test', 13:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:27 INFO - 'SHELL': '/bin/bash', 13:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:27 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:27 INFO - 'USER': 'cltbld', 13:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:27 INFO - 'XPC_FLAGS': '0x0', 13:17:27 INFO - 'XPC_SERVICE_NAME': '0', 13:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:17:27 INFO - Cleaning up... 13:17:27 INFO - Return code: 0 13:17:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:27 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:27 INFO - 'HOME': '/Users/cltbld', 13:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:27 INFO - 'LOGNAME': 'cltbld', 13:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:27 INFO - 'MOZ_NO_REMOTE': '1', 13:17:27 INFO - 'NO_EM_RESTART': '1', 13:17:27 INFO - 'PAGER': '/bin/cat', 13:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:27 INFO - 'PWD': '/builds/slave/test', 13:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:27 INFO - 'SHELL': '/bin/bash', 13:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:27 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:27 INFO - 'USER': 'cltbld', 13:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:27 INFO - 'XPC_FLAGS': '0x0', 13:17:27 INFO - 'XPC_SERVICE_NAME': '0', 13:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:28 INFO - Downloading/unpacking jsonschema 13:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:30 INFO - Downloading/unpacking functools32 (from jsonschema) 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:30 INFO - warning: no files found matching '*.txt' 13:17:30 INFO - no previously-included directories found matching 'build' 13:17:30 INFO - no previously-included directories found matching 'dist' 13:17:30 INFO - no previously-included directories found matching '.git*' 13:17:30 INFO - Installing collected packages: jsonschema, functools32 13:17:30 INFO - Running setup.py install for functools32 13:17:31 INFO - warning: no files found matching '*.txt' 13:17:31 INFO - no previously-included directories found matching 'build' 13:17:31 INFO - no previously-included directories found matching 'dist' 13:17:31 INFO - no previously-included directories found matching '.git*' 13:17:31 INFO - Successfully installed jsonschema functools32 13:17:31 INFO - Cleaning up... 13:17:31 INFO - Return code: 0 13:17:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:31 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 0x101398a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8693576440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, '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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:31 INFO - 'HOME': '/Users/cltbld', 13:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:31 INFO - 'LOGNAME': 'cltbld', 13:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:31 INFO - 'MOZ_NO_REMOTE': '1', 13:17:31 INFO - 'NO_EM_RESTART': '1', 13:17:31 INFO - 'PAGER': '/bin/cat', 13:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:31 INFO - 'PWD': '/builds/slave/test', 13:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:31 INFO - 'SHELL': '/bin/bash', 13:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:17:31 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:31 INFO - 'USER': 'cltbld', 13:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:31 INFO - 'XPC_FLAGS': '0x0', 13:17:31 INFO - 'XPC_SERVICE_NAME': '0', 13:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:31 INFO - Downloading/unpacking flake8 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:17:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:17:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:17:35 INFO - no previously-included directories found matching 'docs/_build' 13:17:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:17:35 INFO - Running setup.py install for pep8 13:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:17:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:17:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:17:35 INFO - no previously-included directories found matching 'docs/_build' 13:17:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:17:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:17:35 INFO - Cleaning up... 13:17:35 INFO - Return code: 0 13:17:35 INFO - Running post-action listener: _resource_record_post_action 13:17:35 INFO - Running post-action listener: _start_resource_monitoring 13:17:35 INFO - Starting resource monitoring. 13:17:35 INFO - ##### 13:17:35 INFO - ##### Running install step. 13:17:35 INFO - ##### 13:17:35 INFO - Running pre-action listener: _resource_record_pre_action 13:17:35 INFO - Running main action method: install 13:17:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:35 INFO - Reading from file tmpfile_stdout 13:17:35 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:35 INFO - Reading from file tmpfile_stdout 13:17:35 INFO - Output received: 13:17:35 INFO - Usage: mozinstall [options] installer 13:17:35 INFO - Options: 13:17:35 INFO - -h, --help show this help message and exit 13:17:35 INFO - -d DEST, --destination=DEST 13:17:35 INFO - Directory to install application into. [default: 13:17:35 INFO - "/builds/slave/test"] 13:17:35 INFO - --app=APP Application being installed. [default: firefox] 13:17:35 INFO - mkdir: /builds/slave/test/build/application 13:17:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:18:09 INFO - Reading from file tmpfile_stdout 13:18:09 INFO - Output received: 13:18:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:18:09 INFO - Running post-action listener: _resource_record_post_action 13:18:09 INFO - ##### 13:18:09 INFO - ##### Running run-tests step. 13:18:09 INFO - ##### 13:18:09 INFO - Running pre-action listener: _resource_record_pre_action 13:18:09 INFO - Running main action method: run_tests 13:18:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:09 INFO - 2016-04-29 13:18:09.344 screenresolution[2065:11862] starting screenresolution argv=screenresolution get 13:18:09 INFO - 2016-04-29 13:18:09.347 screenresolution[2065:11862] Display 0: 1600x1200x32@60 13:18:09 INFO - 2016-04-29 13:18:09.353 screenresolution[2066:11864] starting screenresolution argv=screenresolution list 13:18:09 INFO - Available Modes on Display 0 13:18:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:09 INFO - Intel Iris: 13:18:09 INFO - Chipset Model: Intel Iris 13:18:09 INFO - Type: GPU 13:18:09 INFO - Bus: Built-In 13:18:09 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:09 INFO - Vendor: Intel (0x8086) 13:18:09 INFO - Device ID: 0x0a2e 13:18:09 INFO - Revision ID: 0x0009 13:18:09 INFO - Displays: 13:18:09 INFO - Display: 13:18:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:09 INFO - Display Serial Number: 1600x1200 60 13:18:09 INFO - Main Display: Yes 13:18:09 INFO - Mirror: Off 13:18:09 INFO - Online: Yes 13:18:09 INFO - Rotation: Supported 13:18:09 INFO - Return code: 0 13:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:09 INFO - Python 2.7.3 13:18:09 INFO - Return code: 0 13:18:09 INFO - grabbing minidump binary from tooltool 13:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:09 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 0x101237e00>, '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 0x1010a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101232b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:18:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:18:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:09 INFO - Return code: 0 13:18:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:18:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:18:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:18:10 INFO - Return code: 0 13:18:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:18:10 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:18:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m1sRWuFM1F/Render', 13:18:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:10 INFO - 'HOME': '/Users/cltbld', 13:18:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:10 INFO - 'LOGNAME': 'cltbld', 13:18:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:10 INFO - 'MOZ_NO_REMOTE': '1', 13:18:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:10 INFO - 'NO_EM_RESTART': '1', 13:18:10 INFO - 'PAGER': '/bin/cat', 13:18:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:10 INFO - 'PWD': '/builds/slave/test', 13:18:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:10 INFO - 'SHELL': '/bin/bash', 13:18:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sB5Ew2Fcgw/Listeners', 13:18:10 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 13:18:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:10 INFO - 'USER': 'cltbld', 13:18:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:10 INFO - 'XPC_FLAGS': '0x0', 13:18:10 INFO - 'XPC_SERVICE_NAME': '0', 13:18:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:18:10 INFO - mozversion application_buildid: 20160429104432 13:18:10 INFO - mozversion application_changeset: cd2ec0f3b56126297a852cebc67cc5443f670593 13:18:10 INFO - mozversion application_display_name: Nightly 13:18:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:10 INFO - mozversion application_name: Firefox 13:18:10 INFO - mozversion application_remotingname: firefox 13:18:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:18:10 INFO - mozversion application_vendor: Mozilla 13:18:10 INFO - mozversion application_version: 49.0a1 13:18:10 INFO - mozversion platform_buildid: 20160429104432 13:18:10 INFO - mozversion platform_changeset: cd2ec0f3b56126297a852cebc67cc5443f670593 13:18:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:18:10 INFO - mozversion platform_version: 49.0a1 13:18:10 INFO - using testdate: 1461961090 13:18:10 INFO - actual date: 1461961090 13:18:10 INFO - starting webserver on 'localhost:49364' 13:18:10 INFO - SUITE-START | Running 2 tests 13:18:10 INFO - TEST-START | dromaeo_css 13:18:10 INFO - operating with platform_type : mac_ 13:18:10 INFO - Initialising browser for dromaeo_css test... 13:18:11 INFO - TEST-INFO | started process 2084 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpAvHFZq/profile http://localhost:49364/getInfo.html) 13:18:14 INFO - PROCESS | 2084 | __metrics Screen width/height:1600/1200 13:18:14 INFO - PROCESS | 2084 | colorDepth:24 13:18:14 INFO - PROCESS | 2084 | Browser inner width/height: 1024/689 13:18:14 INFO - PROCESS | 2084 | __metrics 13:18:14 ERROR - PROCESS | 2084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:18:14 INFO - TEST-INFO | 2084: exit 0 13:18:14 INFO - Browser initialized. 13:18:14 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:14 INFO - TEST-INFO | started process 2088 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpAvHFZq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:26 INFO - PROCESS | 2088 | RSS: Main: 249606144 13:18:26 INFO - PROCESS | 2088 | 13:19:16 INFO - PROCESS | 2088 | 1461961156660 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:21:26 INFO - PROCESS | 2088 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49364/tests/dromaeo/cssquery-ext.html) 13:21:28 INFO - PROCESS | 2088 | RSS: Main: 261828608 13:21:28 INFO - PROCESS | 2088 | 13:24:30 INFO - PROCESS | 2088 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-ext.html (next: http://localhost:49364/tests/dromaeo/cssquery-jquery.html) 13:24:31 INFO - PROCESS | 2088 | RSS: Main: 273444864 13:24:31 INFO - PROCESS | 2088 | 13:27:32 INFO - PROCESS | 2088 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49364/tests/dromaeo/cssquery-mootools.html) 13:27:33 INFO - PROCESS | 2088 | RSS: Main: 275320832 13:27:33 INFO - PROCESS | 2088 | 13:30:35 INFO - PROCESS | 2088 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49364/tests/dromaeo/cssquery-prototype.html) 13:30:35 INFO - PROCESS | 2088 | RSS: Main: 277393408 13:30:35 INFO - PROCESS | 2088 | 13:33:38 INFO - PROCESS | 2088 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49364/tests/dromaeo/cssquery-yui.html) 13:33:39 INFO - PROCESS | 2088 | RSS: Main: 279949312 13:33:39 INFO - PROCESS | 2088 | 13:36:41 INFO - PROCESS | 2088 | Cycle 1(1): loaded http://localhost:49364/tests/dromaeo/cssquery-yui.html (next: http://localhost:49364/tests/dromaeo/cssquery-dojo.html) 13:36:42 INFO - PROCESS | 2088 | RSS: Main: 280780800 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | __start_tp_report 13:36:42 INFO - PROCESS | 2088 | _x_x_mozilla_page_load 13:36:42 INFO - PROCESS | 2088 | _x_x_mozilla_page_load_details 13:36:42 INFO - PROCESS | 2088 | |i|pagename|runs| 13:36:42 INFO - PROCESS | 2088 | |0;dojo.html;2848.9572656410155;3435.5533780608525;3459.308138372326;3467.4625433057886;3516.085817687402;5619.4380561943735;5785.103308987103;5816.069428891373;5836.299644042716;5867.7066146692705;5789.768409263635;5814.738336774844;5827.621204621697;5872.17789509469;5977.671228082454;5270.077736396125;5295;5333.599980001496;5336.439673834249;5368.785248590052;187.29324771356292;5277.234800953859;5316.149416093426;5320.441353657869;5395.514403703666;5255.737213139328;5258.237555554461;5310.867228319285;5311.57507399409;5319.5744340452675;5250.44870288618;5334.626576139672;5335.1197052486295;5352.545033672142;5407.810726624549;5241.213817927303;5261.710605916673;5302.390225124083;5317.973410132963;5340.973295133499;5348.973255133699;5673.6879471629045;5704.258446401983;5737.913931291034;5773.971130144364;6121.143039974407;6200.81397558074;6271.874562508724;6275.24697036354;6281.497480201619;6197.535184861108;6262.248530176408;6279.6860156992425;6282.96858515709;6300.59046161998;5912.260967379078;5919.674417907014;5938.732757025944;5955.553333499962;5990.820275391745;6176.66028368435;6255.311915689362;6261.186045814015;6305.022721478178;6317.020861766434;6155.692215389213;6176.073588961692;6232.189815323979;6250.4374606285655;6250.843728906722;6237.4698150656795;6267.4986001119805;6280.309165991737;6281.811545653638;6284.622922624657;6122.479589234876;6176.135341052256;6253.312135665074;6274.341194174637;6288.5598008138995;6133.4264757247465;6192.164057852222;6263.279722831932;6269.153664255358;6277.811665649946;3740.6259374062374;4996.550310472075;4997.525235102659;4998.9500104999215;5041.7227052511735;4388.4733831940375;4415.955840441618;4468.843590474317;4488.371627972087;4516.1419330327135;5464.808731694372;5831.475167234969;5866.970665146647;5899.380565040695;5962.910556341659;5729.914051289234;6211.534134939898;6220.471259942865;6239.625622462667;6275.246970363494;4930.630202734809;5429.728513574306;5866.061430171152;5872.500837428781;6011.9699401503585;5475.7262136893;5476.479734425223;5476.863078423071;5476.890462190734;5479.75341109651;5347.598930080259;6363.427291543783;6368.172137622079;6375.330590287953;6406.23125224976;6145.016797312409;6164.951958167033;6238.469730072995;6256.937430625636;6260;5299.33758280215;6323.525735569942;6355.491560675227;6380.361963803768;6392.9360706392345;6101.671357587221;6212.844678883064;6253.530985176221;6261.68691565429;6284.402981716729;6163.907541386972;6202.317745047951;6219.036049412348;6229.283632382334;6256.280527739186;5302.3637163540625;5675.829725108253;6230.657313847601;6231.40801623845;6241.719122639402;6082.635041897501;6136.23297087864;6218.31598524171;6244.68776561161;6251.468625166912;4422.1155768847;5562;5740.425957404394;5956.910646340395;6099.573029887865;5107.438181800073;6141.6007959482495;6237.719302631302;6246.437820596168;6257.061440783918;5973.462388385066;6097.7865774697675;6118.051701986199;6132.141500189888;6156.476699480594 13:36:42 INFO - PROCESS | 2088 | |1;ext.html;495.2274451855104;537.6182910133805;544.2842661899601;568.9687067211302;586.0242695911306;35779;39494.60505394945;39534.80232598833;39566;39587.2082558349;40680.18639627206;41513;41522.58477415225;41528;41714;9357.859632105525;9462.526873656325;9468.621255149787;9614.519274036305;9629.470379129145;9522.476263805487;9742.659006934759;9759.975202603731;9765;9777;9732.610695572168;9767.706968790948;9805.754856128618;9806.11744942955;9828.164606008499;9671.274654400948;9687.75780605487;9762.609495620167;9786.853197202048;9803.362781419184;9582.377145485521;9714.757131071708;9724.951375243149;9726.367786093952;9728.075832795874;39511.40732889009;39840.40239396411;40164.79917600423;40365;40460;2809.9719002809916;2826.2792987787984;3149.7165255127147;3191.69678880506;3436.1066122808;22894.542109157723;27879.442411151867;27881.442371152465;27901.023464178656;28719.425611487863;2707.878145483458;2737.083077169151;2755.655543057118;2881.0408921933076;2966.5550167474835;387281;389941.99999999715;390458;390480;390769;54589;66197.33802661912;66288.6685566569;66354.00468992969;66391;53984;62006.75986480335;63704.04443933345;63902.36097638964;64223.35776642267;17189.398371056952;17244.827551724324;17389.130543472776;17448.563785905455;17474.126293685265;13043.086983911226;13205.20768753878;13248.668783280302;13273.269970151541;13288.468461261442;19883.005849707457;20145;20264.594708105757;20290.594188116156;20497.38507844767;8395.118512556215;8552.273056790118;8563.272121869586;8604.440711353742;8638.136186381438;928.1553786054658;976.3507267667064;998.5221871630029;1029.7785976015043;1110.5835311758092;28776.568351474743;29872;30228.274488466788;30520.084397468112;30559.694403056128;1143.6054561176381;1159.605734050427;1175.535663412947;1189.7977343851567;1210.958575624962;15259.542213733606;15752.212389380486;15800.525984220492;15836.445724399591;15896.284667190004;239603.4059489109;301048;301076;301173;633696;62605.747885042954;62945;63168.68415657892;63256.36743632597;63341.68329158325;1262.3940508555945;1460.627539977299;1492.4701730885379;1499.9775003374957;1500.7523758579712;30111.548326775555;30197.943071992373;30423.239419014702;30507.38985220239;30540.847295764266;55691.88616227734;55868;56160;56215;56367;573585;575879;576688;577252;578300;26677;27589.448211035266;27677.892884284403;27695;27953.301167470974;47554.76222618865;47941;48202.75898620485;48794;49011.75494122507;37364.43953340757;38547.614523854405;38916;39162.412563811;39358.409623856234;37548.06129846776;37821.810890945366;38034.23931521299;38679;38680.8395748128;33086.50370244496;38263.234735304584;38297.23405531929;38670.6132938667;38938;25740.099096531532;30981.690183097882;31119;31318;31351.372972540878;20833.374998750063;24141.034358626162;24200.757992420557;24446.388840279134;24481.143159990028 13:36:42 INFO - PROCESS | 2088 | |2;jquery.html;397.5448111911861;400.34543521342596;403.2298310227466;405.57414714549725;410.3352568838482;14636.853631463682;15333.693326133485;20551.48621284467;20588.69116963243;20598.691019634698;16739.995600263963;18313.816861831412;20220.191192352326;20581.897090514565;21064.946752662345;5030.270610761438;5107.923381149277;5853.414658534155;6187.4431301182885;6234.470070044052;6041.909371359433;6053.51571874249;6151.138840562325;6152.354002829706;6181.289151747562;5691.544676425897;6021.909671354933;6025.307089684698;6057.51539876811;6142.109394137848;5988.461038506533;6046.909296360558;6206.162168107293;6803.115594972672;6812.420944219747;5866.794662186846;5990.790322338741;5991.161237426763;5991.191189189447;6004.279486461609;13930.512432064828;14923.477678281208;20402.28591999288;26075.740532433447;26102.086426974965;2088.1229883448987;2187.1907394264067;2214.900329485161;2304.976950230493;2349.847259928099;9760.804783904354;10768.838467422995;13838.377273022637;15216;15469.071855688695;1799.9280028798833;1960.980390196094;1994.4216177308563;2064.5251592133745;2091.26805618034;135495;136046.3197684015;136796;143774.56225437718;148621.28446788917;18715.812841871408;20655.58688826215;21442.892785535973;22432.551348972927;23307.83460826986;35937.64062359395;35950.280994379966;35984;36037.27925441477;36249.45625815615;9445.244380449547;10031.898393374453;11276.548938042386;11494.597689081009;11536.192466527262;7706.460547761603;9250.72247832566;9261.907380926239;9278.164965153168;9318.254539636948;10033.648822291185;10152.187824973984;10190.337628054152;10290.536925838354;10333.896661033294;3557.3063252665997;3871.8644847430205;3973.8609148679657;4046.817893194813;4079.306517891906;910.9453432794054;988.3081842709988;1000.9299349045497;1025.5385076715509;1025.6564051042835;16005;18076.734628576138;20047.298344557872;21673.67489487659;22079.227227047297;931.1386967055447;958.9808203835884;980.2501086668705;982.5382070426888;1038.766277587552;9589.136977672042;11223;11333.320000799979;11349.489272982735;11429.314241145557;576129;594166;596882;610519;613157;97745;116834.41582792031;117632;124143;141313.29343353218;944.3248077624669;991.306085739985;1053.510117795229;1058.5501162006117;1059.5391004912733;17698.646027079645;18691.887784687347;18895.244190232235;19541.413757587296;19772.50568735793;40149.397759033054;46948;52310.95378092341;52532.737336313076;53342.466575335304;61478.770424590366;77690.6115469419;77874;78064.21935780796;78090.2190978083;5416.729163541729;5944.167816505779;7148.749793757402;7854.3323817473865;8719.21256142502;11478.598249061242;12034.277943323428;12775.297358644992;12896.613101606967;13110.803337950128;10348.016938390841;10787.406692631981;11135.33188008722;11513.251638643462;11539.596114135966;10785.40680262593;11140.733961382179;11291.830622540505;11309;11547.422628868691;11122.109241429138;11421.714457138638;11584.536618535165;11719.296842189497;11724.589639362923;8243.83512329738;8269.25576698076;8407.159284071544;8437.029741579798;8666.046734859034;10795.56817727282;11054.668359949215;11172.664820055412;11352;11478.88521114778 13:36:42 INFO - PROCESS | 2088 | |3;mootools.html;1345.7443085813695;1492.2613306413323;1726.4820553833854;1739.9739003914935;1935.2742721479444;8045.356371490281;8107.391945604074;8630.611622476988;8698.478091314526;8995.10048995101;8650.134986501347;8745.4752714837;8840.911590884089;8849.823003539925;8867.246284065863;2432.635104734291;2465.4452748131616;2468.617364308535;2472.554940110779;2479.38015496126;2227.6967973735386;2308;2455.963160552584;2471.4192164841247;2473.109680515013;2443.0838435586656;2455.8649274289905;2456.815738819587;2480.8139389545854;2481.8262721609494;2419.9153029643967;2430.4895971845935;2439.377958620549;2448.033026954361;2459.754024597553;2433.4281443860677;2434.6469761884605;2438.6951631046118;2471.938201544958;2472.83926544774;8831.867521987175;8860.778480537974;8933.59798809055;8958.41770284936;8966.596503157374;5356.866078348073;5552.500274975271;5591.189277554772;5594.720263986785;5604.887902241932;3184.092533627928;3588.802615856127;3612.5664920209742;3614.8734794282336;3622.094476380905;1037.4086770540796;1055.7835643693024;1063.840423936408;1064.5369264369947;1083.6911480228098;11664.416779161009;11681.532738690443;11683.948444639938;11757.00065494434;11787.05703543723;4092.6725861930972;4885.877853053631;4990.426100998359;5013.724245166478;5077.26379674945;9721.513924303756;9972.950135249277;9973.850392244121;9983.251256155818;10012.949935250277;4426;5249.448807875195;5261.289725887033;5290.7354632269;5331.786728530893;4476.574725401082;4838.250071238893;4934.950650493521;5001.89996200074;5033.245013248042;4029.294873397144;4036.4752582164133;4076.510818701775;4165.875023749292;4176.749395036308;1183.8046722290726;1385.5635474825397;1399.4682020832222;1402.2848347342929;1416.8795652369663;864.1703964194444;879.4503435352905;883.8541640629353;895.4448242089946;969.7284760267137;5862.472377486047;5879.853003674943;6018.187544681412;6034.39656034393;6185.783497577563;407.2526913114468;459.60473992366536;479.92321228603254;482.6766066735296;483.54305181603047;3857.2256761889284;4002.659773919191;4011.538673052578;4065.5121385433936;4113.814878330482;10432.956704329657;10857.077148442313;10955.233133680566;10984;10995.010449059622;10776.407297598707;10810.135189184846;10850.565977360817;10896.400697961688;10960.177986651033;7657.310842024244;8211.917880821115;8243.464174828618;8266.710665126691;8276.8344633107;5781.277340332458;5886.793962211302;5939.643621382731;5953.1367951647635;5997.790077347272;9209.861852072358;10046.146077583195;10056.245781566266;10081.949590252296;10140.847887281845;9046.321525885453;9813.165880900204;10049.045340692623;10087;10289.691309260734;6805.65971701403;7208.35124838767;7491.587962662106;7520.924790752022;7542.321191092828;8252.21603947624;8289.461185022954;8350.540720260444;8369.581520924052;8377.70678026266;7252.311030452099;7352.191258961403;7392;7498.550086994798;7554.055743032121;7210.170830354366;7236.565806051443;7307.926920730724;7326.7435639754485;7378.520396174232;6895.827604309932;6920.7231710731;6942.930570694431;6943.51395402317;7059.047028651066;4827.61379089679;4890.92663610039;4951.356323677899;5030.673006254582;5180.7409629517615;4866.756662166948;4914.533119353656;4963.726995015309;5008.474110218374;5174.275601415729 13:36:42 INFO - PROCESS | 2088 | |4;prototype.html;275.3350658160542;308.46327390340815;325.27950589444384;325.42562377403874;325.8468519795695;5127.7180704823795;5637.746301416436;5658.349289831671;5744.9138262926035;5772.191893134965;5720.9713951430285;5727.169560413738;5731.570132240088;5748.281464816898;5754.280714910637;4346.261135606938;4361.5824856921545;4364.67264955128;4376.759278239696;4382.276924307502;4028.5568587455355;4310.288802347609;4332.06860524987;4377.956220437803;4382.5398333175035;3577.606463289036;3721.6836568891677;4234.428352172464;4281.186574550826;4304;3503.544539209912;3593.825735430053;4247.808848601805;4297.247981603223;4315.611594956469;3619.7071842692358;3689.114612493009;3711.886434069795;3724.255148970217;3727.310447567209;5000.62495312853;5297.629165958385;5485.6982865942355;5505.880236109127;5511.366192887829;4126.752394856288;4397.780110994438;4539.273716205391;4651.837040739815;4913.189323761575;5152.124138896396;5416.404195538487;5678.971605141948;5991.3109992351;6009.849753756147;3271.2803183299634;3576.9642303576893;3613.981930090359;3882.7476214045996;4018.6584140348104;6278.529110316699;6287.271000474861;6361.8409539761415;6366.204224471941;6376.7130479128555;3621.7102631789394;3636.581793093775;4067.206894655573;4077.7553346798695;4086.5504794472586;3719.1631882826687;4170.332746760504;4180.059486615548;4185;4188.6230239278;4481.4174157359985;4870.196417591058;4880.194767863263;4883.780229889663;4895.167821470359;5372.952274306473;5388.225064091996;5903.498202652822;6028.969855150696;6074.119252708421;1325.6420766393212;1499.257867355666;1515.6059424549696;1519.620094976256;1523.2536057331827;871.3421366867974;940.697134468752;977.0620204603518;991.7520619845038;996.7707427291764;5405.270288511079;5736.254286942671;6045;6093.512518998469;6135.84660383494;6393.328700486382;6747.730090796314;6770.1537307836525;6814.318568143146;6823.897641535381;5168.767405466763;5400.028989418834;5748.281464816898;5786.7558474927255;5968.283805943228;2824.2515733330683;3268.3299923515624;3478.7912725236565;3513.543239378864;3577.9105522362147;6435.549511534147;6614.8346291343105;6667.933320666732;7036.437085033287;7056.541324813973;6528.934710652928;6820.795376138723;6927.307269273032;6933.93066069343;6954.756583519553;5940.940590594125;6498.805035848932;6640.402363787186;7004.859902802017;7055;5666.546676265806;5847.795327163529;5941.91087133702;6352.142460767737;6632.403083722488;6600.151957451922;6624.867502650017;6637.800865974028;6655.833604159935;6670.7665231716655;6011.573403160157;6196.605763703131;6568.80293591193;6588.670566471753;6604.801855944329;3570.482280069323;3695.8336874841234;3914.6085391460624;4154.646855017358;4159.230542349675;5180.6891586504935;5820.679862607597;6257.937420625735;6281.246250449975;6339.936600634119;5362.544183744425;6102.38976102404;6134.325224225421;6161.876762464815;6176.474999625082;6120.846978825565;6124.285200143967;6150.569460137747;6164.660943648142;6175.258968923578;5046.899062018812;5565.916511252253;5956.463918247378;5975.282966044103;6008.759649614141;4808.711477311373;5157.871053223699;6008.068749343859;6083.574149809471;6117.877642447215;5578.30271216098;5690.83337915718;5883.794067207627;5910.556708246984;5962.16529685853 13:36:42 INFO - PROCESS | 2088 | |5;yui.html;667.3193342790353;709.8189961559805;730.8246020954969;734.2840730287968;792.0811858244438;16449.50651480456;16897.577560560992;17123.74314385285;17164.14179291035;17164.999999999985;15658.217089145526;15681.843181568182;15772.842271577281;15909.363625454997;15925.203739813021;738.9371903388219;890.536920801183;894.6376717429451;901.2294488212582;932.8787257656495;906.60109551797;917.6375331743957;924.996378928863;925.4077390470104;926.073926073926;944.9433034017981;966.6036924860808;971.621067783565;971.7473456901186;971.9902800972006;912.32943786317;913.3332667152949;958.0228167269381;962.8157366439284;971.9076687714655;678.253920687245;704.485725420446;704.9118860142482;707.6391040569347;719.2016861283971;15013.174275414847;15034;15038.924805376013;15223.695526089527;15263.465778697693;12245.571405000872;12357.196782209128;12376.381180940916;12399.13206075575;12627.368631568477;9791.118799308026;9912.950435247849;10083.19334453242;10414.79170416595;10561.102306303974;3247.236899328656;3423.1955490459723;3438.9656103438897;3503.1417302760988;3553.9466907996402;53961.65095872634;62443;67514.98727519091;72614.99999999948;82903;8250.834983300421;9199.954000229956;9343.34596578233;9355.29835262358;9482.19401350893;17132.914335428242;19765.901170494057;20319.4920126998;20398.490037748878;20522.794772052388;7288.526245794006;7328.926710732824;7385.556866588022;7462.925370746331;7500.249975002565;3930.9213815723524;3972.960270397259;4076.103257283393;4090.1001779608437;4117.814698338582;3578.7673801202836;3626.4560315952817;3657.213699054663;3658.341498530237;3666.4866918631415;520.7058012223082;613.9938600614026;616.2881871438406;649.6199723162003;655.6819942327967;550.8430097422296;574.9971250143723;581.8225441240378;596.2844586496221;598.4404581716109;8062.072861620872;8148.651396210326;8183.95908020456;8197.79505512367;8226.876596851052;469.29371296199685;528.5850607273348;595.1192235491496;595.4789559135756;596.2963702830615;2930.5457654063653;3205.3909757146066;3465.8267086645565;3858.6141385861188;4048.817803198804;91978;94390.52804735933;96593;97830.51084744673;98743.50628246812;75878;77903;79653.20346796457;80290;80438.79341809878;59867;64493.99999999906;67160;70197;71355;7340.265973402617;7734.806629834299;8200.630971606412;8225.177482251727;8270.214329638675;37187.442188367735;38757.837264882095;40416.79791601023;40988.79505602453;44574;60334;60472;60911.39088609235;60921;61067.38932610617;10937.726556836144;11061.61284355076;11123.888761112285;11385.658430247106;11582.536698532302;11925.284482931052;11982.400879956142;12132.757344852876;12135.817962730389;12194.57318993831;11480.885191148316;11620.535178592761;11655.941720291345;11703.122265829927;11874.050075994073;11191.216614836883;11362.829557556477;11700.414979250832;11730.296182228753;11732.354720490113;10994.450277486254;11267.7746445069;11443.885561144281;11651.53393864236;12282.894539491132;9574.760630984281;9824.65613703517;10066.899331006596;10153;10344.482775861328;9497.335186536877;9806.215502759906;9878.703638890845;9906.405615663083;9929.503524823875 13:36:42 INFO - PROCESS | 2088 | __end_tp_report 13:36:42 INFO - PROCESS | 2088 | __start_cc_report 13:36:42 INFO - PROCESS | 2088 | _x_x_mozilla_cycle_collect,415 13:36:42 INFO - PROCESS | 2088 | __end_cc_report 13:36:42 INFO - PROCESS | 2088 | __startTimestamp1461962202112__endTimestamp 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | ------- Summary: start ------- 13:36:42 INFO - PROCESS | 2088 | Number of tests: 6 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | [#0] dojo.html Cycles:165 Average:5721.38 Median:5973.46 stddev:793.33 (13.3%) stddev-sans-first:763.09 13:36:42 INFO - PROCESS | 2088 | Values: 2849.0 3435.6 3459.3 3467.5 3516.1 5619.4 5785.1 5816.1 5836.3 5867.7 5789.8 5814.7 5827.6 5872.2 5977.7 5270.1 5295.0 5333.6 5336.4 5368.8 187.3 5277.2 5316.1 5320.4 5395.5 5255.7 5258.2 5310.9 5311.6 5319.6 5250.4 5334.6 5335.1 5352.5 5407.8 5241.2 5261.7 5302.4 5318.0 5341.0 5349.0 5673.7 5704.3 5737.9 5774.0 6121.1 6200.8 6271.9 6275.2 6281.5 6197.5 6262.2 6279.7 6283.0 6300.6 5912.3 5919.7 5938.7 5955.6 5990.8 6176.7 6255.3 6261.2 6305.0 6317.0 6155.7 6176.1 6232.2 6250.4 6250.8 6237.5 6267.5 6280.3 6281.8 6284.6 6122.5 6176.1 6253.3 6274.3 6288.6 6133.4 6192.2 6263.3 6269.2 6277.8 3740.6 4996.6 4997.5 4999.0 5041.7 4388.5 4416.0 4468.8 4488.4 4516.1 5464.8 5831.5 5867.0 5899.4 5962.9 5729.9 6211.5 6220.5 6239.6 6275.2 4930.6 5429.7 5866.1 5872.5 6012.0 5475.7 5476.5 5476.9 5476.9 5479.8 5347.6 6363.4 6368.2 6375.3 6406.2 6145.0 6165.0 6238.5 6256.9 6260.0 5299.3 6323.5 6355.5 6380.4 6392.9 6101.7 6212.8 6253.5 6261.7 6284.4 6163.9 6202.3 6219.0 6229.3 6256.3 5302.4 5675.8 6230.7 6231.4 6241.7 6082.6 6136.2 6218.3 6244.7 6251.5 4422.1 5562.0 5740.4 5956.9 6099.6 5107.4 6141.6 6237.7 6246.4 6257.1 5973.5 6097.8 6118.1 6132.1 6156.5 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | [#1] ext.html Cycles:180 Average:59753.27 Median:214440.00 stddev:122223.47 (57.0%) stddev-sans-first:122485.36 13:36:42 INFO - PROCESS | 2088 | Values: 495.2 537.6 544.3 569.0 586.0 35779.0 39494.6 39534.8 39566.0 39587.2 40680.2 41513.0 41522.6 41528.0 41714.0 9357.9 9462.5 9468.6 9614.5 9629.5 9522.5 9742.7 9760.0 9765.0 9777.0 9732.6 9767.7 9805.8 9806.1 9828.2 9671.3 9687.8 9762.6 9786.9 9803.4 9582.4 9714.8 9725.0 9726.4 9728.1 39511.4 39840.4 40164.8 40365.0 40460.0 2810.0 2826.3 3149.7 3191.7 3436.1 22894.5 27879.4 27881.4 27901.0 28719.4 2707.9 2737.1 2755.7 2881.0 2966.6 387281.0 389942.0 390458.0 390480.0 390769.0 54589.0 66197.3 66288.7 66354.0 66391.0 53984.0 62006.8 63704.0 63902.4 64223.4 17189.4 17244.8 17389.1 17448.6 17474.1 13043.1 13205.2 13248.7 13273.3 13288.5 19883.0 20145.0 20264.6 20290.6 20497.4 8395.1 8552.3 8563.3 8604.4 8638.1 928.2 976.4 998.5 1029.8 1110.6 28776.6 29872.0 30228.3 30520.1 30559.7 1143.6 1159.6 1175.5 1189.8 1211.0 15259.5 15752.2 15800.5 15836.4 15896.3 239603.4 301048.0 301076.0 301173.0 633696.0 62605.7 62945.0 63168.7 63256.4 63341.7 1262.4 1460.6 1492.5 1500.0 1500.8 30111.5 30197.9 30423.2 30507.4 30540.8 55691.9 55868.0 56160.0 56215.0 56367.0 573585.0 575879.0 576688.0 577252.0 578300.0 26677.0 27589.4 27677.9 27695.0 27953.3 47554.8 47941.0 48202.8 48794.0 49011.8 37364.4 38547.6 38916.0 39162.4 39358.4 37548.1 37821.8 38034.2 38679.0 38680.8 33086.5 38263.2 38297.2 38670.6 38938.0 25740.1 30981.7 31119.0 31318.0 31351.4 20833.4 24141.0 24200.8 24446.4 24481.1 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | [#2] jquery.html Cycles:180 Average:36216.58 Median:12147.06 stddev:100030.19 (823.5%) stddev-sans-first:100274.64 13:36:42 INFO - PROCESS | 2088 | Values: 397.5 400.3 403.2 405.6 410.3 14636.9 15333.7 20551.5 20588.7 20598.7 16740.0 18313.8 20220.2 20581.9 21064.9 5030.3 5107.9 5853.4 6187.4 6234.5 6041.9 6053.5 6151.1 6152.4 6181.3 5691.5 6021.9 6025.3 6057.5 6142.1 5988.5 6046.9 6206.2 6803.1 6812.4 5866.8 5990.8 5991.2 5991.2 6004.3 13930.5 14923.5 20402.3 26075.7 26102.1 2088.1 2187.2 2214.9 2305.0 2349.8 9760.8 10768.8 13838.4 15216.0 15469.1 1799.9 1961.0 1994.4 2064.5 2091.3 135495.0 136046.3 136796.0 143774.6 148621.3 18715.8 20655.6 21442.9 22432.6 23307.8 35937.6 35950.3 35984.0 36037.3 36249.5 9445.2 10031.9 11276.5 11494.6 11536.2 7706.5 9250.7 9261.9 9278.2 9318.3 10033.6 10152.2 10190.3 10290.5 10333.9 3557.3 3871.9 3973.9 4046.8 4079.3 910.9 988.3 1000.9 1025.5 1025.7 16005.0 18076.7 20047.3 21673.7 22079.2 931.1 959.0 980.3 982.5 1038.8 9589.1 11223.0 11333.3 11349.5 11429.3 576129.0 594166.0 596882.0 610519.0 613157.0 97745.0 116834.4 117632.0 124143.0 141313.3 944.3 991.3 1053.5 1058.6 1059.5 17698.6 18691.9 18895.2 19541.4 19772.5 40149.4 46948.0 52311.0 52532.7 53342.5 61478.8 77690.6 77874.0 78064.2 78090.2 5416.7 5944.2 7148.7 7854.3 8719.2 11478.6 12034.3 12775.3 12896.6 13110.8 10348.0 10787.4 11135.3 11513.3 11539.6 10785.4 11140.7 11291.8 11309.0 11547.4 11122.1 11421.7 11584.5 11719.3 11724.6 8243.8 8269.3 8407.2 8437.0 8666.0 10795.6 11054.7 11172.7 11352.0 11478.9 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | [#3] mootools.html Cycles:180 Average:5727.59 Median:4902.73 stddev:3201.61 (65.3%) stddev-sans-first:3193.65 13:36:42 INFO - PROCESS | 2088 | Values: 1345.7 1492.3 1726.5 1740.0 1935.3 8045.4 8107.4 8630.6 8698.5 8995.1 8650.1 8745.5 8840.9 8849.8 8867.2 2432.6 2465.4 2468.6 2472.6 2479.4 2227.7 2308.0 2456.0 2471.4 2473.1 2443.1 2455.9 2456.8 2480.8 2481.8 2419.9 2430.5 2439.4 2448.0 2459.8 2433.4 2434.6 2438.7 2471.9 2472.8 8831.9 8860.8 8933.6 8958.4 8966.6 5356.9 5552.5 5591.2 5594.7 5604.9 3184.1 3588.8 3612.6 3614.9 3622.1 1037.4 1055.8 1063.8 1064.5 1083.7 11664.4 11681.5 11683.9 11757.0 11787.1 4092.7 4885.9 4990.4 5013.7 5077.3 9721.5 9973.0 9973.9 9983.3 10012.9 4426.0 5249.4 5261.3 5290.7 5331.8 4476.6 4838.3 4935.0 5001.9 5033.2 4029.3 4036.5 4076.5 4165.9 4176.7 1183.8 1385.6 1399.5 1402.3 1416.9 864.2 879.5 883.9 895.4 969.7 5862.5 5879.9 6018.2 6034.4 6185.8 407.3 459.6 479.9 482.7 483.5 3857.2 4002.7 4011.5 4065.5 4113.8 10433.0 10857.1 10955.2 10984.0 10995.0 10776.4 10810.1 10850.6 10896.4 10960.2 7657.3 8211.9 8243.5 8266.7 8276.8 5781.3 5886.8 5939.6 5953.1 5997.8 9209.9 10046.1 10056.2 10081.9 10140.8 9046.3 9813.2 10049.0 10087.0 10289.7 6805.7 7208.4 7491.6 7520.9 7542.3 8252.2 8289.5 8350.5 8369.6 8377.7 7252.3 7352.2 7392.0 7498.6 7554.1 7210.2 7236.6 7307.9 7326.7 7378.5 6895.8 6920.7 6942.9 6943.5 7059.0 4827.6 4890.9 4951.4 5030.7 5180.7 4866.8 4914.5 4963.7 5008.5 5174.3 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | [#4] prototype.html Cycles:180 Average:4960.01 Median:5648.05 stddev:1613.78 (28.6%) stddev-sans-first:1579.53 13:36:42 INFO - PROCESS | 2088 | Values: 275.3 308.5 325.3 325.4 325.8 5127.7 5637.7 5658.3 5744.9 5772.2 5721.0 5727.2 5731.6 5748.3 5754.3 4346.3 4361.6 4364.7 4376.8 4382.3 4028.6 4310.3 4332.1 4378.0 4382.5 3577.6 3721.7 4234.4 4281.2 4304.0 3503.5 3593.8 4247.8 4297.2 4315.6 3619.7 3689.1 3711.9 3724.3 3727.3 5000.6 5297.6 5485.7 5505.9 5511.4 4126.8 4397.8 4539.3 4651.8 4913.2 5152.1 5416.4 5679.0 5991.3 6009.8 3271.3 3577.0 3614.0 3882.7 4018.7 6278.5 6287.3 6361.8 6366.2 6376.7 3621.7 3636.6 4067.2 4077.8 4086.6 3719.2 4170.3 4180.1 4185.0 4188.6 4481.4 4870.2 4880.2 4883.8 4895.2 5373.0 5388.2 5903.5 6029.0 6074.1 1325.6 1499.3 1515.6 1519.6 1523.3 871.3 940.7 977.1 991.8 996.8 5405.3 5736.3 6045.0 6093.5 6135.8 6393.3 6747.7 6770.2 6814.3 6823.9 5168.8 5400.0 5748.3 5786.8 5968.3 2824.3 3268.3 3478.8 3513.5 3577.9 6435.5 6614.8 6667.9 7036.4 7056.5 6528.9 6820.8 6927.3 6933.9 6954.8 5940.9 6498.8 6640.4 7004.9 7055.0 5666.5 5847.8 5941.9 6352.1 6632.4 6600.2 6624.9 6637.8 6655.8 6670.8 6011.6 6196.6 6568.8 6588.7 6604.8 3570.5 3695.8 3914.6 4154.6 4159.2 5180.7 5820.7 6257.9 6281.2 6339.9 5362.5 6102.4 6134.3 6161.9 6176.5 6120.8 6124.3 6150.6 6164.7 6175.3 5046.9 5565.9 5956.5 5975.3 6008.8 4808.7 5157.9 6008.1 6083.6 6117.9 5578.3 5690.8 5883.8 5910.6 5962.2 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - PROCESS | 2088 | [#5] yui.html Cycles:180 Average:17565.78 Median:596.29 stddev:24452.16 (4100.7%) stddev-sans-first:24487.83 13:36:42 INFO - PROCESS | 2088 | Values: 667.3 709.8 730.8 734.3 792.1 16449.5 16897.6 17123.7 17164.1 17165.0 15658.2 15681.8 15772.8 15909.4 15925.2 738.9 890.5 894.6 901.2 932.9 906.6 917.6 925.0 925.4 926.1 944.9 966.6 971.6 971.7 972.0 912.3 913.3 958.0 962.8 971.9 678.3 704.5 704.9 707.6 719.2 15013.2 15034.0 15038.9 15223.7 15263.5 12245.6 12357.2 12376.4 12399.1 12627.4 9791.1 9913.0 10083.2 10414.8 10561.1 3247.2 3423.2 3439.0 3503.1 3553.9 53961.7 62443.0 67515.0 72615.0 82903.0 8250.8 9200.0 9343.3 9355.3 9482.2 17132.9 19765.9 20319.5 20398.5 20522.8 7288.5 7328.9 7385.6 7462.9 7500.2 3930.9 3973.0 4076.1 4090.1 4117.8 3578.8 3626.5 3657.2 3658.3 3666.5 520.7 614.0 616.3 649.6 655.7 550.8 575.0 581.8 596.3 598.4 8062.1 8148.7 8184.0 8197.8 8226.9 469.3 528.6 595.1 595.5 596.3 2930.5 3205.4 3465.8 3858.6 4048.8 91978.0 94390.5 96593.0 97830.5 98743.5 75878.0 77903.0 79653.2 80290.0 80438.8 59867.0 64494.0 67160.0 70197.0 71355.0 7340.3 7734.8 8200.6 8225.2 8270.2 37187.4 38757.8 40416.8 40988.8 44574.0 60334.0 60472.0 60911.4 60921.0 61067.4 10937.7 11061.6 11123.9 11385.7 11582.5 11925.3 11982.4 12132.8 12135.8 12194.6 11480.9 11620.5 11655.9 11703.1 11874.1 11191.2 11362.8 11700.4 11730.3 11732.4 10994.5 11267.8 11443.9 11651.5 12282.9 9574.8 9824.7 10066.9 10153.0 10344.5 9497.3 9806.2 9878.7 9906.4 9929.5 13:36:42 INFO - PROCESS | 2088 | -------- Summary: end -------- 13:36:42 INFO - PROCESS | 2088 | 13:36:42 INFO - TEST-INFO | 2088: exit 0 13:36:42 INFO - TEST-OK | dromaeo_css | took 1111773ms 13:36:42 INFO - TEST-START | kraken 13:36:42 INFO - operating with platform_type : mac_ 13:36:42 INFO - Initialising browser for kraken test... 13:36:42 INFO - TEST-INFO | started process 2094 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpxcL6OD/profile http://localhost:49364/getInfo.html) 13:36:45 INFO - PROCESS | 2094 | __metrics Screen width/height:1600/1200 13:36:45 INFO - PROCESS | 2094 | colorDepth:24 13:36:45 INFO - PROCESS | 2094 | Browser inner width/height: 1024/689 13:36:45 INFO - PROCESS | 2094 | __metrics 13:36:45 ERROR - PROCESS | 2094 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:36:46 INFO - TEST-INFO | 2094: exit 0 13:36:46 INFO - Browser initialized. 13:36:46 INFO - Running cycle 1/1 for kraken test... 13:36:46 INFO - TEST-INFO | started process 2097 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpxcL6OD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:58 INFO - PROCESS | 2097 | RSS: Main: 249802752 13:36:58 INFO - PROCESS | 2097 | 13:37:00 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:01 INFO - PROCESS | 2097 | RSS: Main: 261812224 13:37:01 INFO - PROCESS | 2097 | 13:37:04 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-dft) 13:37:05 INFO - PROCESS | 2097 | RSS: Main: 266383360 13:37:05 INFO - PROCESS | 2097 | 13:37:08 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-fft) 13:37:09 INFO - PROCESS | 2097 | RSS: Main: 267345920 13:37:09 INFO - PROCESS | 2097 | 13:37:11 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49364/tests/kraken/driver.html?testName=audio-oscillator) 13:37:11 INFO - PROCESS | 2097 | RSS: Main: 268128256 13:37:11 INFO - PROCESS | 2097 | 13:37:14 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:14 INFO - PROCESS | 2097 | RSS: Main: 267931648 13:37:14 INFO - PROCESS | 2097 | 13:37:17 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49364/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:18 INFO - PROCESS | 2097 | RSS: Main: 268087296 13:37:18 INFO - PROCESS | 2097 | 13:37:21 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49364/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:21 INFO - PROCESS | 2097 | RSS: Main: 268185600 13:37:21 INFO - PROCESS | 2097 | 13:37:24 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49364/tests/kraken/driver.html?testName=json-parse-financial) 13:37:25 INFO - PROCESS | 2097 | RSS: Main: 268414976 13:37:25 INFO - PROCESS | 2097 | 13:37:26 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:27 INFO - PROCESS | 2097 | RSS: Main: 268599296 13:37:27 INFO - PROCESS | 2097 | 13:37:29 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:29 INFO - PROCESS | 2097 | RSS: Main: 268107776 13:37:29 INFO - PROCESS | 2097 | 13:37:32 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:32 INFO - PROCESS | 2097 | RSS: Main: 268341248 13:37:32 INFO - PROCESS | 2097 | 13:37:35 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:36 INFO - PROCESS | 2097 | RSS: Main: 268591104 13:37:36 INFO - PROCESS | 2097 | 13:37:39 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:39 INFO - PROCESS | 2097 | RSS: Main: 268562432 13:37:39 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | Cycle 1(1): loaded http://localhost:49364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49364/tests/kraken/driver.html?testName=ai-astar) 13:37:41 INFO - PROCESS | 2097 | RSS: Main: 270249984 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | __start_tp_report 13:37:41 INFO - PROCESS | 2097 | _x_x_mozilla_page_load 13:37:41 INFO - PROCESS | 2097 | _x_x_mozilla_page_load_details 13:37:41 INFO - PROCESS | 2097 | |i|pagename|runs| 13:37:41 INFO - PROCESS | 2097 | |0;ai-astar;116;112;117;115;117;131;115;117;115;114 13:37:41 INFO - PROCESS | 2097 | |1;audio-beat-detection;153;126;146;168;111;156;128;134;207;154 13:37:41 INFO - PROCESS | 2097 | |2;audio-dft;197;261;271;237;196;205;236;222;282;205 13:37:41 INFO - PROCESS | 2097 | |3;audio-fft;70;79;68;147;47;52;69;91;103;48 13:37:41 INFO - PROCESS | 2097 | |4;audio-oscillator;81;108;173;78;80;82;125;81;92;155 13:37:41 INFO - PROCESS | 2097 | |5;imaging-gaussian-blur;88;89;89;87;90;86;135;92;89;87 13:37:41 INFO - PROCESS | 2097 | |6;imaging-darkroom;96;96;97;96;117;126;98;97;95;95 13:37:41 INFO - PROCESS | 2097 | |7;imaging-desaturate;143;142;90;91;90;90;92;90;92;93 13:37:41 INFO - PROCESS | 2097 | |8;json-parse-financial;60;62;62;61;61;64;73;90;61;59 13:37:41 INFO - PROCESS | 2097 | |9;json-stringify-tinderbox;65;67;74;69;70;76;71;66;66;70 13:37:41 INFO - PROCESS | 2097 | |10;stanford-crypto-aes;88;100;107;110;85;82;85;82;73;84 13:37:41 INFO - PROCESS | 2097 | |11;stanford-crypto-ccm;145;160;137;138;153;119;149;142;212;161 13:37:41 INFO - PROCESS | 2097 | |12;stanford-crypto-pbkdf2;171;169;167;170;168;170;171;203;169;174 13:37:41 INFO - PROCESS | 2097 | |13;stanford-crypto-sha256-iterative;69;75;92;96;101;92;69;70;69;67 13:37:41 INFO - PROCESS | 2097 | __end_tp_report 13:37:41 INFO - PROCESS | 2097 | __start_cc_report 13:37:41 INFO - PROCESS | 2097 | _x_x_mozilla_cycle_collect,1080 13:37:41 INFO - PROCESS | 2097 | __end_cc_report 13:37:41 INFO - PROCESS | 2097 | __startTimestamp1461962261985__endTimestamp 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | ------- Summary: start ------- 13:37:41 INFO - PROCESS | 2097 | Number of tests: 14 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.50 stddev:5.20 (4.5%) stddev-sans-first:5.50 13:37:41 INFO - PROCESS | 2097 | Values: 116.0 112.0 117.0 115.0 117.0 131.0 115.0 117.0 115.0 114.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.50 stddev:26.79 (17.5%) stddev-sans-first:28.36 13:37:41 INFO - PROCESS | 2097 | Values: 153.0 126.0 146.0 168.0 111.0 156.0 128.0 134.0 207.0 154.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#2] audio-dft Cycles:10 Average:231.20 Median:236.50 stddev:31.58 (13.4%) stddev-sans-first:30.98 13:37:41 INFO - PROCESS | 2097 | Values: 197.0 261.0 271.0 237.0 196.0 205.0 236.0 222.0 282.0 205.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#3] audio-fft Cycles:10 Average:77.40 Median:68.50 stddev:30.43 (44.4%) stddev-sans-first:32.16 13:37:41 INFO - PROCESS | 2097 | Values: 70.0 79.0 68.0 147.0 47.0 52.0 69.0 91.0 103.0 48.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:80.50 stddev:34.54 (42.9%) stddev-sans-first:35.47 13:37:41 INFO - PROCESS | 2097 | Values: 81.0 108.0 173.0 78.0 80.0 82.0 125.0 81.0 92.0 155.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:89.00 stddev:14.79 (16.6%) stddev-sans-first:15.56 13:37:41 INFO - PROCESS | 2097 | Values: 88.0 89.0 89.0 87.0 90.0 86.0 135.0 92.0 89.0 87.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:96.00 stddev:10.89 (11.3%) stddev-sans-first:11.38 13:37:41 INFO - PROCESS | 2097 | Values: 96.0 96.0 97.0 96.0 117.0 126.0 98.0 97.0 95.0 95.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:90.50 stddev:21.74 (24.0%) stddev-sans-first:17.04 13:37:41 INFO - PROCESS | 2097 | Values: 143.0 142.0 90.0 91.0 90.0 90.0 92.0 90.0 92.0 93.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:62.00 stddev:9.52 (15.4%) stddev-sans-first:9.91 13:37:41 INFO - PROCESS | 2097 | Values: 60.0 62.0 62.0 61.0 61.0 64.0 73.0 90.0 61.0 59.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:3.60 (5.1%) stddev-sans-first:3.44 13:37:41 INFO - PROCESS | 2097 | Values: 65.0 67.0 74.0 69.0 70.0 76.0 71.0 66.0 66.0 70.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:83.00 stddev:11.99 (14.4%) stddev-sans-first:12.71 13:37:41 INFO - PROCESS | 2097 | Values: 88.0 100.0 107.0 110.0 85.0 82.0 85.0 82.0 73.0 84.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:151.00 stddev:24.52 (16.2%) stddev-sans-first:25.89 13:37:41 INFO - PROCESS | 2097 | Values: 145.0 160.0 137.0 138.0 153.0 119.0 149.0 142.0 212.0 161.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:170.50 stddev:10.64 (6.2%) stddev-sans-first:11.26 13:37:41 INFO - PROCESS | 2097 | Values: 171.0 169.0 167.0 170.0 168.0 170.0 171.0 203.0 169.0 174.0 13:37:41 INFO - PROCESS | 2097 | 13:37:41 INFO - PROCESS | 2097 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.00 Median:72.50 stddev:13.51 (18.6%) stddev-sans-first:13.73 13:37:41 INFO - PROCESS | 2097 | Values: 69.0 75.0 92.0 96.0 101.0 92.0 69.0 70.0 69.0 67.0 13:37:42 INFO - PROCESS | 2097 | -------- Summary: end -------- 13:37:42 INFO - PROCESS | 2097 | 13:37:42 INFO - TEST-INFO | 2097: exit 0 13:37:42 INFO - TEST-OK | kraken | took 60053ms 13:37:42 INFO - SUITE-END | took 1171s 13:37:43 INFO - Completed test suite (00:19:32) 13:37:43 INFO - javascript benchmark 13:37:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2848.9572656410155, 3435.5533780608525, 3459.308138372326, 3467.4625433057886, 3516.085817687402, 5619.4380561943735, 5785.103308987103, 5816.069428891373, 5836.299644042716, 5867.7066146692705, 5789.768409263635, 5814.738336774844, 5827.621204621697, 5872.17789509469, 5977.671228082454, 5270.077736396125, 5295.0, 5333.599980001496, 5336.439673834249, 5368.785248590052, 187.29324771356292, 5277.234800953859, 5316.149416093426, 5320.441353657869, 5395.514403703666, 5255.737213139328, 5258.237555554461, 5310.867228319285, 5311.57507399409, 5319.5744340452675, 5250.44870288618, 5334.626576139672, 5335.1197052486295, 5352.545033672142, 5407.810726624549, 5241.213817927303, 5261.710605916673, 5302.390225124083, 5317.973410132963, 5340.973295133499, 5348.973255133699, 5673.6879471629045, 5704.258446401983, 5737.913931291034, 5773.971130144364, 6121.143039974407, 6200.81397558074, 6271.874562508724, 6275.24697036354, 6281.497480201619, 6197.535184861108, 6262.248530176408, 6279.6860156992425, 6282.96858515709, 6300.59046161998, 5912.260967379078, 5919.674417907014, 5938.732757025944, 5955.553333499962, 5990.820275391745, 6176.66028368435, 6255.311915689362, 6261.186045814015, 6305.022721478178, 6317.020861766434, 6155.692215389213, 6176.073588961692, 6232.189815323979, 6250.4374606285655, 6250.843728906722, 6237.4698150656795, 6267.4986001119805, 6280.309165991737, 6281.811545653638, 6284.622922624657, 6122.479589234876, 6176.135341052256, 6253.312135665074, 6274.341194174637, 6288.5598008138995, 6133.4264757247465, 6192.164057852222, 6263.279722831932, 6269.153664255358, 6277.811665649946, 3740.6259374062374, 4996.550310472075, 4997.525235102659, 4998.9500104999215, 5041.7227052511735, 4388.4733831940375, 4415.955840441618, 4468.843590474317, 4488.371627972087, 4516.1419330327135, 5464.808731694372, 5831.475167234969, 5866.970665146647, 5899.380565040695, 5962.910556341659, 5729.914051289234, 6211.534134939898, 6220.471259942865, 6239.625622462667, 6275.246970363494, 4930.630202734809, 5429.728513574306, 5866.061430171152, 5872.500837428781, 6011.9699401503585, 5475.7262136893, 5476.479734425223, 5476.863078423071, 5476.890462190734, 5479.75341109651, 5347.598930080259, 6363.427291543783, 6368.172137622079, 6375.330590287953, 6406.23125224976, 6145.016797312409, 6164.951958167033, 6238.469730072995, 6256.937430625636, 6260.0, 5299.33758280215, 6323.525735569942, 6355.491560675227, 6380.361963803768, 6392.9360706392345, 6101.671357587221, 6212.844678883064, 6253.530985176221, 6261.68691565429, 6284.402981716729, 6163.907541386972, 6202.317745047951, 6219.036049412348, 6229.283632382334, 6256.280527739186, 5302.3637163540625, 5675.829725108253, 6230.657313847601, 6231.40801623845, 6241.719122639402, 6082.635041897501, 6136.23297087864, 6218.31598524171, 6244.68776561161, 6251.468625166912, 4422.1155768847, 5562.0, 5740.425957404394, 5956.910646340395, 6099.573029887865, 5107.438181800073, 6141.6007959482495, 6237.719302631302, 6246.437820596168, 6257.061440783918, 5973.462388385066, 6097.7865774697675, 6118.051701986199, 6132.141500189888, 6156.476699480594], "value": 5674.729366793701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.2274451855104, 537.6182910133805, 544.2842661899601, 568.9687067211302, 586.0242695911306, 35779.0, 39494.60505394945, 39534.80232598833, 39566.0, 39587.2082558349, 40680.18639627206, 41513.0, 41522.58477415225, 41528.0, 41714.0, 9357.859632105525, 9462.526873656325, 9468.621255149787, 9614.519274036305, 9629.470379129145, 9522.476263805487, 9742.659006934759, 9759.975202603731, 9765.0, 9777.0, 9732.610695572168, 9767.706968790948, 9805.754856128618, 9806.11744942955, 9828.164606008499, 9671.274654400948, 9687.75780605487, 9762.609495620167, 9786.853197202048, 9803.362781419184, 9582.377145485521, 9714.757131071708, 9724.951375243149, 9726.367786093952, 9728.075832795874, 39511.40732889009, 39840.40239396411, 40164.79917600423, 40365.0, 40460.0, 2809.9719002809916, 2826.2792987787984, 3149.7165255127147, 3191.69678880506, 3436.1066122808, 22894.542109157723, 27879.442411151867, 27881.442371152465, 27901.023464178656, 28719.425611487863, 2707.878145483458, 2737.083077169151, 2755.655543057118, 2881.0408921933076, 2966.5550167474835, 387281.0, 389941.99999999715, 390458.0, 390480.0, 390769.0, 54589.0, 66197.33802661912, 66288.6685566569, 66354.00468992969, 66391.0, 53984.0, 62006.75986480335, 63704.04443933345, 63902.36097638964, 64223.35776642267, 17189.398371056952, 17244.827551724324, 17389.130543472776, 17448.563785905455, 17474.126293685265, 13043.086983911226, 13205.20768753878, 13248.668783280302, 13273.269970151541, 13288.468461261442, 19883.005849707457, 20145.0, 20264.594708105757, 20290.594188116156, 20497.38507844767, 8395.118512556215, 8552.273056790118, 8563.272121869586, 8604.440711353742, 8638.136186381438, 928.1553786054658, 976.3507267667064, 998.5221871630029, 1029.7785976015043, 1110.5835311758092, 28776.568351474743, 29872.0, 30228.274488466788, 30520.084397468112, 30559.694403056128, 1143.6054561176381, 1159.605734050427, 1175.535663412947, 1189.7977343851567, 1210.958575624962, 15259.542213733606, 15752.212389380486, 15800.525984220492, 15836.445724399591, 15896.284667190004, 239603.4059489109, 301048.0, 301076.0, 301173.0, 633696.0, 62605.747885042954, 62945.0, 63168.68415657892, 63256.36743632597, 63341.68329158325, 1262.3940508555945, 1460.627539977299, 1492.4701730885379, 1499.9775003374957, 1500.7523758579712, 30111.548326775555, 30197.943071992373, 30423.239419014702, 30507.38985220239, 30540.847295764266, 55691.88616227734, 55868.0, 56160.0, 56215.0, 56367.0, 573585.0, 575879.0, 576688.0, 577252.0, 578300.0, 26677.0, 27589.448211035266, 27677.892884284403, 27695.0, 27953.301167470974, 47554.76222618865, 47941.0, 48202.75898620485, 48794.0, 49011.75494122507, 37364.43953340757, 38547.614523854405, 38916.0, 39162.412563811, 39358.409623856234, 37548.06129846776, 37821.810890945366, 38034.23931521299, 38679.0, 38680.8395748128, 33086.50370244496, 38263.234735304584, 38297.23405531929, 38670.6132938667, 38938.0, 25740.099096531532, 30981.690183097882, 31119.0, 31318.0, 31351.372972540878, 20833.374998750063, 24141.034358626162, 24200.757992420557, 24446.388840279134, 24481.143159990028], "value": 19698.470117172372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.5448111911861, 400.34543521342596, 403.2298310227466, 405.57414714549725, 410.3352568838482, 14636.853631463682, 15333.693326133485, 20551.48621284467, 20588.69116963243, 20598.691019634698, 16739.995600263963, 18313.816861831412, 20220.191192352326, 20581.897090514565, 21064.946752662345, 5030.270610761438, 5107.923381149277, 5853.414658534155, 6187.4431301182885, 6234.470070044052, 6041.909371359433, 6053.51571874249, 6151.138840562325, 6152.354002829706, 6181.289151747562, 5691.544676425897, 6021.909671354933, 6025.307089684698, 6057.51539876811, 6142.109394137848, 5988.461038506533, 6046.909296360558, 6206.162168107293, 6803.115594972672, 6812.420944219747, 5866.794662186846, 5990.790322338741, 5991.161237426763, 5991.191189189447, 6004.279486461609, 13930.512432064828, 14923.477678281208, 20402.28591999288, 26075.740532433447, 26102.086426974965, 2088.1229883448987, 2187.1907394264067, 2214.900329485161, 2304.976950230493, 2349.847259928099, 9760.804783904354, 10768.838467422995, 13838.377273022637, 15216.0, 15469.071855688695, 1799.9280028798833, 1960.980390196094, 1994.4216177308563, 2064.5251592133745, 2091.26805618034, 135495.0, 136046.3197684015, 136796.0, 143774.56225437718, 148621.28446788917, 18715.812841871408, 20655.58688826215, 21442.892785535973, 22432.551348972927, 23307.83460826986, 35937.64062359395, 35950.280994379966, 35984.0, 36037.27925441477, 36249.45625815615, 9445.244380449547, 10031.898393374453, 11276.548938042386, 11494.597689081009, 11536.192466527262, 7706.460547761603, 9250.72247832566, 9261.907380926239, 9278.164965153168, 9318.254539636948, 10033.648822291185, 10152.187824973984, 10190.337628054152, 10290.536925838354, 10333.896661033294, 3557.3063252665997, 3871.8644847430205, 3973.8609148679657, 4046.817893194813, 4079.306517891906, 910.9453432794054, 988.3081842709988, 1000.9299349045497, 1025.5385076715509, 1025.6564051042835, 16005.0, 18076.734628576138, 20047.298344557872, 21673.67489487659, 22079.227227047297, 931.1386967055447, 958.9808203835884, 980.2501086668705, 982.5382070426888, 1038.766277587552, 9589.136977672042, 11223.0, 11333.320000799979, 11349.489272982735, 11429.314241145557, 576129.0, 594166.0, 596882.0, 610519.0, 613157.0, 97745.0, 116834.41582792031, 117632.0, 124143.0, 141313.29343353218, 944.3248077624669, 991.306085739985, 1053.510117795229, 1058.5501162006117, 1059.5391004912733, 17698.646027079645, 18691.887784687347, 18895.244190232235, 19541.413757587296, 19772.50568735793, 40149.397759033054, 46948.0, 52310.95378092341, 52532.737336313076, 53342.466575335304, 61478.770424590366, 77690.6115469419, 77874.0, 78064.21935780796, 78090.2190978083, 5416.729163541729, 5944.167816505779, 7148.749793757402, 7854.3323817473865, 8719.21256142502, 11478.598249061242, 12034.277943323428, 12775.297358644992, 12896.613101606967, 13110.803337950128, 10348.016938390841, 10787.406692631981, 11135.33188008722, 11513.251638643462, 11539.596114135966, 10785.40680262593, 11140.733961382179, 11291.830622540505, 11309.0, 11547.422628868691, 11122.109241429138, 11421.714457138638, 11584.536618535165, 11719.296842189497, 11724.589639362923, 8243.83512329738, 8269.25576698076, 8407.159284071544, 8437.029741579798, 8666.046734859034, 10795.56817727282, 11054.668359949215, 11172.664820055412, 11352.0, 11478.88521114778], "value": 10547.039017535655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.7443085813695, 1492.2613306413323, 1726.4820553833854, 1739.9739003914935, 1935.2742721479444, 8045.356371490281, 8107.391945604074, 8630.611622476988, 8698.478091314526, 8995.10048995101, 8650.134986501347, 8745.4752714837, 8840.911590884089, 8849.823003539925, 8867.246284065863, 2432.635104734291, 2465.4452748131616, 2468.617364308535, 2472.554940110779, 2479.38015496126, 2227.6967973735386, 2308.0, 2455.963160552584, 2471.4192164841247, 2473.109680515013, 2443.0838435586656, 2455.8649274289905, 2456.815738819587, 2480.8139389545854, 2481.8262721609494, 2419.9153029643967, 2430.4895971845935, 2439.377958620549, 2448.033026954361, 2459.754024597553, 2433.4281443860677, 2434.6469761884605, 2438.6951631046118, 2471.938201544958, 2472.83926544774, 8831.867521987175, 8860.778480537974, 8933.59798809055, 8958.41770284936, 8966.596503157374, 5356.866078348073, 5552.500274975271, 5591.189277554772, 5594.720263986785, 5604.887902241932, 3184.092533627928, 3588.802615856127, 3612.5664920209742, 3614.8734794282336, 3622.094476380905, 1037.4086770540796, 1055.7835643693024, 1063.840423936408, 1064.5369264369947, 1083.6911480228098, 11664.416779161009, 11681.532738690443, 11683.948444639938, 11757.00065494434, 11787.05703543723, 4092.6725861930972, 4885.877853053631, 4990.426100998359, 5013.724245166478, 5077.26379674945, 9721.513924303756, 9972.950135249277, 9973.850392244121, 9983.251256155818, 10012.949935250277, 4426.0, 5249.448807875195, 5261.289725887033, 5290.7354632269, 5331.786728530893, 4476.574725401082, 4838.250071238893, 4934.950650493521, 5001.89996200074, 5033.245013248042, 4029.294873397144, 4036.4752582164133, 4076.510818701775, 4165.875023749292, 4176.749395036308, 1183.8046722290726, 1385.5635474825397, 1399.4682020832222, 1402.2848347342929, 1416.8795652369663, 864.1703964194444, 879.4503435352905, 883.8541640629353, 895.4448242089946, 969.7284760267137, 5862.472377486047, 5879.853003674943, 6018.187544681412, 6034.39656034393, 6185.783497577563, 407.2526913114468, 459.60473992366536, 479.92321228603254, 482.6766066735296, 483.54305181603047, 3857.2256761889284, 4002.659773919191, 4011.538673052578, 4065.5121385433936, 4113.814878330482, 10432.956704329657, 10857.077148442313, 10955.233133680566, 10984.0, 10995.010449059622, 10776.407297598707, 10810.135189184846, 10850.565977360817, 10896.400697961688, 10960.177986651033, 7657.310842024244, 8211.917880821115, 8243.464174828618, 8266.710665126691, 8276.8344633107, 5781.277340332458, 5886.793962211302, 5939.643621382731, 5953.1367951647635, 5997.790077347272, 9209.861852072358, 10046.146077583195, 10056.245781566266, 10081.949590252296, 10140.847887281845, 9046.321525885453, 9813.165880900204, 10049.045340692623, 10087.0, 10289.691309260734, 6805.65971701403, 7208.35124838767, 7491.587962662106, 7520.924790752022, 7542.321191092828, 8252.21603947624, 8289.461185022954, 8350.540720260444, 8369.581520924052, 8377.70678026266, 7252.311030452099, 7352.191258961403, 7392.0, 7498.550086994798, 7554.055743032121, 7210.170830354366, 7236.565806051443, 7307.926920730724, 7326.7435639754485, 7378.520396174232, 6895.827604309932, 6920.7231710731, 6942.930570694431, 6943.51395402317, 7059.047028651066, 4827.61379089679, 4890.92663610039, 4951.356323677899, 5030.673006254582, 5180.7409629517615, 4866.756662166948, 4914.533119353656, 4963.726995015309, 5008.474110218374, 5174.275601415729], "value": 4547.647708094885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.3350658160542, 308.46327390340815, 325.27950589444384, 325.42562377403874, 325.8468519795695, 5127.7180704823795, 5637.746301416436, 5658.349289831671, 5744.9138262926035, 5772.191893134965, 5720.9713951430285, 5727.169560413738, 5731.570132240088, 5748.281464816898, 5754.280714910637, 4346.261135606938, 4361.5824856921545, 4364.67264955128, 4376.759278239696, 4382.276924307502, 4028.5568587455355, 4310.288802347609, 4332.06860524987, 4377.956220437803, 4382.5398333175035, 3577.606463289036, 3721.6836568891677, 4234.428352172464, 4281.186574550826, 4304.0, 3503.544539209912, 3593.825735430053, 4247.808848601805, 4297.247981603223, 4315.611594956469, 3619.7071842692358, 3689.114612493009, 3711.886434069795, 3724.255148970217, 3727.310447567209, 5000.62495312853, 5297.629165958385, 5485.6982865942355, 5505.880236109127, 5511.366192887829, 4126.752394856288, 4397.780110994438, 4539.273716205391, 4651.837040739815, 4913.189323761575, 5152.124138896396, 5416.404195538487, 5678.971605141948, 5991.3109992351, 6009.849753756147, 3271.2803183299634, 3576.9642303576893, 3613.981930090359, 3882.7476214045996, 4018.6584140348104, 6278.529110316699, 6287.271000474861, 6361.8409539761415, 6366.204224471941, 6376.7130479128555, 3621.7102631789394, 3636.581793093775, 4067.206894655573, 4077.7553346798695, 4086.5504794472586, 3719.1631882826687, 4170.332746760504, 4180.059486615548, 4185.0, 4188.6230239278, 4481.4174157359985, 4870.196417591058, 4880.194767863263, 4883.780229889663, 4895.167821470359, 5372.952274306473, 5388.225064091996, 5903.498202652822, 6028.969855150696, 6074.119252708421, 1325.6420766393212, 1499.257867355666, 1515.6059424549696, 1519.620094976256, 1523.2536057331827, 871.3421366867974, 940.697134468752, 977.0620204603518, 991.7520619845038, 996.7707427291764, 5405.270288511079, 5736.254286942671, 6045.0, 6093.512518998469, 6135.84660383494, 6393.328700486382, 6747.730090796314, 6770.1537307836525, 6814.318568143146, 6823.897641535381, 5168.767405466763, 5400.028989418834, 5748.281464816898, 5786.7558474927255, 5968.283805943228, 2824.2515733330683, 3268.3299923515624, 3478.7912725236565, 3513.543239378864, 3577.9105522362147, 6435.549511534147, 6614.8346291343105, 6667.933320666732, 7036.437085033287, 7056.541324813973, 6528.934710652928, 6820.795376138723, 6927.307269273032, 6933.93066069343, 6954.756583519553, 5940.940590594125, 6498.805035848932, 6640.402363787186, 7004.859902802017, 7055.0, 5666.546676265806, 5847.795327163529, 5941.91087133702, 6352.142460767737, 6632.403083722488, 6600.151957451922, 6624.867502650017, 6637.800865974028, 6655.833604159935, 6670.7665231716655, 6011.573403160157, 6196.605763703131, 6568.80293591193, 6588.670566471753, 6604.801855944329, 3570.482280069323, 3695.8336874841234, 3914.6085391460624, 4154.646855017358, 4159.230542349675, 5180.6891586504935, 5820.679862607597, 6257.937420625735, 6281.246250449975, 6339.936600634119, 5362.544183744425, 6102.38976102404, 6134.325224225421, 6161.876762464815, 6176.474999625082, 6120.846978825565, 6124.285200143967, 6150.569460137747, 6164.660943648142, 6175.258968923578, 5046.899062018812, 5565.916511252253, 5956.463918247378, 5975.282966044103, 6008.759649614141, 4808.711477311373, 5157.871053223699, 6008.068749343859, 6083.574149809471, 6117.877642447215, 5578.30271216098, 5690.83337915718, 5883.794067207627, 5910.556708246984, 5962.16529685853], "value": 4442.763269601092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.3193342790353, 709.8189961559805, 730.8246020954969, 734.2840730287968, 792.0811858244438, 16449.50651480456, 16897.577560560992, 17123.74314385285, 17164.14179291035, 17164.999999999985, 15658.217089145526, 15681.843181568182, 15772.842271577281, 15909.363625454997, 15925.203739813021, 738.9371903388219, 890.536920801183, 894.6376717429451, 901.2294488212582, 932.8787257656495, 906.60109551797, 917.6375331743957, 924.996378928863, 925.4077390470104, 926.073926073926, 944.9433034017981, 966.6036924860808, 971.621067783565, 971.7473456901186, 971.9902800972006, 912.32943786317, 913.3332667152949, 958.0228167269381, 962.8157366439284, 971.9076687714655, 678.253920687245, 704.485725420446, 704.9118860142482, 707.6391040569347, 719.2016861283971, 15013.174275414847, 15034.0, 15038.924805376013, 15223.695526089527, 15263.465778697693, 12245.571405000872, 12357.196782209128, 12376.381180940916, 12399.13206075575, 12627.368631568477, 9791.118799308026, 9912.950435247849, 10083.19334453242, 10414.79170416595, 10561.102306303974, 3247.236899328656, 3423.1955490459723, 3438.9656103438897, 3503.1417302760988, 3553.9466907996402, 53961.65095872634, 62443.0, 67514.98727519091, 72614.99999999948, 82903.0, 8250.834983300421, 9199.954000229956, 9343.34596578233, 9355.29835262358, 9482.19401350893, 17132.914335428242, 19765.901170494057, 20319.4920126998, 20398.490037748878, 20522.794772052388, 7288.526245794006, 7328.926710732824, 7385.556866588022, 7462.925370746331, 7500.249975002565, 3930.9213815723524, 3972.960270397259, 4076.103257283393, 4090.1001779608437, 4117.814698338582, 3578.7673801202836, 3626.4560315952817, 3657.213699054663, 3658.341498530237, 3666.4866918631415, 520.7058012223082, 613.9938600614026, 616.2881871438406, 649.6199723162003, 655.6819942327967, 550.8430097422296, 574.9971250143723, 581.8225441240378, 596.2844586496221, 598.4404581716109, 8062.072861620872, 8148.651396210326, 8183.95908020456, 8197.79505512367, 8226.876596851052, 469.29371296199685, 528.5850607273348, 595.1192235491496, 595.4789559135756, 596.2963702830615, 2930.5457654063653, 3205.3909757146066, 3465.8267086645565, 3858.6141385861188, 4048.817803198804, 91978.0, 94390.52804735933, 96593.0, 97830.51084744673, 98743.50628246812, 75878.0, 77903.0, 79653.20346796457, 80290.0, 80438.79341809878, 59867.0, 64493.99999999906, 67160.0, 70197.0, 71355.0, 7340.265973402617, 7734.806629834299, 8200.630971606412, 8225.177482251727, 8270.214329638675, 37187.442188367735, 38757.837264882095, 40416.79791601023, 40988.79505602453, 44574.0, 60334.0, 60472.0, 60911.39088609235, 60921.0, 61067.38932610617, 10937.726556836144, 11061.61284355076, 11123.888761112285, 11385.658430247106, 11582.536698532302, 11925.284482931052, 11982.400879956142, 12132.757344852876, 12135.817962730389, 12194.57318993831, 11480.885191148316, 11620.535178592761, 11655.941720291345, 11703.122265829927, 11874.050075994073, 11191.216614836883, 11362.829557556477, 11700.414979250832, 11730.296182228753, 11732.354720490113, 10994.450277486254, 11267.7746445069, 11443.885561144281, 11651.53393864236, 12282.894539491132, 9574.760630984281, 9824.65613703517, 10066.899331006596, 10153.0, 10344.482775861328, 9497.335186536877, 9806.215502759906, 9878.703638890845, 9906.405615663083, 9929.503524823875], "value": 6812.179913487797, "unit": "score"}], "name": "dromaeo_css", "value": 7385.496633989418, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 117.0, 115.0, 117.0, 131.0, 115.0, 117.0, 115.0, 114.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 146.0, 168.0, 111.0, 156.0, 128.0, 134.0, 207.0, 154.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 261.0, 271.0, 237.0, 196.0, 205.0, 236.0, 222.0, 282.0, 205.0], "value": 231.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 68.0, 147.0, 47.0, 52.0, 69.0, 91.0, 103.0, 48.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 108.0, 173.0, 78.0, 80.0, 82.0, 125.0, 81.0, 92.0, 155.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 87.0, 90.0, 86.0, 135.0, 92.0, 89.0, 87.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 117.0, 126.0, 98.0, 97.0, 95.0, 95.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 90.0, 91.0, 90.0, 90.0, 92.0, 90.0, 92.0, 93.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 61.0, 61.0, 64.0, 73.0, 90.0, 61.0, 59.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 74.0, 69.0, 70.0, 76.0, 71.0, 66.0, 66.0, 70.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 100.0, 107.0, 110.0, 85.0, 82.0, 85.0, 82.0, 73.0, 84.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 160.0, 137.0, 138.0, 153.0, 119.0, 149.0, 142.0, 212.0, 161.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 167.0, 170.0, 168.0, 170.0, 171.0, 203.0, 169.0, 174.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 92.0, 96.0, 101.0, 92.0, 69.0, 70.0, 69.0, 67.0], "value": 80.0, "unit": "score"}], "name": "kraken", "value": 1604.2, "alertThreshold": 2.0}]} 13:37:43 INFO - Return code: 0 13:37:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:37:43 ERROR - # TBPL SUCCESS # 13:37:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:37:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:37:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:37:43 INFO - 2016-04-29 13:37:43.317 screenresolution[2103:14348] starting screenresolution argv=screenresolution get 13:37:43 INFO - 2016-04-29 13:37:43.320 screenresolution[2103:14348] Display 0: 1600x1200x32@60 13:37:43 INFO - 2016-04-29 13:37:43.326 screenresolution[2104:14351] starting screenresolution argv=screenresolution list 13:37:43 INFO - Available Modes on Display 0 13:37:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:37:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:37:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:37:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:37:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:37:43 INFO - Intel Iris: 13:37:43 INFO - Chipset Model: Intel Iris 13:37:43 INFO - Type: GPU 13:37:43 INFO - Bus: Built-In 13:37:43 INFO - VRAM (Dynamic, Max): 1536 MB 13:37:43 INFO - Vendor: Intel (0x8086) 13:37:43 INFO - Device ID: 0x0a2e 13:37:43 INFO - Revision ID: 0x0009 13:37:43 INFO - Displays: 13:37:43 INFO - Display: 13:37:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:37:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:37:43 INFO - Display Serial Number: 1600x1200 60 13:37:43 INFO - Main Display: Yes 13:37:43 INFO - Mirror: Off 13:37:43 INFO - Online: Yes 13:37:43 INFO - Rotation: Supported 13:37:43 INFO - Return code: 0 13:37:43 INFO - Running post-action listener: _resource_record_post_action 13:37:43 INFO - Running post-run listener: _resource_record_post_run 13:37:44 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 30080512; Write bytes: 698337280; Read time: 301; Write time: 1910 13:37:44 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378823168; Write bytes: 372200960; Read time: 28273; Write time: 775 13:37:44 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 30076416; Write bytes: 299799040; Read time: 301; Write time: 1084 13:37:44 INFO - Running post-run listener: _upload_blobber_files 13:37:44 INFO - Blob upload gear active. 13:37:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:37:44 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'] 13:37:44 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 13:37:45 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:46 INFO - (blobuploader) - INFO - Done attempting. 13:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:37:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:47 INFO - (blobuploader) - INFO - Done attempting. 13:37:47 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:47 INFO - Return code: 0 13:37:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d42c9102f10814ed452587b94686dfe52d26483a3b2953ec16ea2c09c767427825d013363218cf5af734bfa22ba093894ec1eebfaf49c209ad44433826e37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6ff838b4b527c878871131713bee2201e0f4127d4a5057e967f7f20b78ac734077741865a0b517c823dcfc8e1272f06956667b0f655998bc5e4025d1fff9967"} 13:37:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:47 INFO - Contents: 13:37:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d42c9102f10814ed452587b94686dfe52d26483a3b2953ec16ea2c09c767427825d013363218cf5af734bfa22ba093894ec1eebfaf49c209ad44433826e37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6ff838b4b527c878871131713bee2201e0f4127d4a5057e967f7f20b78ac734077741865a0b517c823dcfc8e1272f06956667b0f655998bc5e4025d1fff9967"} 13:37:47 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:47 INFO - Copying logs to upload dir... 13:37:47 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.292644 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-29 13:37:47.264723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 13:37:47.269173) ========= 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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d42c9102f10814ed452587b94686dfe52d26483a3b2953ec16ea2c09c767427825d013363218cf5af734bfa22ba093894ec1eebfaf49c209ad44433826e37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6ff838b4b527c878871131713bee2201e0f4127d4a5057e967f7f20b78ac734077741865a0b517c823dcfc8e1272f06956667b0f655998bc5e4025d1fff9967"} build_url:https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/ZO-iJjvlSDyRqlfYh2UBOQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/258d42c9102f10814ed452587b94686dfe52d26483a3b2953ec16ea2c09c767427825d013363218cf5af734bfa22ba093894ec1eebfaf49c209ad44433826e37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6ff838b4b527c878871131713bee2201e0f4127d4a5057e967f7f20b78ac734077741865a0b517c823dcfc8e1272f06956667b0f655998bc5e4025d1fff9967"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 13:37:47.298299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:37:47.298661) ========= 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.m1sRWuFM1F/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.sB5Ew2Fcgw/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005142 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:37:47.347609) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:37:47.347975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:37:47.348736) ========= ========= Total master_lag: 0.17 =========