builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0174 starttime: 1462408770.41 results: success (0) buildid: 20160504164543 builduid: eaaaf46d6a94444fa4e90930e356c6bc revision: 3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.409217) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.409693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.409982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.432279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.432586) ========= 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.cWhanJMyVL/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.4OYMjTwGBu/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-05-04 17:39:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.61M=0.001s 2016-05-04 17:39:30 (8.61 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.534385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.534731) ========= 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.cWhanJMyVL/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.4OYMjTwGBu/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.020439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:30.583534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 17:39:30.583920) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c --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 3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cWhanJMyVL/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.4OYMjTwGBu/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-05-04 17:39:30,653 truncating revision to first 12 chars 2016-05-04 17:39:30,653 Setting DEBUG logging. 2016-05-04 17:39:30,653 attempt 1/10 2016-05-04 17:39:30,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3fd6d4621afc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 17:39:32,068 unpacking tar archive at: fx-team-3fd6d4621afc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.654985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 17:39:32.255958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:32.256304) ========= script_repo_revision: 3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:32.256735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:32.257025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:39:32.272388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-04 17:39:32.272939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cWhanJMyVL/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.4OYMjTwGBu/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:39:32 INFO - MultiFileLogger online at 20160504 17:39:32 in /builds/slave/test 17:39:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:39:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:39:32 INFO - {'append_to_log': False, 17:39:32 INFO - 'base_work_dir': '/builds/slave/test', 17:39:32 INFO - 'blob_upload_branch': 'Fx-Team', 17:39:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:39:32 INFO - 'branch': 'Fx-Team', 17:39:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:39:32 INFO - 'config_files': ('talos/mac_config.py',), 17:39:32 INFO - 'default_actions': ('clobber', 17:39:32 INFO - 'read-buildbot-config', 17:39:32 INFO - 'download-and-extract', 17:39:32 INFO - 'populate-webroot', 17:39:32 INFO - 'create-virtualenv', 17:39:32 INFO - 'install', 17:39:32 INFO - 'run-tests'), 17:39:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:39:32 INFO - 'download_minidump_stackwalk': True, 17:39:32 INFO - 'download_symbols': 'ondemand', 17:39:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:39:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:39:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:39:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:39:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:39:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:39:32 INFO - 'installer_path': 'installer.exe', 17:39:32 INFO - 'log_level': 'info', 17:39:32 INFO - 'log_name': 'talos', 17:39:32 INFO - 'log_to_console': True, 17:39:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:39:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:39:32 INFO - 'opt_config_files': (), 17:39:32 INFO - 'pip_index': False, 17:39:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:39:32 INFO - 'cmd': ('bash', 17:39:32 INFO - '-c', 17:39:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:39:32 INFO - 'enabled': True, 17:39:32 INFO - 'halt_on_failure': False, 17:39:32 INFO - 'name': 'check_screen_resolution'},), 17:39:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:39:32 INFO - 'cmd': ('bash', 17:39:32 INFO - '-c', 17:39:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:39:32 INFO - 'enabled': True, 17:39:32 INFO - 'halt_on_failure': False, 17:39:32 INFO - 'name': 'check_screen_resolution'},), 17:39:32 INFO - 'run_cmd_checks_enabled': True, 17:39:32 INFO - 'sps_profile': False, 17:39:32 INFO - 'sps_profile_interval': 0, 17:39:32 INFO - 'suite': 'dromaeojs', 17:39:32 INFO - 'system_bits': '32', 17:39:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:39:32 INFO - 'title': 't-yosemite-r7-0174', 17:39:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:39:32 INFO - 'use_talos_json': True, 17:39:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:39:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:39:32 INFO - 'work_dir': 'build'} 17:39:32 INFO - ##### 17:39:32 INFO - ##### Running clobber step. 17:39:32 INFO - ##### 17:39:32 INFO - Running pre-action listener: _resource_record_pre_action 17:39:32 INFO - Running main action method: clobber 17:39:32 INFO - rmtree: /builds/slave/test/build 17:39:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:39:33 INFO - Running post-action listener: _resource_record_post_action 17:39:33 INFO - ##### 17:39:33 INFO - ##### Running read-buildbot-config step. 17:39:33 INFO - ##### 17:39:33 INFO - Running pre-action listener: _resource_record_pre_action 17:39:33 INFO - Running main action method: read_buildbot_config 17:39:33 INFO - Using buildbot properties: 17:39:33 INFO - { 17:39:33 INFO - "project": "", 17:39:33 INFO - "product": "firefox", 17:39:33 INFO - "script_repo_revision": "production", 17:39:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:39:33 INFO - "repository": "", 17:39:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:39:33 INFO - "buildid": "20160504164543", 17:39:33 INFO - "pgo_build": "False", 17:39:33 INFO - "basedir": "/builds/slave/test", 17:39:33 INFO - "buildnumber": 767, 17:39:33 INFO - "slavename": "t-yosemite-r7-0174", 17:39:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:39:33 INFO - "platform": "yosemite_r7", 17:39:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:39:33 INFO - "branch": "fx-team", 17:39:33 INFO - "repo_path": "integration/fx-team", 17:39:33 INFO - "revision": "3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c", 17:39:33 INFO - "stage_platform": "macosx64", 17:39:33 INFO - "builduid": "eaaaf46d6a94444fa4e90930e356c6bc", 17:39:33 INFO - "slavebuilddir": "test" 17:39:33 INFO - } 17:39:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 17:39:33 INFO - Running post-action listener: _resource_record_post_action 17:39:33 INFO - ##### 17:39:33 INFO - ##### Running download-and-extract step. 17:39:33 INFO - ##### 17:39:33 INFO - Running pre-action listener: _resource_record_pre_action 17:39:33 INFO - Running main action method: download_and_extract 17:39:33 INFO - mkdir: /builds/slave/test/build/tests 17:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:33 INFO - https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:39:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:39:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:39:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 17:39:35 INFO - Downloaded 1199 bytes. 17:39:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:39:35 INFO - Using the following test package requirements: 17:39:35 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:39:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 17:39:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 17:39:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'jsshell-mac.zip'], 17:39:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 17:39:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:39:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 17:39:35 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 17:39:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 17:39:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:39:35 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 17:39:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:35 INFO - https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:39:36 INFO - Downloaded 18130891 bytes. 17:39:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:39:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:39:39 INFO - Return code: 0 17:39:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:39 INFO - https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:39:40 INFO - Downloaded 18130891 bytes. 17:39:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:39:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:39:44 INFO - Return code: 0 17:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:44 INFO - https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:39:45 INFO - Downloaded 10840152 bytes. 17:39:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:39:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:39:45 INFO - Return code: 0 17:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:45 INFO - https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:39:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:39:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:39:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 17:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 17:39:48 INFO - Downloaded 110550482 bytes. 17:39:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:39:48 INFO - mkdir: /builds/slave/test/properties 17:39:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:39:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:39:49 INFO - Contents: 17:39:49 INFO - build_url:https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:39:50 INFO - Running post-action listener: _resource_record_post_action 17:39:50 INFO - Running post-action listener: set_extra_try_arguments 17:39:50 INFO - ##### 17:39:50 INFO - ##### Running populate-webroot step. 17:39:50 INFO - ##### 17:39:50 INFO - Running pre-action listener: _resource_record_pre_action 17:39:50 INFO - Running main action method: populate_webroot 17:39:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:39:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:39:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:39:50 INFO - '--tppagecycles', 17:39:50 INFO - '7'], 17:39:50 INFO - 'tests': ['tsvgm']}}, 17:39:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:39:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:39:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:39:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:39:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['damp', 'tps']}, 17:39:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'tests': ['damp', 'tps']}, 17:39:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['dromaeo_dom']}, 17:39:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:39:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['a11yr', 17:39:50 INFO - 'ts_paint', 17:39:50 INFO - 'tpaint', 17:39:50 INFO - 'sessionrestore', 17:39:50 INFO - 'sessionrestore_no_auto_restore', 17:39:50 INFO - 'tabpaint']}, 17:39:50 INFO - 'other-e10s': {'tests': ['a11yr', 17:39:50 INFO - 'ts_paint', 17:39:50 INFO - 'tpaint', 17:39:50 INFO - 'sessionrestore', 17:39:50 INFO - 'sessionrestore_no_auto_restore', 17:39:50 INFO - 'tabpaint']}, 17:39:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:39:50 INFO - 'ts_paint', 17:39:50 INFO - 'tpaint', 17:39:50 INFO - 'sessionrestore', 17:39:50 INFO - 'sessionrestore_no_auto_restore', 17:39:50 INFO - 'tabpaint']}, 17:39:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:39:50 INFO - 'ts_paint', 17:39:50 INFO - 'tpaint', 17:39:50 INFO - 'sessionrestore', 17:39:50 INFO - 'sessionrestore_no_auto_restore', 17:39:50 INFO - 'tabpaint']}, 17:39:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['a11yr', 17:39:50 INFO - 'ts_paint', 17:39:50 INFO - 'tpaint', 17:39:50 INFO - 'sessionrestore', 17:39:50 INFO - 'sessionrestore_no_auto_restore', 17:39:50 INFO - 'tabpaint']}, 17:39:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['a11yr', 17:39:50 INFO - 'ts_paint', 17:39:50 INFO - 'tpaint', 17:39:50 INFO - 'sessionrestore', 17:39:50 INFO - 'sessionrestore_no_auto_restore', 17:39:50 INFO - 'tabpaint']}, 17:39:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['tsvgx', 17:39:50 INFO - 'tsvgr_opacity', 17:39:50 INFO - 'tart', 17:39:50 INFO - 'tscrollx', 17:39:50 INFO - 'cart']}, 17:39:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:39:50 INFO - 'tsvgr_opacity', 17:39:50 INFO - 'tart', 17:39:50 INFO - 'tscrollx', 17:39:50 INFO - 'cart']}, 17:39:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'talos_options': ['--disable-e10s'], 17:39:50 INFO - 'tests': ['tp5o']}, 17:39:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'tests': ['tp5o']}, 17:39:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'talos_options': ['--disable-e10s', 17:39:50 INFO - '--xperf_path', 17:39:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:50 INFO - 'tests': ['tp5n']}, 17:39:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:39:50 INFO - 'talos_options': ['--xperf_path', 17:39:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:50 INFO - 'tests': ['tp5n']}}, 17:39:50 INFO - 'talos.zip': {'path': '', 17:39:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:39:50 INFO - Running post-action listener: _resource_record_post_action 17:39:50 INFO - ##### 17:39:50 INFO - ##### Running create-virtualenv step. 17:39:50 INFO - ##### 17:39:50 INFO - Running pre-action listener: _resource_record_pre_action 17:39:50 INFO - Running main action method: create_virtualenv 17:39:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:39:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:39:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:39:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:39:50 INFO - Using real prefix '/tools/python27' 17:39:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:39:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:39:53 INFO - Installing pip.................done. 17:39:53 INFO - Return code: 0 17:39:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:53 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:53 INFO - 'HOME': '/Users/cltbld', 17:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:53 INFO - 'LOGNAME': 'cltbld', 17:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:53 INFO - 'MOZ_NO_REMOTE': '1', 17:39:53 INFO - 'NO_EM_RESTART': '1', 17:39:53 INFO - 'PAGER': '/bin/cat', 17:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:53 INFO - 'PWD': '/builds/slave/test', 17:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:53 INFO - 'SHELL': '/bin/bash', 17:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:39:53 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:53 INFO - 'USER': 'cltbld', 17:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:53 INFO - 'XPC_FLAGS': '0x0', 17:39:53 INFO - 'XPC_SERVICE_NAME': '0', 17:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:39:54 INFO - Cleaning up... 17:39:54 INFO - Return code: 0 17:39:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:54 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:39:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:39:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:54 INFO - 'HOME': '/Users/cltbld', 17:39:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:54 INFO - 'LOGNAME': 'cltbld', 17:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:54 INFO - 'MOZ_NO_REMOTE': '1', 17:39:54 INFO - 'NO_EM_RESTART': '1', 17:39:54 INFO - 'PAGER': '/bin/cat', 17:39:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:54 INFO - 'PWD': '/builds/slave/test', 17:39:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:54 INFO - 'SHELL': '/bin/bash', 17:39:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:39:54 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:39:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:54 INFO - 'USER': 'cltbld', 17:39:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:54 INFO - 'XPC_FLAGS': '0x0', 17:39:54 INFO - 'XPC_SERVICE_NAME': '0', 17:39:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:54 INFO - Downloading/unpacking psutil>=0.7.1 17:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:57 INFO - Installing collected packages: psutil 17:39:57 INFO - Running setup.py install for psutil 17:39:57 INFO - building 'psutil._psutil_osx' extension 17:39:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:39:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:39:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:39:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:39:57 INFO - building 'psutil._psutil_posix' extension 17:39:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:39:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:39:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:39:57 INFO - ^ 17:39:58 INFO - 1 warning generated. 17:39:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:39:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:58 INFO - Successfully installed psutil 17:39:58 INFO - Cleaning up... 17:39:58 INFO - Return code: 0 17:39:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:58 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:39:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:39:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:58 INFO - 'HOME': '/Users/cltbld', 17:39:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:58 INFO - 'LOGNAME': 'cltbld', 17:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:58 INFO - 'MOZ_NO_REMOTE': '1', 17:39:58 INFO - 'NO_EM_RESTART': '1', 17:39:58 INFO - 'PAGER': '/bin/cat', 17:39:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:58 INFO - 'PWD': '/builds/slave/test', 17:39:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:58 INFO - 'SHELL': '/bin/bash', 17:39:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:39:58 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:39:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:58 INFO - 'USER': 'cltbld', 17:39:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:58 INFO - 'XPC_FLAGS': '0x0', 17:39:58 INFO - 'XPC_SERVICE_NAME': '0', 17:39:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:40:01 INFO - Installing collected packages: mozsystemmonitor 17:40:01 INFO - Running setup.py install for mozsystemmonitor 17:40:01 INFO - Successfully installed mozsystemmonitor 17:40:01 INFO - Cleaning up... 17:40:01 INFO - Return code: 0 17:40:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:01 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:01 INFO - 'HOME': '/Users/cltbld', 17:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:01 INFO - 'LOGNAME': 'cltbld', 17:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:01 INFO - 'MOZ_NO_REMOTE': '1', 17:40:01 INFO - 'NO_EM_RESTART': '1', 17:40:01 INFO - 'PAGER': '/bin/cat', 17:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:01 INFO - 'PWD': '/builds/slave/test', 17:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:01 INFO - 'SHELL': '/bin/bash', 17:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:01 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:01 INFO - 'USER': 'cltbld', 17:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:01 INFO - 'XPC_FLAGS': '0x0', 17:40:01 INFO - 'XPC_SERVICE_NAME': '0', 17:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:40:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:40:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:05 INFO - Downloading docopt-0.6.1.tar.gz 17:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:40:05 INFO - Installing collected packages: blobuploader, requests, docopt 17:40:05 INFO - Running setup.py install for blobuploader 17:40:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:40:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:40:05 INFO - Running setup.py install for requests 17:40:05 INFO - Running setup.py install for docopt 17:40:05 INFO - Successfully installed blobuploader requests docopt 17:40:05 INFO - Cleaning up... 17:40:05 INFO - Return code: 0 17:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40: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')]} 17:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:05 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:05 INFO - 'HOME': '/Users/cltbld', 17:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:05 INFO - 'LOGNAME': 'cltbld', 17:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:05 INFO - 'MOZ_NO_REMOTE': '1', 17:40:05 INFO - 'NO_EM_RESTART': '1', 17:40:05 INFO - 'PAGER': '/bin/cat', 17:40:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:05 INFO - 'PWD': '/builds/slave/test', 17:40:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:05 INFO - 'SHELL': '/bin/bash', 17:40:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:05 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:05 INFO - 'USER': 'cltbld', 17:40:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:05 INFO - 'XPC_FLAGS': '0x0', 17:40:05 INFO - 'XPC_SERVICE_NAME': '0', 17:40:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ce78tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-VdFtGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-xFS0re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-e7ClHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-OYb3g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-8dATzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-xCx2tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:40:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-39v2pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-XFkqDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ltpmEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1h5mYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-i_Zduz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-hszcBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-JQVe_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-RpDF7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_dAuT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:40:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-bcOhgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:40:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:40:07 INFO - Running setup.py install for manifestparser 17:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:40:08 INFO - Running setup.py install for mozcrash 17:40:08 INFO - Running setup.py install for mozdebug 17:40:08 INFO - Running setup.py install for mozdevice 17:40:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:40:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:40:08 INFO - Running setup.py install for mozfile 17:40:08 INFO - Running setup.py install for mozhttpd 17:40:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:40:08 INFO - Running setup.py install for mozinfo 17:40:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Running setup.py install for mozInstall 17:40:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Running setup.py install for mozleak 17:40:09 INFO - Running setup.py install for mozlog 17:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Running setup.py install for moznetwork 17:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Running setup.py install for mozprocess 17:40:09 INFO - Running setup.py install for mozprofile 17:40:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:40:09 INFO - Running setup.py install for mozrunner 17:40:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:40:10 INFO - Running setup.py install for mozscreenshot 17:40:10 INFO - Running setup.py install for moztest 17:40:10 INFO - Running setup.py install for mozversion 17:40:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:40:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:40:10 INFO - Cleaning up... 17:40:10 INFO - Return code: 0 17:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:10 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:10 INFO - 'HOME': '/Users/cltbld', 17:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:10 INFO - 'LOGNAME': 'cltbld', 17:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:10 INFO - 'MOZ_NO_REMOTE': '1', 17:40:10 INFO - 'NO_EM_RESTART': '1', 17:40:10 INFO - 'PAGER': '/bin/cat', 17:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:10 INFO - 'PWD': '/builds/slave/test', 17:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:10 INFO - 'SHELL': '/bin/bash', 17:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:10 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:10 INFO - 'USER': 'cltbld', 17:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:10 INFO - 'XPC_FLAGS': '0x0', 17:40:10 INFO - 'XPC_SERVICE_NAME': '0', 17:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:40:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gGn0Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:40:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-XuRBnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_5kp0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-6ISQnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-G66td3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ALPkfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-uOUxQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Mb7uLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-y_9zGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-45b5VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-oA63ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:40:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-SHXqqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:40:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-BEhclF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:40:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-2Fk3rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ydwsji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:40:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-soKq8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:40:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-12fn8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:15 INFO - Downloading blessings-1.6.tar.gz 17:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:40:15 INFO - Installing collected packages: blessings 17:40:15 INFO - Running setup.py install for blessings 17:40:15 INFO - Successfully installed blessings 17:40:15 INFO - Cleaning up... 17:40:15 INFO - Return code: 0 17:40:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:40:15 INFO - Reading from file tmpfile_stdout 17:40:15 INFO - Current package versions: 17:40:15 INFO - blessings == 1.6 17:40:15 INFO - blobuploader == 1.2.4 17:40:15 INFO - docopt == 0.6.1 17:40:15 INFO - manifestparser == 1.1 17:40:15 INFO - mozInstall == 1.12 17:40:15 INFO - mozcrash == 0.17 17:40:15 INFO - mozdebug == 0.1 17:40:15 INFO - mozdevice == 0.48 17:40:15 INFO - mozfile == 1.2 17:40:15 INFO - mozhttpd == 0.7 17:40:15 INFO - mozinfo == 0.9 17:40:15 INFO - mozleak == 0.1 17:40:15 INFO - mozlog == 3.1 17:40:15 INFO - moznetwork == 0.27 17:40:15 INFO - mozprocess == 0.22 17:40:15 INFO - mozprofile == 0.28 17:40:15 INFO - mozrunner == 6.11 17:40:15 INFO - mozscreenshot == 0.1 17:40:15 INFO - mozsystemmonitor == 0.0 17:40:15 INFO - moztest == 0.7 17:40:15 INFO - mozversion == 1.4 17:40:15 INFO - psutil == 3.1.1 17:40:15 INFO - requests == 1.2.3 17:40:15 INFO - wsgiref == 0.1.2 17:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40: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')]} 17:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:15 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 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:15 INFO - 'HOME': '/Users/cltbld', 17:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:15 INFO - 'LOGNAME': 'cltbld', 17:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:15 INFO - 'MOZ_NO_REMOTE': '1', 17:40:15 INFO - 'NO_EM_RESTART': '1', 17:40:15 INFO - 'PAGER': '/bin/cat', 17:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:15 INFO - 'PWD': '/builds/slave/test', 17:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:15 INFO - 'SHELL': '/bin/bash', 17:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:15 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:15 INFO - 'USER': 'cltbld', 17:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:15 INFO - 'XPC_FLAGS': '0x0', 17:40:15 INFO - 'XPC_SERVICE_NAME': '0', 17:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:40:15 INFO - Cleaning up... 17:40:15 INFO - Return code: 0 17:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40: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')]} 17:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:40: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', 'jsonschema'] in /builds/slave/test/build 17:40: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 jsonschema 17:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:15 INFO - 'HOME': '/Users/cltbld', 17:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:15 INFO - 'LOGNAME': 'cltbld', 17:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:15 INFO - 'MOZ_NO_REMOTE': '1', 17:40:15 INFO - 'NO_EM_RESTART': '1', 17:40:15 INFO - 'PAGER': '/bin/cat', 17:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:15 INFO - 'PWD': '/builds/slave/test', 17:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:15 INFO - 'SHELL': '/bin/bash', 17:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:15 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:15 INFO - 'USER': 'cltbld', 17:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:15 INFO - 'XPC_FLAGS': '0x0', 17:40:15 INFO - 'XPC_SERVICE_NAME': '0', 17:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:16 INFO - Downloading/unpacking jsonschema 17:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:40:18 INFO - Downloading/unpacking functools32 (from jsonschema) 17:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:40:19 INFO - warning: no files found matching '*.txt' 17:40:19 INFO - no previously-included directories found matching 'build' 17:40:19 INFO - no previously-included directories found matching 'dist' 17:40:19 INFO - no previously-included directories found matching '.git*' 17:40:19 INFO - Installing collected packages: jsonschema, functools32 17:40:19 INFO - Running setup.py install for functools32 17:40:19 INFO - warning: no files found matching '*.txt' 17:40:19 INFO - no previously-included directories found matching 'build' 17:40:19 INFO - no previously-included directories found matching 'dist' 17:40:19 INFO - no previously-included directories found matching '.git*' 17:40:19 INFO - Successfully installed jsonschema functools32 17:40:19 INFO - Cleaning up... 17:40:19 INFO - Return code: 0 17:40:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:40: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')]} 17:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40: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')]} 17:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10870f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cba5bb5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, '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.cWhanJMyVL/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.4OYMjTwGBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:40: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', 'flake8'] in /builds/slave/test/build 17:40: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 flake8 17:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:19 INFO - 'HOME': '/Users/cltbld', 17:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:19 INFO - 'LOGNAME': 'cltbld', 17:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:19 INFO - 'MOZ_NO_REMOTE': '1', 17:40:19 INFO - 'NO_EM_RESTART': '1', 17:40:19 INFO - 'PAGER': '/bin/cat', 17:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:19 INFO - 'PWD': '/builds/slave/test', 17:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:19 INFO - 'SHELL': '/bin/bash', 17:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:19 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:19 INFO - 'USER': 'cltbld', 17:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:19 INFO - 'XPC_FLAGS': '0x0', 17:40:19 INFO - 'XPC_SERVICE_NAME': '0', 17:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:19 INFO - Downloading/unpacking flake8 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:40:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:40:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40: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 17:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:40:23 INFO - no previously-included directories found matching 'docs/_build' 17:40:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:40:23 INFO - Running setup.py install for pep8 17:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:40:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:40:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:40:23 INFO - no previously-included directories found matching 'docs/_build' 17:40:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:40:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:40:23 INFO - Cleaning up... 17:40:23 INFO - Return code: 0 17:40:23 INFO - Running post-action listener: _resource_record_post_action 17:40:23 INFO - Running post-action listener: _start_resource_monitoring 17:40:23 INFO - Starting resource monitoring. 17:40:23 INFO - ##### 17:40:23 INFO - ##### Running install step. 17:40:23 INFO - ##### 17:40:23 INFO - Running pre-action listener: _resource_record_pre_action 17:40:23 INFO - Running main action method: install 17:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:40:23 INFO - Reading from file tmpfile_stdout 17:40:23 INFO - Detecting whether we're running mozinstall >=1.0... 17:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:40:24 INFO - Reading from file tmpfile_stdout 17:40:24 INFO - Output received: 17:40:24 INFO - Usage: mozinstall [options] installer 17:40:24 INFO - Options: 17:40:24 INFO - -h, --help show this help message and exit 17:40:24 INFO - -d DEST, --destination=DEST 17:40:24 INFO - Directory to install application into. [default: 17:40:24 INFO - "/builds/slave/test"] 17:40:24 INFO - --app=APP Application being installed. [default: firefox] 17:40:24 INFO - mkdir: /builds/slave/test/build/application 17:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:40:58 INFO - Reading from file tmpfile_stdout 17:40:58 INFO - Output received: 17:40:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:40:58 INFO - Running post-action listener: _resource_record_post_action 17:40:58 INFO - ##### 17:40:58 INFO - ##### Running run-tests step. 17:40:58 INFO - ##### 17:40:58 INFO - Running pre-action listener: _resource_record_pre_action 17:40:58 INFO - Running main action method: run_tests 17:40:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:40:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:40:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:40:58 INFO - 2016-05-04 17:40:58.363 screenresolution[1915:14828] starting screenresolution argv=screenresolution get 17:40:58 INFO - 2016-05-04 17:40:58.366 screenresolution[1915:14828] Display 0: 1600x1200x32@60 17:40:58 INFO - 2016-05-04 17:40:58.372 screenresolution[1916:14831] starting screenresolution argv=screenresolution list 17:40:58 INFO - Available Modes on Display 0 17:40:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:40:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:40:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:40:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:40:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:40:58 INFO - Intel Iris: 17:40:58 INFO - Chipset Model: Intel Iris 17:40:58 INFO - Type: GPU 17:40:58 INFO - Bus: Built-In 17:40:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:40:58 INFO - Vendor: Intel (0x8086) 17:40:58 INFO - Device ID: 0x0a2e 17:40:58 INFO - Revision ID: 0x0009 17:40:58 INFO - Displays: 17:40:58 INFO - Display: 17:40:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:40:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:40:58 INFO - Display Serial Number: 1600x1200 60 17:40:58 INFO - Main Display: Yes 17:40:58 INFO - Mirror: Off 17:40:58 INFO - Online: Yes 17:40:58 INFO - Rotation: Supported 17:40:58 INFO - Return code: 0 17:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:40:58 INFO - Python 2.7.3 17:40:58 INFO - Return code: 0 17:40:58 INFO - grabbing minidump binary from tooltool 17:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:40:58 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 0x10859ee00>, '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 0x1083c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108599b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:40:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:40:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:40:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:40:58 INFO - Return code: 0 17:40:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:40:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:40:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:40:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:40:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:40:59 INFO - Return code: 0 17:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:40:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cWhanJMyVL/Render', 17:40:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:59 INFO - 'HOME': '/Users/cltbld', 17:40:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:59 INFO - 'LOGNAME': 'cltbld', 17:40:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:40:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:59 INFO - 'MOZ_NO_REMOTE': '1', 17:40:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:40:59 INFO - 'NO_EM_RESTART': '1', 17:40:59 INFO - 'PAGER': '/bin/cat', 17:40:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:59 INFO - 'PWD': '/builds/slave/test', 17:40:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:40:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:59 INFO - 'SHELL': '/bin/bash', 17:40:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4OYMjTwGBu/Listeners', 17:40:59 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 17:40:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:59 INFO - 'USER': 'cltbld', 17:40:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:59 INFO - 'XPC_FLAGS': '0x0', 17:40:59 INFO - 'XPC_SERVICE_NAME': '0', 17:40:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:41:00 INFO - mozversion application_buildid: 20160504164543 17:41:00 INFO - mozversion application_changeset: 3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c 17:41:00 INFO - mozversion application_display_name: Nightly 17:41:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:41:00 INFO - mozversion application_name: Firefox 17:41:00 INFO - mozversion application_remotingname: firefox 17:41:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:41:00 INFO - mozversion application_vendor: Mozilla 17:41:00 INFO - mozversion application_version: 49.0a1 17:41:00 INFO - mozversion platform_buildid: 20160504164543 17:41:00 INFO - mozversion platform_changeset: 3fd6d4621afc93ac2bd60a44511c31d2b1da4a9c 17:41:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:41:00 INFO - mozversion platform_version: 49.0a1 17:41:00 INFO - using testdate: 1462408860 17:41:00 INFO - actual date: 1462408860 17:41:00 INFO - starting webserver on 'localhost:52285' 17:41:00 INFO - SUITE-START | Running 2 tests 17:41:00 INFO - TEST-START | dromaeo_css 17:41:00 INFO - operating with platform_type : mac_ 17:41:00 INFO - Initialising browser for dromaeo_css test... 17:41:00 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpyQhZub/profile http://localhost:52285/getInfo.html) 17:41:02 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 17:41:02 INFO - PROCESS | 1934 | colorDepth:24 17:41:02 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 17:41:02 INFO - PROCESS | 1934 | __metrics 17:41:02 INFO - PROCESS | 1934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:41:02 ERROR - PROCESS | 1934 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:41:03 INFO - TEST-INFO | 1934: exit 0 17:41:03 INFO - Browser initialized. 17:41:03 INFO - Running cycle 1/1 for dromaeo_css test... 17:41:03 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpyQhZub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:15 INFO - PROCESS | 1936 | RSS: Main: 239570944 17:41:15 INFO - PROCESS | 1936 | 17:42:05 INFO - PROCESS | 1936 | 1462408925862 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:44:17 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52285/tests/dromaeo/cssquery-ext.html) 17:44:18 INFO - PROCESS | 1936 | RSS: Main: 334110720 17:44:18 INFO - PROCESS | 1936 | 17:47:21 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-ext.html (next: http://localhost:52285/tests/dromaeo/cssquery-jquery.html) 17:47:22 INFO - PROCESS | 1936 | RSS: Main: 373788672 17:47:22 INFO - PROCESS | 1936 | 17:50:24 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52285/tests/dromaeo/cssquery-mootools.html) 17:50:25 INFO - PROCESS | 1936 | RSS: Main: 368422912 17:50:25 INFO - PROCESS | 1936 | 17:53:27 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52285/tests/dromaeo/cssquery-prototype.html) 17:53:27 INFO - PROCESS | 1936 | RSS: Main: 369750016 17:53:27 INFO - PROCESS | 1936 | 17:56:31 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52285/tests/dromaeo/cssquery-yui.html) 17:56:31 INFO - PROCESS | 1936 | RSS: Main: 340353024 17:56:31 INFO - PROCESS | 1936 | 17:59:34 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:52285/tests/dromaeo/cssquery-yui.html (next: http://localhost:52285/tests/dromaeo/cssquery-dojo.html) 17:59:35 INFO - PROCESS | 1936 | RSS: Main: 378142720 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | __start_tp_report 17:59:35 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 17:59:35 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 17:59:35 INFO - PROCESS | 1936 | |i|pagename|runs| 17:59:35 INFO - PROCESS | 1936 | |0;dojo.html;3366.7811592246508;3423.0928803866964;3446.6897979181867;3455.498952651867;3489.860405583777;5522.254495643087;5638.210650508921;5642.4357564243555;5662.490375866171;5707;4603.240465323218;5572.136318870572;5649.774009039634;5650.7174641267975;5652.773889044443;5086.0590790703745;5108.84673459795;5129.999650068219;5160.14857548504;5179.922301165486;5162.096633089194;5173.068847607429;5188.507091826289;5192.350956130484;5209.21861720743;5112.8977420451565;5145.81989630363;5148.613853960949;5159.458256883029;5182.015417070764;5100.719460429694;5112.488751124895;5128.769205385766;5136.64043516954;5177.534021938006;4971.37857767779;5030.220315851049;5049.469805670426;5055.69665820052;5117.950820081875;4336.436263285784;5415.025295446818;5455.563554915637;5517.393086760453;5541.639793413456;6159.538034647419;6169.259688837368;6188.721507532172;6190;6192.442680158807;4654.953450465486;6084.139168577419;6153.138560601519;6199.411055949678;6222.160008398853;5585.441455854382;5611.915821262603;5612.719364031782;5647.209390685307;5650.406707295716;6147.139400483936;6214.161088253119;6229.688515574294;6230.190075290274;6244.344343843922;5883.411658834082;5905.586608937333;5933.910991335133;5994.550408719363;6030.517558595389;6144.600600960924;6158.661273629993;6167.229096362955;6167.444929956326;6173.290071641819;6100.241811387125;6102.792231004566;6106.331479465868;6115.327313995457;6115.407021614468;5003.799848006039;5971.910421343597;6121.051237058263;6129.328227221949;6134.1604111416345;4834.178189707758;4843.782029808667;4860.708357498562;4863.513648635108;4871.732054737024;4380.8904777380185;4402.273624851863;4414.3157810539415;4419.513853476115;4423.469183697976;5575;5689.459501347365;5691.601587888891;5705.2012718219485;5712.600117991784;6163.506919446433;6205.565610407228;6207.596506227081;6209.813705588749;6210.968945155245;4720.716756994591;5646.2377579027125;5646.971765141148;5647.887042259132;5661;5219.269302297681;5263.184206448007;5293.867653308621;5319.468053194727;5381.2197231402015;6265.780697675559;6305.558610897285;6313.43179113882;6318.147050148263;6354.586951848115;6179.969100154471;6198;6210.875782484415;6212.844678883064;6228.937710622836;6151.477124444473;6218.81343559694;6283.717232724447;6284.245890492987;6324.683765811599;6086.482648974709;6094.573379863367;6102.328743838263;6111;6124.601900876429;6162.352952939877;6167.5682702210415;6171.9199140151195;6176.969115154396;6183.690815459299;5862.7654893805475;5957.553183511167;6022.548308876764;6080.148779171008;6115.969420152871;5742.397048309867;5779.335376431764;5789.45000224978;5789.8263052108505;5798.10129429939;5680.715964201856;5685.687287199244;5685.800996965087;5690;5706.201131841629;5812.76748930055;5992.370801065999;6068.939310606837;6090.177825993434;6123.418275263843;5847.8245652630485;5862.853428664317;5868.471837534642;5870.853228669317;5880.294364676266 17:59:35 INFO - PROCESS | 1936 | |1;ext.html;490.93957052766024;533.2640955481435;611.3458599298749;631.6052467207993;659.6569783712466;30288.939887103956;30839.84580077102;30860.845695771517;30871.919482818106;30944.226394340152;25418.237452876398;32924.50613240797;32954.835225823896;40195.99510012251;40952.795236023856;9337.019612940645;9523.380980236298;9543.236541076698;9558.665446709367;9596.952015239915;9406.764830879249;9590;9590.136887680108;9599.04009599038;9632.903670963306;8311.127331630183;8544.102869198738;9552.522373881313;11031.448427578629;11275.154363422776;11408;11505.654830355103;11519.25124866881;11519.596814111508;11531.308121512737;11238.325700457917;11416.657500275005;11421.257618254787;11436.828447573293;11441.828372574419;29978;30478.390432191452;30532.38935221283;37295.25409491822;37877.81061094705;3175.4442972479724;3267.0525547591405;3277.0824169232415;3289.654586268455;3799.525059367579;28119.0158344459;28372.71627283742;28423;28595.142145735663;28729;2693.5555633320478;2727.4545090981883;2742.5886117082396;2747.6840163381266;2789.1353680359152;332059;396543;397483;397668;398484.00757996313;60978.69510652507;61103.38896611066;61570.69214653988;61669.38330616636;61679.38320616737;65486.36284092936;65830.67084664546;65888;65897.01154482686;65914;16753.41363052312;17361.913190433967;17387.391441299493;17402.65194696099;17407.825921740874;13138.868611313765;13207.867921320663;13220.537281195113;13224.47102115924;13256.602301930958;16184.352625894833;19654.312099076462;20092.69860952087;20161;20208;7167.964160179165;7267.527610705393;7413.629318534159;7939.245771651684;7993.440459167919;969.340848223215;1042.608118162262;1042.7914417116608;1046.7487802927242;1144.6394385768456;26120.73879261183;26567.33581660474;27897.023604173755;27951.03395532304;28454.71545284562;980.578351308944;1120.9327440353604;1134.7673726885969;1200.3098218524383;1206.5656363709058;14300.785488217685;14920.701585968436;14996.62508437276;15173.924130379277;15238.642328681675;651708;660636;663034;663849;665865;47996.760016199696;55032.724836375564;55721.442785572435;60957.390426096055;61662.766744664856;1451.1075688451526;1458.6207586027497;1462.2688655672164;1464.8681618654373;1467.9706405872037;28549.714502855535;28552.000679976933;28634.713652863204;29269.560956586094;29307.41385172327;48987;49217.50782492272;49659.751701241265;49669.25496117489;49708.26021089245;379532;405313;416585.7512137381;416955;474566;27156.32109197286;27535.724642754118;27549.586756199074;27560.862195688893;27596.586051208847;46366;46399.76800115978;46556.603301901;46946.765266173454;48036;37436.21309294595;37490.812545938184;37683.81158094192;38066.238675226894;38314.80842595769;37422;37708.81145594364;37772.62227377691;38172.23655526818;38491.807540962116;37397.43903841499;37763.81118094392;38584.2283154341;38622.227555449295;38665.61334386733;32646.673533265315;32801.17997049997;33750.831245844594;33757;33983.83008085043;24242.51514969726;24904;25000.874995624905;25012.37469063288;25440.982360706104 17:59:35 INFO - PROCESS | 1936 | |2;jquery.html;370.5479315235412;388.88916658752277;397.6222588540886;399.8940280825582;400.40626586976055;19893.900530497365;20284.69572956405;20974.58050838984;21006.474838129034;21009.26467573635;19548.511287217792;19931.501712457197;21225.257116000943;21230.36308910731;21262.936853157356;5431.103867861808;5951.166836642873;5959.10613407988;5962.731677074542;5964.075568286901;5685.658860468365;5787.710614469281;5842.707864606774;5923.259592550931;5951.226340575719;5854.034084376073;5867.794627188049;5885.176075349455;5886.676232807194;5887.205227294325;5619.325680918275;5859.6191247569195;5878.559108066869;5911.793087241947;5931.139984702238;5113.744312784346;5145.536901678867;5148.124818780779;5151.871203219912;5155.639105262633;24629.261122166365;25128.49743005148;25773.61339579908;25780.96876124953;25833.354166145997;2176.673498975151;2211.3866490021437;2313.548857972696;2375;2489.7012358517095;11931.880681193164;14224.359903804354;14516.782248266285;14946.476873309492;15168.620784480367;1610.5329454458192;1706.3771723321022;1767.7260024696193;1783.7681101456858;1799.478151336111;82695;89490;110463.44768276188;114009;114121;9051.778009968702;10794.892051079389;11075.612353567587;11314.208005439705;11509.597164099216;14483.565493035227;14526.418943242363;14551.490697825737;14594.489192878198;14597.708045839025;8206.958965205255;8406.915930840612;8439;8497.2777313929;8524.8721269181;8427.41008129425;8436.45163064399;8464.534450605153;8557.614907329185;8558.443701159405;4435.578620031092;4529.479109902403;4536.5236650151255;4569.1547063793305;4612.630989520831;1908.6373589018042;1962.3229985654925;1968.4881930698123;1969.084375765276;1974.3484650065443;831.5260301628014;853.1042405474227;921.4425272710048;933.3932943586587;1009.1935435570247;14645.822425013048;16224.351025959066;19673.704894426595;20215.4946126348;20512.89743551273;795.6300320350949;924.117467818232;931.3759780946782;962.4465932089076;996.4519514267124;10505.369677819355;10681;10784.784304314027;10789.406582637874;10804.621838235624;587327;596641;607042;608261;608428;84935;116651.83348166579;128447;130604.3469782645;134466;875.2735229759285;971.7813491964251;974.2498276327188;1000.73407139968;1003.7992401519725;17079.48761537156;17734.379296724554;18111.184996674918;18134.45596632103;18207.362742303954;53690;54173;54966.35100946978;55174.068907588044;55271;79718.60140699259;80268.59865700868;81291.59354203191;81528.59235704021;82945.58527207325;7709.151993280847;7816.625965413889;7822.687092516236;8002.639881205476;8029.678812847421;10730.570777169138;10996.065334446661;11316.6039188628;12267.263964162179;12399.75200496003;10328.690139295833;10604.787904241717;10662.573497060032;10685.946570267099;10772.24594278393;8977.865332019894;9915.950420247853;10556.313839600401;10724.249302548747;10821.40482273451;10913.781724365626;11050.392228427514;11248.718782030515;11308.49111789955;11310.491027903929;7659.617019149132;7908.565028923234;7947.052972021892;8005.9599702001115;8239.835203295781;8191.918080819354;10214.744631384276;10742.086922611665;11020.724481888017;11217.046551043253 17:59:35 INFO - PROCESS | 1936 | |3;mootools.html;1436.0665567381195;1612.3147662243546;1617.3045590396132;1900.36337826828;2031.8171364577195;7867.960660196698;8670.956645216773;8834.469931804097;8851;8851.690190843321;8430.578471076453;8664.783380415493;8678;8680.91319086809;8688.391812573122;2103.968440473394;2174.2281490071036;2176.031665908671;2426.672399226104;2463.359526523099;2225.2434172381386;2421.7578242175728;2523.5836087045614;2524.8485090894515;2534.3664083979006;2424.6847909771705;2457.69278840145;2459.397447625325;2463.6304554316816;2470.6788117544693;2149.3014770199748;2444.5477586646525;2449.5590793657134;2456.38590352411;2459.95080098397;2446.6696995905504;2513.710923243832;2515.0819950718037;2515.1448507507534;2516.937076573082;8440.240378365976;8556.144385561456;8557.572121393905;8561.614727337284;8600.311975041981;5126.231065340229;5329.467053294678;5332.200169974496;5372.919406208871;5375.489328513785;3359.5464612277274;3481.756277060607;3549.94675079874;3554.5023696682483;3572;1034.3845411979935;1052.6631477927067;1058.2909450668071;1060.5068643081004;1063.3672964586137;11439.256448330832;11699.298042117414;11730.824037639528;11731.002864756507;11747;4688.249880019249;4692.41344831896;4828.179209534387;4878.682885612424;4879.707217566957;10006.949965250273;10050.949745251228;10052.296339256329;10058.29591928558;10086.344387614781;5361.222622719762;5396.64921780083;5397.163439666858;5402.459754024566;5412;4743.31221972812;4768.928466073012;4936.160852655057;4965.90068198634;4973.5523802857915;3792.715546334036;3844.59631738669;3887.261420330128;3895.2599006188734;3946.605339466088;1190.7261329894172;1193.1349771415655;1203.5125774061519;1207.7825991321647;1207.9396030198454;778.852018116556;855.3036775077951;891.0065277215857;931.7391130483476;965.7875267441152;5671.6597004179885;5708.514776243983;5865.090910908816;5888.5289176865745;6032.50578319155;468.770302551754;476.8688610632104;478.62427994024523;909.777104609375;1054.7415883108688;3897.5517815451585;3943.211357728466;3962.3660214365564;3969.7221194516105;3996.1008773025837;10266.332688375232;10295.3822770634;10736.516856741466;10747.301425407324;10784.406857622906;10516;10606.946965265124;10736.409497477558;10740.409277489813;10758.031777140095;6236.282827474898;7995.720149794729;8083.514989100673;8245.257926786499;8256.793580160424;5698.857528561819;5753.252077229933;5978.432048955342;6042.607230530001;6048.637081775108;7269.636518174176;9654.2276617869;9846.556904939152;9854.704358869245;9870.703878883645;9121.77195570116;9598.280128990215;9873.901260987586;9933.056359645821;9956.452395118338;6549.115869357575;6852.794416167523;7035.226125126334;7052.964735176496;7057.6471176442;7530.548167109991;7608.505447145918;8071.152528984372;8081.878771818545;8089.191080891864;7167.104111986002;7296.19741828409;7311.524750891175;7417.703291868264;7460.626968651437;7183.245759195209;7188.424926006011;7248.166460857069;7321.121465424183;7322.3775979042375;6701.765438209639;6960.269171737097;6979;6985.965070174617;6997.195322537769;3809.29528037314;4846.200376937766;4886.193778026728;4964.602831773522;5078.771455284447;4860.635452341018;4886.755662216804;4933.605311574994;4953.876153096201;5004.174311238605 17:59:35 INFO - PROCESS | 1936 | |4;prototype.html;307.87838803672537;315.03598987099474;323.7054280604649;325.5101072885307;327.09068788767206;4211.178820130076;4886.584640305578;5180.430152683207;5249.454014802827;5312.203169524569;5037.596992240621;5121.795128194868;5126.359205099363;5214.148977113127;5287.788488460457;3280.8195549244783;3575.8390872410805;3659.9451008234896;3688.981555092221;4029.355303151496;3766.435034744783;4059.9797001014954;4060.1173167051284;4084.100893084715;4093.2018256440006;3127.311991361908;3474.409350410436;3948.486696729421;4003.256954747306;4010.7794071326066;3315.237495376077;3977.8011099445202;3988.4615576897327;3991.2217117662067;4007.819648115827;3442.638522955104;3480.4083305838067;3489.94765078524;3512.824358782076;3519.8416071276856;4395.868123956287;4777.993242837982;4865.6107511399005;5017.096922553938;5128.282040514331;4241.809118589671;4497.505274419844;4513.684042117053;4527.207738645757;4534.31985202219;4567.885802854922;4593.747343896084;5475.753591088411;5489.204065410533;5502.606366230702;3660.3960346543054;3824.6749026332795;3828;3834.1373191032076;3842.4620553122586;5773.162891380726;5798.652080875118;5820.5634577406445;5841.474267315962;5858.472737453607;3362.81504517249;3795.8802153364823;3801.2777572261184;3856.305864944337;3907.0623050467684;3358.9587227958923;3483.355579217802;3516.2088530081037;3925.684895559962;4010.258102251093;3558.7153027757718;4084.917496863334;4316.395704601358;4323.740575565414;4586.908261834745;4882.951170488321;4921.040397122527;5030.798768049311;5603.887922241533;5626.578006649518;1358.1443690474937;1376.8554301798367;1394.8047273381735;1424.3376829774204;1437.2813593203398;804.9154838741965;916.7708072981754;936.5779184873757;956.6699488676395;958.3052287091942;4671.649626278043;5523.7238138093735;5533.280673512418;5554.972225138848;5613.410591887875;6139.96930015356;6177.139287945034;6187.938120618736;6224.221972253468;6226.533010024266;5241.868953276123;5319.601029922771;5518.806841760519;5569.554435645138;5576.414476479992;2570.4216551275813;3217.790843595159;3224.725898298671;3239.49787782894;3244.977831982918;4984.352034235599;6414.332273608895;6436.873547129234;6475.061116138134;6498.902516462257;5884.882302353929;6305.022721478178;6331.493480521547;6366.554341196072;6385.553011289258;5197.688138711689;5916.964531207108;6427.646479443675;6472.741090356333;6550.7707230246715;5858.9121163181735;6206.937930620817;6211.254649442096;6213.105002974136;6221.626702397871;4883.584895283799;5861.6225187080145;6080.621952194413;6123.785667501616;6141.232345956755;5664.348599910898;5728.427157284238;6158.737458820841;6296.874062518816;6298.708764703317;3674.8713795017047;3697.1144716194394;3699.1307042845447;4050.939235911405;4136.710430269853;5200.791968321376;5451.400345961862;5988.921994041115;6197.380261973947;6216.875662486816;5142.885691446752;5334.67991920486;5498.5876059296515;5562.721863906708;5604.551635869202;4668.296071933788;4951.910579672611;5168.922466162935;5507.339119305549;5513;4369.934450983302;5416.350037995466;5442.945570544244;5492.176173573996;5504.972475137599;5462.726863656721;5500.452208325528;5518.475744804237;5545.500904918576;5553.16702494629;4157.625813676663;4479.977600111979;4757.785899634456;5427.402985671652;5467.890642187054 17:59:35 INFO - PROCESS | 1936 | |5;yui.html;699.8180473076999;711.2887112887112;731.4148681055157;745.1840234942736;764.5336344829657;14828.555143345704;14861.588149125842;15095.169765662884;15105.924470377633;15144.242787860618;11564.479598418091;13826.930865345685;13866.029377943523;13964.720705585907;13983.93008034961;702.1959855964917;724.5000949344961;886.2289807867148;906;908.7728067983004;861.8060936289347;905.2441211588332;907.9319051071163;908.0374802709116;908.0374802709149;945.5036106044347;966.9854952175723;967.6177909725654;968.903109689029;969.1035791892507;736.7789663101048;936.8688383626297;954.5322791831987;961.0677642686618;972.2222222222265;723.5622448418684;724.0840336973732;724.7101159536174;726.1431510817233;728.2026181331433;14685.412583496647;14742.631434214123;14749.115053096848;14765.704685906328;14767.704645907022;12233.755324893542;12352.752944941141;12451.315177665225;12705.110642255046;12765.489380424771;8681.784550162982;8984.416012959202;9841.606335746561;10020.498975051218;10196.643117490927;3462.307538492312;3511.0169152637304;3531.911702207465;3548.929021419557;3598.7660802047785;56903.71548142274;72508.27491725067;74464.02143914292;79275.60362198151;84287.15712842855;9274.814503709888;9413.858792118124;9461.90538094624;9597;9706.951465242628;22446.438839029153;22460.887695561418;22464;22490.32529024132;22492.662610060863;7406.333429991327;7511.661975211128;7512.361449276764;7519.511231769918;7712;4005.679545636342;4044.8786536403954;4059.4316795648633;4065.0447144920918;4068.898277543085;3567.3935430976794;3661.8169091545315;3663.853445862189;3664.6518580734787;3666.7983260920373;604.0968751716213;621.273110460762;621.8880601491775;623.9469645080128;656.1207981305074;506.05873076078467;519.304132462502;573.8393249890038;610.2158726037021;615.8152554233712;7612.238776122344;8043.959780201179;8146.796330091676;8261.38039647029;8294.182414220866;503.5644167794831;558.9664620122805;584.4389386189221;598.5211830535641;602.8221674606002;3254.7884387514737;3777.58446570877;3959.8812035638975;3989.4215338776294;4181.829087855405;76087.61956190184;78757.60621196972;79109;97319.54020689696;99695;69080;72739;77456;79063;79097.20902791014;66777.33222667809;67212.66393668001;67721.3227867715;70067;73010.2944983165;7482.176960534228;8216.26053655174;8336.458130221516;8349.749507514784;8448.957755211184;41106.79446602748;43061.56938430701;43254.56745432506;44027.77986110177;44402.11195776002;45227.77386113048;61153.694231528556;61198.08202877049;61705.38294617176;62308.68845655743;10538.8419173714;10639.255252132276;10797.190210734068;11169.106471482424;11608.6517404478;12008.339541324962;12012;12282.32447215376;12559.43482543306;12597.811032834697;11257.831132533182;11535.538578456768;11611.187216894736;11796.88203117992;11887.286762793914;9233.445993240428;11380.886191137983;11410.30540981907;11475.311481311148;11633.243839150427;9422.905770942203;11231.550737970716;11286.66140015801;11313.434328283718;11662.70843228926;9589.232861370934;9844;9869.555869985725;9929.226893780316;10108.1408080314;9465.763355916157;9658.162781055256;9687.176589989647;9762.414255144715;9868.851967220355 17:59:35 INFO - PROCESS | 1936 | __end_tp_report 17:59:35 INFO - PROCESS | 1936 | __start_cc_report 17:59:35 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1273 17:59:35 INFO - PROCESS | 1936 | __end_cc_report 17:59:35 INFO - PROCESS | 1936 | __startTimestamp1462409975047__endTimestamp 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | ------- Summary: start ------- 17:59:35 INFO - PROCESS | 1936 | Number of tests: 6 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | [#0] dojo.html Cycles:165 Average:5626.29 Median:5742.40 stddev:639.06 (11.1%) stddev-sans-first:615.95 17:59:35 INFO - PROCESS | 1936 | Values: 3366.8 3423.1 3446.7 3455.5 3489.9 5522.3 5638.2 5642.4 5662.5 5707.0 4603.2 5572.1 5649.8 5650.7 5652.8 5086.1 5108.8 5130.0 5160.1 5179.9 5162.1 5173.1 5188.5 5192.4 5209.2 5112.9 5145.8 5148.6 5159.5 5182.0 5100.7 5112.5 5128.8 5136.6 5177.5 4971.4 5030.2 5049.5 5055.7 5118.0 4336.4 5415.0 5455.6 5517.4 5541.6 6159.5 6169.3 6188.7 6190.0 6192.4 4655.0 6084.1 6153.1 6199.4 6222.2 5585.4 5611.9 5612.7 5647.2 5650.4 6147.1 6214.2 6229.7 6230.2 6244.3 5883.4 5905.6 5933.9 5994.6 6030.5 6144.6 6158.7 6167.2 6167.4 6173.3 6100.2 6102.8 6106.3 6115.3 6115.4 5003.8 5971.9 6121.1 6129.3 6134.2 4834.2 4843.8 4860.7 4863.5 4871.7 4380.9 4402.3 4414.3 4419.5 4423.5 5575.0 5689.5 5691.6 5705.2 5712.6 6163.5 6205.6 6207.6 6209.8 6211.0 4720.7 5646.2 5647.0 5647.9 5661.0 5219.3 5263.2 5293.9 5319.5 5381.2 6265.8 6305.6 6313.4 6318.1 6354.6 6180.0 6198.0 6210.9 6212.8 6228.9 6151.5 6218.8 6283.7 6284.2 6324.7 6086.5 6094.6 6102.3 6111.0 6124.6 6162.4 6167.6 6171.9 6177.0 6183.7 5862.8 5957.6 6022.5 6080.1 6116.0 5742.4 5779.3 5789.5 5789.8 5798.1 5680.7 5685.7 5685.8 5690.0 5706.2 5812.8 5992.4 6068.9 6090.2 6123.4 5847.8 5862.9 5868.5 5870.9 5880.3 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | [#1] ext.html Cycles:180 Average:62805.23 Median:32939.67 stddev:134720.93 (409.0%) stddev-sans-first:135017.62 17:59:35 INFO - PROCESS | 1936 | Values: 490.9 533.3 611.3 631.6 659.7 30288.9 30839.8 30860.8 30871.9 30944.2 25418.2 32924.5 32954.8 40196.0 40952.8 9337.0 9523.4 9543.2 9558.7 9597.0 9406.8 9590.0 9590.1 9599.0 9632.9 8311.1 8544.1 9552.5 11031.4 11275.2 11408.0 11505.7 11519.3 11519.6 11531.3 11238.3 11416.7 11421.3 11436.8 11441.8 29978.0 30478.4 30532.4 37295.3 37877.8 3175.4 3267.1 3277.1 3289.7 3799.5 28119.0 28372.7 28423.0 28595.1 28729.0 2693.6 2727.5 2742.6 2747.7 2789.1 332059.0 396543.0 397483.0 397668.0 398484.0 60978.7 61103.4 61570.7 61669.4 61679.4 65486.4 65830.7 65888.0 65897.0 65914.0 16753.4 17361.9 17387.4 17402.7 17407.8 13138.9 13207.9 13220.5 13224.5 13256.6 16184.4 19654.3 20092.7 20161.0 20208.0 7168.0 7267.5 7413.6 7939.2 7993.4 969.3 1042.6 1042.8 1046.7 1144.6 26120.7 26567.3 27897.0 27951.0 28454.7 980.6 1120.9 1134.8 1200.3 1206.6 14300.8 14920.7 14996.6 15173.9 15238.6 651708.0 660636.0 663034.0 663849.0 665865.0 47996.8 55032.7 55721.4 60957.4 61662.8 1451.1 1458.6 1462.3 1464.9 1468.0 28549.7 28552.0 28634.7 29269.6 29307.4 48987.0 49217.5 49659.8 49669.3 49708.3 379532.0 405313.0 416585.8 416955.0 474566.0 27156.3 27535.7 27549.6 27560.9 27596.6 46366.0 46399.8 46556.6 46946.8 48036.0 37436.2 37490.8 37683.8 38066.2 38314.8 37422.0 37708.8 37772.6 38172.2 38491.8 37397.4 37763.8 38584.2 38622.2 38665.6 32646.7 32801.2 33750.8 33757.0 33983.8 24242.5 24904.0 25000.9 25012.4 25441.0 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | [#2] jquery.html Cycles:180 Average:34453.06 Median:13101.95 stddev:99960.73 (762.9%) stddev-sans-first:100208.39 17:59:35 INFO - PROCESS | 1936 | Values: 370.5 388.9 397.6 399.9 400.4 19893.9 20284.7 20974.6 21006.5 21009.3 19548.5 19931.5 21225.3 21230.4 21262.9 5431.1 5951.2 5959.1 5962.7 5964.1 5685.7 5787.7 5842.7 5923.3 5951.2 5854.0 5867.8 5885.2 5886.7 5887.2 5619.3 5859.6 5878.6 5911.8 5931.1 5113.7 5145.5 5148.1 5151.9 5155.6 24629.3 25128.5 25773.6 25781.0 25833.4 2176.7 2211.4 2313.5 2375.0 2489.7 11931.9 14224.4 14516.8 14946.5 15168.6 1610.5 1706.4 1767.7 1783.8 1799.5 82695.0 89490.0 110463.4 114009.0 114121.0 9051.8 10794.9 11075.6 11314.2 11509.6 14483.6 14526.4 14551.5 14594.5 14597.7 8207.0 8406.9 8439.0 8497.3 8524.9 8427.4 8436.5 8464.5 8557.6 8558.4 4435.6 4529.5 4536.5 4569.2 4612.6 1908.6 1962.3 1968.5 1969.1 1974.3 831.5 853.1 921.4 933.4 1009.2 14645.8 16224.4 19673.7 20215.5 20512.9 795.6 924.1 931.4 962.4 996.5 10505.4 10681.0 10784.8 10789.4 10804.6 587327.0 596641.0 607042.0 608261.0 608428.0 84935.0 116651.8 128447.0 130604.3 134466.0 875.3 971.8 974.2 1000.7 1003.8 17079.5 17734.4 18111.2 18134.5 18207.4 53690.0 54173.0 54966.4 55174.1 55271.0 79718.6 80268.6 81291.6 81528.6 82945.6 7709.2 7816.6 7822.7 8002.6 8029.7 10730.6 10996.1 11316.6 12267.3 12399.8 10328.7 10604.8 10662.6 10685.9 10772.2 8977.9 9916.0 10556.3 10724.2 10821.4 10913.8 11050.4 11248.7 11308.5 11310.5 7659.6 7908.6 7947.1 8006.0 8239.8 8191.9 10214.7 10742.1 11020.7 11217.0 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | [#3] mootools.html Cycles:180 Average:5624.54 Median:4910.18 stddev:3131.85 (63.8%) stddev-sans-first:3124.82 17:59:35 INFO - PROCESS | 1936 | Values: 1436.1 1612.3 1617.3 1900.4 2031.8 7868.0 8671.0 8834.5 8851.0 8851.7 8430.6 8664.8 8678.0 8680.9 8688.4 2104.0 2174.2 2176.0 2426.7 2463.4 2225.2 2421.8 2523.6 2524.8 2534.4 2424.7 2457.7 2459.4 2463.6 2470.7 2149.3 2444.5 2449.6 2456.4 2460.0 2446.7 2513.7 2515.1 2515.1 2516.9 8440.2 8556.1 8557.6 8561.6 8600.3 5126.2 5329.5 5332.2 5372.9 5375.5 3359.5 3481.8 3549.9 3554.5 3572.0 1034.4 1052.7 1058.3 1060.5 1063.4 11439.3 11699.3 11730.8 11731.0 11747.0 4688.2 4692.4 4828.2 4878.7 4879.7 10006.9 10050.9 10052.3 10058.3 10086.3 5361.2 5396.6 5397.2 5402.5 5412.0 4743.3 4768.9 4936.2 4965.9 4973.6 3792.7 3844.6 3887.3 3895.3 3946.6 1190.7 1193.1 1203.5 1207.8 1207.9 778.9 855.3 891.0 931.7 965.8 5671.7 5708.5 5865.1 5888.5 6032.5 468.8 476.9 478.6 909.8 1054.7 3897.6 3943.2 3962.4 3969.7 3996.1 10266.3 10295.4 10736.5 10747.3 10784.4 10516.0 10606.9 10736.4 10740.4 10758.0 6236.3 7995.7 8083.5 8245.3 8256.8 5698.9 5753.3 5978.4 6042.6 6048.6 7269.6 9654.2 9846.6 9854.7 9870.7 9121.8 9598.3 9873.9 9933.1 9956.5 6549.1 6852.8 7035.2 7053.0 7057.6 7530.5 7608.5 8071.2 8081.9 8089.2 7167.1 7296.2 7311.5 7417.7 7460.6 7183.2 7188.4 7248.2 7321.1 7322.4 6701.8 6960.3 6979.0 6986.0 6997.2 3809.3 4846.2 4886.2 4964.6 5078.8 4860.6 4886.8 4933.6 4953.9 5004.2 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | [#4] prototype.html Cycles:180 Average:4578.25 Median:5079.70 stddev:1475.55 (29.0%) stddev-sans-first:1444.46 17:59:35 INFO - PROCESS | 1936 | Values: 307.9 315.0 323.7 325.5 327.1 4211.2 4886.6 5180.4 5249.5 5312.2 5037.6 5121.8 5126.4 5214.1 5287.8 3280.8 3575.8 3659.9 3689.0 4029.4 3766.4 4060.0 4060.1 4084.1 4093.2 3127.3 3474.4 3948.5 4003.3 4010.8 3315.2 3977.8 3988.5 3991.2 4007.8 3442.6 3480.4 3489.9 3512.8 3519.8 4395.9 4778.0 4865.6 5017.1 5128.3 4241.8 4497.5 4513.7 4527.2 4534.3 4567.9 4593.7 5475.8 5489.2 5502.6 3660.4 3824.7 3828.0 3834.1 3842.5 5773.2 5798.7 5820.6 5841.5 5858.5 3362.8 3795.9 3801.3 3856.3 3907.1 3359.0 3483.4 3516.2 3925.7 4010.3 3558.7 4084.9 4316.4 4323.7 4586.9 4883.0 4921.0 5030.8 5603.9 5626.6 1358.1 1376.9 1394.8 1424.3 1437.3 804.9 916.8 936.6 956.7 958.3 4671.6 5523.7 5533.3 5555.0 5613.4 6140.0 6177.1 6187.9 6224.2 6226.5 5241.9 5319.6 5518.8 5569.6 5576.4 2570.4 3217.8 3224.7 3239.5 3245.0 4984.4 6414.3 6436.9 6475.1 6498.9 5884.9 6305.0 6331.5 6366.6 6385.6 5197.7 5917.0 6427.6 6472.7 6550.8 5858.9 6206.9 6211.3 6213.1 6221.6 4883.6 5861.6 6080.6 6123.8 6141.2 5664.3 5728.4 6158.7 6296.9 6298.7 3674.9 3697.1 3699.1 4050.9 4136.7 5200.8 5451.4 5988.9 6197.4 6216.9 5142.9 5334.7 5498.6 5562.7 5604.6 4668.3 4951.9 5168.9 5507.3 5513.0 4369.9 5416.4 5442.9 5492.2 5505.0 5462.7 5500.5 5518.5 5545.5 5553.2 4157.6 4480.0 4757.8 5427.4 5467.9 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - PROCESS | 1936 | [#5] yui.html Cycles:180 Average:17357.91 Median:31160.60 stddev:23937.84 (76.8%) stddev-sans-first:23972.31 17:59:35 INFO - PROCESS | 1936 | Values: 699.8 711.3 731.4 745.2 764.5 14828.6 14861.6 15095.2 15105.9 15144.2 11564.5 13826.9 13866.0 13964.7 13983.9 702.2 724.5 886.2 906.0 908.8 861.8 905.2 907.9 908.0 908.0 945.5 967.0 967.6 968.9 969.1 736.8 936.9 954.5 961.1 972.2 723.6 724.1 724.7 726.1 728.2 14685.4 14742.6 14749.1 14765.7 14767.7 12233.8 12352.8 12451.3 12705.1 12765.5 8681.8 8984.4 9841.6 10020.5 10196.6 3462.3 3511.0 3531.9 3548.9 3598.8 56903.7 72508.3 74464.0 79275.6 84287.2 9274.8 9413.9 9461.9 9597.0 9707.0 22446.4 22460.9 22464.0 22490.3 22492.7 7406.3 7511.7 7512.4 7519.5 7712.0 4005.7 4044.9 4059.4 4065.0 4068.9 3567.4 3661.8 3663.9 3664.7 3666.8 604.1 621.3 621.9 623.9 656.1 506.1 519.3 573.8 610.2 615.8 7612.2 8044.0 8146.8 8261.4 8294.2 503.6 559.0 584.4 598.5 602.8 3254.8 3777.6 3959.9 3989.4 4181.8 76087.6 78757.6 79109.0 97319.5 99695.0 69080.0 72739.0 77456.0 79063.0 79097.2 66777.3 67212.7 67721.3 70067.0 73010.3 7482.2 8216.3 8336.5 8349.7 8449.0 41106.8 43061.6 43254.6 44027.8 44402.1 45227.8 61153.7 61198.1 61705.4 62308.7 10538.8 10639.3 10797.2 11169.1 11608.7 12008.3 12012.0 12282.3 12559.4 12597.8 11257.8 11535.5 11611.2 11796.9 11887.3 9233.4 11380.9 11410.3 11475.3 11633.2 9422.9 11231.6 11286.7 11313.4 11662.7 9589.2 9844.0 9869.6 9929.2 10108.1 9465.8 9658.2 9687.2 9762.4 9868.9 17:59:35 INFO - PROCESS | 1936 | -------- Summary: end -------- 17:59:35 INFO - PROCESS | 1936 | 17:59:35 INFO - TEST-INFO | 1936: exit 0 17:59:35 INFO - TEST-OK | dromaeo_css | took 1115604ms 17:59:35 INFO - TEST-START | kraken 17:59:35 INFO - operating with platform_type : mac_ 17:59:35 INFO - Initialising browser for kraken test... 17:59:35 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp4I4lui/profile http://localhost:52285/getInfo.html) 17:59:37 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 17:59:37 INFO - PROCESS | 1939 | colorDepth:24 17:59:37 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 17:59:37 INFO - PROCESS | 1939 | __metrics 17:59:37 INFO - PROCESS | 1939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:59:37 ERROR - PROCESS | 1939 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:59:38 INFO - TEST-INFO | 1939: exit 0 17:59:38 INFO - Browser initialized. 17:59:38 INFO - Running cycle 1/1 for kraken test... 17:59:38 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp4I4lui/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:50 INFO - PROCESS | 1941 | RSS: Main: 239706112 17:59:50 INFO - PROCESS | 1941 | 17:59:53 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-beat-detection) 17:59:54 INFO - PROCESS | 1941 | RSS: Main: 287141888 17:59:54 INFO - PROCESS | 1941 | 17:59:56 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-dft) 17:59:57 INFO - PROCESS | 1941 | RSS: Main: 295653376 17:59:57 INFO - PROCESS | 1941 | 18:00:00 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-fft) 18:00:01 INFO - PROCESS | 1941 | RSS: Main: 381808640 18:00:01 INFO - PROCESS | 1941 | 18:00:03 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52285/tests/kraken/driver.html?testName=audio-oscillator) 18:00:04 INFO - PROCESS | 1941 | RSS: Main: 280293376 18:00:04 INFO - PROCESS | 1941 | 18:00:06 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:00:06 INFO - PROCESS | 1941 | RSS: Main: 285294592 18:00:06 INFO - PROCESS | 1941 | 18:00:09 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52285/tests/kraken/driver.html?testName=imaging-darkroom) 18:00:10 INFO - PROCESS | 1941 | RSS: Main: 321110016 18:00:10 INFO - PROCESS | 1941 | 18:00:13 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52285/tests/kraken/driver.html?testName=imaging-desaturate) 18:00:13 INFO - PROCESS | 1941 | RSS: Main: 322297856 18:00:13 INFO - PROCESS | 1941 | 18:00:16 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52285/tests/kraken/driver.html?testName=json-parse-financial) 18:00:17 INFO - PROCESS | 1941 | RSS: Main: 320409600 18:00:17 INFO - PROCESS | 1941 | 18:00:18 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:00:19 INFO - PROCESS | 1941 | RSS: Main: 312922112 18:00:19 INFO - PROCESS | 1941 | 18:00:21 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:00:21 INFO - PROCESS | 1941 | RSS: Main: 320106496 18:00:21 INFO - PROCESS | 1941 | 18:00:23 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:00:24 INFO - PROCESS | 1941 | RSS: Main: 321323008 18:00:24 INFO - PROCESS | 1941 | 18:00:27 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:00:28 INFO - PROCESS | 1941 | RSS: Main: 326361088 18:00:28 INFO - PROCESS | 1941 | 18:00:31 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:00:31 INFO - PROCESS | 1941 | RSS: Main: 324038656 18:00:31 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52285/tests/kraken/driver.html?testName=ai-astar) 18:00:33 INFO - PROCESS | 1941 | RSS: Main: 388345856 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | __start_tp_report 18:00:33 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 18:00:33 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 18:00:33 INFO - PROCESS | 1941 | |i|pagename|runs| 18:00:33 INFO - PROCESS | 1941 | |0;ai-astar;111;112;108;111;114;112;111;112;102;119 18:00:33 INFO - PROCESS | 1941 | |1;audio-beat-detection;155;120;141;164;119;141;137;119;167;121 18:00:33 INFO - PROCESS | 1941 | |2;audio-dft;182;187;182;185;186;184;181;186;184;186 18:00:33 INFO - PROCESS | 1941 | |3;audio-fft;80;73;88;92;56;58;59;85;87;55 18:00:33 INFO - PROCESS | 1941 | |4;audio-oscillator;93;95;140;77;76;79;125;80;79;130 18:00:33 INFO - PROCESS | 1941 | |5;imaging-gaussian-blur;87;84;87;84;87;84;88;88;134;84 18:00:33 INFO - PROCESS | 1941 | |6;imaging-darkroom;94;95;94;94;93;94;94;94;93;94 18:00:33 INFO - PROCESS | 1941 | |7;imaging-desaturate;84;84;83;86;85;84;85;83;86;87 18:00:33 INFO - PROCESS | 1941 | |8;json-parse-financial;61;62;59;58;59;60;58;76;60;59 18:00:33 INFO - PROCESS | 1941 | |9;json-stringify-tinderbox;63;70;80;73;71;67;66;67;68;69 18:00:33 INFO - PROCESS | 1941 | |10;stanford-crypto-aes;83;82;82;83;83;82;82;89;104;106 18:00:33 INFO - PROCESS | 1941 | |11;stanford-crypto-ccm;137;136;150;146;141;145;152;136;178;152 18:00:33 INFO - PROCESS | 1941 | |12;stanford-crypto-pbkdf2;174;174;175;174;172;169;171;172;172;170 18:00:33 INFO - PROCESS | 1941 | |13;stanford-crypto-sha256-iterative;68;68;70;67;67;67;70;88;96;92 18:00:33 INFO - PROCESS | 1941 | __end_tp_report 18:00:33 INFO - PROCESS | 1941 | __start_cc_report 18:00:33 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,2093 18:00:33 INFO - PROCESS | 1941 | __end_cc_report 18:00:33 INFO - PROCESS | 1941 | __startTimestamp1462410033767__endTimestamp 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | ------- Summary: start ------- 18:00:33 INFO - PROCESS | 1941 | Number of tests: 14 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:4.29 (3.8%) stddev-sans-first:4.55 18:00:33 INFO - PROCESS | 1941 | Values: 111.0 112.0 108.0 111.0 114.0 112.0 111.0 112.0 102.0 119.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:141.00 stddev:18.73 (13.3%) stddev-sans-first:18.88 18:00:33 INFO - PROCESS | 1941 | Values: 155.0 120.0 141.0 164.0 119.0 141.0 137.0 119.0 167.0 121.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.06 (1.1%) stddev-sans-first:2.01 18:00:33 INFO - PROCESS | 1941 | Values: 182.0 187.0 182.0 185.0 186.0 184.0 181.0 186.0 184.0 186.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#3] audio-fft Cycles:10 Average:73.30 Median:82.50 stddev:14.94 (18.1%) stddev-sans-first:15.65 18:00:33 INFO - PROCESS | 1941 | Values: 80.0 73.0 88.0 92.0 56.0 58.0 59.0 85.0 87.0 55.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:79.00 stddev:24.76 (31.3%) stddev-sans-first:26.21 18:00:33 INFO - PROCESS | 1941 | Values: 93.0 95.0 140.0 77.0 76.0 79.0 125.0 80.0 79.0 130.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:87.00 stddev:15.31 (17.6%) stddev-sans-first:16.18 18:00:33 INFO - PROCESS | 1941 | Values: 87.0 84.0 87.0 84.0 87.0 84.0 88.0 88.0 134.0 84.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:00:33 INFO - PROCESS | 1941 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 94.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 18:00:33 INFO - PROCESS | 1941 | Values: 84.0 84.0 83.0 86.0 85.0 84.0 85.0 83.0 86.0 87.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:60.00 stddev:5.35 (8.9%) stddev-sans-first:5.67 18:00:33 INFO - PROCESS | 1941 | Values: 61.0 62.0 59.0 58.0 59.0 60.0 58.0 76.0 60.0 59.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:4.65 (6.7%) stddev-sans-first:4.31 18:00:33 INFO - PROCESS | 1941 | Values: 63.0 70.0 80.0 73.0 71.0 67.0 66.0 67.0 68.0 69.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:82.50 stddev:9.42 (11.4%) stddev-sans-first:9.84 18:00:33 INFO - PROCESS | 1941 | Values: 83.0 82.0 82.0 83.0 83.0 82.0 82.0 89.0 104.0 106.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:148.00 stddev:12.48 (8.4%) stddev-sans-first:12.67 18:00:33 INFO - PROCESS | 1941 | Values: 137.0 136.0 150.0 146.0 141.0 145.0 152.0 136.0 178.0 152.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:1.95 (1.1%) stddev-sans-first:1.96 18:00:33 INFO - PROCESS | 1941 | Values: 174.0 174.0 175.0 174.0 172.0 169.0 171.0 172.0 172.0 170.0 18:00:33 INFO - PROCESS | 1941 | 18:00:33 INFO - PROCESS | 1941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:70.00 stddev:11.73 (16.8%) stddev-sans-first:12.14 18:00:33 INFO - PROCESS | 1941 | Values: 68.0 68.0 70.0 67.0 67.0 67.0 70.0 88.0 96.0 92.0 18:00:33 INFO - PROCESS | 1941 | -------- Summary: end -------- 18:00:33 INFO - PROCESS | 1941 | 18:00:34 INFO - TEST-INFO | 1941: exit 0 18:00:34 INFO - TEST-OK | kraken | took 58951ms 18:00:34 INFO - SUITE-END | took 1174s 18:00:34 INFO - Completed test suite (00:19:34) 18:00:34 INFO - javascript benchmark 18:00:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.7811592246508, 3423.0928803866964, 3446.6897979181867, 3455.498952651867, 3489.860405583777, 5522.254495643087, 5638.210650508921, 5642.4357564243555, 5662.490375866171, 5707.0, 4603.240465323218, 5572.136318870572, 5649.774009039634, 5650.7174641267975, 5652.773889044443, 5086.0590790703745, 5108.84673459795, 5129.999650068219, 5160.14857548504, 5179.922301165486, 5162.096633089194, 5173.068847607429, 5188.507091826289, 5192.350956130484, 5209.21861720743, 5112.8977420451565, 5145.81989630363, 5148.613853960949, 5159.458256883029, 5182.015417070764, 5100.719460429694, 5112.488751124895, 5128.769205385766, 5136.64043516954, 5177.534021938006, 4971.37857767779, 5030.220315851049, 5049.469805670426, 5055.69665820052, 5117.950820081875, 4336.436263285784, 5415.025295446818, 5455.563554915637, 5517.393086760453, 5541.639793413456, 6159.538034647419, 6169.259688837368, 6188.721507532172, 6190.0, 6192.442680158807, 4654.953450465486, 6084.139168577419, 6153.138560601519, 6199.411055949678, 6222.160008398853, 5585.441455854382, 5611.915821262603, 5612.719364031782, 5647.209390685307, 5650.406707295716, 6147.139400483936, 6214.161088253119, 6229.688515574294, 6230.190075290274, 6244.344343843922, 5883.411658834082, 5905.586608937333, 5933.910991335133, 5994.550408719363, 6030.517558595389, 6144.600600960924, 6158.661273629993, 6167.229096362955, 6167.444929956326, 6173.290071641819, 6100.241811387125, 6102.792231004566, 6106.331479465868, 6115.327313995457, 6115.407021614468, 5003.799848006039, 5971.910421343597, 6121.051237058263, 6129.328227221949, 6134.1604111416345, 4834.178189707758, 4843.782029808667, 4860.708357498562, 4863.513648635108, 4871.732054737024, 4380.8904777380185, 4402.273624851863, 4414.3157810539415, 4419.513853476115, 4423.469183697976, 5575.0, 5689.459501347365, 5691.601587888891, 5705.2012718219485, 5712.600117991784, 6163.506919446433, 6205.565610407228, 6207.596506227081, 6209.813705588749, 6210.968945155245, 4720.716756994591, 5646.2377579027125, 5646.971765141148, 5647.887042259132, 5661.0, 5219.269302297681, 5263.184206448007, 5293.867653308621, 5319.468053194727, 5381.2197231402015, 6265.780697675559, 6305.558610897285, 6313.43179113882, 6318.147050148263, 6354.586951848115, 6179.969100154471, 6198.0, 6210.875782484415, 6212.844678883064, 6228.937710622836, 6151.477124444473, 6218.81343559694, 6283.717232724447, 6284.245890492987, 6324.683765811599, 6086.482648974709, 6094.573379863367, 6102.328743838263, 6111.0, 6124.601900876429, 6162.352952939877, 6167.5682702210415, 6171.9199140151195, 6176.969115154396, 6183.690815459299, 5862.7654893805475, 5957.553183511167, 6022.548308876764, 6080.148779171008, 6115.969420152871, 5742.397048309867, 5779.335376431764, 5789.45000224978, 5789.8263052108505, 5798.10129429939, 5680.715964201856, 5685.687287199244, 5685.800996965087, 5690.0, 5706.201131841629, 5812.76748930055, 5992.370801065999, 6068.939310606837, 6090.177825993434, 6123.418275263843, 5847.8245652630485, 5862.853428664317, 5868.471837534642, 5870.853228669317, 5880.294364676266], "value": 5588.114378999873, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.93957052766024, 533.2640955481435, 611.3458599298749, 631.6052467207993, 659.6569783712466, 30288.939887103956, 30839.84580077102, 30860.845695771517, 30871.919482818106, 30944.226394340152, 25418.237452876398, 32924.50613240797, 32954.835225823896, 40195.99510012251, 40952.795236023856, 9337.019612940645, 9523.380980236298, 9543.236541076698, 9558.665446709367, 9596.952015239915, 9406.764830879249, 9590.0, 9590.136887680108, 9599.04009599038, 9632.903670963306, 8311.127331630183, 8544.102869198738, 9552.522373881313, 11031.448427578629, 11275.154363422776, 11408.0, 11505.654830355103, 11519.25124866881, 11519.596814111508, 11531.308121512737, 11238.325700457917, 11416.657500275005, 11421.257618254787, 11436.828447573293, 11441.828372574419, 29978.0, 30478.390432191452, 30532.38935221283, 37295.25409491822, 37877.81061094705, 3175.4442972479724, 3267.0525547591405, 3277.0824169232415, 3289.654586268455, 3799.525059367579, 28119.0158344459, 28372.71627283742, 28423.0, 28595.142145735663, 28729.0, 2693.5555633320478, 2727.4545090981883, 2742.5886117082396, 2747.6840163381266, 2789.1353680359152, 332059.0, 396543.0, 397483.0, 397668.0, 398484.00757996313, 60978.69510652507, 61103.38896611066, 61570.69214653988, 61669.38330616636, 61679.38320616737, 65486.36284092936, 65830.67084664546, 65888.0, 65897.01154482686, 65914.0, 16753.41363052312, 17361.913190433967, 17387.391441299493, 17402.65194696099, 17407.825921740874, 13138.868611313765, 13207.867921320663, 13220.537281195113, 13224.47102115924, 13256.602301930958, 16184.352625894833, 19654.312099076462, 20092.69860952087, 20161.0, 20208.0, 7167.964160179165, 7267.527610705393, 7413.629318534159, 7939.245771651684, 7993.440459167919, 969.340848223215, 1042.608118162262, 1042.7914417116608, 1046.7487802927242, 1144.6394385768456, 26120.73879261183, 26567.33581660474, 27897.023604173755, 27951.03395532304, 28454.71545284562, 980.578351308944, 1120.9327440353604, 1134.7673726885969, 1200.3098218524383, 1206.5656363709058, 14300.785488217685, 14920.701585968436, 14996.62508437276, 15173.924130379277, 15238.642328681675, 651708.0, 660636.0, 663034.0, 663849.0, 665865.0, 47996.760016199696, 55032.724836375564, 55721.442785572435, 60957.390426096055, 61662.766744664856, 1451.1075688451526, 1458.6207586027497, 1462.2688655672164, 1464.8681618654373, 1467.9706405872037, 28549.714502855535, 28552.000679976933, 28634.713652863204, 29269.560956586094, 29307.41385172327, 48987.0, 49217.50782492272, 49659.751701241265, 49669.25496117489, 49708.26021089245, 379532.0, 405313.0, 416585.7512137381, 416955.0, 474566.0, 27156.32109197286, 27535.724642754118, 27549.586756199074, 27560.862195688893, 27596.586051208847, 46366.0, 46399.76800115978, 46556.603301901, 46946.765266173454, 48036.0, 37436.21309294595, 37490.812545938184, 37683.81158094192, 38066.238675226894, 38314.80842595769, 37422.0, 37708.81145594364, 37772.62227377691, 38172.23655526818, 38491.807540962116, 37397.43903841499, 37763.81118094392, 38584.2283154341, 38622.227555449295, 38665.61334386733, 32646.673533265315, 32801.17997049997, 33750.831245844594, 33757.0, 33983.83008085043, 24242.51514969726, 24904.0, 25000.874995624905, 25012.37469063288, 25440.982360706104], "value": 19544.403333301685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.5479315235412, 388.88916658752277, 397.6222588540886, 399.8940280825582, 400.40626586976055, 19893.900530497365, 20284.69572956405, 20974.58050838984, 21006.474838129034, 21009.26467573635, 19548.511287217792, 19931.501712457197, 21225.257116000943, 21230.36308910731, 21262.936853157356, 5431.103867861808, 5951.166836642873, 5959.10613407988, 5962.731677074542, 5964.075568286901, 5685.658860468365, 5787.710614469281, 5842.707864606774, 5923.259592550931, 5951.226340575719, 5854.034084376073, 5867.794627188049, 5885.176075349455, 5886.676232807194, 5887.205227294325, 5619.325680918275, 5859.6191247569195, 5878.559108066869, 5911.793087241947, 5931.139984702238, 5113.744312784346, 5145.536901678867, 5148.124818780779, 5151.871203219912, 5155.639105262633, 24629.261122166365, 25128.49743005148, 25773.61339579908, 25780.96876124953, 25833.354166145997, 2176.673498975151, 2211.3866490021437, 2313.548857972696, 2375.0, 2489.7012358517095, 11931.880681193164, 14224.359903804354, 14516.782248266285, 14946.476873309492, 15168.620784480367, 1610.5329454458192, 1706.3771723321022, 1767.7260024696193, 1783.7681101456858, 1799.478151336111, 82695.0, 89490.0, 110463.44768276188, 114009.0, 114121.0, 9051.778009968702, 10794.892051079389, 11075.612353567587, 11314.208005439705, 11509.597164099216, 14483.565493035227, 14526.418943242363, 14551.490697825737, 14594.489192878198, 14597.708045839025, 8206.958965205255, 8406.915930840612, 8439.0, 8497.2777313929, 8524.8721269181, 8427.41008129425, 8436.45163064399, 8464.534450605153, 8557.614907329185, 8558.443701159405, 4435.578620031092, 4529.479109902403, 4536.5236650151255, 4569.1547063793305, 4612.630989520831, 1908.6373589018042, 1962.3229985654925, 1968.4881930698123, 1969.084375765276, 1974.3484650065443, 831.5260301628014, 853.1042405474227, 921.4425272710048, 933.3932943586587, 1009.1935435570247, 14645.822425013048, 16224.351025959066, 19673.704894426595, 20215.4946126348, 20512.89743551273, 795.6300320350949, 924.117467818232, 931.3759780946782, 962.4465932089076, 996.4519514267124, 10505.369677819355, 10681.0, 10784.784304314027, 10789.406582637874, 10804.621838235624, 587327.0, 596641.0, 607042.0, 608261.0, 608428.0, 84935.0, 116651.83348166579, 128447.0, 130604.3469782645, 134466.0, 875.2735229759285, 971.7813491964251, 974.2498276327188, 1000.73407139968, 1003.7992401519725, 17079.48761537156, 17734.379296724554, 18111.184996674918, 18134.45596632103, 18207.362742303954, 53690.0, 54173.0, 54966.35100946978, 55174.068907588044, 55271.0, 79718.60140699259, 80268.59865700868, 81291.59354203191, 81528.59235704021, 82945.58527207325, 7709.151993280847, 7816.625965413889, 7822.687092516236, 8002.639881205476, 8029.678812847421, 10730.570777169138, 10996.065334446661, 11316.6039188628, 12267.263964162179, 12399.75200496003, 10328.690139295833, 10604.787904241717, 10662.573497060032, 10685.946570267099, 10772.24594278393, 8977.865332019894, 9915.950420247853, 10556.313839600401, 10724.249302548747, 10821.40482273451, 10913.781724365626, 11050.392228427514, 11248.718782030515, 11308.49111789955, 11310.491027903929, 7659.617019149132, 7908.565028923234, 7947.052972021892, 8005.9599702001115, 8239.835203295781, 8191.918080819354, 10214.744631384276, 10742.086922611665, 11020.724481888017, 11217.046551043253], "value": 9426.41976686809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.0665567381195, 1612.3147662243546, 1617.3045590396132, 1900.36337826828, 2031.8171364577195, 7867.960660196698, 8670.956645216773, 8834.469931804097, 8851.0, 8851.690190843321, 8430.578471076453, 8664.783380415493, 8678.0, 8680.91319086809, 8688.391812573122, 2103.968440473394, 2174.2281490071036, 2176.031665908671, 2426.672399226104, 2463.359526523099, 2225.2434172381386, 2421.7578242175728, 2523.5836087045614, 2524.8485090894515, 2534.3664083979006, 2424.6847909771705, 2457.69278840145, 2459.397447625325, 2463.6304554316816, 2470.6788117544693, 2149.3014770199748, 2444.5477586646525, 2449.5590793657134, 2456.38590352411, 2459.95080098397, 2446.6696995905504, 2513.710923243832, 2515.0819950718037, 2515.1448507507534, 2516.937076573082, 8440.240378365976, 8556.144385561456, 8557.572121393905, 8561.614727337284, 8600.311975041981, 5126.231065340229, 5329.467053294678, 5332.200169974496, 5372.919406208871, 5375.489328513785, 3359.5464612277274, 3481.756277060607, 3549.94675079874, 3554.5023696682483, 3572.0, 1034.3845411979935, 1052.6631477927067, 1058.2909450668071, 1060.5068643081004, 1063.3672964586137, 11439.256448330832, 11699.298042117414, 11730.824037639528, 11731.002864756507, 11747.0, 4688.249880019249, 4692.41344831896, 4828.179209534387, 4878.682885612424, 4879.707217566957, 10006.949965250273, 10050.949745251228, 10052.296339256329, 10058.29591928558, 10086.344387614781, 5361.222622719762, 5396.64921780083, 5397.163439666858, 5402.459754024566, 5412.0, 4743.31221972812, 4768.928466073012, 4936.160852655057, 4965.90068198634, 4973.5523802857915, 3792.715546334036, 3844.59631738669, 3887.261420330128, 3895.2599006188734, 3946.605339466088, 1190.7261329894172, 1193.1349771415655, 1203.5125774061519, 1207.7825991321647, 1207.9396030198454, 778.852018116556, 855.3036775077951, 891.0065277215857, 931.7391130483476, 965.7875267441152, 5671.6597004179885, 5708.514776243983, 5865.090910908816, 5888.5289176865745, 6032.50578319155, 468.770302551754, 476.8688610632104, 478.62427994024523, 909.777104609375, 1054.7415883108688, 3897.5517815451585, 3943.211357728466, 3962.3660214365564, 3969.7221194516105, 3996.1008773025837, 10266.332688375232, 10295.3822770634, 10736.516856741466, 10747.301425407324, 10784.406857622906, 10516.0, 10606.946965265124, 10736.409497477558, 10740.409277489813, 10758.031777140095, 6236.282827474898, 7995.720149794729, 8083.514989100673, 8245.257926786499, 8256.793580160424, 5698.857528561819, 5753.252077229933, 5978.432048955342, 6042.607230530001, 6048.637081775108, 7269.636518174176, 9654.2276617869, 9846.556904939152, 9854.704358869245, 9870.703878883645, 9121.77195570116, 9598.280128990215, 9873.901260987586, 9933.056359645821, 9956.452395118338, 6549.115869357575, 6852.794416167523, 7035.226125126334, 7052.964735176496, 7057.6471176442, 7530.548167109991, 7608.505447145918, 8071.152528984372, 8081.878771818545, 8089.191080891864, 7167.104111986002, 7296.19741828409, 7311.524750891175, 7417.703291868264, 7460.626968651437, 7183.245759195209, 7188.424926006011, 7248.166460857069, 7321.121465424183, 7322.3775979042375, 6701.765438209639, 6960.269171737097, 6979.0, 6985.965070174617, 6997.195322537769, 3809.29528037314, 4846.200376937766, 4886.193778026728, 4964.602831773522, 5078.771455284447, 4860.635452341018, 4886.755662216804, 4933.605311574994, 4953.876153096201, 5004.174311238605], "value": 4512.164364650735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.87838803672537, 315.03598987099474, 323.7054280604649, 325.5101072885307, 327.09068788767206, 4211.178820130076, 4886.584640305578, 5180.430152683207, 5249.454014802827, 5312.203169524569, 5037.596992240621, 5121.795128194868, 5126.359205099363, 5214.148977113127, 5287.788488460457, 3280.8195549244783, 3575.8390872410805, 3659.9451008234896, 3688.981555092221, 4029.355303151496, 3766.435034744783, 4059.9797001014954, 4060.1173167051284, 4084.100893084715, 4093.2018256440006, 3127.311991361908, 3474.409350410436, 3948.486696729421, 4003.256954747306, 4010.7794071326066, 3315.237495376077, 3977.8011099445202, 3988.4615576897327, 3991.2217117662067, 4007.819648115827, 3442.638522955104, 3480.4083305838067, 3489.94765078524, 3512.824358782076, 3519.8416071276856, 4395.868123956287, 4777.993242837982, 4865.6107511399005, 5017.096922553938, 5128.282040514331, 4241.809118589671, 4497.505274419844, 4513.684042117053, 4527.207738645757, 4534.31985202219, 4567.885802854922, 4593.747343896084, 5475.753591088411, 5489.204065410533, 5502.606366230702, 3660.3960346543054, 3824.6749026332795, 3828.0, 3834.1373191032076, 3842.4620553122586, 5773.162891380726, 5798.652080875118, 5820.5634577406445, 5841.474267315962, 5858.472737453607, 3362.81504517249, 3795.8802153364823, 3801.2777572261184, 3856.305864944337, 3907.0623050467684, 3358.9587227958923, 3483.355579217802, 3516.2088530081037, 3925.684895559962, 4010.258102251093, 3558.7153027757718, 4084.917496863334, 4316.395704601358, 4323.740575565414, 4586.908261834745, 4882.951170488321, 4921.040397122527, 5030.798768049311, 5603.887922241533, 5626.578006649518, 1358.1443690474937, 1376.8554301798367, 1394.8047273381735, 1424.3376829774204, 1437.2813593203398, 804.9154838741965, 916.7708072981754, 936.5779184873757, 956.6699488676395, 958.3052287091942, 4671.649626278043, 5523.7238138093735, 5533.280673512418, 5554.972225138848, 5613.410591887875, 6139.96930015356, 6177.139287945034, 6187.938120618736, 6224.221972253468, 6226.533010024266, 5241.868953276123, 5319.601029922771, 5518.806841760519, 5569.554435645138, 5576.414476479992, 2570.4216551275813, 3217.790843595159, 3224.725898298671, 3239.49787782894, 3244.977831982918, 4984.352034235599, 6414.332273608895, 6436.873547129234, 6475.061116138134, 6498.902516462257, 5884.882302353929, 6305.022721478178, 6331.493480521547, 6366.554341196072, 6385.553011289258, 5197.688138711689, 5916.964531207108, 6427.646479443675, 6472.741090356333, 6550.7707230246715, 5858.9121163181735, 6206.937930620817, 6211.254649442096, 6213.105002974136, 6221.626702397871, 4883.584895283799, 5861.6225187080145, 6080.621952194413, 6123.785667501616, 6141.232345956755, 5664.348599910898, 5728.427157284238, 6158.737458820841, 6296.874062518816, 6298.708764703317, 3674.8713795017047, 3697.1144716194394, 3699.1307042845447, 4050.939235911405, 4136.710430269853, 5200.791968321376, 5451.400345961862, 5988.921994041115, 6197.380261973947, 6216.875662486816, 5142.885691446752, 5334.67991920486, 5498.5876059296515, 5562.721863906708, 5604.551635869202, 4668.296071933788, 4951.910579672611, 5168.922466162935, 5507.339119305549, 5513.0, 4369.934450983302, 5416.350037995466, 5442.945570544244, 5492.176173573996, 5504.972475137599, 5462.726863656721, 5500.452208325528, 5518.475744804237, 5545.500904918576, 5553.16702494629, 4157.625813676663, 4479.977600111979, 4757.785899634456, 5427.402985671652, 5467.890642187054], "value": 4123.391939649068, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.8180473076999, 711.2887112887112, 731.4148681055157, 745.1840234942736, 764.5336344829657, 14828.555143345704, 14861.588149125842, 15095.169765662884, 15105.924470377633, 15144.242787860618, 11564.479598418091, 13826.930865345685, 13866.029377943523, 13964.720705585907, 13983.93008034961, 702.1959855964917, 724.5000949344961, 886.2289807867148, 906.0, 908.7728067983004, 861.8060936289347, 905.2441211588332, 907.9319051071163, 908.0374802709116, 908.0374802709149, 945.5036106044347, 966.9854952175723, 967.6177909725654, 968.903109689029, 969.1035791892507, 736.7789663101048, 936.8688383626297, 954.5322791831987, 961.0677642686618, 972.2222222222265, 723.5622448418684, 724.0840336973732, 724.7101159536174, 726.1431510817233, 728.2026181331433, 14685.412583496647, 14742.631434214123, 14749.115053096848, 14765.704685906328, 14767.704645907022, 12233.755324893542, 12352.752944941141, 12451.315177665225, 12705.110642255046, 12765.489380424771, 8681.784550162982, 8984.416012959202, 9841.606335746561, 10020.498975051218, 10196.643117490927, 3462.307538492312, 3511.0169152637304, 3531.911702207465, 3548.929021419557, 3598.7660802047785, 56903.71548142274, 72508.27491725067, 74464.02143914292, 79275.60362198151, 84287.15712842855, 9274.814503709888, 9413.858792118124, 9461.90538094624, 9597.0, 9706.951465242628, 22446.438839029153, 22460.887695561418, 22464.0, 22490.32529024132, 22492.662610060863, 7406.333429991327, 7511.661975211128, 7512.361449276764, 7519.511231769918, 7712.0, 4005.679545636342, 4044.8786536403954, 4059.4316795648633, 4065.0447144920918, 4068.898277543085, 3567.3935430976794, 3661.8169091545315, 3663.853445862189, 3664.6518580734787, 3666.7983260920373, 604.0968751716213, 621.273110460762, 621.8880601491775, 623.9469645080128, 656.1207981305074, 506.05873076078467, 519.304132462502, 573.8393249890038, 610.2158726037021, 615.8152554233712, 7612.238776122344, 8043.959780201179, 8146.796330091676, 8261.38039647029, 8294.182414220866, 503.5644167794831, 558.9664620122805, 584.4389386189221, 598.5211830535641, 602.8221674606002, 3254.7884387514737, 3777.58446570877, 3959.8812035638975, 3989.4215338776294, 4181.829087855405, 76087.61956190184, 78757.60621196972, 79109.0, 97319.54020689696, 99695.0, 69080.0, 72739.0, 77456.0, 79063.0, 79097.20902791014, 66777.33222667809, 67212.66393668001, 67721.3227867715, 70067.0, 73010.2944983165, 7482.176960534228, 8216.26053655174, 8336.458130221516, 8349.749507514784, 8448.957755211184, 41106.79446602748, 43061.56938430701, 43254.56745432506, 44027.77986110177, 44402.11195776002, 45227.77386113048, 61153.694231528556, 61198.08202877049, 61705.38294617176, 62308.68845655743, 10538.8419173714, 10639.255252132276, 10797.190210734068, 11169.106471482424, 11608.6517404478, 12008.339541324962, 12012.0, 12282.32447215376, 12559.43482543306, 12597.811032834697, 11257.831132533182, 11535.538578456768, 11611.187216894736, 11796.88203117992, 11887.286762793914, 9233.445993240428, 11380.886191137983, 11410.30540981907, 11475.311481311148, 11633.243839150427, 9422.905770942203, 11231.550737970716, 11286.66140015801, 11313.434328283718, 11662.70843228926, 9589.232861370934, 9844.0, 9869.555869985725, 9929.226893780316, 10108.1408080314, 9465.763355916157, 9658.162781055256, 9687.176589989647, 9762.414255144715, 9868.851967220355], "value": 6768.914978898378, "unit": "score"}], "name": "dromaeo_css", "value": 7114.424184898909, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 108.0, 111.0, 114.0, 112.0, 111.0, 112.0, 102.0, 119.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 141.0, 164.0, 119.0, 141.0, 137.0, 119.0, 167.0, 121.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 182.0, 185.0, 186.0, 184.0, 181.0, 186.0, 184.0, 186.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 88.0, 92.0, 56.0, 58.0, 59.0, 85.0, 87.0, 55.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 140.0, 77.0, 76.0, 79.0, 125.0, 80.0, 79.0, 130.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 88.0, 134.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 86.0, 85.0, 84.0, 85.0, 83.0, 86.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 59.0, 58.0, 59.0, 60.0, 58.0, 76.0, 60.0, 59.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 80.0, 73.0, 71.0, 67.0, 66.0, 67.0, 68.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 83.0, 83.0, 82.0, 82.0, 89.0, 104.0, 106.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 150.0, 146.0, 141.0, 145.0, 152.0, 136.0, 178.0, 152.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 175.0, 174.0, 172.0, 169.0, 171.0, 172.0, 172.0, 170.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 67.0, 67.0, 67.0, 70.0, 88.0, 96.0, 92.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1487.0, "alertThreshold": 2.0}]} 18:00:34 INFO - Return code: 0 18:00:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:00:35 ERROR - # TBPL SUCCESS # 18:00:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:00:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:00:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:00:35 INFO - 2016-05-04 18:00:35.055 screenresolution[1945:16888] starting screenresolution argv=screenresolution get 18:00:35 INFO - 2016-05-04 18:00:35.057 screenresolution[1945:16888] Display 0: 1600x1200x32@60 18:00:35 INFO - 2016-05-04 18:00:35.063 screenresolution[1946:16891] starting screenresolution argv=screenresolution list 18:00:35 INFO - Available Modes on Display 0 18:00:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:00:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:00:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:00:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:00:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:00:35 INFO - Intel Iris: 18:00:35 INFO - Chipset Model: Intel Iris 18:00:35 INFO - Type: GPU 18:00:35 INFO - Bus: Built-In 18:00:35 INFO - VRAM (Dynamic, Max): 1536 MB 18:00:35 INFO - Vendor: Intel (0x8086) 18:00:35 INFO - Device ID: 0x0a2e 18:00:35 INFO - Revision ID: 0x0009 18:00:35 INFO - Displays: 18:00:35 INFO - Display: 18:00:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:00:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:00:35 INFO - Display Serial Number: 1600x1200 60 18:00:35 INFO - Main Display: Yes 18:00:35 INFO - Mirror: Off 18:00:35 INFO - Online: Yes 18:00:35 INFO - Rotation: Supported 18:00:35 INFO - Return code: 0 18:00:35 INFO - Running post-action listener: _resource_record_post_action 18:00:35 INFO - Running post-run listener: _resource_record_post_run 18:00:36 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 720896; Write bytes: 696329216; Read time: 8; Write time: 1834 18:00:36 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384573952; Write bytes: 378890240; Read time: 29606; Write time: 669 18:00:36 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 720896; Write bytes: 295754752; Read time: 8; Write time: 1124 18:00:36 INFO - Running post-run listener: _upload_blobber_files 18:00:36 INFO - Blob upload gear active. 18:00:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:00:36 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 18:00:36 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'] 18:00:36 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 18:00:36 INFO - (blobuploader) - INFO - Open directory for files ... 18:00:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:00:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:00:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:37 INFO - (blobuploader) - INFO - Done attempting. 18:00:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:00:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:00:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:38 INFO - (blobuploader) - INFO - Done attempting. 18:00:38 INFO - (blobuploader) - INFO - Iteration through files over. 18:00:38 INFO - Return code: 0 18:00:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:00:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:00:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62bde044132b86ac9e3c8667c36320ae360b4ff1ba6bcb5cde1ffed09a900dedfa6b08f8276d9a4b9994fd33dda2128de62397d7106f20f27bdf55f907032a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18753555c37e6e82565451677a48c7f11f6f6172b3a568db98233e16e2fb715a6eac85cb39b9da0602a5097c6b9d8fa5959cddfc483db976b9cbf2001ecc18df"} 18:00:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:00:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:00:38 INFO - Contents: 18:00:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62bde044132b86ac9e3c8667c36320ae360b4ff1ba6bcb5cde1ffed09a900dedfa6b08f8276d9a4b9994fd33dda2128de62397d7106f20f27bdf55f907032a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18753555c37e6e82565451677a48c7f11f6f6172b3a568db98233e16e2fb715a6eac85cb39b9da0602a5097c6b9d8fa5959cddfc483db976b9cbf2001ecc18df"} 18:00:38 INFO - Running post-run listener: copy_logs_to_upload_dir 18:00:38 INFO - Copying logs to upload dir... 18:00:38 INFO - mkdir: /builds/slave/test/build/upload/logs 18:00:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.293929 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-04 18:00:38.599923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 18:00:38.603888) ========= 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.cWhanJMyVL/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.4OYMjTwGBu/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62bde044132b86ac9e3c8667c36320ae360b4ff1ba6bcb5cde1ffed09a900dedfa6b08f8276d9a4b9994fd33dda2128de62397d7106f20f27bdf55f907032a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18753555c37e6e82565451677a48c7f11f6f6172b3a568db98233e16e2fb715a6eac85cb39b9da0602a5097c6b9d8fa5959cddfc483db976b9cbf2001ecc18df"} build_url:https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010985 build_url: 'https://queue.taskcluster.net/v1/task/L4mE5MtpRe-3HecgJy6jWA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62bde044132b86ac9e3c8667c36320ae360b4ff1ba6bcb5cde1ffed09a900dedfa6b08f8276d9a4b9994fd33dda2128de62397d7106f20f27bdf55f907032a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18753555c37e6e82565451677a48c7f11f6f6172b3a568db98233e16e2fb715a6eac85cb39b9da0602a5097c6b9d8fa5959cddfc483db976b9cbf2001ecc18df"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 18:00:38.631050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 18:00:38.631370) ========= 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.cWhanJMyVL/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.4OYMjTwGBu/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005279 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 18:00:38.680798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 18:00:38.681124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 18:00:38.681589) ========= ========= Total master_lag: 0.16 =========