builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0140 starttime: 1461329811.53 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.527716) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.528154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.528428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.548212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.548478) ========= 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.AFuoDDwPIU/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.UT1rCmTw97/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-22 05:56:51-- 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% 22.3M=0.001s 2016-04-22 05:56:51 (22.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.665423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.665746) ========= 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.AFuoDDwPIU/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.UT1rCmTw97/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.026947 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.721874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:51.722200) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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 bf3a35b355f0b48ac1020c47198053af9944a493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AFuoDDwPIU/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.UT1rCmTw97/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-22 05:56:51,796 truncating revision to first 12 chars 2016-04-22 05:56:51,796 Setting DEBUG logging. 2016-04-22 05:56:51,796 attempt 1/10 2016-04-22 05:56:51,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:56:52,213 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:52.401470) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:52.401788) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:52.402188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:52.402456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:52.416480) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-22 05:56:52.416762) ========= /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.AFuoDDwPIU/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.UT1rCmTw97/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:56:52 INFO - MultiFileLogger online at 20160422 05:56:52 in /builds/slave/test 05:56:52 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 05:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:52 INFO - {'append_to_log': False, 05:56:52 INFO - 'base_work_dir': '/builds/slave/test', 05:56:52 INFO - 'blob_upload_branch': 'Fx-Team', 05:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:52 INFO - 'branch': 'Fx-Team', 05:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:52 INFO - 'config_files': ('talos/mac_config.py',), 05:56:52 INFO - 'default_actions': ('clobber', 05:56:52 INFO - 'read-buildbot-config', 05:56:52 INFO - 'download-and-extract', 05:56:52 INFO - 'populate-webroot', 05:56:52 INFO - 'create-virtualenv', 05:56:52 INFO - 'install', 05:56:52 INFO - 'run-tests'), 05:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:52 INFO - 'download_minidump_stackwalk': True, 05:56:52 INFO - 'download_symbols': 'ondemand', 05:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:52 INFO - 'installer_path': 'installer.exe', 05:56:52 INFO - 'log_level': 'info', 05:56:52 INFO - 'log_name': 'talos', 05:56:52 INFO - 'log_to_console': True, 05:56:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:56:52 INFO - 'opt_config_files': (), 05:56:52 INFO - 'pip_index': False, 05:56:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:52 INFO - 'cmd': ('bash', 05:56:52 INFO - '-c', 05:56:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:52 INFO - 'enabled': True, 05:56:52 INFO - 'halt_on_failure': False, 05:56:52 INFO - 'name': 'check_screen_resolution'},), 05:56:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:52 INFO - 'cmd': ('bash', 05:56:52 INFO - '-c', 05:56:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:52 INFO - 'enabled': True, 05:56:52 INFO - 'halt_on_failure': False, 05:56:52 INFO - 'name': 'check_screen_resolution'},), 05:56:52 INFO - 'run_cmd_checks_enabled': True, 05:56:52 INFO - 'sps_profile': False, 05:56:52 INFO - 'sps_profile_interval': 0, 05:56:52 INFO - 'suite': 'dromaeojs-e10s', 05:56:52 INFO - 'system_bits': '32', 05:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:52 INFO - 'title': 't-yosemite-r7-0140', 05:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:52 INFO - 'use_talos_json': True, 05:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:52 INFO - 'work_dir': 'build'} 05:56:52 INFO - ##### 05:56:52 INFO - ##### Running clobber step. 05:56:52 INFO - ##### 05:56:52 INFO - Running pre-action listener: _resource_record_pre_action 05:56:52 INFO - Running main action method: clobber 05:56:52 INFO - rmtree: /builds/slave/test/build 05:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:54 INFO - Running post-action listener: _resource_record_post_action 05:56:54 INFO - ##### 05:56:54 INFO - ##### Running read-buildbot-config step. 05:56:54 INFO - ##### 05:56:54 INFO - Running pre-action listener: _resource_record_pre_action 05:56:54 INFO - Running main action method: read_buildbot_config 05:56:54 INFO - Using buildbot properties: 05:56:54 INFO - { 05:56:54 INFO - "project": "", 05:56:54 INFO - "product": "firefox", 05:56:54 INFO - "script_repo_revision": "production", 05:56:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:56:54 INFO - "repository": "", 05:56:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:56:54 INFO - "buildid": "20160419211331", 05:56:54 INFO - "pgo_build": "False", 05:56:54 INFO - "basedir": "/builds/slave/test", 05:56:54 INFO - "buildnumber": 624, 05:56:54 INFO - "slavename": "t-yosemite-r7-0140", 05:56:54 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:56:54 INFO - "platform": "yosemite_r7", 05:56:54 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:56:54 INFO - "branch": "fx-team", 05:56:54 INFO - "repo_path": "integration/fx-team", 05:56:54 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 05:56:54 INFO - "stage_platform": "macosx64", 05:56:54 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 05:56:54 INFO - "slavebuilddir": "test" 05:56:54 INFO - } 05:56:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:56:54 INFO - Running post-action listener: _resource_record_post_action 05:56:54 INFO - ##### 05:56:54 INFO - ##### Running download-and-extract step. 05:56:54 INFO - ##### 05:56:54 INFO - Running pre-action listener: _resource_record_pre_action 05:56:54 INFO - Running main action method: download_and_extract 05:56:54 INFO - mkdir: /builds/slave/test/build/tests 05:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:54 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:56:55 INFO - Downloaded 1199 bytes. 05:56:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:55 INFO - Using the following test package requirements: 05:56:55 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:56:55 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:56:55 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:56:55 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'jsshell-mac.zip'], 05:56:55 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:56:55 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:56:55 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:56:55 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:56:55 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:56:55 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:55 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:56:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:55 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:56:56 INFO - Downloaded 18095501 bytes. 05:56:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:56:59 INFO - Return code: 0 05:56:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:59 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:57:01 INFO - Downloaded 18095501 bytes. 05:57:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:57:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:57:05 INFO - Return code: 0 05:57: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')]} 05:57:05 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:57:06 INFO - Downloaded 10845952 bytes. 05:57:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:57:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:57:06 INFO - Return code: 0 05:57: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')]} 05:57:06 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:57:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:57:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:57:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:57:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:57:09 INFO - Downloaded 110002250 bytes. 05:57:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:57:09 INFO - mkdir: /builds/slave/test/properties 05:57:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:57:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:57:09 INFO - Contents: 05:57:09 INFO - build_url:https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:57:11 INFO - Running post-action listener: _resource_record_post_action 05:57:11 INFO - Running post-action listener: set_extra_try_arguments 05:57:11 INFO - ##### 05:57:11 INFO - ##### Running populate-webroot step. 05:57:11 INFO - ##### 05:57:11 INFO - Running pre-action listener: _resource_record_pre_action 05:57:11 INFO - Running main action method: populate_webroot 05:57:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:57:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:57:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:57:11 INFO - '--tppagecycles', 05:57:11 INFO - '7'], 05:57:11 INFO - 'tests': ['tsvgm']}}, 05:57:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:57:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:57:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:57:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:57:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['damp', 'tps']}, 05:57:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'tests': ['damp', 'tps']}, 05:57:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['dromaeo_dom']}, 05:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:57:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['a11yr', 05:57:11 INFO - 'ts_paint', 05:57:11 INFO - 'tpaint', 05:57:11 INFO - 'sessionrestore', 05:57:11 INFO - 'sessionrestore_no_auto_restore', 05:57:11 INFO - 'tabpaint']}, 05:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:57:11 INFO - 'ts_paint', 05:57:11 INFO - 'tpaint', 05:57:11 INFO - 'sessionrestore', 05:57:11 INFO - 'sessionrestore_no_auto_restore', 05:57:11 INFO - 'tabpaint']}, 05:57:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:57:11 INFO - 'ts_paint', 05:57:11 INFO - 'tpaint', 05:57:11 INFO - 'sessionrestore', 05:57:11 INFO - 'sessionrestore_no_auto_restore', 05:57:11 INFO - 'tabpaint']}, 05:57:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:57:11 INFO - 'ts_paint', 05:57:11 INFO - 'tpaint', 05:57:11 INFO - 'sessionrestore', 05:57:11 INFO - 'sessionrestore_no_auto_restore', 05:57:11 INFO - 'tabpaint']}, 05:57:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['a11yr', 05:57:11 INFO - 'ts_paint', 05:57:11 INFO - 'tpaint', 05:57:11 INFO - 'sessionrestore', 05:57:11 INFO - 'sessionrestore_no_auto_restore', 05:57:11 INFO - 'tabpaint']}, 05:57:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['a11yr', 05:57:11 INFO - 'ts_paint', 05:57:11 INFO - 'tpaint', 05:57:11 INFO - 'sessionrestore', 05:57:11 INFO - 'sessionrestore_no_auto_restore', 05:57:11 INFO - 'tabpaint']}, 05:57:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['tsvgx', 05:57:11 INFO - 'tsvgr_opacity', 05:57:11 INFO - 'tart', 05:57:11 INFO - 'tscrollx', 05:57:11 INFO - 'cart']}, 05:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:57:11 INFO - 'tsvgr_opacity', 05:57:11 INFO - 'tart', 05:57:11 INFO - 'tscrollx', 05:57:11 INFO - 'cart']}, 05:57:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'talos_options': ['--disable-e10s'], 05:57:11 INFO - 'tests': ['tp5o']}, 05:57:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'tests': ['tp5o']}, 05:57:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'talos_options': ['--disable-e10s', 05:57:11 INFO - '--xperf_path', 05:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:11 INFO - 'tests': ['tp5n']}, 05:57:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:11 INFO - 'talos_options': ['--xperf_path', 05:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:11 INFO - 'tests': ['tp5n']}}, 05:57:11 INFO - 'talos.zip': {'path': '', 05:57:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:57:11 INFO - Running post-action listener: _resource_record_post_action 05:57:11 INFO - ##### 05:57:11 INFO - ##### Running create-virtualenv step. 05:57:11 INFO - ##### 05:57:11 INFO - Running pre-action listener: _resource_record_pre_action 05:57:11 INFO - Running main action method: create_virtualenv 05:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:57:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:57:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:57:11 INFO - Using real prefix '/tools/python27' 05:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:57:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:14 INFO - Installing pip.................done. 05:57:14 INFO - Return code: 0 05:57:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:14 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:14 INFO - 'HOME': '/Users/cltbld', 05:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:14 INFO - 'LOGNAME': 'cltbld', 05:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:14 INFO - 'MOZ_NO_REMOTE': '1', 05:57:14 INFO - 'NO_EM_RESTART': '1', 05:57:14 INFO - 'PAGER': '/bin/cat', 05:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:14 INFO - 'PWD': '/builds/slave/test', 05:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:14 INFO - 'SHELL': '/bin/bash', 05:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:14 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:14 INFO - 'USER': 'cltbld', 05:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:14 INFO - 'XPC_FLAGS': '0x0', 05:57:14 INFO - 'XPC_SERVICE_NAME': '0', 05:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:57:15 INFO - Cleaning up... 05:57:15 INFO - Return code: 0 05:57:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:15 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:15 INFO - 'HOME': '/Users/cltbld', 05:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:15 INFO - 'LOGNAME': 'cltbld', 05:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:15 INFO - 'MOZ_NO_REMOTE': '1', 05:57:15 INFO - 'NO_EM_RESTART': '1', 05:57:15 INFO - 'PAGER': '/bin/cat', 05:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:15 INFO - 'PWD': '/builds/slave/test', 05:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:15 INFO - 'SHELL': '/bin/bash', 05:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:15 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:15 INFO - 'USER': 'cltbld', 05:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:15 INFO - 'XPC_FLAGS': '0x0', 05:57:15 INFO - 'XPC_SERVICE_NAME': '0', 05:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:15 INFO - Downloading/unpacking psutil>=0.7.1 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:18 INFO - Installing collected packages: psutil 05:57:18 INFO - Running setup.py install for psutil 05:57:18 INFO - building 'psutil._psutil_osx' extension 05:57:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:57:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:57:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:57:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:57:19 INFO - building 'psutil._psutil_posix' extension 05:57:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:57:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:57:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:57:19 INFO - ^ 05:57:19 INFO - 1 warning generated. 05:57:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:57:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:19 INFO - Successfully installed psutil 05:57:19 INFO - Cleaning up... 05:57:19 INFO - Return code: 0 05:57:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:19 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:19 INFO - 'HOME': '/Users/cltbld', 05:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:19 INFO - 'LOGNAME': 'cltbld', 05:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:19 INFO - 'MOZ_NO_REMOTE': '1', 05:57:19 INFO - 'NO_EM_RESTART': '1', 05:57:19 INFO - 'PAGER': '/bin/cat', 05:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:19 INFO - 'PWD': '/builds/slave/test', 05:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:19 INFO - 'SHELL': '/bin/bash', 05:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:19 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:19 INFO - 'USER': 'cltbld', 05:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:19 INFO - 'XPC_FLAGS': '0x0', 05:57:19 INFO - 'XPC_SERVICE_NAME': '0', 05:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:57:22 INFO - Installing collected packages: mozsystemmonitor 05:57:22 INFO - Running setup.py install for mozsystemmonitor 05:57:22 INFO - Successfully installed mozsystemmonitor 05:57:22 INFO - Cleaning up... 05:57:22 INFO - Return code: 0 05:57:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:22 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:22 INFO - 'HOME': '/Users/cltbld', 05:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:22 INFO - 'LOGNAME': 'cltbld', 05:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:22 INFO - 'MOZ_NO_REMOTE': '1', 05:57:22 INFO - 'NO_EM_RESTART': '1', 05:57:22 INFO - 'PAGER': '/bin/cat', 05:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:22 INFO - 'PWD': '/builds/slave/test', 05:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:22 INFO - 'SHELL': '/bin/bash', 05:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:22 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:22 INFO - 'USER': 'cltbld', 05:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:22 INFO - 'XPC_FLAGS': '0x0', 05:57:22 INFO - 'XPC_SERVICE_NAME': '0', 05:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:26 INFO - Downloading docopt-0.6.1.tar.gz 05:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:26 INFO - Running setup.py install for blobuploader 05:57:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:26 INFO - Running setup.py install for requests 05:57:27 INFO - Running setup.py install for docopt 05:57:27 INFO - Successfully installed blobuploader requests docopt 05:57:27 INFO - Cleaning up... 05:57:27 INFO - Return code: 0 05:57:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:27 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:27 INFO - 'HOME': '/Users/cltbld', 05:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:27 INFO - 'LOGNAME': 'cltbld', 05:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:27 INFO - 'MOZ_NO_REMOTE': '1', 05:57:27 INFO - 'NO_EM_RESTART': '1', 05:57:27 INFO - 'PAGER': '/bin/cat', 05:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:27 INFO - 'PWD': '/builds/slave/test', 05:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:27 INFO - 'SHELL': '/bin/bash', 05:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:27 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:27 INFO - 'USER': 'cltbld', 05:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:27 INFO - 'XPC_FLAGS': '0x0', 05:57:27 INFO - 'XPC_SERVICE_NAME': '0', 05:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:27 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6zccnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:27 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-fOsElm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:27 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xx08qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-5KPLuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-IIMs68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-0mHHi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Ow7yiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MFR7rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-qGQzmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-77bMS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-8gQWYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MGk3MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-WhlAnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-a89tB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xrDiOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yc2ZAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xzNROG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:29 INFO - Running setup.py install for manifestparser 05:57:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:29 INFO - Running setup.py install for mozcrash 05:57:29 INFO - Running setup.py install for mozdebug 05:57:29 INFO - Running setup.py install for mozdevice 05:57:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozfile 05:57:30 INFO - Running setup.py install for mozhttpd 05:57:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozinfo 05:57:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozInstall 05:57:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozleak 05:57:30 INFO - Running setup.py install for mozlog 05:57:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for moznetwork 05:57:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Running setup.py install for mozprocess 05:57:31 INFO - Running setup.py install for mozprofile 05:57:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Running setup.py install for mozrunner 05:57:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Running setup.py install for mozscreenshot 05:57:31 INFO - Running setup.py install for moztest 05:57:31 INFO - Running setup.py install for mozversion 05:57:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:32 INFO - Cleaning up... 05:57:32 INFO - Return code: 0 05:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:32 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:32 INFO - 'HOME': '/Users/cltbld', 05:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:32 INFO - 'LOGNAME': 'cltbld', 05:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:32 INFO - 'MOZ_NO_REMOTE': '1', 05:57:32 INFO - 'NO_EM_RESTART': '1', 05:57:32 INFO - 'PAGER': '/bin/cat', 05:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:32 INFO - 'PWD': '/builds/slave/test', 05:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:32 INFO - 'SHELL': '/bin/bash', 05:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:32 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:32 INFO - 'USER': 'cltbld', 05:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:32 INFO - 'XPC_FLAGS': '0x0', 05:57:32 INFO - 'XPC_SERVICE_NAME': '0', 05:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-FSs_RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-jMFQEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SGfjI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-7DEXx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-166g1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-R2hMcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:32 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-61HfGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-l3nx7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-FJHoJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yBL_qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uQ0bOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-JLpU1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-pLLi0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Zm5bnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-lu_vVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-G6S257-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Jxr8ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:36 INFO - Downloading blessings-1.6.tar.gz 05:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:36 INFO - Installing collected packages: blessings 05:57:36 INFO - Running setup.py install for blessings 05:57:36 INFO - Successfully installed blessings 05:57:36 INFO - Cleaning up... 05:57:36 INFO - Return code: 0 05:57:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:37 INFO - Reading from file tmpfile_stdout 05:57:37 INFO - Current package versions: 05:57:37 INFO - blessings == 1.6 05:57:37 INFO - blobuploader == 1.2.4 05:57:37 INFO - docopt == 0.6.1 05:57:37 INFO - manifestparser == 1.1 05:57:37 INFO - mozInstall == 1.12 05:57:37 INFO - mozcrash == 0.17 05:57:37 INFO - mozdebug == 0.1 05:57:37 INFO - mozdevice == 0.48 05:57:37 INFO - mozfile == 1.2 05:57:37 INFO - mozhttpd == 0.7 05:57:37 INFO - mozinfo == 0.9 05:57:37 INFO - mozleak == 0.1 05:57:37 INFO - mozlog == 3.1 05:57:37 INFO - moznetwork == 0.27 05:57:37 INFO - mozprocess == 0.22 05:57:37 INFO - mozprofile == 0.28 05:57:37 INFO - mozrunner == 6.11 05:57:37 INFO - mozscreenshot == 0.1 05:57:37 INFO - mozsystemmonitor == 0.0 05:57:37 INFO - moztest == 0.7 05:57:37 INFO - mozversion == 1.4 05:57:37 INFO - psutil == 3.1.1 05:57:37 INFO - requests == 1.2.3 05:57:37 INFO - wsgiref == 0.1.2 05:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:37 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:37 INFO - 'HOME': '/Users/cltbld', 05:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:37 INFO - 'LOGNAME': 'cltbld', 05:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:37 INFO - 'MOZ_NO_REMOTE': '1', 05:57:37 INFO - 'NO_EM_RESTART': '1', 05:57:37 INFO - 'PAGER': '/bin/cat', 05:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:37 INFO - 'PWD': '/builds/slave/test', 05:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:37 INFO - 'SHELL': '/bin/bash', 05:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:37 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:37 INFO - 'USER': 'cltbld', 05:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:37 INFO - 'XPC_FLAGS': '0x0', 05:57:37 INFO - 'XPC_SERVICE_NAME': '0', 05:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:37 INFO - Cleaning up... 05:57:37 INFO - Return code: 0 05:57:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:37 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:37 INFO - 'HOME': '/Users/cltbld', 05:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:37 INFO - 'LOGNAME': 'cltbld', 05:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:37 INFO - 'MOZ_NO_REMOTE': '1', 05:57:37 INFO - 'NO_EM_RESTART': '1', 05:57:37 INFO - 'PAGER': '/bin/cat', 05:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:37 INFO - 'PWD': '/builds/slave/test', 05:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:37 INFO - 'SHELL': '/bin/bash', 05:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:37 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:37 INFO - 'USER': 'cltbld', 05:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:37 INFO - 'XPC_FLAGS': '0x0', 05:57:37 INFO - 'XPC_SERVICE_NAME': '0', 05:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:37 INFO - Downloading/unpacking jsonschema 05:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:40 INFO - Downloading/unpacking functools32 (from jsonschema) 05:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:40 INFO - warning: no files found matching '*.txt' 05:57:40 INFO - no previously-included directories found matching 'build' 05:57:40 INFO - no previously-included directories found matching 'dist' 05:57:40 INFO - no previously-included directories found matching '.git*' 05:57:40 INFO - Installing collected packages: jsonschema, functools32 05:57:40 INFO - Running setup.py install for functools32 05:57:40 INFO - warning: no files found matching '*.txt' 05:57:40 INFO - no previously-included directories found matching 'build' 05:57:40 INFO - no previously-included directories found matching 'dist' 05:57:40 INFO - no previously-included directories found matching '.git*' 05:57:40 INFO - Successfully installed jsonschema functools32 05:57:40 INFO - Cleaning up... 05:57:40 INFO - Return code: 0 05:57:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:40 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 0x101dd4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101de4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4914cd9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, '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.AFuoDDwPIU/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.UT1rCmTw97/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:40 INFO - 'HOME': '/Users/cltbld', 05:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:40 INFO - 'LOGNAME': 'cltbld', 05:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:40 INFO - 'MOZ_NO_REMOTE': '1', 05:57:40 INFO - 'NO_EM_RESTART': '1', 05:57:40 INFO - 'PAGER': '/bin/cat', 05:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:40 INFO - 'PWD': '/builds/slave/test', 05:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:40 INFO - 'SHELL': '/bin/bash', 05:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:57:40 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:40 INFO - 'USER': 'cltbld', 05:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:40 INFO - 'XPC_FLAGS': '0x0', 05:57:40 INFO - 'XPC_SERVICE_NAME': '0', 05:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:41 INFO - Downloading/unpacking flake8 05:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:44 INFO - no previously-included directories found matching 'docs/_build' 05:57:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:44 INFO - Running setup.py install for pep8 05:57:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:45 INFO - no previously-included directories found matching 'docs/_build' 05:57:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:45 INFO - Cleaning up... 05:57:45 INFO - Return code: 0 05:57:45 INFO - Running post-action listener: _resource_record_post_action 05:57:45 INFO - Running post-action listener: _start_resource_monitoring 05:57:45 INFO - Starting resource monitoring. 05:57:45 INFO - ##### 05:57:45 INFO - ##### Running install step. 05:57:45 INFO - ##### 05:57:45 INFO - Running pre-action listener: _resource_record_pre_action 05:57:45 INFO - Running main action method: install 05:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:45 INFO - Reading from file tmpfile_stdout 05:57:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:45 INFO - Reading from file tmpfile_stdout 05:57:45 INFO - Output received: 05:57:45 INFO - Usage: mozinstall [options] installer 05:57:45 INFO - Options: 05:57:45 INFO - -h, --help show this help message and exit 05:57:45 INFO - -d DEST, --destination=DEST 05:57:45 INFO - Directory to install application into. [default: 05:57:45 INFO - "/builds/slave/test"] 05:57:45 INFO - --app=APP Application being installed. [default: firefox] 05:57:45 INFO - mkdir: /builds/slave/test/build/application 05:57:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:58:19 INFO - Reading from file tmpfile_stdout 05:58:19 INFO - Output received: 05:58:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:58:19 INFO - Running post-action listener: _resource_record_post_action 05:58:19 INFO - ##### 05:58:19 INFO - ##### Running run-tests step. 05:58:19 INFO - ##### 05:58:19 INFO - Running pre-action listener: _resource_record_pre_action 05:58:19 INFO - Running main action method: run_tests 05:58:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:19 INFO - 2016-04-22 05:58:19.060 screenresolution[1643:7372] starting screenresolution argv=screenresolution get 05:58:19 INFO - 2016-04-22 05:58:19.062 screenresolution[1643:7372] Display 0: 1600x1200x32@60 05:58:19 INFO - 2016-04-22 05:58:19.068 screenresolution[1644:7374] starting screenresolution argv=screenresolution list 05:58:19 INFO - Available Modes on Display 0 05:58:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:19 INFO - Intel Iris: 05:58:19 INFO - Chipset Model: Intel Iris 05:58:19 INFO - Type: GPU 05:58:19 INFO - Bus: Built-In 05:58:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:19 INFO - Vendor: Intel (0x8086) 05:58:19 INFO - Device ID: 0x0a2e 05:58:19 INFO - Revision ID: 0x0009 05:58:19 INFO - Displays: 05:58:19 INFO - Display: 05:58:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:19 INFO - Display Serial Number: 1600x1200 60 05:58:19 INFO - Main Display: Yes 05:58:19 INFO - Mirror: Off 05:58:19 INFO - Online: Yes 05:58:19 INFO - Rotation: Supported 05:58:19 INFO - Return code: 0 05:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:19 INFO - Python 2.7.3 05:58:19 INFO - Return code: 0 05:58:19 INFO - grabbing minidump binary from tooltool 05:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:19 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 0x101c73e00>, '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 0x101adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c6eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:58:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:58:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:19 INFO - Return code: 0 05:58:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:58:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:58:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:58:20 INFO - Return code: 0 05:58:20 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/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:58:20 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/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFuoDDwPIU/Render', 05:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:20 INFO - 'HOME': '/Users/cltbld', 05:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:20 INFO - 'LOGNAME': 'cltbld', 05:58:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:20 INFO - 'MOZ_NO_REMOTE': '1', 05:58:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:20 INFO - 'NO_EM_RESTART': '1', 05:58:20 INFO - 'PAGER': '/bin/cat', 05:58:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:20 INFO - 'PWD': '/builds/slave/test', 05:58:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:20 INFO - 'SHELL': '/bin/bash', 05:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UT1rCmTw97/Listeners', 05:58:20 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 05:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:20 INFO - 'USER': 'cltbld', 05:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:20 INFO - 'XPC_FLAGS': '0x0', 05:58:20 INFO - 'XPC_SERVICE_NAME': '0', 05:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:20 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/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:58:20 INFO - mozversion application_buildid: 20160419211331 05:58:20 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 05:58:20 INFO - mozversion application_display_name: Nightly 05:58:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:20 INFO - mozversion application_name: Firefox 05:58:20 INFO - mozversion application_remotingname: firefox 05:58:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:58:20 INFO - mozversion application_vendor: Mozilla 05:58:20 INFO - mozversion application_version: 48.0a1 05:58:20 INFO - mozversion platform_buildid: 20160419211331 05:58:20 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 05:58:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:58:20 INFO - mozversion platform_version: 48.0a1 05:58:20 INFO - using testdate: 1461329900 05:58:20 INFO - actual date: 1461329900 05:58:20 INFO - starting webserver on 'localhost:49283' 05:58:20 INFO - SUITE-START | Running 2 tests 05:58:20 INFO - TEST-START | dromaeo_css 05:58:20 INFO - operating with platform_type : mac_ 05:58:20 INFO - Initialising browser for dromaeo_css test... 05:58:20 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpzAxU9m/profile http://localhost:49283/getInfo.html) 05:58:23 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:58:23 INFO - PROCESS | 1662 | colorDepth:24 05:58:23 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:58:23 INFO - PROCESS | 1662 | __metrics 05:58:24 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:58:24 INFO - TEST-INFO | 1662: exit 0 05:58:24 INFO - Browser initialized. 05:58:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:24 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpzAxU9m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:36 INFO - PROCESS | 1665 | RSS: Main: 247562240 05:58:36 INFO - PROCESS | 1665 | 05:59:26 INFO - PROCESS | 1665 | 1461329966221 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:01:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 06:01:38 INFO - PROCESS | 1665 | RSS: Main: 261660672 06:01:38 INFO - PROCESS | 1665 | 06:04:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 06:04:41 INFO - PROCESS | 1665 | RSS: Main: 271798272 06:04:41 INFO - PROCESS | 1665 | 06:07:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 06:07:43 INFO - PROCESS | 1665 | RSS: Main: 274243584 06:07:43 INFO - PROCESS | 1665 | 06:10:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 06:10:46 INFO - PROCESS | 1665 | RSS: Main: 275439616 06:10:46 INFO - PROCESS | 1665 | 06:13:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 06:13:49 INFO - PROCESS | 1665 | RSS: Main: 278257664 06:13:49 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 06:16:52 INFO - PROCESS | 1665 | RSS: Main: 279130112 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | __start_tp_report 06:16:52 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:16:52 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:16:52 INFO - PROCESS | 1665 | |i|pagename|runs| 06:16:52 INFO - PROCESS | 1665 | |0;dojo.html;3287.1453422110253;3546.6630670086347;3554.857805687771;3560.679538841504;3572.178398968237;5439.728013599324;5820.738066786994;5847.64914105154;5860.5311575074;5865.853353666161;5722.570807189457;5807.593468457209;5864.5894787364905;5882.147088672151;5974.372690867462;5186.922196167051;5271.894562108756;5290.444503327153;5298.4436634153435;5348.251244825728;236.81746631169196;4208.600182982612;5218.478152184789;5246.055709972204;5255.106631872591;5249.02892964799;5249.265102885599;5260.079486089957;5286.995470860525;5312.574994000471;5295.629305948585;5296.576273898079;5308.469153084699;5321.600879934021;5329.307190065306;4260.8721738347895;4730.266808644631;5100.107481190814;5111.744412779383;5268.420473747885;4830.589399901012;5584.888302233932;5741.368449470555;5776.8844623107725;5797.130430435468;6239.500839932794;6254.374562543755;6277.7802776903045;6280;6308.463780578656;6172.537059720539;6214.5960512566535;6252.968735156341;6311.211098612674;6319.115323854664;5948.434898684618;5982.880342393128;5994.994179859822;6007.36922623127;6029.969850150765;5246.344206974129;6232.968835155795;6376.29860715321;6388.872222555523;6391.169148010729;6163;6226.782062627786;6251.9687401562705;6254;6281.277653069864;6219.502439804804;6251.374862513712;6275.780347687901;6296.5592408530965;6329.620222786648;6137.407629318989;6186.81439556814;6252.906206406908;6283.214598175228;6283.905741413882;6200.286966998763;6211.409916057967;6219.533534984895;6226.750929962841;6254.249490061222;4873.951260487421;4952.579030782352;4960.883801144713;4971.676841005323;4975.601951843843;4452.465704115527;4457.977710111429;4463.129689710475;4514.864554063383;4521.638268938477;5403.459654034644;5822.475977161991;5921.496672782776;5938.346781853993;5946.672932988728;6180.103884936659;6252.656103914328;6273.780417685359;6279.806836701012;6338.112664227012;5974.133750606138;6001.4298641628975;6014.218151640259;6059.460319987215;6083.543734219951;5395.487428694268;5496.477834605706;5508.862278442991;5510.752016159283;5511.338639363302;5743.712814359349;6429.45349645276;6527.281998980204;6531.0856480092825;6547.1161393211305;6269.185005949197;6312.5265605078885;6313.08460273267;6314.8737025258315;6322.747090116344;6296.5277604178955;6336.081268216175;6436.227652681709;6481.675916204265;6541.70562324687;6232.501399887908;6279.277883043508;6288.717007734572;6302.621842689453;6321;6273;6275.403836635513;6281.026440901667;6281.434670879643;6296.370362963667;4622.491525932078;6131.866048757656;6217.316095229431;6228.750849965951;6252.124702541557;6203.472704820141;6228.875422491434;6235.376462353728;6241.937580624317;6277.340879207617;5297.152455607084;5926.348101708722;6095.451409373178;6096.116063170727;6152.661603611666;6049.062395328731;6158.107074474266;6174.845628859135;6218.06728990655;6231.345708700703;6068.149682353295;6123.71402005566;6136.325004249618;6141.631502109888;6189.060196406671 06:16:52 INFO - PROCESS | 1665 | |1;ext.html;527.8152646573702;543.2774410034654;543.2828666160669;591.9936108615352;614.9415805498479;37353.25293494129;38138.855834324946;38175.61824381755;38186.42720359197;38503.22993540131;39765.20469590607;40004.199916001664;40141.799291003575;40233.79883100588;40285.39571906424;9318.440893546374;9540.809183816355;9551.856722149174;9588.472634005127;9606.711798646053;9406.388584742004;9671.468069256189;9693.224542036656;9697.224222062217;9710.271729620272;8545.060043395222;9512.286578506604;9650.420974741503;9657.179139773129;9673;9548.856767148498;9570.56932438042;9662.90337096627;9676.56455459499;9679.08048735369;9571.33000689952;9675.080867317594;9702.417854928726;9706.126448619587;9709.417434953926;38293.85118446451;38397.80801096005;38635.420468692995;39163;39194;3196.7922085064397;3248.480243161083;3304.735621150302;3431.759776815624;3676.852925882988;28518.572221416696;28648.85675571609;29014.27464313388;29625.259368515744;29912.10263692093;2679.9866000670067;2715.7963152763623;2779.471900338929;2817.281593193743;2887.2781804548863;461566;469138;473434.99999999657;473839.78480645636;475477;36448.81775591105;69040.65479672569;69131.65434172798;69664.30335696579;70130.29869701237;37065.62934370622;37106.257874842355;37383;37392.81303593519;37465.625343746215;14784.852151478563;14785.408583656748;14931.178785166703;15105.924470377797;15303.770443443358;12849.036322275866;12927.965762738959;13015.869841301655;13022;13077.346132693327;8305.501669899826;8358.331333493306;8478.321734261368;8530.74407767768;8531.317494600416;3524.647535246455;3560.3769340365334;3580.803055831954;3589.6230895756094;3613.0786649404236;940.7130825098274;989.5794287427815;1068.0974576482859;1084.967450976472;1099.6865893220395;26324.290045777896;28191.872325107175;30263.546046808875;30303.545446818316;30531.542026869614;1066;1098.2970898624887;1138.9430528473708;1204.7831390349645;1219.2928101700993;14259.42962281497;15609.219539023003;15776.97449665768;15778.13220272896;15858.60353491172;630634;637910;643686;645712;648015;57853.71073144692;59948;60083.699581501816;60413.4896627579;60425.69787151124;1466.5233799015364;1469.9853001469849;1480.3634437191895;1483.7180935622198;1484.3839806480405;29463.26341841471;29752.85123574368;30020.099397018126;30234.470188507017;30238.69761302447;53795.46204537905;54220.728896355264;54223.72888135534;54575.454245458626;54645.72677136589;578022;578393;583402;583764;585787;27620;27887.721122789324;27943.16170514888;27985.860070699517;28331.008414705386;45993;46671.76664116794;47016.52983470258;47502.76248618735;47990.760046199546;31465;31909;34609.30781384408;38014.61985380111;39026.41460378154;37859.24281514409;37903.81048094742;38019.23961520809;38463.615363846;38622.6137738619;32494.83752581222;37745.81127094457;38272;38321.23357532889;39078.21843563056;27534.862325688242;30481.628326725793;31854.68145318517;31877.681223187472;31953.041408757774;24095.277141685776;24260.272191834272;24658.013679452622;24769.009239630934;24962.875185623954 06:16:52 INFO - PROCESS | 1665 | |2;jquery.html;366.47227991691966;390.2604564350556;391.6807801641664;403.582292327441;410.2901979575336;18652.90673546632;20640.793592064074;20940.685889711665;20966.790332096676;21526.784732152675;19576.804231957674;19851.900740496276;20168.991550422492;20408.183672653115;21143;5193.818216362428;5835.270591176113;6025.879482410349;6028.577999540034;6039;4033.6773058155277;6120.938790612081;6477.157969463987;6491.902621460682;6509.6419696916655;5380.515753582177;6386.680665966706;6416.807495775134;6443.677816109176;6446.548741588091;5782.595218334718;6361.872762544746;6403.231612206565;6426.260979987291;6534.379233972765;5426.186072089179;5702.914456283159;5727.484526392603;5740.54075673945;5761.942380576183;25570;25857;26097.217083487525;26186.512281333435;26321.473570528484;1791.0149417820278;1803.9909800450914;2304.873231972241;2346;2399.58007348715;9091.499967501784;10931.836022459669;11859.940700296529;14647.340869660891;15127.697446051017;1692.93228270869;1726.5942503511665;1729.5848996240939;1775.8845675031082;1782.6612943540686;115844;121382;122356.99999999911;125909;130879.34560327137;11471.655850324503;11491.885081149248;11536.653900383002;11600.76798464026;11783;14595.343209555596;14672;14742.18917959501;14929.70140597182;14938.551843444715;8486.278666313308;8619.439736417113;8701.521416322163;8720.473917064488;8726.734623479686;8403.41176117666;8408.32733381328;8480.279176269964;8481.787955301043;8549.546577081912;3850.730448868608;4194.266003449384;4522.547745225451;4601.677882548256;4625.653076019312;1688.8817782755089;1853.7960824309316;1911.9139638716013;1981.9108140133728;1991.9502012449805;929.9349045566745;932.9953350233205;942.665353799405;998.9500524973722;1020.4947702139433;18531.351402700842;18886;20063.799362006484;20376.898115509328;20441;928.5774972387547;982.0768477631004;1003.4781913404988;1009.4498498318434;1058.2697938422464;10037.648682296085;10325;10356.326838755607;10421.895781042092;10430.68707938763;561122;581432;582194;598568;602892;96233.51883240539;116619;123586.76413235933;126591;130193.34903325423;997.9151772099453;998.8363556456792;1016.527314798637;1018.6383833739064;1024.6208902706046;16744.581385464975;16820.074895880844;16978.660426791146;17322.30710771555;17397.565060873578;46254.53745462637;50792.746036269586;50890.23664644959;50915.49084509107;51526.74236628793;69656;73594.63202683952;75632;75665;77347.61326193334;5887.5289976802605;6427.971524556048;6842.828929276808;7575.507592006502;8314.501129932223;10540.577022101917;11227.55089796399;11913.880861191277;12430.254184748945;12637.93681031589;10321.174306055347;10569.260151789302;10684.038436540437;10783.784324313312;11030.669079927615;10439.321444106108;10490.370577765358;10662;10800.837987430352;10936.671899843017;9644.9035509644;10830.891691082988;11157.609483668357;11299.943500282447;11385;7339.302766237199;7356.852862942818;7445.851082978418;7460.962695186489;7522.5862577558755;9448;10660.413677247516;10707.464626768786;10734.677959661223;10830.729231768953 06:16:52 INFO - PROCESS | 1665 | |3;mootools.html;1586.2623879895846;1638.5084474657604;1872.4944265048437;1931.7681878174621;1936.5255512399456;7049.647517624111;7900.604969751518;8551.401401901869;8829.558522073903;8833.293336533077;8587.270082043018;8614.827703445928;8690.08754080822;8708.564571771401;8756.12438756124;2396.125414223813;2422.39440139965;2434.4522482441484;2440.6583078369044;2441.1333976438377;2380.071772008918;2405.2663937499055;2425.890834912433;2456.250843492734;2460.1512478194995;2427.8057755379527;2431.209856796548;2437.9512409751796;2449.09383528094;2460.9261722148362;2011.5775687105725;2337.8714170720687;2338.0414030247516;2341.051873991028;2355.128602417108;2411.2645643078854;2415.613501839715;2417.4319035026756;2427.453822889853;2450.718167410753;8822.250108740765;8856.8671469928;8898.777530561723;8927.687530936451;8935.687250946186;4285.164392943378;5267.420583735786;5291.3385826771655;5404.729763511848;5425.945740542623;3509.631488693676;3562.9133114400356;3574.249407624402;3618.113562177257;3626.4016437287814;1028.9897101029044;1038.1176000399676;1044.3577200022007;1057.571683468189;1083.6044843632096;11519;11696.590619328283;11703.765924681458;11739.471723772365;11745.706357341049;4619.422572178478;4644.326572646947;4837.129316722953;4861.149298872683;4896.804127834918;9896.406215627085;9920.355176913621;9920.950395247977;9941.453220072965;9945.80108397828;5340.439253878365;5357.223202635596;5358.115910874662;5368.087425137736;5395.3525576931015;4416.33754936762;4746.501617330199;4889.779959901813;4901.117798796179;4920.40955085392;4028.8589899353383;4059.654929330981;4085.673146148301;4153;4170.854020109282;1355.9525416610372;1358.3547814787896;1360.9183448992894;1368.8152099466645;1377.7520046391746;820.5240960243045;843.9156084391511;898.1557336104041;902.4044130873723;950.0404591362635;5256.869772998747;5846.532277417797;5936.257967754031;5948.613340132878;6010.435129939819;803.5540275147232;823.8260478817781;900.7658008917598;929.9163075323119;961.1253759079204;3262.885798997024;3883.339832228528;3898.5321761388814;3972.324704800191;3986.505060602274;10254.333468324536;10846;10900.563977440972;10968.616098436516;10989.230753847314;10702.946485267525;10833.945830270799;10886.129109671365;10893;10940.671779846618;8143.470674406145;8313.750587482264;8376.455530390505;8414.537200453911;8428.873566896502;4381.802818873222;4915.6067514598035;5672.914906276326;5800.535957123336;5820.592558520862;9881.110700036743;10049.447280399649;10054.8491772622;10076.647317343857;10161.847572286273;9855.655052073143;10141.239407044648;10199.13307368882;10313.587456501957;10419.374837509773;6500.057491663777;6867.519273650796;7044.436445084483;7077.327653872874;7174.569525828467;8333.624986875726;8361.205685459872;8431.03043150021;8432.873506897524;8457.492550446992;7309.963450182715;7361.558306501627;7422;7537.849243015218;7581.772546823604;5750.6262092963825;7092.148942126978;7232.493725439169;7288.052553168054;7385.630718463948;6804.76183333581;6869.313068693091;6912.758053468105;6927.653617319013;6977.616231107338;4829.517048295143;4853.6602437829015;4873.853784386474;4957.107720610325;5062.746862656926;4837.927431088607;4864.902701945871;4877.292792545132;4929.2359684248995;5114.514121158484 06:16:52 INFO - PROCESS | 1665 | |4;prototype.html;321.13934655124274;323.7377724043524;329.91092405050637;330.55045138611484;333.1255454432116;5609.439056094388;6101.816945491637;6171.413715697013;6229.532785041129;6273.3726627337355;5143.3570803649545;6155.953487907055;6169.259688837335;6184.16513770642;6186.483866777256;3793.905152371185;4389.692721509496;4499.145162419146;4592.380028696117;4612.815487380518;4363.167469662733;4467.771362875203;4600.631949444037;4638.83764068256;4659.930101048487;3939.8227079781336;4072.572379900112;4256.5105012923605;4578.427696537933;4601.194790911593;3495.912602184953;4550.954490455103;4586.885327866797;4589.151007063704;4606.82129330764;3973.562908080109;3974.5230572331507;3993;4005.459262999487;4007.438958545806;5862.648241105548;5886.676232807194;5903.675297858616;5909.940900590982;5946.524278057745;4295.9474928642685;5124.6419698779855;5296.073187192226;5447.7119609763595;5466.34403871538;5317.627766056377;5834.97082514589;6261.998080307175;6564.8137971003325;6568.93431065688;3781.716371272138;4488.304312831517;4490.461144662629;4502.144592527442;4507.909841803178;6374.298827129012;6440.4847612190915;6557.409833114994;6805.727770889159;6828.015548649514;3492.8253587320532;3740.9438858417147;3764.604716504782;4318.805653745589;4347.152305300436;3444.50054742061;4201.873943781691;4392.9896123891685;4397.494288156839;4412.294032954776;5065.341505604248;5418.783248670088;5430.64700794455;5441.918371224435;5451.64564303319;5584.63699859516;6541.542092053605;6564.245111812107;6639.402453779183;6658.500612454085;1414.6392669869117;1508.2835653064706;1588.7458006718869;1589.4834178891674;1601.4074792326915;988.268681175939;1040.7242080848582;1046.5709059285657;1062.7247303236147;1066.2376400873259;5111.105556527593;5705.828825135252;5768.769249229984;6136.447719705248;6136.754529818846;5624.634398764068;6223.0354295084335;6566.4418524425;6804.4216241620015;6805.217399999064;5142.428785607196;5743.770249190069;6083.9391606084255;6099.237595300588;6117.357677443893;3271.3457308538386;3533.363994481018;3541.29174165168;3553.5608078728155;3559;5564.051052941947;6735.629540375228;7042.92957070433;7054.75308364215;7082.752103676346;5777.364489906107;6622.8344291393105;6926.896096558556;6987.231404545496;7021.26170793391;5732.3407808101765;6112.2970858351855;7034.804083305952;7038.155421349471;7079.39825114871;5008.6744361616375;5805.680687562056;6022.45797878193;6696.660667866544;6791.845386284244;5814.534837212928;6419.935800641933;6684.498662600422;6706.463482921257;6720.966395167993;7033.859322813412;7046.401055910305;7058.329458701415;7091.468139889632;7091.893621595784;4552.635789136927;4585.747783871786;4588.082383523375;4590.931136033029;4598.4711758146905;6410.839729006626;6671.866562668816;6672.833179170365;6722.764703235363;6810.523263371517;6382.840428989312;6448.323945562539;6506.804795856132;6508.739650413931;6546.738130474728;5894.823155305347;6261.217347831521;6462.700585519829;6500.642464664489;6561.704723287368;5253.89492210146;5441.2654291670115;6137.447629713347;6304.873902522016;6323.336049714898;5217.399999000164;5783.450572195635;6360.982242841308;6388.881945659584;6575.178102737158;5387.973060134675;6215.223097112861;6358.459530939922;6471.314404522071;6490.318516555693 06:16:52 INFO - PROCESS | 1665 | |5;yui.html;567.5573053018644;730.5215084119901;761.4936067515099;762.1159455032164;814.3281792521168;14818;15037.172955487444;15072.32174552145;15248.542543723679;15316.310766015527;11259;12124.93937530311;14020.018598698096;14038.157710537374;14097.718045639082;730.8392153726198;855.7249697950072;941.0824446165003;943.377370935183;957.6169532187112;774.260581145008;945.4421891084259;946.7443790176649;947.3415975896754;948.2698322291831;993.9503024848729;995.9651412200575;1006.954687039085;1007.4308015970989;1009.8232809258387;966.3718582921088;966.4974213409023;966.8936416994125;966.9323147379686;968.6464440479209;726.0960104669667;730.9195988441268;732.5128789355073;735.7755884455239;741.0366523519403;14988.850111498854;15206.543803685796;15227.162506062163;15280.388784448609;15304.005239659387;10618.681439556825;11237.213395062348;12546.874531254753;12571.434285457177;12650.430730617052;11037.779244415067;11134.27627204229;11221.495032723466;11261.887381126166;11688.707782305426;4092.7339722918214;4103.7948102594755;4141.91716165675;4148.128892932487;4156.168766246763;87213;87417.25165496655;88419.55790221007;88603.55698221468;89472;9355.53222338894;9479.146876781122;9652.662156824477;9965.701028968997;9998.1001709845;22062;22404.43988900258;22448;22450.88774556117;22935.54128917412;7372.410207183412;7521.247875212435;7565.319121279002;7603.9619801900635;7802.063752349754;4025.174839158024;4075.5924407559005;4077.5310839253866;4079.265732168179;4085.693572981979;3563.465480177994;3635.94546081809;3652.36083685354;3661.359262129117;3665.2119794244363;683.928187540311;703.4267072336132;703.8381172330393;714.5748279773527;722.6170129831092;563.7378618942212;582.347770497046;589.7228302697725;615.4860691322706;628.8207860759753;7805.453618246668;7936.801579960432;8011.919880801117;8018.398620103516;8182.549959752271;568.3605943313772;578.9400638420177;595.6366616364014;599.4215581963426;618.6411881108946;3786.746885603062;3799.715021373408;3860.1576936678425;3915.2169566086895;4044.5348784889525;79723.00692482735;98247;98801;100655;101034.49482752687;74167;75512.24487755162;76911.61544192243;77488;77612.22387776163;62879.05681414691;63219.683901580196;64089;64998.67500662561;66138.66930665412;7377.8155546111775;7446.25537446251;7467.02928619276;7563.168051514439;7563.8109047272055;45266;45533;45657.40199093016;46581.76709116433;47130.821729457035;57260.71369643125;60592.39407605868;61405.46486337877;65235;65773.68452631016;10973.780524389627;11151.944240278746;11215.158863085464;11359.204855660024;11634.6509604712;9883.258755593215;11904.345261010727;12342;12367.62897113088;12430.378481076092;11304.830427543759;11540.076793856304;11555.191136620357;11560.884391155982;11964.64106076819;11544.94227528857;11648.767024659628;11708.531658733555;11962.700932476757;11981.932007290718;11429.428528573371;11443.198976071595;11456.656300311004;11671.74039769445;11721.413929303671;7147.017678364142;8512.687608295051;9363.887988429957;9617;10228.59085636596;9651.324407291422;10169.135623472088;10185.541650625888;10207.693769186937;10207.693769186937 06:16:52 INFO - PROCESS | 1665 | __end_tp_report 06:16:52 INFO - PROCESS | 1665 | __start_cc_report 06:16:52 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,403 06:16:52 INFO - PROCESS | 1665 | __end_cc_report 06:16:52 INFO - PROCESS | 1665 | __startTimestamp1461331012520__endTimestamp 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:16:52 INFO - PROCESS | 1665 | Number of tests: 6 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5759.43 Median:6095.45 stddev:800.58 (13.1%) stddev-sans-first:779.18 06:16:52 INFO - PROCESS | 1665 | Values: 3287.1 3546.7 3554.9 3560.7 3572.2 5439.7 5820.7 5847.6 5860.5 5865.9 5722.6 5807.6 5864.6 5882.1 5974.4 5186.9 5271.9 5290.4 5298.4 5348.3 236.8 4208.6 5218.5 5246.1 5255.1 5249.0 5249.3 5260.1 5287.0 5312.6 5295.6 5296.6 5308.5 5321.6 5329.3 4260.9 4730.3 5100.1 5111.7 5268.4 4830.6 5584.9 5741.4 5776.9 5797.1 6239.5 6254.4 6277.8 6280.0 6308.5 6172.5 6214.6 6253.0 6311.2 6319.1 5948.4 5982.9 5995.0 6007.4 6030.0 5246.3 6233.0 6376.3 6388.9 6391.2 6163.0 6226.8 6252.0 6254.0 6281.3 6219.5 6251.4 6275.8 6296.6 6329.6 6137.4 6186.8 6252.9 6283.2 6283.9 6200.3 6211.4 6219.5 6226.8 6254.2 4874.0 4952.6 4960.9 4971.7 4975.6 4452.5 4458.0 4463.1 4514.9 4521.6 5403.5 5822.5 5921.5 5938.3 5946.7 6180.1 6252.7 6273.8 6279.8 6338.1 5974.1 6001.4 6014.2 6059.5 6083.5 5395.5 5496.5 5508.9 5510.8 5511.3 5743.7 6429.5 6527.3 6531.1 6547.1 6269.2 6312.5 6313.1 6314.9 6322.7 6296.5 6336.1 6436.2 6481.7 6541.7 6232.5 6279.3 6288.7 6302.6 6321.0 6273.0 6275.4 6281.0 6281.4 6296.4 4622.5 6131.9 6217.3 6228.8 6252.1 6203.5 6228.9 6235.4 6241.9 6277.3 5297.2 5926.3 6095.5 6096.1 6152.7 6049.1 6158.1 6174.8 6218.1 6231.3 6068.1 6123.7 6136.3 6141.6 6189.1 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:68538.02 Median:38181.02 stddev:152377.28 (399.1%) stddev-sans-first:152719.18 06:16:52 INFO - PROCESS | 1665 | Values: 527.8 543.3 543.3 592.0 614.9 37353.3 38138.9 38175.6 38186.4 38503.2 39765.2 40004.2 40141.8 40233.8 40285.4 9318.4 9540.8 9551.9 9588.5 9606.7 9406.4 9671.5 9693.2 9697.2 9710.3 8545.1 9512.3 9650.4 9657.2 9673.0 9548.9 9570.6 9662.9 9676.6 9679.1 9571.3 9675.1 9702.4 9706.1 9709.4 38293.9 38397.8 38635.4 39163.0 39194.0 3196.8 3248.5 3304.7 3431.8 3676.9 28518.6 28648.9 29014.3 29625.3 29912.1 2680.0 2715.8 2779.5 2817.3 2887.3 461566.0 469138.0 473435.0 473839.8 475477.0 36448.8 69040.7 69131.7 69664.3 70130.3 37065.6 37106.3 37383.0 37392.8 37465.6 14784.9 14785.4 14931.2 15105.9 15303.8 12849.0 12928.0 13015.9 13022.0 13077.3 8305.5 8358.3 8478.3 8530.7 8531.3 3524.6 3560.4 3580.8 3589.6 3613.1 940.7 989.6 1068.1 1085.0 1099.7 26324.3 28191.9 30263.5 30303.5 30531.5 1066.0 1098.3 1138.9 1204.8 1219.3 14259.4 15609.2 15777.0 15778.1 15858.6 630634.0 637910.0 643686.0 645712.0 648015.0 57853.7 59948.0 60083.7 60413.5 60425.7 1466.5 1470.0 1480.4 1483.7 1484.4 29463.3 29752.9 30020.1 30234.5 30238.7 53795.5 54220.7 54223.7 54575.5 54645.7 578022.0 578393.0 583402.0 583764.0 585787.0 27620.0 27887.7 27943.2 27985.9 28331.0 45993.0 46671.8 47016.5 47502.8 47990.8 31465.0 31909.0 34609.3 38014.6 39026.4 37859.2 37903.8 38019.2 38463.6 38622.6 32494.8 37745.8 38272.0 38321.2 39078.2 27534.9 30481.6 31854.7 31877.7 31953.0 24095.3 24260.3 24658.0 24769.0 24962.9 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34264.22 Median:2325.44 stddev:97713.97 (4202.0%) stddev-sans-first:97954.94 06:16:52 INFO - PROCESS | 1665 | Values: 366.5 390.3 391.7 403.6 410.3 18652.9 20640.8 20940.7 20966.8 21526.8 19576.8 19851.9 20169.0 20408.2 21143.0 5193.8 5835.3 6025.9 6028.6 6039.0 4033.7 6120.9 6477.2 6491.9 6509.6 5380.5 6386.7 6416.8 6443.7 6446.5 5782.6 6361.9 6403.2 6426.3 6534.4 5426.2 5702.9 5727.5 5740.5 5761.9 25570.0 25857.0 26097.2 26186.5 26321.5 1791.0 1804.0 2304.9 2346.0 2399.6 9091.5 10931.8 11859.9 14647.3 15127.7 1692.9 1726.6 1729.6 1775.9 1782.7 115844.0 121382.0 122357.0 125909.0 130879.3 11471.7 11491.9 11536.7 11600.8 11783.0 14595.3 14672.0 14742.2 14929.7 14938.6 8486.3 8619.4 8701.5 8720.5 8726.7 8403.4 8408.3 8480.3 8481.8 8549.5 3850.7 4194.3 4522.5 4601.7 4625.7 1688.9 1853.8 1911.9 1981.9 1992.0 929.9 933.0 942.7 999.0 1020.5 18531.4 18886.0 20063.8 20376.9 20441.0 928.6 982.1 1003.5 1009.4 1058.3 10037.6 10325.0 10356.3 10421.9 10430.7 561122.0 581432.0 582194.0 598568.0 602892.0 96233.5 116619.0 123586.8 126591.0 130193.3 997.9 998.8 1016.5 1018.6 1024.6 16744.6 16820.1 16978.7 17322.3 17397.6 46254.5 50792.7 50890.2 50915.5 51526.7 69656.0 73594.6 75632.0 75665.0 77347.6 5887.5 6428.0 6842.8 7575.5 8314.5 10540.6 11227.6 11913.9 12430.3 12637.9 10321.2 10569.3 10684.0 10783.8 11030.7 10439.3 10490.4 10662.0 10800.8 10936.7 9644.9 10830.9 11157.6 11299.9 11385.0 7339.3 7356.9 7445.9 7461.0 7522.6 9448.0 10660.4 10707.5 10734.7 10830.7 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5685.74 Median:4875.57 stddev:3192.63 (65.5%) stddev-sans-first:3186.73 06:16:52 INFO - PROCESS | 1665 | Values: 1586.3 1638.5 1872.5 1931.8 1936.5 7049.6 7900.6 8551.4 8829.6 8833.3 8587.3 8614.8 8690.1 8708.6 8756.1 2396.1 2422.4 2434.5 2440.7 2441.1 2380.1 2405.3 2425.9 2456.3 2460.2 2427.8 2431.2 2438.0 2449.1 2460.9 2011.6 2337.9 2338.0 2341.1 2355.1 2411.3 2415.6 2417.4 2427.5 2450.7 8822.3 8856.9 8898.8 8927.7 8935.7 4285.2 5267.4 5291.3 5404.7 5425.9 3509.6 3562.9 3574.2 3618.1 3626.4 1029.0 1038.1 1044.4 1057.6 1083.6 11519.0 11696.6 11703.8 11739.5 11745.7 4619.4 4644.3 4837.1 4861.1 4896.8 9896.4 9920.4 9921.0 9941.5 9945.8 5340.4 5357.2 5358.1 5368.1 5395.4 4416.3 4746.5 4889.8 4901.1 4920.4 4028.9 4059.7 4085.7 4153.0 4170.9 1356.0 1358.4 1360.9 1368.8 1377.8 820.5 843.9 898.2 902.4 950.0 5256.9 5846.5 5936.3 5948.6 6010.4 803.6 823.8 900.8 929.9 961.1 3262.9 3883.3 3898.5 3972.3 3986.5 10254.3 10846.0 10900.6 10968.6 10989.2 10702.9 10833.9 10886.1 10893.0 10940.7 8143.5 8313.8 8376.5 8414.5 8428.9 4381.8 4915.6 5672.9 5800.5 5820.6 9881.1 10049.4 10054.8 10076.6 10161.8 9855.7 10141.2 10199.1 10313.6 10419.4 6500.1 6867.5 7044.4 7077.3 7174.6 8333.6 8361.2 8431.0 8432.9 8457.5 7310.0 7361.6 7422.0 7537.8 7581.8 5750.6 7092.1 7232.5 7288.1 7385.6 6804.8 6869.3 6912.8 6927.7 6977.6 4829.5 4853.7 4873.9 4957.1 5062.7 4837.9 4864.9 4877.3 4929.2 5114.5 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5215.11 Median:5773.07 stddev:1646.94 (28.5%) stddev-sans-first:1610.08 06:16:52 INFO - PROCESS | 1665 | Values: 321.1 323.7 329.9 330.6 333.1 5609.4 6101.8 6171.4 6229.5 6273.4 5143.4 6156.0 6169.3 6184.2 6186.5 3793.9 4389.7 4499.1 4592.4 4612.8 4363.2 4467.8 4600.6 4638.8 4659.9 3939.8 4072.6 4256.5 4578.4 4601.2 3495.9 4551.0 4586.9 4589.2 4606.8 3973.6 3974.5 3993.0 4005.5 4007.4 5862.6 5886.7 5903.7 5909.9 5946.5 4295.9 5124.6 5296.1 5447.7 5466.3 5317.6 5835.0 6262.0 6564.8 6568.9 3781.7 4488.3 4490.5 4502.1 4507.9 6374.3 6440.5 6557.4 6805.7 6828.0 3492.8 3740.9 3764.6 4318.8 4347.2 3444.5 4201.9 4393.0 4397.5 4412.3 5065.3 5418.8 5430.6 5441.9 5451.6 5584.6 6541.5 6564.2 6639.4 6658.5 1414.6 1508.3 1588.7 1589.5 1601.4 988.3 1040.7 1046.6 1062.7 1066.2 5111.1 5705.8 5768.8 6136.4 6136.8 5624.6 6223.0 6566.4 6804.4 6805.2 5142.4 5743.8 6083.9 6099.2 6117.4 3271.3 3533.4 3541.3 3553.6 3559.0 5564.1 6735.6 7042.9 7054.8 7082.8 5777.4 6622.8 6926.9 6987.2 7021.3 5732.3 6112.3 7034.8 7038.2 7079.4 5008.7 5805.7 6022.5 6696.7 6791.8 5814.5 6419.9 6684.5 6706.5 6721.0 7033.9 7046.4 7058.3 7091.5 7091.9 4552.6 4585.7 4588.1 4590.9 4598.5 6410.8 6671.9 6672.8 6722.8 6810.5 6382.8 6448.3 6506.8 6508.7 6546.7 5894.8 6261.2 6462.7 6500.6 6561.7 5253.9 5441.3 6137.4 6304.9 6323.3 5217.4 5783.5 6361.0 6388.9 6575.2 5388.0 6215.2 6358.5 6471.3 6490.3 06:16:52 INFO - PROCESS | 1665 | 06:16:52 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18173.71 Median:567.96 stddev:25707.25 (4526.3%) stddev-sans-first:25745.38 06:16:52 INFO - PROCESS | 1665 | Values: 567.6 730.5 761.5 762.1 814.3 14818.0 15037.2 15072.3 15248.5 15316.3 11259.0 12124.9 14020.0 14038.2 14097.7 730.8 855.7 941.1 943.4 957.6 774.3 945.4 946.7 947.3 948.3 994.0 996.0 1007.0 1007.4 1009.8 966.4 966.5 966.9 966.9 968.6 726.1 730.9 732.5 735.8 741.0 14988.9 15206.5 15227.2 15280.4 15304.0 10618.7 11237.2 12546.9 12571.4 12650.4 11037.8 11134.3 11221.5 11261.9 11688.7 4092.7 4103.8 4141.9 4148.1 4156.2 87213.0 87417.3 88419.6 88603.6 89472.0 9355.5 9479.1 9652.7 9965.7 9998.1 22062.0 22404.4 22448.0 22450.9 22935.5 7372.4 7521.2 7565.3 7604.0 7802.1 4025.2 4075.6 4077.5 4079.3 4085.7 3563.5 3635.9 3652.4 3661.4 3665.2 683.9 703.4 703.8 714.6 722.6 563.7 582.3 589.7 615.5 628.8 7805.5 7936.8 8011.9 8018.4 8182.5 568.4 578.9 595.6 599.4 618.6 3786.7 3799.7 3860.2 3915.2 4044.5 79723.0 98247.0 98801.0 100655.0 101034.5 74167.0 75512.2 76911.6 77488.0 77612.2 62879.1 63219.7 64089.0 64998.7 66138.7 7377.8 7446.3 7467.0 7563.2 7563.8 45266.0 45533.0 45657.4 46581.8 47130.8 57260.7 60592.4 61405.5 65235.0 65773.7 10973.8 11151.9 11215.2 11359.2 11634.7 9883.3 11904.3 12342.0 12367.6 12430.4 11304.8 11540.1 11555.2 11560.9 11964.6 11544.9 11648.8 11708.5 11962.7 11981.9 11429.4 11443.2 11456.7 11671.7 11721.4 7147.0 8512.7 9363.9 9617.0 10228.6 9651.3 10169.1 10185.5 10207.7 10207.7 06:16:52 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:16:52 INFO - PROCESS | 1665 | 06:16:53 INFO - TEST-INFO | 1665: exit 0 06:16:53 INFO - TEST-OK | dromaeo_css | took 1112238ms 06:16:53 INFO - TEST-START | kraken 06:16:53 INFO - operating with platform_type : mac_ 06:16:53 INFO - Initialising browser for kraken test... 06:16:53 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp8nmos1/profile http://localhost:49283/getInfo.html) 06:16:56 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 06:16:56 INFO - PROCESS | 1676 | colorDepth:24 06:16:56 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 06:16:56 INFO - PROCESS | 1676 | __metrics 06:16:56 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:16:56 INFO - TEST-INFO | 1676: exit 0 06:16:56 INFO - Browser initialized. 06:16:56 INFO - Running cycle 1/1 for kraken test... 06:16:56 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp8nmos1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:08 INFO - PROCESS | 1679 | RSS: Main: 247943168 06:17:08 INFO - PROCESS | 1679 | 06:17:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:12 INFO - PROCESS | 1679 | RSS: Main: 260141056 06:17:12 INFO - PROCESS | 1679 | 06:17:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 06:17:15 INFO - PROCESS | 1679 | RSS: Main: 269418496 06:17:15 INFO - PROCESS | 1679 | 06:17:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 06:17:19 INFO - PROCESS | 1679 | RSS: Main: 272662528 06:17:19 INFO - PROCESS | 1679 | 06:17:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 06:17:22 INFO - PROCESS | 1679 | RSS: Main: 274300928 06:17:22 INFO - PROCESS | 1679 | 06:17:24 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:24 INFO - PROCESS | 1679 | RSS: Main: 275550208 06:17:24 INFO - PROCESS | 1679 | 06:17:27 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:28 INFO - PROCESS | 1679 | RSS: Main: 275763200 06:17:28 INFO - PROCESS | 1679 | 06:17:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:31 INFO - PROCESS | 1679 | RSS: Main: 275693568 06:17:31 INFO - PROCESS | 1679 | 06:17:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 06:17:35 INFO - PROCESS | 1679 | RSS: Main: 275767296 06:17:35 INFO - PROCESS | 1679 | 06:17:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:37 INFO - PROCESS | 1679 | RSS: Main: 274931712 06:17:37 INFO - PROCESS | 1679 | 06:17:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:40 INFO - PROCESS | 1679 | RSS: Main: 275091456 06:17:40 INFO - PROCESS | 1679 | 06:17:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:42 INFO - PROCESS | 1679 | RSS: Main: 275394560 06:17:42 INFO - PROCESS | 1679 | 06:17:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:46 INFO - PROCESS | 1679 | RSS: Main: 275464192 06:17:46 INFO - PROCESS | 1679 | 06:17:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:50 INFO - PROCESS | 1679 | RSS: Main: 275513344 06:17:50 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 06:17:52 INFO - PROCESS | 1679 | RSS: Main: 277278720 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | __start_tp_report 06:17:52 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 06:17:52 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 06:17:52 INFO - PROCESS | 1679 | |i|pagename|runs| 06:17:52 INFO - PROCESS | 1679 | |0;ai-astar;118;109;116;116;116;130;116;117;116;105 06:17:52 INFO - PROCESS | 1679 | |1;audio-beat-detection;153;122;145;161;121;149;120;162;157;145 06:17:52 INFO - PROCESS | 1679 | |2;audio-dft;194;192;196;211;259;170;253;277;202;197 06:17:52 INFO - PROCESS | 1679 | |3;audio-fft;63;90;75;143;57;57;56;64;132;58 06:17:52 INFO - PROCESS | 1679 | |4;audio-oscillator;78;83;126;76;82;82;118;81;80;119 06:17:52 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;89;136;128;89;86;87;85;88;85 06:17:52 INFO - PROCESS | 1679 | |6;imaging-darkroom;100;95;94;95;95;94;94;105;94;100 06:17:52 INFO - PROCESS | 1679 | |7;imaging-desaturate;93;93;90;93;99;91;90;93;86;91 06:17:52 INFO - PROCESS | 1679 | |8;json-parse-financial;62;63;60;62;63;61;59;80;64;61 06:17:52 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;65;64;73;101;107;106;78;65;66 06:17:52 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;87;83;84;84;81;84;82;87;84;86 06:17:52 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;165;167;149;143;140;155;146;161;186;233 06:17:52 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;216;174;194;183;171;172;178;206;190;225 06:17:52 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;66;88;72;61;70;102;90;70;57;73 06:17:52 INFO - PROCESS | 1679 | __end_tp_report 06:17:52 INFO - PROCESS | 1679 | __start_cc_report 06:17:52 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1027 06:17:52 INFO - PROCESS | 1679 | __end_cc_report 06:17:52 INFO - PROCESS | 1679 | __startTimestamp1461331072256__endTimestamp 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | ------- Summary: start ------- 06:17:52 INFO - PROCESS | 1679 | Number of tests: 14 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:6.42 (5.5%) stddev-sans-first:6.76 06:17:52 INFO - PROCESS | 1679 | Values: 118.0 109.0 116.0 116.0 116.0 130.0 116.0 117.0 116.0 105.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:151.00 stddev:16.59 (11.0%) stddev-sans-first:17.23 06:17:52 INFO - PROCESS | 1679 | Values: 153.0 122.0 145.0 161.0 121.0 149.0 120.0 162.0 157.0 145.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:215.10 Median:206.50 stddev:35.10 (17.0%) stddev-sans-first:36.39 06:17:52 INFO - PROCESS | 1679 | Values: 194.0 192.0 196.0 211.0 259.0 170.0 253.0 277.0 202.0 197.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:79.50 Median:60.50 stddev:32.42 (53.6%) stddev-sans-first:33.83 06:17:52 INFO - PROCESS | 1679 | Values: 63.0 90.0 75.0 143.0 57.0 57.0 56.0 64.0 132.0 58.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:80.50 stddev:19.88 (24.7%) stddev-sans-first:20.38 06:17:52 INFO - PROCESS | 1679 | Values: 78.0 83.0 126.0 76.0 82.0 82.0 118.0 81.0 80.0 119.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:87.50 stddev:19.03 (21.7%) stddev-sans-first:20.00 06:17:52 INFO - PROCESS | 1679 | Values: 89.0 89.0 136.0 128.0 89.0 86.0 87.0 85.0 88.0 85.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:94.00 stddev:3.78 (4.0%) stddev-sans-first:3.80 06:17:52 INFO - PROCESS | 1679 | Values: 100.0 95.0 94.0 95.0 95.0 94.0 94.0 105.0 94.0 100.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:93.00 stddev:3.31 (3.6%) stddev-sans-first:3.49 06:17:52 INFO - PROCESS | 1679 | Values: 93.0 93.0 90.0 93.0 99.0 91.0 90.0 93.0 86.0 91.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:62.50 stddev:5.99 (9.6%) stddev-sans-first:6.32 06:17:52 INFO - PROCESS | 1679 | Values: 62.0 63.0 60.0 62.0 63.0 61.0 59.0 80.0 64.0 61.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:79.00 Median:65.00 stddev:18.31 (28.2%) stddev-sans-first:18.70 06:17:52 INFO - PROCESS | 1679 | Values: 65.0 65.0 64.0 73.0 101.0 107.0 106.0 78.0 65.0 66.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.99 (2.4%) stddev-sans-first:1.83 06:17:52 INFO - PROCESS | 1679 | Values: 87.0 83.0 84.0 84.0 81.0 84.0 82.0 87.0 84.0 86.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:164.50 Median:163.00 stddev:27.71 (17.0%) stddev-sans-first:29.39 06:17:52 INFO - PROCESS | 1679 | Values: 165.0 167.0 149.0 143.0 140.0 155.0 146.0 161.0 186.0 233.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:192.00 stddev:19.15 (10.0%) stddev-sans-first:18.02 06:17:52 INFO - PROCESS | 1679 | Values: 216.0 174.0 194.0 183.0 171.0 172.0 178.0 206.0 190.0 225.0 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:71.00 stddev:14.09 (19.8%) stddev-sans-first:14.57 06:17:52 INFO - PROCESS | 1679 | Values: 66.0 88.0 72.0 61.0 70.0 102.0 90.0 70.0 57.0 73.0 06:17:52 INFO - PROCESS | 1679 | -------- Summary: end -------- 06:17:52 INFO - PROCESS | 1679 | 06:17:52 INFO - TEST-INFO | 1679: exit 0 06:17:53 INFO - TEST-OK | kraken | took 59978ms 06:17:53 INFO - SUITE-END | took 1172s 06:17:53 INFO - Completed test suite (00:19:32) 06:17:53 INFO - javascript benchmark 06:17:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.1453422110253, 3546.6630670086347, 3554.857805687771, 3560.679538841504, 3572.178398968237, 5439.728013599324, 5820.738066786994, 5847.64914105154, 5860.5311575074, 5865.853353666161, 5722.570807189457, 5807.593468457209, 5864.5894787364905, 5882.147088672151, 5974.372690867462, 5186.922196167051, 5271.894562108756, 5290.444503327153, 5298.4436634153435, 5348.251244825728, 236.81746631169196, 4208.600182982612, 5218.478152184789, 5246.055709972204, 5255.106631872591, 5249.02892964799, 5249.265102885599, 5260.079486089957, 5286.995470860525, 5312.574994000471, 5295.629305948585, 5296.576273898079, 5308.469153084699, 5321.600879934021, 5329.307190065306, 4260.8721738347895, 4730.266808644631, 5100.107481190814, 5111.744412779383, 5268.420473747885, 4830.589399901012, 5584.888302233932, 5741.368449470555, 5776.8844623107725, 5797.130430435468, 6239.500839932794, 6254.374562543755, 6277.7802776903045, 6280.0, 6308.463780578656, 6172.537059720539, 6214.5960512566535, 6252.968735156341, 6311.211098612674, 6319.115323854664, 5948.434898684618, 5982.880342393128, 5994.994179859822, 6007.36922623127, 6029.969850150765, 5246.344206974129, 6232.968835155795, 6376.29860715321, 6388.872222555523, 6391.169148010729, 6163.0, 6226.782062627786, 6251.9687401562705, 6254.0, 6281.277653069864, 6219.502439804804, 6251.374862513712, 6275.780347687901, 6296.5592408530965, 6329.620222786648, 6137.407629318989, 6186.81439556814, 6252.906206406908, 6283.214598175228, 6283.905741413882, 6200.286966998763, 6211.409916057967, 6219.533534984895, 6226.750929962841, 6254.249490061222, 4873.951260487421, 4952.579030782352, 4960.883801144713, 4971.676841005323, 4975.601951843843, 4452.465704115527, 4457.977710111429, 4463.129689710475, 4514.864554063383, 4521.638268938477, 5403.459654034644, 5822.475977161991, 5921.496672782776, 5938.346781853993, 5946.672932988728, 6180.103884936659, 6252.656103914328, 6273.780417685359, 6279.806836701012, 6338.112664227012, 5974.133750606138, 6001.4298641628975, 6014.218151640259, 6059.460319987215, 6083.543734219951, 5395.487428694268, 5496.477834605706, 5508.862278442991, 5510.752016159283, 5511.338639363302, 5743.712814359349, 6429.45349645276, 6527.281998980204, 6531.0856480092825, 6547.1161393211305, 6269.185005949197, 6312.5265605078885, 6313.08460273267, 6314.8737025258315, 6322.747090116344, 6296.5277604178955, 6336.081268216175, 6436.227652681709, 6481.675916204265, 6541.70562324687, 6232.501399887908, 6279.277883043508, 6288.717007734572, 6302.621842689453, 6321.0, 6273.0, 6275.403836635513, 6281.026440901667, 6281.434670879643, 6296.370362963667, 4622.491525932078, 6131.866048757656, 6217.316095229431, 6228.750849965951, 6252.124702541557, 6203.472704820141, 6228.875422491434, 6235.376462353728, 6241.937580624317, 6277.340879207617, 5297.152455607084, 5926.348101708722, 6095.451409373178, 6096.116063170727, 6152.661603611666, 6049.062395328731, 6158.107074474266, 6174.845628859135, 6218.06728990655, 6231.345708700703, 6068.149682353295, 6123.71402005566, 6136.325004249618, 6141.631502109888, 6189.060196406671], "value": 5709.667503780871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.8152646573702, 543.2774410034654, 543.2828666160669, 591.9936108615352, 614.9415805498479, 37353.25293494129, 38138.855834324946, 38175.61824381755, 38186.42720359197, 38503.22993540131, 39765.20469590607, 40004.199916001664, 40141.799291003575, 40233.79883100588, 40285.39571906424, 9318.440893546374, 9540.809183816355, 9551.856722149174, 9588.472634005127, 9606.711798646053, 9406.388584742004, 9671.468069256189, 9693.224542036656, 9697.224222062217, 9710.271729620272, 8545.060043395222, 9512.286578506604, 9650.420974741503, 9657.179139773129, 9673.0, 9548.856767148498, 9570.56932438042, 9662.90337096627, 9676.56455459499, 9679.08048735369, 9571.33000689952, 9675.080867317594, 9702.417854928726, 9706.126448619587, 9709.417434953926, 38293.85118446451, 38397.80801096005, 38635.420468692995, 39163.0, 39194.0, 3196.7922085064397, 3248.480243161083, 3304.735621150302, 3431.759776815624, 3676.852925882988, 28518.572221416696, 28648.85675571609, 29014.27464313388, 29625.259368515744, 29912.10263692093, 2679.9866000670067, 2715.7963152763623, 2779.471900338929, 2817.281593193743, 2887.2781804548863, 461566.0, 469138.0, 473434.99999999657, 473839.78480645636, 475477.0, 36448.81775591105, 69040.65479672569, 69131.65434172798, 69664.30335696579, 70130.29869701237, 37065.62934370622, 37106.257874842355, 37383.0, 37392.81303593519, 37465.625343746215, 14784.852151478563, 14785.408583656748, 14931.178785166703, 15105.924470377797, 15303.770443443358, 12849.036322275866, 12927.965762738959, 13015.869841301655, 13022.0, 13077.346132693327, 8305.501669899826, 8358.331333493306, 8478.321734261368, 8530.74407767768, 8531.317494600416, 3524.647535246455, 3560.3769340365334, 3580.803055831954, 3589.6230895756094, 3613.0786649404236, 940.7130825098274, 989.5794287427815, 1068.0974576482859, 1084.967450976472, 1099.6865893220395, 26324.290045777896, 28191.872325107175, 30263.546046808875, 30303.545446818316, 30531.542026869614, 1066.0, 1098.2970898624887, 1138.9430528473708, 1204.7831390349645, 1219.2928101700993, 14259.42962281497, 15609.219539023003, 15776.97449665768, 15778.13220272896, 15858.60353491172, 630634.0, 637910.0, 643686.0, 645712.0, 648015.0, 57853.71073144692, 59948.0, 60083.699581501816, 60413.4896627579, 60425.69787151124, 1466.5233799015364, 1469.9853001469849, 1480.3634437191895, 1483.7180935622198, 1484.3839806480405, 29463.26341841471, 29752.85123574368, 30020.099397018126, 30234.470188507017, 30238.69761302447, 53795.46204537905, 54220.728896355264, 54223.72888135534, 54575.454245458626, 54645.72677136589, 578022.0, 578393.0, 583402.0, 583764.0, 585787.0, 27620.0, 27887.721122789324, 27943.16170514888, 27985.860070699517, 28331.008414705386, 45993.0, 46671.76664116794, 47016.52983470258, 47502.76248618735, 47990.760046199546, 31465.0, 31909.0, 34609.30781384408, 38014.61985380111, 39026.41460378154, 37859.24281514409, 37903.81048094742, 38019.23961520809, 38463.615363846, 38622.6137738619, 32494.83752581222, 37745.81127094457, 38272.0, 38321.23357532889, 39078.21843563056, 27534.862325688242, 30481.628326725793, 31854.68145318517, 31877.681223187472, 31953.041408757774, 24095.277141685776, 24260.272191834272, 24658.013679452622, 24769.009239630934, 24962.875185623954], "value": 18748.166716355037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.47227991691966, 390.2604564350556, 391.6807801641664, 403.582292327441, 410.2901979575336, 18652.90673546632, 20640.793592064074, 20940.685889711665, 20966.790332096676, 21526.784732152675, 19576.804231957674, 19851.900740496276, 20168.991550422492, 20408.183672653115, 21143.0, 5193.818216362428, 5835.270591176113, 6025.879482410349, 6028.577999540034, 6039.0, 4033.6773058155277, 6120.938790612081, 6477.157969463987, 6491.902621460682, 6509.6419696916655, 5380.515753582177, 6386.680665966706, 6416.807495775134, 6443.677816109176, 6446.548741588091, 5782.595218334718, 6361.872762544746, 6403.231612206565, 6426.260979987291, 6534.379233972765, 5426.186072089179, 5702.914456283159, 5727.484526392603, 5740.54075673945, 5761.942380576183, 25570.0, 25857.0, 26097.217083487525, 26186.512281333435, 26321.473570528484, 1791.0149417820278, 1803.9909800450914, 2304.873231972241, 2346.0, 2399.58007348715, 9091.499967501784, 10931.836022459669, 11859.940700296529, 14647.340869660891, 15127.697446051017, 1692.93228270869, 1726.5942503511665, 1729.5848996240939, 1775.8845675031082, 1782.6612943540686, 115844.0, 121382.0, 122356.99999999911, 125909.0, 130879.34560327137, 11471.655850324503, 11491.885081149248, 11536.653900383002, 11600.76798464026, 11783.0, 14595.343209555596, 14672.0, 14742.18917959501, 14929.70140597182, 14938.551843444715, 8486.278666313308, 8619.439736417113, 8701.521416322163, 8720.473917064488, 8726.734623479686, 8403.41176117666, 8408.32733381328, 8480.279176269964, 8481.787955301043, 8549.546577081912, 3850.730448868608, 4194.266003449384, 4522.547745225451, 4601.677882548256, 4625.653076019312, 1688.8817782755089, 1853.7960824309316, 1911.9139638716013, 1981.9108140133728, 1991.9502012449805, 929.9349045566745, 932.9953350233205, 942.665353799405, 998.9500524973722, 1020.4947702139433, 18531.351402700842, 18886.0, 20063.799362006484, 20376.898115509328, 20441.0, 928.5774972387547, 982.0768477631004, 1003.4781913404988, 1009.4498498318434, 1058.2697938422464, 10037.648682296085, 10325.0, 10356.326838755607, 10421.895781042092, 10430.68707938763, 561122.0, 581432.0, 582194.0, 598568.0, 602892.0, 96233.51883240539, 116619.0, 123586.76413235933, 126591.0, 130193.34903325423, 997.9151772099453, 998.8363556456792, 1016.527314798637, 1018.6383833739064, 1024.6208902706046, 16744.581385464975, 16820.074895880844, 16978.660426791146, 17322.30710771555, 17397.565060873578, 46254.53745462637, 50792.746036269586, 50890.23664644959, 50915.49084509107, 51526.74236628793, 69656.0, 73594.63202683952, 75632.0, 75665.0, 77347.61326193334, 5887.5289976802605, 6427.971524556048, 6842.828929276808, 7575.507592006502, 8314.501129932223, 10540.577022101917, 11227.55089796399, 11913.880861191277, 12430.254184748945, 12637.93681031589, 10321.174306055347, 10569.260151789302, 10684.038436540437, 10783.784324313312, 11030.669079927615, 10439.321444106108, 10490.370577765358, 10662.0, 10800.837987430352, 10936.671899843017, 9644.9035509644, 10830.891691082988, 11157.609483668357, 11299.943500282447, 11385.0, 7339.302766237199, 7356.852862942818, 7445.851082978418, 7460.962695186489, 7522.5862577558755, 9448.0, 10660.413677247516, 10707.464626768786, 10734.677959661223, 10830.729231768953], "value": 9450.851329600428, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1586.2623879895846, 1638.5084474657604, 1872.4944265048437, 1931.7681878174621, 1936.5255512399456, 7049.647517624111, 7900.604969751518, 8551.401401901869, 8829.558522073903, 8833.293336533077, 8587.270082043018, 8614.827703445928, 8690.08754080822, 8708.564571771401, 8756.12438756124, 2396.125414223813, 2422.39440139965, 2434.4522482441484, 2440.6583078369044, 2441.1333976438377, 2380.071772008918, 2405.2663937499055, 2425.890834912433, 2456.250843492734, 2460.1512478194995, 2427.8057755379527, 2431.209856796548, 2437.9512409751796, 2449.09383528094, 2460.9261722148362, 2011.5775687105725, 2337.8714170720687, 2338.0414030247516, 2341.051873991028, 2355.128602417108, 2411.2645643078854, 2415.613501839715, 2417.4319035026756, 2427.453822889853, 2450.718167410753, 8822.250108740765, 8856.8671469928, 8898.777530561723, 8927.687530936451, 8935.687250946186, 4285.164392943378, 5267.420583735786, 5291.3385826771655, 5404.729763511848, 5425.945740542623, 3509.631488693676, 3562.9133114400356, 3574.249407624402, 3618.113562177257, 3626.4016437287814, 1028.9897101029044, 1038.1176000399676, 1044.3577200022007, 1057.571683468189, 1083.6044843632096, 11519.0, 11696.590619328283, 11703.765924681458, 11739.471723772365, 11745.706357341049, 4619.422572178478, 4644.326572646947, 4837.129316722953, 4861.149298872683, 4896.804127834918, 9896.406215627085, 9920.355176913621, 9920.950395247977, 9941.453220072965, 9945.80108397828, 5340.439253878365, 5357.223202635596, 5358.115910874662, 5368.087425137736, 5395.3525576931015, 4416.33754936762, 4746.501617330199, 4889.779959901813, 4901.117798796179, 4920.40955085392, 4028.8589899353383, 4059.654929330981, 4085.673146148301, 4153.0, 4170.854020109282, 1355.9525416610372, 1358.3547814787896, 1360.9183448992894, 1368.8152099466645, 1377.7520046391746, 820.5240960243045, 843.9156084391511, 898.1557336104041, 902.4044130873723, 950.0404591362635, 5256.869772998747, 5846.532277417797, 5936.257967754031, 5948.613340132878, 6010.435129939819, 803.5540275147232, 823.8260478817781, 900.7658008917598, 929.9163075323119, 961.1253759079204, 3262.885798997024, 3883.339832228528, 3898.5321761388814, 3972.324704800191, 3986.505060602274, 10254.333468324536, 10846.0, 10900.563977440972, 10968.616098436516, 10989.230753847314, 10702.946485267525, 10833.945830270799, 10886.129109671365, 10893.0, 10940.671779846618, 8143.470674406145, 8313.750587482264, 8376.455530390505, 8414.537200453911, 8428.873566896502, 4381.802818873222, 4915.6067514598035, 5672.914906276326, 5800.535957123336, 5820.592558520862, 9881.110700036743, 10049.447280399649, 10054.8491772622, 10076.647317343857, 10161.847572286273, 9855.655052073143, 10141.239407044648, 10199.13307368882, 10313.587456501957, 10419.374837509773, 6500.057491663777, 6867.519273650796, 7044.436445084483, 7077.327653872874, 7174.569525828467, 8333.624986875726, 8361.205685459872, 8431.03043150021, 8432.873506897524, 8457.492550446992, 7309.963450182715, 7361.558306501627, 7422.0, 7537.849243015218, 7581.772546823604, 5750.6262092963825, 7092.148942126978, 7232.493725439169, 7288.052553168054, 7385.630718463948, 6804.76183333581, 6869.313068693091, 6912.758053468105, 6927.653617319013, 6977.616231107338, 4829.517048295143, 4853.6602437829015, 4873.853784386474, 4957.107720610325, 5062.746862656926, 4837.927431088607, 4864.902701945871, 4877.292792545132, 4929.2359684248995, 5114.514121158484], "value": 4583.733763952134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.13934655124274, 323.7377724043524, 329.91092405050637, 330.55045138611484, 333.1255454432116, 5609.439056094388, 6101.816945491637, 6171.413715697013, 6229.532785041129, 6273.3726627337355, 5143.3570803649545, 6155.953487907055, 6169.259688837335, 6184.16513770642, 6186.483866777256, 3793.905152371185, 4389.692721509496, 4499.145162419146, 4592.380028696117, 4612.815487380518, 4363.167469662733, 4467.771362875203, 4600.631949444037, 4638.83764068256, 4659.930101048487, 3939.8227079781336, 4072.572379900112, 4256.5105012923605, 4578.427696537933, 4601.194790911593, 3495.912602184953, 4550.954490455103, 4586.885327866797, 4589.151007063704, 4606.82129330764, 3973.562908080109, 3974.5230572331507, 3993.0, 4005.459262999487, 4007.438958545806, 5862.648241105548, 5886.676232807194, 5903.675297858616, 5909.940900590982, 5946.524278057745, 4295.9474928642685, 5124.6419698779855, 5296.073187192226, 5447.7119609763595, 5466.34403871538, 5317.627766056377, 5834.97082514589, 6261.998080307175, 6564.8137971003325, 6568.93431065688, 3781.716371272138, 4488.304312831517, 4490.461144662629, 4502.144592527442, 4507.909841803178, 6374.298827129012, 6440.4847612190915, 6557.409833114994, 6805.727770889159, 6828.015548649514, 3492.8253587320532, 3740.9438858417147, 3764.604716504782, 4318.805653745589, 4347.152305300436, 3444.50054742061, 4201.873943781691, 4392.9896123891685, 4397.494288156839, 4412.294032954776, 5065.341505604248, 5418.783248670088, 5430.64700794455, 5441.918371224435, 5451.64564303319, 5584.63699859516, 6541.542092053605, 6564.245111812107, 6639.402453779183, 6658.500612454085, 1414.6392669869117, 1508.2835653064706, 1588.7458006718869, 1589.4834178891674, 1601.4074792326915, 988.268681175939, 1040.7242080848582, 1046.5709059285657, 1062.7247303236147, 1066.2376400873259, 5111.105556527593, 5705.828825135252, 5768.769249229984, 6136.447719705248, 6136.754529818846, 5624.634398764068, 6223.0354295084335, 6566.4418524425, 6804.4216241620015, 6805.217399999064, 5142.428785607196, 5743.770249190069, 6083.9391606084255, 6099.237595300588, 6117.357677443893, 3271.3457308538386, 3533.363994481018, 3541.29174165168, 3553.5608078728155, 3559.0, 5564.051052941947, 6735.629540375228, 7042.92957070433, 7054.75308364215, 7082.752103676346, 5777.364489906107, 6622.8344291393105, 6926.896096558556, 6987.231404545496, 7021.26170793391, 5732.3407808101765, 6112.2970858351855, 7034.804083305952, 7038.155421349471, 7079.39825114871, 5008.6744361616375, 5805.680687562056, 6022.45797878193, 6696.660667866544, 6791.845386284244, 5814.534837212928, 6419.935800641933, 6684.498662600422, 6706.463482921257, 6720.966395167993, 7033.859322813412, 7046.401055910305, 7058.329458701415, 7091.468139889632, 7091.893621595784, 4552.635789136927, 4585.747783871786, 4588.082383523375, 4590.931136033029, 4598.4711758146905, 6410.839729006626, 6671.866562668816, 6672.833179170365, 6722.764703235363, 6810.523263371517, 6382.840428989312, 6448.323945562539, 6506.804795856132, 6508.739650413931, 6546.738130474728, 5894.823155305347, 6261.217347831521, 6462.700585519829, 6500.642464664489, 6561.704723287368, 5253.89492210146, 5441.2654291670115, 6137.447629713347, 6304.873902522016, 6323.336049714898, 5217.399999000164, 5783.450572195635, 6360.982242841308, 6388.881945659584, 6575.178102737158, 5387.973060134675, 6215.223097112861, 6358.459530939922, 6471.314404522071, 6490.318516555693], "value": 4689.527116912932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.5573053018644, 730.5215084119901, 761.4936067515099, 762.1159455032164, 814.3281792521168, 14818.0, 15037.172955487444, 15072.32174552145, 15248.542543723679, 15316.310766015527, 11259.0, 12124.93937530311, 14020.018598698096, 14038.157710537374, 14097.718045639082, 730.8392153726198, 855.7249697950072, 941.0824446165003, 943.377370935183, 957.6169532187112, 774.260581145008, 945.4421891084259, 946.7443790176649, 947.3415975896754, 948.2698322291831, 993.9503024848729, 995.9651412200575, 1006.954687039085, 1007.4308015970989, 1009.8232809258387, 966.3718582921088, 966.4974213409023, 966.8936416994125, 966.9323147379686, 968.6464440479209, 726.0960104669667, 730.9195988441268, 732.5128789355073, 735.7755884455239, 741.0366523519403, 14988.850111498854, 15206.543803685796, 15227.162506062163, 15280.388784448609, 15304.005239659387, 10618.681439556825, 11237.213395062348, 12546.874531254753, 12571.434285457177, 12650.430730617052, 11037.779244415067, 11134.27627204229, 11221.495032723466, 11261.887381126166, 11688.707782305426, 4092.7339722918214, 4103.7948102594755, 4141.91716165675, 4148.128892932487, 4156.168766246763, 87213.0, 87417.25165496655, 88419.55790221007, 88603.55698221468, 89472.0, 9355.53222338894, 9479.146876781122, 9652.662156824477, 9965.701028968997, 9998.1001709845, 22062.0, 22404.43988900258, 22448.0, 22450.88774556117, 22935.54128917412, 7372.410207183412, 7521.247875212435, 7565.319121279002, 7603.9619801900635, 7802.063752349754, 4025.174839158024, 4075.5924407559005, 4077.5310839253866, 4079.265732168179, 4085.693572981979, 3563.465480177994, 3635.94546081809, 3652.36083685354, 3661.359262129117, 3665.2119794244363, 683.928187540311, 703.4267072336132, 703.8381172330393, 714.5748279773527, 722.6170129831092, 563.7378618942212, 582.347770497046, 589.7228302697725, 615.4860691322706, 628.8207860759753, 7805.453618246668, 7936.801579960432, 8011.919880801117, 8018.398620103516, 8182.549959752271, 568.3605943313772, 578.9400638420177, 595.6366616364014, 599.4215581963426, 618.6411881108946, 3786.746885603062, 3799.715021373408, 3860.1576936678425, 3915.2169566086895, 4044.5348784889525, 79723.00692482735, 98247.0, 98801.0, 100655.0, 101034.49482752687, 74167.0, 75512.24487755162, 76911.61544192243, 77488.0, 77612.22387776163, 62879.05681414691, 63219.683901580196, 64089.0, 64998.67500662561, 66138.66930665412, 7377.8155546111775, 7446.25537446251, 7467.02928619276, 7563.168051514439, 7563.8109047272055, 45266.0, 45533.0, 45657.40199093016, 46581.76709116433, 47130.821729457035, 57260.71369643125, 60592.39407605868, 61405.46486337877, 65235.0, 65773.68452631016, 10973.780524389627, 11151.944240278746, 11215.158863085464, 11359.204855660024, 11634.6509604712, 9883.258755593215, 11904.345261010727, 12342.0, 12367.62897113088, 12430.378481076092, 11304.830427543759, 11540.076793856304, 11555.191136620357, 11560.884391155982, 11964.64106076819, 11544.94227528857, 11648.767024659628, 11708.531658733555, 11962.700932476757, 11981.932007290718, 11429.428528573371, 11443.198976071595, 11456.656300311004, 11671.74039769445, 11721.413929303671, 7147.017678364142, 8512.687608295051, 9363.887988429957, 9617.0, 10228.59085636596, 9651.324407291422, 10169.135623472088, 10185.541650625888, 10207.693769186937, 10207.693769186937], "value": 6965.602600188882, "unit": "score"}], "name": "dromaeo_css", "value": 7301.256593521299, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 109.0, 116.0, 116.0, 116.0, 130.0, 116.0, 117.0, 116.0, 105.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 145.0, 161.0, 121.0, 149.0, 120.0, 162.0, 157.0, 145.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 192.0, 196.0, 211.0, 259.0, 170.0, 253.0, 277.0, 202.0, 197.0], "value": 215.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 90.0, 75.0, 143.0, 57.0, 57.0, 56.0, 64.0, 132.0, 58.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 126.0, 76.0, 82.0, 82.0, 118.0, 81.0, 80.0, 119.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 136.0, 128.0, 89.0, 86.0, 87.0, 85.0, 88.0, 85.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 105.0, 94.0, 100.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 90.0, 93.0, 99.0, 91.0, 90.0, 93.0, 86.0, 91.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 60.0, 62.0, 63.0, 61.0, 59.0, 80.0, 64.0, 61.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 73.0, 101.0, 107.0, 106.0, 78.0, 65.0, 66.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 84.0, 84.0, 81.0, 84.0, 82.0, 87.0, 84.0, 86.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 149.0, 143.0, 140.0, 155.0, 146.0, 161.0, 186.0, 233.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 174.0, 194.0, 183.0, 171.0, 172.0, 178.0, 206.0, 190.0, 225.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 88.0, 72.0, 61.0, 70.0, 102.0, 90.0, 70.0, 57.0, 73.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1588.2000000000003, "alertThreshold": 2.0}]} 06:17:53 INFO - Return code: 0 06:17:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:17:53 ERROR - # TBPL SUCCESS # 06:17:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:17:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:17:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:17:53 INFO - 2016-04-22 06:17:53.565 screenresolution[1684:10167] starting screenresolution argv=screenresolution get 06:17:53 INFO - 2016-04-22 06:17:53.568 screenresolution[1684:10167] Display 0: 1600x1200x32@60 06:17:53 INFO - 2016-04-22 06:17:53.574 screenresolution[1685:10170] starting screenresolution argv=screenresolution list 06:17:53 INFO - Available Modes on Display 0 06:17:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:17:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:17:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:17:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:17:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:17:53 INFO - Intel Iris: 06:17:53 INFO - Chipset Model: Intel Iris 06:17:53 INFO - Type: GPU 06:17:53 INFO - Bus: Built-In 06:17:53 INFO - VRAM (Dynamic, Max): 1536 MB 06:17:53 INFO - Vendor: Intel (0x8086) 06:17:53 INFO - Device ID: 0x0a2e 06:17:53 INFO - Revision ID: 0x0009 06:17:53 INFO - Displays: 06:17:53 INFO - Display: 06:17:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:17:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:17:53 INFO - Display Serial Number: 1600x1200 60 06:17:53 INFO - Main Display: Yes 06:17:53 INFO - Mirror: Off 06:17:53 INFO - Online: Yes 06:17:53 INFO - Rotation: Supported 06:17:53 INFO - Return code: 0 06:17:53 INFO - Running post-action listener: _resource_record_post_action 06:17:53 INFO - Running post-run listener: _resource_record_post_run 06:17:54 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37799424; Write bytes: 695159808; Read time: 395; Write time: 2059 06:17:54 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377639424; Write bytes: 371259392; Read time: 28034; Write time: 830 06:17:54 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36800000; Write bytes: 298705920; Read time: 377; Write time: 1180 06:17:54 INFO - Running post-run listener: _upload_blobber_files 06:17:54 INFO - Blob upload gear active. 06:17:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:55 INFO - (blobuploader) - INFO - Done attempting. 06:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:57 INFO - (blobuploader) - INFO - Done attempting. 06:17:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:57 INFO - Return code: 0 06:17:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ff69f59fb3c7031616cf6b41a044bacb943660e1b7e2b0a5a4bcb5dea7b3fc1f10e5b195091cd33743932064993bf432c2d0de58b1c47ba8dd8b3f7fef7206", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518bc9720522651fb5223626c176b101c7db7f2905a2f9331ebd19e9651c93bbce4f368ca1ac95eb98d63b5bdcde12f37ac71e897701f693d6a9820b2e455fd1"} 06:17:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:57 INFO - Contents: 06:17:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ff69f59fb3c7031616cf6b41a044bacb943660e1b7e2b0a5a4bcb5dea7b3fc1f10e5b195091cd33743932064993bf432c2d0de58b1c47ba8dd8b3f7fef7206", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518bc9720522651fb5223626c176b101c7db7f2905a2f9331ebd19e9651c93bbce4f368ca1ac95eb98d63b5bdcde12f37ac71e897701f693d6a9820b2e455fd1"} 06:17:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:57 INFO - Copying logs to upload dir... 06:17:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.763489 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-22 06:17:57.315787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:17:57.319031) ========= 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.AFuoDDwPIU/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.UT1rCmTw97/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/41ff69f59fb3c7031616cf6b41a044bacb943660e1b7e2b0a5a4bcb5dea7b3fc1f10e5b195091cd33743932064993bf432c2d0de58b1c47ba8dd8b3f7fef7206", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518bc9720522651fb5223626c176b101c7db7f2905a2f9331ebd19e9651c93bbce4f368ca1ac95eb98d63b5bdcde12f37ac71e897701f693d6a9820b2e455fd1"} build_url:https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ff69f59fb3c7031616cf6b41a044bacb943660e1b7e2b0a5a4bcb5dea7b3fc1f10e5b195091cd33743932064993bf432c2d0de58b1c47ba8dd8b3f7fef7206", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/518bc9720522651fb5223626c176b101c7db7f2905a2f9331ebd19e9651c93bbce4f368ca1ac95eb98d63b5bdcde12f37ac71e897701f693d6a9820b2e455fd1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:17:57.347408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:17:57.347767) ========= 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.AFuoDDwPIU/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.UT1rCmTw97/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:17:57.396678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:17:57.397050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:17:57.397443) ========= ========= Total master_lag: 0.26 =========