builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0172 starttime: 1461711280.58 results: success (0) buildid: 20160426142000 builduid: 5722bb5f51de428aa5a1b268a481d421 revision: 52072b6bec1416578615ec73027eb80a65d3fcd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.581138) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.581647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.581974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.602398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.602941) ========= 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.2mkHymspEN/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.hbaPmf5dBO/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-26 15:54:40-- 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% 55.9M=0s 2016-04-26 15:54:40 (55.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.730504) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.730867) ========= 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.2mkHymspEN/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.hbaPmf5dBO/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.026642 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:40.779547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 15:54:40.779964) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52072b6bec1416578615ec73027eb80a65d3fcd4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 52072b6bec1416578615ec73027eb80a65d3fcd4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2mkHymspEN/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.hbaPmf5dBO/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-26 15:54:40,854 truncating revision to first 12 chars 2016-04-26 15:54:40,855 Setting DEBUG logging. 2016-04-26 15:54:40,855 attempt 1/10 2016-04-26 15:54:40,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52072b6bec14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 15:54:41,898 unpacking tar archive at: mozilla-central-52072b6bec14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300133 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 15:54:42.205214) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:42.205598) ========= script_repo_revision: 52072b6bec1416578615ec73027eb80a65d3fcd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:42.206060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:42.206414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:42.221262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-26 15:54:42.221672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2mkHymspEN/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.hbaPmf5dBO/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:54:42 INFO - MultiFileLogger online at 20160426 15:54:42 in /builds/slave/test 15:54:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:54:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:42 INFO - {'append_to_log': False, 15:54:42 INFO - 'base_work_dir': '/builds/slave/test', 15:54:42 INFO - 'blob_upload_branch': 'Firefox', 15:54:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:42 INFO - 'branch': 'Firefox', 15:54:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:42 INFO - 'config_files': ('talos/mac_config.py',), 15:54:42 INFO - 'default_actions': ('clobber', 15:54:42 INFO - 'read-buildbot-config', 15:54:42 INFO - 'download-and-extract', 15:54:42 INFO - 'populate-webroot', 15:54:42 INFO - 'create-virtualenv', 15:54:42 INFO - 'install', 15:54:42 INFO - 'run-tests'), 15:54:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:42 INFO - 'download_minidump_stackwalk': True, 15:54:42 INFO - 'download_symbols': 'ondemand', 15:54:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:42 INFO - 'installer_path': 'installer.exe', 15:54:42 INFO - 'log_level': 'info', 15:54:42 INFO - 'log_name': 'talos', 15:54:42 INFO - 'log_to_console': True, 15:54:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:54:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:54:42 INFO - 'opt_config_files': (), 15:54:42 INFO - 'pip_index': False, 15:54:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:54:42 INFO - 'cmd': ('bash', 15:54:42 INFO - '-c', 15:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:54:42 INFO - 'enabled': True, 15:54:42 INFO - 'halt_on_failure': False, 15:54:42 INFO - 'name': 'check_screen_resolution'},), 15:54:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:54:42 INFO - 'cmd': ('bash', 15:54:42 INFO - '-c', 15:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:54:42 INFO - 'enabled': True, 15:54:42 INFO - 'halt_on_failure': False, 15:54:42 INFO - 'name': 'check_screen_resolution'},), 15:54:42 INFO - 'run_cmd_checks_enabled': True, 15:54:42 INFO - 'sps_profile': False, 15:54:42 INFO - 'sps_profile_interval': 0, 15:54:42 INFO - 'suite': 'dromaeojs', 15:54:42 INFO - 'system_bits': '32', 15:54:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:42 INFO - 'title': 't-yosemite-r7-0172', 15:54:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:42 INFO - 'use_talos_json': True, 15:54:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:42 INFO - 'work_dir': 'build'} 15:54:42 INFO - ##### 15:54:42 INFO - ##### Running clobber step. 15:54:42 INFO - ##### 15:54:42 INFO - Running pre-action listener: _resource_record_pre_action 15:54:42 INFO - Running main action method: clobber 15:54:42 INFO - rmtree: /builds/slave/test/build 15:54:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:44 INFO - Running post-action listener: _resource_record_post_action 15:54:44 INFO - ##### 15:54:44 INFO - ##### Running read-buildbot-config step. 15:54:44 INFO - ##### 15:54:44 INFO - Running pre-action listener: _resource_record_pre_action 15:54:44 INFO - Running main action method: read_buildbot_config 15:54:44 INFO - Using buildbot properties: 15:54:44 INFO - { 15:54:44 INFO - "project": "", 15:54:44 INFO - "product": "firefox", 15:54:44 INFO - "script_repo_revision": "production", 15:54:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:54:44 INFO - "repository": "", 15:54:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:54:44 INFO - "buildid": "20160426142000", 15:54:44 INFO - "pgo_build": "False", 15:54:44 INFO - "basedir": "/builds/slave/test", 15:54:44 INFO - "buildnumber": 238, 15:54:44 INFO - "slavename": "t-yosemite-r7-0172", 15:54:44 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:54:44 INFO - "platform": "yosemite_r7", 15:54:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:54:44 INFO - "branch": "mozilla-central", 15:54:44 INFO - "repo_path": "mozilla-central", 15:54:44 INFO - "revision": "52072b6bec1416578615ec73027eb80a65d3fcd4", 15:54:44 INFO - "stage_platform": "macosx64", 15:54:44 INFO - "builduid": "5722bb5f51de428aa5a1b268a481d421", 15:54:44 INFO - "slavebuilddir": "test" 15:54:44 INFO - } 15:54:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 15:54:44 INFO - Running post-action listener: _resource_record_post_action 15:54:44 INFO - ##### 15:54:44 INFO - ##### Running download-and-extract step. 15:54:44 INFO - ##### 15:54:44 INFO - Running pre-action listener: _resource_record_pre_action 15:54:44 INFO - Running main action method: download_and_extract 15:54:44 INFO - mkdir: /builds/slave/test/build/tests 15:54: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')]} 15:54:44 INFO - https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:54:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 15:54:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 15:54:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:45 INFO - Downloaded 1199 bytes. 15:54:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 15:54:45 INFO - Using the following test package requirements: 15:54:45 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 15:54:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 15:54:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 15:54:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'jsshell-mac.zip'], 15:54:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 15:54:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 15:54:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 15:54:45 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 15:54:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 15:54:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:54:45 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 15:54:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:54: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')]} 15:54:45 INFO - https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:54:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:54:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:54:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:46 INFO - Downloaded 18114038 bytes. 15:54:46 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'] 15:54:46 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 15:54:49 INFO - Return code: 0 15:54:49 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 15:54:49 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')]} 15:54:49 INFO - https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:50 INFO - Downloaded 18114038 bytes. 15:54:50 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'] 15:54:50 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 15:54:54 INFO - Return code: 0 15:54: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')]} 15:54:54 INFO - https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:54:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 15:54:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 15:54:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:55 INFO - Downloaded 10840145 bytes. 15:54:55 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'] 15:54:55 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 15:54:55 INFO - Return code: 0 15:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:55 INFO - https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:54:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:54:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:54:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 15:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/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 15:54:58 INFO - Downloaded 110222485 bytes. 15:54:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:54:58 INFO - mkdir: /builds/slave/test/properties 15:54:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:58 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:58 INFO - Contents: 15:54:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:54:59 INFO - Running post-action listener: _resource_record_post_action 15:54:59 INFO - Running post-action listener: set_extra_try_arguments 15:54:59 INFO - ##### 15:54:59 INFO - ##### Running populate-webroot step. 15:54:59 INFO - ##### 15:54:59 INFO - Running pre-action listener: _resource_record_pre_action 15:54:59 INFO - Running main action method: populate_webroot 15:54:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:59 INFO - '--tppagecycles', 15:54:59 INFO - '7'], 15:54:59 INFO - 'tests': ['tsvgm']}}, 15:54:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['damp', 'tps']}, 15:54:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'tests': ['damp', 'tps']}, 15:54:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['dromaeo_dom']}, 15:54:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['a11yr', 15:54:59 INFO - 'ts_paint', 15:54:59 INFO - 'tpaint', 15:54:59 INFO - 'sessionrestore', 15:54:59 INFO - 'sessionrestore_no_auto_restore', 15:54:59 INFO - 'tabpaint']}, 15:54:59 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:59 INFO - 'ts_paint', 15:54:59 INFO - 'tpaint', 15:54:59 INFO - 'sessionrestore', 15:54:59 INFO - 'sessionrestore_no_auto_restore', 15:54:59 INFO - 'tabpaint']}, 15:54:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:59 INFO - 'ts_paint', 15:54:59 INFO - 'tpaint', 15:54:59 INFO - 'sessionrestore', 15:54:59 INFO - 'sessionrestore_no_auto_restore', 15:54:59 INFO - 'tabpaint']}, 15:54:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:59 INFO - 'ts_paint', 15:54:59 INFO - 'tpaint', 15:54:59 INFO - 'sessionrestore', 15:54:59 INFO - 'sessionrestore_no_auto_restore', 15:54:59 INFO - 'tabpaint']}, 15:54:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['a11yr', 15:54:59 INFO - 'ts_paint', 15:54:59 INFO - 'tpaint', 15:54:59 INFO - 'sessionrestore', 15:54:59 INFO - 'sessionrestore_no_auto_restore', 15:54:59 INFO - 'tabpaint']}, 15:54:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['a11yr', 15:54:59 INFO - 'ts_paint', 15:54:59 INFO - 'tpaint', 15:54:59 INFO - 'sessionrestore', 15:54:59 INFO - 'sessionrestore_no_auto_restore', 15:54:59 INFO - 'tabpaint']}, 15:54:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['tsvgx', 15:54:59 INFO - 'tsvgr_opacity', 15:54:59 INFO - 'tart', 15:54:59 INFO - 'tscrollx', 15:54:59 INFO - 'cart']}, 15:54:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:59 INFO - 'tsvgr_opacity', 15:54:59 INFO - 'tart', 15:54:59 INFO - 'tscrollx', 15:54:59 INFO - 'cart']}, 15:54:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'talos_options': ['--disable-e10s'], 15:54:59 INFO - 'tests': ['tp5o']}, 15:54:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'tests': ['tp5o']}, 15:54:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'talos_options': ['--disable-e10s', 15:54:59 INFO - '--xperf_path', 15:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:59 INFO - 'tests': ['tp5n']}, 15:54:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:59 INFO - 'talos_options': ['--xperf_path', 15:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:59 INFO - 'tests': ['tp5n']}}, 15:54:59 INFO - 'talos.zip': {'path': '', 15:54:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:59 INFO - Running post-action listener: _resource_record_post_action 15:54:59 INFO - ##### 15:54:59 INFO - ##### Running create-virtualenv step. 15:54:59 INFO - ##### 15:54:59 INFO - Running pre-action listener: _resource_record_pre_action 15:54:59 INFO - Running main action method: create_virtualenv 15:54:59 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:59 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 15:54:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:59 INFO - Using real prefix '/tools/python27' 15:54:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:55:00 INFO - Installing distribute.............................................................................................................................................................................................done. 15:55:03 INFO - Installing pip.................done. 15:55:03 INFO - Return code: 0 15:55:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:03 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 15:55:03 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 15:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:03 INFO - 'HOME': '/Users/cltbld', 15:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:03 INFO - 'LOGNAME': 'cltbld', 15:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:03 INFO - 'MOZ_NO_REMOTE': '1', 15:55:03 INFO - 'NO_EM_RESTART': '1', 15:55:03 INFO - 'PAGER': '/bin/cat', 15:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:03 INFO - 'PWD': '/builds/slave/test', 15:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:03 INFO - 'SHELL': '/bin/bash', 15:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:03 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:03 INFO - 'USER': 'cltbld', 15:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:03 INFO - 'XPC_FLAGS': '0x0', 15:55:03 INFO - 'XPC_SERVICE_NAME': '0', 15:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:03 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 15:55:03 INFO - Cleaning up... 15:55:03 INFO - Return code: 0 15:55:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:03 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 15:55:03 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 15:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:03 INFO - 'HOME': '/Users/cltbld', 15:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:03 INFO - 'LOGNAME': 'cltbld', 15:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:03 INFO - 'MOZ_NO_REMOTE': '1', 15:55:03 INFO - 'NO_EM_RESTART': '1', 15:55:03 INFO - 'PAGER': '/bin/cat', 15:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:03 INFO - 'PWD': '/builds/slave/test', 15:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:03 INFO - 'SHELL': '/bin/bash', 15:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:03 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:03 INFO - 'USER': 'cltbld', 15:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:03 INFO - 'XPC_FLAGS': '0x0', 15:55:03 INFO - 'XPC_SERVICE_NAME': '0', 15:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:03 INFO - Downloading/unpacking psutil>=0.7.1 15:55: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 15:55: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 15:55: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 15:55: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 15:55: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 15:55: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 15:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:55:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:06 INFO - Installing collected packages: psutil 15:55:06 INFO - Running setup.py install for psutil 15:55:06 INFO - building 'psutil._psutil_osx' extension 15:55:06 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 15:55:07 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 15:55:07 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 15:55:07 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 15:55:07 INFO - building 'psutil._psutil_posix' extension 15:55:07 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 15:55:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:55:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:55:07 INFO - ^ 15:55:07 INFO - 1 warning generated. 15:55:07 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 15:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:08 INFO - Successfully installed psutil 15:55:08 INFO - Cleaning up... 15:55:08 INFO - Return code: 0 15:55:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:55:08 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')]} 15:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:08 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')]} 15:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:08 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:08 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 15:55:08 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 15:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:08 INFO - 'HOME': '/Users/cltbld', 15:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:08 INFO - 'LOGNAME': 'cltbld', 15:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:08 INFO - 'MOZ_NO_REMOTE': '1', 15:55:08 INFO - 'NO_EM_RESTART': '1', 15:55:08 INFO - 'PAGER': '/bin/cat', 15:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:08 INFO - 'PWD': '/builds/slave/test', 15:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:08 INFO - 'SHELL': '/bin/bash', 15:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:08 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:08 INFO - 'USER': 'cltbld', 15:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:08 INFO - 'XPC_FLAGS': '0x0', 15:55:08 INFO - 'XPC_SERVICE_NAME': '0', 15:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:55:08 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 15:55:08 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 15:55:08 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 15:55:08 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 15:55:08 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 15:55:08 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 15:55:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:55:10 INFO - Installing collected packages: mozsystemmonitor 15:55:10 INFO - Running setup.py install for mozsystemmonitor 15:55:10 INFO - Successfully installed mozsystemmonitor 15:55:10 INFO - Cleaning up... 15:55:11 INFO - Return code: 0 15:55:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:11 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:11 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 15:55:11 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 15:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:11 INFO - 'HOME': '/Users/cltbld', 15:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:11 INFO - 'LOGNAME': 'cltbld', 15:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:11 INFO - 'MOZ_NO_REMOTE': '1', 15:55:11 INFO - 'NO_EM_RESTART': '1', 15:55:11 INFO - 'PAGER': '/bin/cat', 15:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:11 INFO - 'PWD': '/builds/slave/test', 15:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:11 INFO - 'SHELL': '/bin/bash', 15:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:11 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:11 INFO - 'USER': 'cltbld', 15:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:11 INFO - 'XPC_FLAGS': '0x0', 15:55:11 INFO - 'XPC_SERVICE_NAME': '0', 15:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:11 INFO - Downloading/unpacking blobuploader==1.2.4 15:55:11 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 15:55:11 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 15:55:11 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 15:55:11 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 15:55:11 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 15:55:11 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 15:55:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:55:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:55:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:55:14 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 15:55:14 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 15:55:14 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 15:55:14 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 15:55:14 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 15:55:14 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 15:55:14 INFO - Downloading docopt-0.6.1.tar.gz 15:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:55:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:55:14 INFO - Running setup.py install for blobuploader 15:55:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:55:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:55:15 INFO - Running setup.py install for requests 15:55:15 INFO - Running setup.py install for docopt 15:55:15 INFO - Successfully installed blobuploader requests docopt 15:55:15 INFO - Cleaning up... 15:55:15 INFO - Return code: 0 15:55:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55: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')]} 15:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:15 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:15 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 15:55:15 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 15:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:15 INFO - 'HOME': '/Users/cltbld', 15:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:15 INFO - 'LOGNAME': 'cltbld', 15:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:15 INFO - 'MOZ_NO_REMOTE': '1', 15:55:15 INFO - 'NO_EM_RESTART': '1', 15:55:15 INFO - 'PAGER': '/bin/cat', 15:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:15 INFO - 'PWD': '/builds/slave/test', 15:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:15 INFO - 'SHELL': '/bin/bash', 15:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:15 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:15 INFO - 'USER': 'cltbld', 15:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:15 INFO - 'XPC_FLAGS': '0x0', 15:55:15 INFO - 'XPC_SERVICE_NAME': '0', 15:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-hfvrrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-4i92QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-VsRdir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-pzlmOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-E_iYX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-MBAwgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-431oKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-s5Ap1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-bbMpBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-1MyZGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-acxan1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-gK9A7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-xLn21J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-f2F6nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-WtblqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-E2uL_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:17 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-KS7bl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:55:17 INFO - Running setup.py install for manifestparser 15:55:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:55:17 INFO - Running setup.py install for mozcrash 15:55:18 INFO - Running setup.py install for mozdebug 15:55:18 INFO - Running setup.py install for mozdevice 15:55:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Running setup.py install for mozfile 15:55:18 INFO - Running setup.py install for mozhttpd 15:55:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Running setup.py install for mozinfo 15:55:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Running setup.py install for mozInstall 15:55:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:55:18 INFO - Running setup.py install for mozleak 15:55:19 INFO - Running setup.py install for mozlog 15:55:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:55:19 INFO - Running setup.py install for moznetwork 15:55:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:55:19 INFO - Running setup.py install for mozprocess 15:55:19 INFO - Running setup.py install for mozprofile 15:55:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:55:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:55:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:55:19 INFO - Running setup.py install for mozrunner 15:55:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:55:19 INFO - Running setup.py install for mozscreenshot 15:55:20 INFO - Running setup.py install for moztest 15:55:20 INFO - Running setup.py install for mozversion 15:55:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:55:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:55:20 INFO - Cleaning up... 15:55:20 INFO - Return code: 0 15:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:20 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:20 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 15:55:20 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 15:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:20 INFO - 'HOME': '/Users/cltbld', 15:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:20 INFO - 'LOGNAME': 'cltbld', 15:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:20 INFO - 'MOZ_NO_REMOTE': '1', 15:55:20 INFO - 'NO_EM_RESTART': '1', 15:55:20 INFO - 'PAGER': '/bin/cat', 15:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:20 INFO - 'PWD': '/builds/slave/test', 15:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:20 INFO - 'SHELL': '/bin/bash', 15:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:20 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:20 INFO - 'USER': 'cltbld', 15:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:20 INFO - 'XPC_FLAGS': '0x0', 15:55:20 INFO - 'XPC_SERVICE_NAME': '0', 15:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:20 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-IYj7yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:20 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)) 15:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:20 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-BzN7hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:20 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)) 15:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:20 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-wR_Gl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:20 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)) 15:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:20 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ooZPHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-0Uzutk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-CddHek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-8fbAiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Dmpiwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-pzJQwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-1DoZ07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-NMRnSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-_Ty0Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:21 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)) 15:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:21 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-NL34di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:22 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)) 15:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:22 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-uCoF9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:22 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)) 15:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:22 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-XjYfLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:22 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)) 15:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:22 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-CZVtxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:22 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)) 15:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:22 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-DGuKUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:22 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)) 15:55:22 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)) 15:55:22 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)) 15:55:22 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)) 15:55:22 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)) 15:55:22 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)) 15:55:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:55: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 15:55: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 15:55: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 15:55: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 15:55: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 15:55: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 15:55:24 INFO - Downloading blessings-1.6.tar.gz 15:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:55:24 INFO - Installing collected packages: blessings 15:55:24 INFO - Running setup.py install for blessings 15:55:25 INFO - Successfully installed blessings 15:55:25 INFO - Cleaning up... 15:55:25 INFO - Return code: 0 15:55:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:55:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:25 INFO - Reading from file tmpfile_stdout 15:55:25 INFO - Current package versions: 15:55:25 INFO - blessings == 1.6 15:55:25 INFO - blobuploader == 1.2.4 15:55:25 INFO - docopt == 0.6.1 15:55:25 INFO - manifestparser == 1.1 15:55:25 INFO - mozInstall == 1.12 15:55:25 INFO - mozcrash == 0.17 15:55:25 INFO - mozdebug == 0.1 15:55:25 INFO - mozdevice == 0.48 15:55:25 INFO - mozfile == 1.2 15:55:25 INFO - mozhttpd == 0.7 15:55:25 INFO - mozinfo == 0.9 15:55:25 INFO - mozleak == 0.1 15:55:25 INFO - mozlog == 3.1 15:55:25 INFO - moznetwork == 0.27 15:55:25 INFO - mozprocess == 0.22 15:55:25 INFO - mozprofile == 0.28 15:55:25 INFO - mozrunner == 6.11 15:55:25 INFO - mozscreenshot == 0.1 15:55:25 INFO - mozsystemmonitor == 0.0 15:55:25 INFO - moztest == 0.7 15:55:25 INFO - mozversion == 1.4 15:55:25 INFO - psutil == 3.1.1 15:55:25 INFO - requests == 1.2.3 15:55:25 INFO - wsgiref == 0.1.2 15:55:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:25 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 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:25 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 15:55:25 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 15:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:25 INFO - 'HOME': '/Users/cltbld', 15:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:25 INFO - 'LOGNAME': 'cltbld', 15:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:25 INFO - 'MOZ_NO_REMOTE': '1', 15:55:25 INFO - 'NO_EM_RESTART': '1', 15:55:25 INFO - 'PAGER': '/bin/cat', 15:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:25 INFO - 'PWD': '/builds/slave/test', 15:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:25 INFO - 'SHELL': '/bin/bash', 15:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:25 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:25 INFO - 'USER': 'cltbld', 15:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:25 INFO - 'XPC_FLAGS': '0x0', 15:55:25 INFO - 'XPC_SERVICE_NAME': '0', 15:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 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)) 15:55:25 INFO - Cleaning up... 15:55:25 INFO - Return code: 0 15:55:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:25 INFO - 'HOME': '/Users/cltbld', 15:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:25 INFO - 'LOGNAME': 'cltbld', 15:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:25 INFO - 'MOZ_NO_REMOTE': '1', 15:55:25 INFO - 'NO_EM_RESTART': '1', 15:55:25 INFO - 'PAGER': '/bin/cat', 15:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:25 INFO - 'PWD': '/builds/slave/test', 15:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:25 INFO - 'SHELL': '/bin/bash', 15:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:25 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:25 INFO - 'USER': 'cltbld', 15:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:25 INFO - 'XPC_FLAGS': '0x0', 15:55:25 INFO - 'XPC_SERVICE_NAME': '0', 15:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:25 INFO - Downloading/unpacking jsonschema 15:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:55:28 INFO - Downloading/unpacking functools32 (from jsonschema) 15:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:55:28 INFO - warning: no files found matching '*.txt' 15:55:28 INFO - no previously-included directories found matching 'build' 15:55:28 INFO - no previously-included directories found matching 'dist' 15:55:28 INFO - no previously-included directories found matching '.git*' 15:55:28 INFO - Installing collected packages: jsonschema, functools32 15:55:28 INFO - Running setup.py install for functools32 15:55:29 INFO - warning: no files found matching '*.txt' 15:55:29 INFO - no previously-included directories found matching 'build' 15:55:29 INFO - no previously-included directories found matching 'dist' 15:55:29 INFO - no previously-included directories found matching '.git*' 15:55:29 INFO - Successfully installed jsonschema functools32 15:55:29 INFO - Cleaning up... 15:55:29 INFO - Return code: 0 15:55:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d20ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb433ce9820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, '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.2mkHymspEN/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.hbaPmf5dBO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 15:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:29 INFO - 'HOME': '/Users/cltbld', 15:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:29 INFO - 'LOGNAME': 'cltbld', 15:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:29 INFO - 'MOZ_NO_REMOTE': '1', 15:55:29 INFO - 'NO_EM_RESTART': '1', 15:55:29 INFO - 'PAGER': '/bin/cat', 15:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:29 INFO - 'PWD': '/builds/slave/test', 15:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:29 INFO - 'SHELL': '/bin/bash', 15:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:55:29 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:29 INFO - 'USER': 'cltbld', 15:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:29 INFO - 'XPC_FLAGS': '0x0', 15:55:29 INFO - 'XPC_SERVICE_NAME': '0', 15:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:29 INFO - Downloading/unpacking flake8 15:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:55:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:55:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:33 INFO - no previously-included directories found matching 'docs/_build' 15:55:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:55:33 INFO - Running setup.py install for pep8 15:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:33 INFO - no previously-included directories found matching 'docs/_build' 15:55:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:55:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:55:33 INFO - Cleaning up... 15:55:33 INFO - Return code: 0 15:55:33 INFO - Running post-action listener: _resource_record_post_action 15:55:33 INFO - Running post-action listener: _start_resource_monitoring 15:55:33 INFO - Starting resource monitoring. 15:55:33 INFO - ##### 15:55:33 INFO - ##### Running install step. 15:55:33 INFO - ##### 15:55:33 INFO - Running pre-action listener: _resource_record_pre_action 15:55:33 INFO - Running main action method: install 15:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:33 INFO - Reading from file tmpfile_stdout 15:55:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:55:33 INFO - Reading from file tmpfile_stdout 15:55:33 INFO - Output received: 15:55:33 INFO - Usage: mozinstall [options] installer 15:55:33 INFO - Options: 15:55:33 INFO - -h, --help show this help message and exit 15:55:33 INFO - -d DEST, --destination=DEST 15:55:33 INFO - Directory to install application into. [default: 15:55:33 INFO - "/builds/slave/test"] 15:55:33 INFO - --app=APP Application being installed. [default: firefox] 15:55:33 INFO - mkdir: /builds/slave/test/build/application 15:55:33 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'] 15:55:33 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 15:56:07 INFO - Reading from file tmpfile_stdout 15:56:07 INFO - Output received: 15:56:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:56:07 INFO - Running post-action listener: _resource_record_post_action 15:56:07 INFO - ##### 15:56:07 INFO - ##### Running run-tests step. 15:56:07 INFO - ##### 15:56:07 INFO - Running pre-action listener: _resource_record_pre_action 15:56:07 INFO - Running main action method: run_tests 15:56:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:56:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:56:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:56:07 INFO - 2016-04-26 15:56:07.917 screenresolution[1638:7398] starting screenresolution argv=screenresolution get 15:56:07 INFO - 2016-04-26 15:56:07.920 screenresolution[1638:7398] Display 0: 1600x1200x32@60 15:56:07 INFO - 2016-04-26 15:56:07.926 screenresolution[1639:7400] starting screenresolution argv=screenresolution list 15:56:07 INFO - Available Modes on Display 0 15:56:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:56:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:56:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:56:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:56:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:56:08 INFO - Intel Iris: 15:56:08 INFO - Chipset Model: Intel Iris 15:56:08 INFO - Type: GPU 15:56:08 INFO - Bus: Built-In 15:56:08 INFO - VRAM (Dynamic, Max): 1536 MB 15:56:08 INFO - Vendor: Intel (0x8086) 15:56:08 INFO - Device ID: 0x0a2e 15:56:08 INFO - Revision ID: 0x0009 15:56:08 INFO - Displays: 15:56:08 INFO - Display: 15:56:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:56:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:56:08 INFO - Display Serial Number: 1600x1200 60 15:56:08 INFO - Main Display: Yes 15:56:08 INFO - Mirror: Off 15:56:08 INFO - Online: Yes 15:56:08 INFO - Rotation: Supported 15:56:08 INFO - Return code: 0 15:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:08 INFO - Python 2.7.3 15:56:08 INFO - Return code: 0 15:56:08 INFO - grabbing minidump binary from tooltool 15:56:08 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')]} 15:56:08 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 0x10d0ade00>, '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 0x10ced6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:08 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 15:56:08 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 15:56:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:08 INFO - Return code: 0 15:56:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:56:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:56:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:56:09 INFO - Return code: 0 15:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 15:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --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 15:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mkHymspEN/Render', 15:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:09 INFO - 'HOME': '/Users/cltbld', 15:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:09 INFO - 'LOGNAME': 'cltbld', 15:56:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:09 INFO - 'MOZ_NO_REMOTE': '1', 15:56:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:09 INFO - 'NO_EM_RESTART': '1', 15:56:09 INFO - 'PAGER': '/bin/cat', 15:56:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:09 INFO - 'PWD': '/builds/slave/test', 15:56:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:09 INFO - 'SHELL': '/bin/bash', 15:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hbaPmf5dBO/Listeners', 15:56:09 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 15:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:09 INFO - 'USER': 'cltbld', 15:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:09 INFO - 'XPC_FLAGS': '0x0', 15:56:09 INFO - 'XPC_SERVICE_NAME': '0', 15:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 15:56:09 INFO - mozversion application_buildid: 20160426142000 15:56:09 INFO - mozversion application_changeset: 52072b6bec1416578615ec73027eb80a65d3fcd4 15:56:09 INFO - mozversion application_display_name: Nightly 15:56:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:09 INFO - mozversion application_name: Firefox 15:56:09 INFO - mozversion application_remotingname: firefox 15:56:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:56:09 INFO - mozversion application_vendor: Mozilla 15:56:09 INFO - mozversion application_version: 49.0a1 15:56:09 INFO - mozversion platform_buildid: 20160426142000 15:56:09 INFO - mozversion platform_changeset: 52072b6bec1416578615ec73027eb80a65d3fcd4 15:56:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:56:09 INFO - mozversion platform_version: 49.0a1 15:56:09 INFO - using testdate: 1461711369 15:56:09 INFO - actual date: 1461711369 15:56:09 INFO - starting webserver on 'localhost:49283' 15:56:09 INFO - SUITE-START | Running 2 tests 15:56:09 INFO - TEST-START | dromaeo_css 15:56:09 INFO - operating with platform_type : mac_ 15:56:09 INFO - Initialising browser for dromaeo_css test... 15:56:09 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp2WaQXv/profile http://localhost:49283/getInfo.html) 15:56:11 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:56:11 INFO - PROCESS | 1657 | colorDepth:24 15:56:11 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:56:11 INFO - PROCESS | 1657 | __metrics 15:56:12 INFO - PROCESS | 1657 | 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" 15:56:12 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:56:12 INFO - TEST-INFO | 1657: exit 0 15:56:12 INFO - Browser initialized. 15:56:12 INFO - Running cycle 1/1 for dromaeo_css test... 15:56:12 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp2WaQXv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:24 INFO - PROCESS | 1659 | RSS: Main: 238993408 15:56:24 INFO - PROCESS | 1659 | 15:57:15 INFO - PROCESS | 1659 | 1461711435852 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] 15:59:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 15:59:27 INFO - PROCESS | 1659 | RSS: Main: 378216448 15:59:27 INFO - PROCESS | 1659 | 16:02:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 16:02:31 INFO - PROCESS | 1659 | RSS: Main: 372142080 16:02:31 INFO - PROCESS | 1659 | 16:05:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 16:05:33 INFO - PROCESS | 1659 | RSS: Main: 374607872 16:05:33 INFO - PROCESS | 1659 | 16:08:36 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 16:08:36 INFO - PROCESS | 1659 | RSS: Main: 375652352 16:08:36 INFO - PROCESS | 1659 | 16:11:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 16:11:40 INFO - PROCESS | 1659 | RSS: Main: 345370624 16:11:40 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 16:14:44 INFO - PROCESS | 1659 | RSS: Main: 385007616 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | __start_tp_report 16:14:44 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 16:14:44 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 16:14:44 INFO - PROCESS | 1659 | |i|pagename|runs| 16:14:44 INFO - PROCESS | 1659 | |0;dojo.html;2899.2606885244263;3462.8614855405785;3463.1861512544547;3473.9652603473955;3531.240783231605;5620.747066382012;5699.800506982257;5700.344460387057;5704.657720536766;5716.885662286757;5696.914546281809;5723.399043100477;5732.971335143329;5823.650580965145;5836.445537673925;5092.592592592584;5095.414027386852;5109.974450127745;5127.33344665193;5145.794168233266;5204.713740744258;5209.453007434222;5226.764795584208;5232.555232805216;5276.709780962045;4010.8796736097966;5078.26365177051;5113.079645663779;5187.170052791555;5190.948090519084;5131.666441681279;5141.331626888481;5152.639315247934;5183.118869792144;5185.429602743695;5079.212722028092;5124.103281925648;5149;5189.195674670432;5195.766190521435;5569.888602227973;5621.494065534122;5661.631993920382;5695.629784064023;5752.36723960364;5887.1463637772285;6145.718293884107;6190.814275571695;6197.442230199259;6231.875362492725;5598.529978364583;5697.715114244271;6198.62808231503;6257.9687101564205;6270.278917924452;5470.261514695545;5774.711264436762;5787.942120578782;5850.795222167204;5872.647641141545;6267.091271765568;6271.153394291803;6288.434040936338;6294.276158241861;6296.779612713533;6120.632762034292;6146.754129834846;6154.7230374633245;6171.9691401543605;6173.9073913891325;6067.939320606825;6165.907511387333;6176.135341052256;6199.442050215503;6288.748450061947;6201.317855035943;6229.972054611029;6239.906401403982;6246;6249.9062514062325;6260.154879091356;6273.62358258506;6284.43440090385;6293.402126797947;6295.150154729053;4789.640776941744;4910.48439913811;4913.901721965541;4923.409190897115;4953.083679519301;4407.713498622579;4456.420665313489;4481.977590112028;4482.305242687324;4485.730856148642;5696.886062278814;5701.800436984686;5708.372079071299;5713;5717.313922329264;6137.539684523678;6142.907856382158;6156.107364432132;6240.500759939194;6246.125542424064;5726.198332233491;5729.885402292014;5748.5688573357165;5749.080147176432;5752.856178595569;5332.413434522199;5394.379646340721;5400.567954563626;5409.972950135303;5410.215518749759;6231.189945307081;6267.9373206268265;6332.303446620868;6358.395952384516;6372.330905254881;6303.558750887394;6309.179806625109;6318.494520438262;6329.7468101275435;6333.778317758856;6318.115463835159;6331.145295385064;6332.556721029484;6336.461400780985;6339.873202536016;6087.4521293083835;6135.2326666699655;6148.339948214047;6210.720517576629;6230.906536402048;6286.339934306832;6293.527985401205;6297.149884765498;6319.494440444661;6353.078803573549;5966.940330596812;6134.447899689049;6147.047207682816;6154.876902462015;6175.042868355412;5915.260592425947;6074.544409169418;6106.15732346443;6137.346341658419;6138.143176733788;5888.381719919346;5934.9406505934385;5958.6424814511265;5982.282126144891;5997.70011499432;5946.108083787466;6105.931461994044;6125.203723515914;6144.877102457836;6149.354317796746;5909.6158749681135;5947.434993675594;5953.702314884152;5954.434328738763;5960.105984102419 16:14:44 INFO - PROCESS | 1659 | |1;ext.html;500.0374279511941;507.7106049551756;553.6207697727054;571.4114462104033;639.347865177519;29524;33793.493097603525;34738.30523389534;34770.130746731345;34804.30391392171;41359.37960930581;41980.79009604947;41997.58002419975;42006.1692905316;42277.577224227745;9397.671081512131;9639.421634701941;9639.710808675716;9644.276679249084;9647.372920760163;9428.151466368026;9592.280578956572;9592.376495527804;9597.520123993807;9609.327347085708;8525.403221774479;9389.342746007782;9545.80908381832;9618.182454491376;9622.422654640708;9535.332526723132;9589.568469418893;9592.904070959306;9593.136617704371;9597.952010239975;9363.297752668577;9449.480278584675;9461.574229159703;9464.716058518256;9466.29002824784;37992.62007379918;38003.429948550795;38342.23315533702;38408;38423.807880960696;3271.345730853815;3336.4828451590042;3386.271951530408;3476.374252634525;3514.068771775456;27431.86284068587;27778.305542361402;27963.021294254602;28383.864645414364;28393.858030709922;2663.9600405993924;2674.826136301154;2681.4771119631678;2754.5868119781994;2868.512352900012;358636;361106;362919.3372596479;364173;364464;56076.43923560794;56678.7166064167;56959.71520142456;56980.715096424254;56999.43000570024;58866.7056664714;60067;60141.39858601445;60184.476940382454;60185.39814601885;16275.755863662054;16489.587760306087;16494;16506.58733531647;16523.256453459384;12571.748565028649;12595.370231488389;12611.558595449114;12633.431495582538;12637.747245055047;14819.77770333446;17789.110544472725;18334.174962126737;18349.3577724779;18393.172307246205;7161.498695091398;7571.015767950242;8139.145389734111;8139.959300203461;8157.2250636189465;901.4185850126631;927.4296307770672;967.8451447768323;1009.7929924365487;1169.2808922512763;28249;28473.71526284752;28812.279693007422;28965.275868103465;29165.85417072901;967.2890425537224;1072.6138590107555;1139.726465648255;1181.8050021746487;1267.9683007924875;12036.856498632616;14705.41178352854;14723.411063557553;14816.770619532459;15054.698906022037;467634;471172;477905;479062;479361;56264.71867640636;56900;57154.57113572194;57289;57374.139387909214;1376.3324787478066;1385.8544852790312;1503.8947273690737;1525.9847401526065;1545.5517899808929;27494.450110998067;28111.43777124487;28216;28500.85749571322;29348.706512935452;47948.52051479441;48070.03859922712;49002.509974899796;49074.509254906996;49151.508484914695;392724.03637981624;394467;395215;396771;398281;21483.785162148804;24084.51830963406;24494.755052449247;24642.01431942702;25238.242852714448;39723.60276397199;40005.59994400019;40685.59314406818;40870;41132.58867411288;34218.82890585531;34911.65088349186;34960.12599684927;35618.46572301469;36146.4578031335;28635.997740078998;34111.4883276756;34148.65851341455;34539.654603453644;34986.82506587451;34044.65955340415;34464.82767586146;34683.47974780431;34965.825170873984;35045.29909401849;29738.8513057442;30717.23206919845;32178.67821321757;32247.35505289928;32261.51607725839;23766.648189485626;24038.63942040836;24091.573016961196;24161.03355865746;24463.75536244686 16:14:44 INFO - PROCESS | 1659 | |2;jquery.html;331.224635951301;393.36864332745944;397.1025482409753;402.24378169042194;407.2872473171949;19266.614667706654;19740.70388944167;21042.57914841704;21075.367738967856;21118;11848.585299514518;12105.97099246565;15031.473898413558;17636.38272660457;20909.581808363822;5332.866678333054;5499.780008799643;5530.004599172147;5531.889362212753;5544.722763861811;5600.747966341524;5930.347661757225;5937.079752638348;5947.702614869261;5952.464278214959;5882.852928676774;5907.940920590803;5922.2005029321135;5924.911126333109;6017.247844019497;6387.105805187278;6407.743690252408;6421.967890160519;6424.196975378078;6426.6144031358035;5496.1755736639425;5701.600887937846;5715.982774835412;5721.71391430431;5734.885302293973;22331.54844935074;24878.37804054895;25452.618210726854;25640;25928.092516761822;2044.9591008179752;2050.2004218354855;2099.88450635215;2109.177420805887;2179.2263746370127;9817.5582098805;9851.655192068243;10104.191664666809;10155.7461063474;10293.970602939646;1696.1180186303177;1723.5432610358266;1774.6184570317444;1796.2904652662125;1890.8960007199598;88976;106659;110116;111462.99999999919;114254.28618570729;11516.769664606829;11601.361925094032;11698.532058717556;11751.471183796579;11870.169088163746;15103.773443398359;15206.923965380323;15241.390344386322;15251.618709532351;15257.313420896086;8556.058833528306;8745.650173993095;8758.47449153053;8887.511186884783;8899.955500222586;8567.014793298726;8603.182697643713;8615.061611137444;8712.564371781385;8719.694810681596;3790.2608991246993;4554.749488778149;4643.3963584733765;4711.858644240679;4719.309993303853;1609.5412807349849;1806.9790568328851;1872.279172518563;1981.3659628918608;1983.2959299448487;740.7888751705738;877.3463769491642;989.4508547756064;994.3983889746744;1001.2540657210425;17756.57947364208;17905.820941790415;21025.579488410145;21621.67567486489;21899.233526826483;948.3219498058921;990.153418826907;1013.9087482126644;1015.137133436573;1104.4256986367045;10637.553362726461;11127.888721112848;11168;11178.44107794607;11186.993170614684;602455;606243;607739;623850;629388;92176;93360;117964.41017794856;123533;124492;1015.7765291635828;1024.8770147582338;1046.1578429364436;1050.1126548067025;1052.5684469367523;14850.925745371203;18336.358227461973;18476.72284915754;18477.16852741603;18845.90577047106;42413.57586424219;44682.77658611686;49184.26223606577;50160.49839501558;51573;63775;64582.35417645764;70424.64787676233;71084.64457677885;73381.16547086365;7841.8039549009445;8157.75526734199;8176.427650064438;8261.917380826355;8577.970643522567;12546.686332841387;12731.681707957376;12832.29422381778;13134.60596182116;13181.07732458757;9480.715578532656;9898.554565044446;10553.261271710906;10667.359958402521;11074.280171788809;10820.080293175168;10966.945165274441;10975.560977561128;11049.624330768924;11181.049610783175;11311.547538098384;11324.037456816262;11496.367699776258;11711.238769479956;11826.053915686896;8129.512229266263;8146.429749917449;8396.076431592643;8429.957850210709;8481.842761752625;11014.953579409943;11087.113030957666;11375.488103035548;11412.54349826031;11444.42777861087 16:14:44 INFO - PROCESS | 1659 | |3;mootools.html;1434.103685196752;1612.5404259785962;1618.7167245731998;1732.887362321449;1817.3820900893702;7834.412419068572;8192.098869124398;8592.785180370494;8808.119188081204;8827.161419665137;8502.829943401128;8555.272801811854;8643.697470588531;8646.827063458742;8685.392022558424;2133.765285818559;2366.160013195317;2425.454272788626;2457.8156638252112;2458.1027924807495;2480.528699547089;2502.3493891588137;2507.0974449198275;2507.3104896153613;2510.309664842174;2428.9392765180837;2452.546278938402;2466.4450498637843;2468.518638865413;2472.184179220853;2109.4304537774715;2348.283773449097;2430.064425196303;2439.48770758141;2444.0712529238863;2444.2178502879087;2469.8888550015113;2474.257722683206;2476.6037434010473;2489.054159419427;8613.526256055915;8679;8692.261157801595;8702.825943481159;8703.47779133254;5151.845444636667;5348.1442969124755;5377.4084850666395;5381.865453363658;5388.757505912244;3357.3956687796185;3473.513708080871;3669.027707657473;3671.834767435445;3681.4661874028384;1051.1223128687554;1053.2995557953952;1054.8628678271775;1056.6037735849056;1059.6873922192972;11547.018503427134;11593.304401735923;11597.304161750322;11612.477438515287;11626.476808543552;4707.29390591414;4842.15262329091;4893.119238537026;4920.581750551171;4943.703377797344;9803.656872009446;9897.455639939872;9915.107640312262;9915.504224788732;9919.50402479873;5321.308229930161;5393.2449457076045;5418.187271909245;5423.078076726966;5426.077566813651;4403.867883963486;4615.699979501322;4761.857144285607;4877.463479017305;4918.729469879191;3865.323568375523;3894.1043559980794;3963.672169823084;3966.3257246268204;3978.7214894957656;1132.4677401621225;1319.887809536181;1330.933453327349;1345.5223395694584;1348.3864841497095;802.2138304461661;826.0830478169228;845.9534725590152;919.1635611593418;970.4371464550544;5684.914726279109;5847;5860.619059761102;5923.703814809242;6029.914615369275;923.0769230769231;950.5484894675112;953.9618415263451;954.71358592422;1004.603181743222;3433.261848702541;3611.7539448890093;3722.8883133506038;3866.420036994417;3881.0491429599365;10142.340747851365;10591.629292974709;10659;10702.839457408145;10745.462726863781;10185.388876667424;10669.519871605797;10792.676219713421;10917.781644367069;10951.945240273748;6773.830654233683;8064.677412903418;8196.83606327882;8284.875726864102;8295.336373090138;5566.721663916869;5668.291463567054;5739.71301434935;5747.971260143672;5850.970745146247;9534.380265282734;9870.753231169278;9907.900920990985;10024.849627255451;10032.64885728996;10179.389236645826;10198.59205631796;10328.948355258175;10333.689989300334;10349.223808214263;6462.967685161544;6729.89905151433;6860.862782744417;6995.195552511526;7151.8569628608175;8195.385346098947;8381.413301069111;8381.832363352576;8392.370572207232;8396.412251142361;7228.63856807168;7326.9267307326245;7348.412127029718;7482.3639990601405;7541.321281084729;7192.676329565077;7303.525270857377;7349.228331025379;7356.117265928123;7388.298111679382;6933.064036355229;6979.616121113388;7024.5434046786795;7031.859362812817;7044.542104763174;4814;4822.903541929212;4874.439439464507;4929.285253638131;5083.974580127076;4853.174960256694;4859.125357435695;4862.562369386772;4950.504949505021;5154.278401023935 16:14:44 INFO - PROCESS | 1659 | |4;prototype.html;303.98176109433433;321.12973840891186;321.3204073384791;322.17362465276574;323.32102584572385;5020.698758074509;5134.717590532519;5157.742112894354;5233.764480598373;5243.895122097556;4165.937510937339;5152.51051150141;5153.330067091273;5201.713905735183;5206.542168192903;3981.104251543394;3985.342418500944;4003.519577650686;4010.0977280112033;4013.478247827793;3990.9201815963665;4006.13868018376;4038;4041.2927737645796;4042.484068474322;2964.673885872552;3252.333271679312;3568.8750893718725;3699.3341198584244;3949.4273330367078;3898.4542164097047;3917.216556688645;3928.921421571567;3935.134270460494;3963.9693679643356;3399.813010284458;3415.026717385533;3433.0044287156693;3433.6909678129086;3450.861965521376;4363.80362883671;4583.670735486705;4834.679353910143;5008.8998220035755;5042.672226305315;3800.5629352624524;4262.786860656955;4333.696641235115;4462.8884277892985;4537.342085397599;5410.3507579090765;5426.728663566845;5459;5460.481254280837;5466.644668096601;3413.7198550543544;3747.381682022463;3766.8304926278383;3804.8097595120134;3820.59883712209;5274.683518988834;5477.863053423656;5651.463111004489;5695.465517844561;5719.3422756382715;3745.962540374616;3834.884953451401;3840.7503512271614;3866.2847373235477;3904.9651842261824;3351.463765797461;3727.2731817295908;3850.172212974224;3907.5506316773367;3912.765234085964;3260.9401944368174;3846.249981253629;4357.803898824561;4510.872281929518;4519.254323036662;4211.810468528924;4445.977770111129;5097.617678674114;5331.760070796823;5430.15832545956;1349.71776812027;1426.0445501514012;1432.5129455985016;1435.3182238436868;1435.4904009076627;792.37798328312;943.4150826487485;943.8065196634674;948.7343543807744;950.9524523773922;4248.915021699549;4804.543568361;5493.835184944458;5536.4186760390385;5544.833654990357;6139.877202455926;6152.185644900191;6161.199044124325;6202.015355086419;6285.214348206474;4930.753462326869;5137.640365174402;5205.869853253699;5210.348706411699;5489.807856724996;3015.20097174249;3073.3085055862252;3280.803151810899;3282.720968717638;3286.983565082207;5507;5743.454371834752;6191.288001879841;6258;6542.934570654328;6396.776112836122;6399.488040956712;6403.615783053032;6407.391297826699;6415.230172379344;6487.318831522716;6499.642519661369;6502;6530.477561795045;6531.575447595891;5362.391282615278;5670.8015219467125;5676.20533125371;5682.829515114553;5718.714064296852;4199.958000419957;5382.3541175059245;5387.030334539821;5584.804531841366;5644.209810626434;4490.977545112253;5734.509027652757;5759.337676167294;5787.971060144672;6010.909836352545;3951.6245956634075;3981.800909954549;3985.860494882665;4017.1563971566297;4033.5563088060876;4707.163661615772;5466.808661696821;5592.972035139798;5627.679668995313;5646.520045795989;5416.369004501094;5473.534749546333;5476.096444086681;5489.3687225969525;5563.554915606823;4824.807007719652;4924.704517728947;5007.29897814299;5441.238226648194;5468.4531546845;5038.294638750651;5073.133679471087;5455.781768729206;5476.1511965643795;5489.451054894478;4438.223310920641;4937.555619994074;5337.733113344395;5490.203920431435;5560.499555040065;4491.393661855608;4624.30635404692;5352.250684904195;5425.04335137359;5445.319335083114 16:14:44 INFO - PROCESS | 1659 | |5;yui.html;654.1594051643638;721.336370539104;749.9287567681068;759.7986533568605;795.7294519863245;13868.791968120473;14000.789988150173;14062.085964412307;14080.436782528686;14263.928680356597;11762.882371176285;13875.861241387584;13925.442982280721;13929.094608850417;13944.233067181302;730.4813582356534;767.0087644060612;908.1735620585268;908.1826356279336;908.5184852028435;903.8056817784175;909.8726178335038;928.475411392561;931.2549960031947;932.2728271947891;750.2947229604182;870.851955167623;958.7296831697993;975.5268694683073;980.0101897083925;927.2998885841214;965.9951700241525;966.405660518783;967.1489089601176;967.6226271754022;713.8322494213855;714.0253553898942;714.0895358418059;715.0418439291323;715.2239819795528;14531.346089426;14617.78073328901;14637.194954277511;14660.560183194415;14663.70672586553;12130.636080917586;12345.69135771604;12466.189697669623;12666.49334026638;12772.233665979978;9837.458939758311;9936.155426788731;10112.848307275397;10364.067233948905;10489.79020419595;3427.845746941394;3466.861325546975;3510.508528805969;3524.365614189445;3581.3195492856535;66202;68132;70353.64823175903;72732;76127;9375.62497500106;9617.278704097082;9644.083812037845;9730.854037189449;9752.512374381253;20865.89567052155;21116.78883211179;21155.365339039854;21157.471063223235;21166.78833211679;7608.429367797437;7645.617719114022;7714.652840622185;7784.844303113906;7954.880676789853;4042.6967977401814;4070.3283958146576;4106.630403263721;4157;4416.492103408085;3500.579930408367;3601.8019008954757;3620.601733809279;3627.238279961238;3649.4708267301626;646.1890327638877;653.2911790707136;658.0589756647944;661.8775526527608;664.6278084272823;557.7518004488045;563.9492445679908;588.6703446070214;600.2586805295457;617.0713076819447;7354.632268386559;8197.836043279101;8340.332773378115;8359.205875441823;8424.78938026542;502.2591677275989;546.2161797820141;584.1733946465704;622.4460230394952;636.328673249726;3906.2382835346834;3951.9012024699614;3971.099495081897;3972.0864201233876;4171.541130475645;90555;94585;95799.0420095804;97585.51207243919;98022.01977980272;75625;76929.46141077147;77070.6146469264;79349.60325198337;81514;57551.424485755444;74099;74269;74324.45249826518;74839.62580187064;7766.611669416619;7793.571353575608;7847.176046515034;7856.5678887661725;8019.879701804594;31566;46045.76977115093;46143.76928115338;47330;48103;57813.26560203201;62394;62532.37467625266;62620;66563.33436665572;8680.739577812676;10046;10231.94884025605;10301.227407944285;10684.679459616224;11324.490397932277;11532.308061516;11582.768344632892;11598.304101753922;12105.273683579013;10464.529096190538;10892.128629709763;10928.398938058164;10929.39888306119;11024.724381890517;8800.427972181787;10479.800498753117;10840.67477975662;10916.290441121302;10941.781164376827;10269.948650257;10381.480925953823;10675.46622668879;10706;10713.678589642012;8803.955980220058;8974.057723938893;9076.546172691207;9274.907250927405;9439.48082855422;8800.735977920673;8951;9026.503542305236;9028.954855225682;9080.772980675536 16:14:44 INFO - PROCESS | 1659 | __end_tp_report 16:14:44 INFO - PROCESS | 1659 | __start_cc_report 16:14:44 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1388 16:14:44 INFO - PROCESS | 1659 | __end_cc_report 16:14:44 INFO - PROCESS | 1659 | __startTimestamp1461712484448__endTimestamp 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | ------- Summary: start ------- 16:14:44 INFO - PROCESS | 1659 | Number of tests: 6 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5729.19 Median:5946.11 stddev:657.03 (11.0%) stddev-sans-first:620.40 16:14:44 INFO - PROCESS | 1659 | Values: 2899.3 3462.9 3463.2 3474.0 3531.2 5620.7 5699.8 5700.3 5704.7 5716.9 5696.9 5723.4 5733.0 5823.7 5836.4 5092.6 5095.4 5110.0 5127.3 5145.8 5204.7 5209.5 5226.8 5232.6 5276.7 4010.9 5078.3 5113.1 5187.2 5190.9 5131.7 5141.3 5152.6 5183.1 5185.4 5079.2 5124.1 5149.0 5189.2 5195.8 5569.9 5621.5 5661.6 5695.6 5752.4 5887.1 6145.7 6190.8 6197.4 6231.9 5598.5 5697.7 6198.6 6258.0 6270.3 5470.3 5774.7 5787.9 5850.8 5872.6 6267.1 6271.2 6288.4 6294.3 6296.8 6120.6 6146.8 6154.7 6172.0 6173.9 6067.9 6165.9 6176.1 6199.4 6288.7 6201.3 6230.0 6239.9 6246.0 6249.9 6260.2 6273.6 6284.4 6293.4 6295.2 4789.6 4910.5 4913.9 4923.4 4953.1 4407.7 4456.4 4482.0 4482.3 4485.7 5696.9 5701.8 5708.4 5713.0 5717.3 6137.5 6142.9 6156.1 6240.5 6246.1 5726.2 5729.9 5748.6 5749.1 5752.9 5332.4 5394.4 5400.6 5410.0 5410.2 6231.2 6267.9 6332.3 6358.4 6372.3 6303.6 6309.2 6318.5 6329.7 6333.8 6318.1 6331.1 6332.6 6336.5 6339.9 6087.5 6135.2 6148.3 6210.7 6230.9 6286.3 6293.5 6297.1 6319.5 6353.1 5966.9 6134.4 6147.0 6154.9 6175.0 5915.3 6074.5 6106.2 6137.3 6138.1 5888.4 5934.9 5958.6 5982.3 5997.7 5946.1 6105.9 6125.2 6144.9 6149.4 5909.6 5947.4 5953.7 5954.4 5960.1 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:55649.75 Median:359871.00 stddev:109575.07 (30.4%) stddev-sans-first:109804.22 16:14:44 INFO - PROCESS | 1659 | Values: 500.0 507.7 553.6 571.4 639.3 29524.0 33793.5 34738.3 34770.1 34804.3 41359.4 41980.8 41997.6 42006.2 42277.6 9397.7 9639.4 9639.7 9644.3 9647.4 9428.2 9592.3 9592.4 9597.5 9609.3 8525.4 9389.3 9545.8 9618.2 9622.4 9535.3 9589.6 9592.9 9593.1 9598.0 9363.3 9449.5 9461.6 9464.7 9466.3 37992.6 38003.4 38342.2 38408.0 38423.8 3271.3 3336.5 3386.3 3476.4 3514.1 27431.9 27778.3 27963.0 28383.9 28393.9 2664.0 2674.8 2681.5 2754.6 2868.5 358636.0 361106.0 362919.3 364173.0 364464.0 56076.4 56678.7 56959.7 56980.7 56999.4 58866.7 60067.0 60141.4 60184.5 60185.4 16275.8 16489.6 16494.0 16506.6 16523.3 12571.7 12595.4 12611.6 12633.4 12637.7 14819.8 17789.1 18334.2 18349.4 18393.2 7161.5 7571.0 8139.1 8140.0 8157.2 901.4 927.4 967.8 1009.8 1169.3 28249.0 28473.7 28812.3 28965.3 29165.9 967.3 1072.6 1139.7 1181.8 1268.0 12036.9 14705.4 14723.4 14816.8 15054.7 467634.0 471172.0 477905.0 479062.0 479361.0 56264.7 56900.0 57154.6 57289.0 57374.1 1376.3 1385.9 1503.9 1526.0 1545.6 27494.5 28111.4 28216.0 28500.9 29348.7 47948.5 48070.0 49002.5 49074.5 49151.5 392724.0 394467.0 395215.0 396771.0 398281.0 21483.8 24084.5 24494.8 24642.0 25238.2 39723.6 40005.6 40685.6 40870.0 41132.6 34218.8 34911.7 34960.1 35618.5 36146.5 28636.0 34111.5 34148.7 34539.7 34986.8 34044.7 34464.8 34683.5 34965.8 35045.3 29738.9 30717.2 32178.7 32247.4 32261.5 23766.6 24038.6 24091.6 24161.0 24463.8 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34092.50 Median:12039.23 stddev:101621.46 (844.1%) stddev-sans-first:101874.92 16:14:44 INFO - PROCESS | 1659 | Values: 331.2 393.4 397.1 402.2 407.3 19266.6 19740.7 21042.6 21075.4 21118.0 11848.6 12106.0 15031.5 17636.4 20909.6 5332.9 5499.8 5530.0 5531.9 5544.7 5600.7 5930.3 5937.1 5947.7 5952.5 5882.9 5907.9 5922.2 5924.9 6017.2 6387.1 6407.7 6422.0 6424.2 6426.6 5496.2 5701.6 5716.0 5721.7 5734.9 22331.5 24878.4 25452.6 25640.0 25928.1 2045.0 2050.2 2099.9 2109.2 2179.2 9817.6 9851.7 10104.2 10155.7 10294.0 1696.1 1723.5 1774.6 1796.3 1890.9 88976.0 106659.0 110116.0 111463.0 114254.3 11516.8 11601.4 11698.5 11751.5 11870.2 15103.8 15206.9 15241.4 15251.6 15257.3 8556.1 8745.7 8758.5 8887.5 8900.0 8567.0 8603.2 8615.1 8712.6 8719.7 3790.3 4554.7 4643.4 4711.9 4719.3 1609.5 1807.0 1872.3 1981.4 1983.3 740.8 877.3 989.5 994.4 1001.3 17756.6 17905.8 21025.6 21621.7 21899.2 948.3 990.2 1013.9 1015.1 1104.4 10637.6 11127.9 11168.0 11178.4 11187.0 602455.0 606243.0 607739.0 623850.0 629388.0 92176.0 93360.0 117964.4 123533.0 124492.0 1015.8 1024.9 1046.2 1050.1 1052.6 14850.9 18336.4 18476.7 18477.2 18845.9 42413.6 44682.8 49184.3 50160.5 51573.0 63775.0 64582.4 70424.6 71084.6 73381.2 7841.8 8157.8 8176.4 8261.9 8578.0 12546.7 12731.7 12832.3 13134.6 13181.1 9480.7 9898.6 10553.3 10667.4 11074.3 10820.1 10966.9 10975.6 11049.6 11181.0 11311.5 11324.0 11496.4 11711.2 11826.1 8129.5 8146.4 8396.1 8430.0 8481.8 11015.0 11087.1 11375.5 11412.5 11444.4 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5677.10 Median:4905.92 stddev:3158.46 (64.4%) stddev-sans-first:3151.22 16:14:44 INFO - PROCESS | 1659 | Values: 1434.1 1612.5 1618.7 1732.9 1817.4 7834.4 8192.1 8592.8 8808.1 8827.2 8502.8 8555.3 8643.7 8646.8 8685.4 2133.8 2366.2 2425.5 2457.8 2458.1 2480.5 2502.3 2507.1 2507.3 2510.3 2428.9 2452.5 2466.4 2468.5 2472.2 2109.4 2348.3 2430.1 2439.5 2444.1 2444.2 2469.9 2474.3 2476.6 2489.1 8613.5 8679.0 8692.3 8702.8 8703.5 5151.8 5348.1 5377.4 5381.9 5388.8 3357.4 3473.5 3669.0 3671.8 3681.5 1051.1 1053.3 1054.9 1056.6 1059.7 11547.0 11593.3 11597.3 11612.5 11626.5 4707.3 4842.2 4893.1 4920.6 4943.7 9803.7 9897.5 9915.1 9915.5 9919.5 5321.3 5393.2 5418.2 5423.1 5426.1 4403.9 4615.7 4761.9 4877.5 4918.7 3865.3 3894.1 3963.7 3966.3 3978.7 1132.5 1319.9 1330.9 1345.5 1348.4 802.2 826.1 846.0 919.2 970.4 5684.9 5847.0 5860.6 5923.7 6029.9 923.1 950.5 954.0 954.7 1004.6 3433.3 3611.8 3722.9 3866.4 3881.0 10142.3 10591.6 10659.0 10702.8 10745.5 10185.4 10669.5 10792.7 10917.8 10951.9 6773.8 8064.7 8196.8 8284.9 8295.3 5566.7 5668.3 5739.7 5748.0 5851.0 9534.4 9870.8 9907.9 10024.8 10032.6 10179.4 10198.6 10328.9 10333.7 10349.2 6463.0 6729.9 6860.9 6995.2 7151.9 8195.4 8381.4 8381.8 8392.4 8396.4 7228.6 7326.9 7348.4 7482.4 7541.3 7192.7 7303.5 7349.2 7356.1 7388.3 6933.1 6979.6 7024.5 7031.9 7044.5 4814.0 4822.9 4874.4 4929.3 5084.0 4853.2 4859.1 4862.6 4950.5 5154.3 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4517.49 Median:5029.50 stddev:1423.04 (28.3%) stddev-sans-first:1391.45 16:14:44 INFO - PROCESS | 1659 | Values: 304.0 321.1 321.3 322.2 323.3 5020.7 5134.7 5157.7 5233.8 5243.9 4165.9 5152.5 5153.3 5201.7 5206.5 3981.1 3985.3 4003.5 4010.1 4013.5 3990.9 4006.1 4038.0 4041.3 4042.5 2964.7 3252.3 3568.9 3699.3 3949.4 3898.5 3917.2 3928.9 3935.1 3964.0 3399.8 3415.0 3433.0 3433.7 3450.9 4363.8 4583.7 4834.7 5008.9 5042.7 3800.6 4262.8 4333.7 4462.9 4537.3 5410.4 5426.7 5459.0 5460.5 5466.6 3413.7 3747.4 3766.8 3804.8 3820.6 5274.7 5477.9 5651.5 5695.5 5719.3 3746.0 3834.9 3840.8 3866.3 3905.0 3351.5 3727.3 3850.2 3907.6 3912.8 3260.9 3846.2 4357.8 4510.9 4519.3 4211.8 4446.0 5097.6 5331.8 5430.2 1349.7 1426.0 1432.5 1435.3 1435.5 792.4 943.4 943.8 948.7 951.0 4248.9 4804.5 5493.8 5536.4 5544.8 6139.9 6152.2 6161.2 6202.0 6285.2 4930.8 5137.6 5205.9 5210.3 5489.8 3015.2 3073.3 3280.8 3282.7 3287.0 5507.0 5743.5 6191.3 6258.0 6542.9 6396.8 6399.5 6403.6 6407.4 6415.2 6487.3 6499.6 6502.0 6530.5 6531.6 5362.4 5670.8 5676.2 5682.8 5718.7 4200.0 5382.4 5387.0 5584.8 5644.2 4491.0 5734.5 5759.3 5788.0 6010.9 3951.6 3981.8 3985.9 4017.2 4033.6 4707.2 5466.8 5593.0 5627.7 5646.5 5416.4 5473.5 5476.1 5489.4 5563.6 4824.8 4924.7 5007.3 5441.2 5468.5 5038.3 5073.1 5455.8 5476.2 5489.5 4438.2 4937.6 5337.7 5490.2 5560.5 4491.4 4624.3 5352.3 5425.0 5445.3 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:17618.19 Median:641.26 stddev:24991.50 (3897.3%) stddev-sans-first:25029.15 16:14:44 INFO - PROCESS | 1659 | Values: 654.2 721.3 749.9 759.8 795.7 13868.8 14000.8 14062.1 14080.4 14263.9 11762.9 13875.9 13925.4 13929.1 13944.2 730.5 767.0 908.2 908.2 908.5 903.8 909.9 928.5 931.3 932.3 750.3 870.9 958.7 975.5 980.0 927.3 966.0 966.4 967.1 967.6 713.8 714.0 714.1 715.0 715.2 14531.3 14617.8 14637.2 14660.6 14663.7 12130.6 12345.7 12466.2 12666.5 12772.2 9837.5 9936.2 10112.8 10364.1 10489.8 3427.8 3466.9 3510.5 3524.4 3581.3 66202.0 68132.0 70353.6 72732.0 76127.0 9375.6 9617.3 9644.1 9730.9 9752.5 20865.9 21116.8 21155.4 21157.5 21166.8 7608.4 7645.6 7714.7 7784.8 7954.9 4042.7 4070.3 4106.6 4157.0 4416.5 3500.6 3601.8 3620.6 3627.2 3649.5 646.2 653.3 658.1 661.9 664.6 557.8 563.9 588.7 600.3 617.1 7354.6 8197.8 8340.3 8359.2 8424.8 502.3 546.2 584.2 622.4 636.3 3906.2 3951.9 3971.1 3972.1 4171.5 90555.0 94585.0 95799.0 97585.5 98022.0 75625.0 76929.5 77070.6 79349.6 81514.0 57551.4 74099.0 74269.0 74324.5 74839.6 7766.6 7793.6 7847.2 7856.6 8019.9 31566.0 46045.8 46143.8 47330.0 48103.0 57813.3 62394.0 62532.4 62620.0 66563.3 8680.7 10046.0 10231.9 10301.2 10684.7 11324.5 11532.3 11582.8 11598.3 12105.3 10464.5 10892.1 10928.4 10929.4 11024.7 8800.4 10479.8 10840.7 10916.3 10941.8 10269.9 10381.5 10675.5 10706.0 10713.7 8804.0 8974.1 9076.5 9274.9 9439.5 8800.7 8951.0 9026.5 9029.0 9080.8 16:14:44 INFO - PROCESS | 1659 | -------- Summary: end -------- 16:14:44 INFO - PROCESS | 1659 | 16:14:44 INFO - TEST-INFO | 1659: exit 0 16:14:45 INFO - TEST-OK | dromaeo_css | took 1115455ms 16:14:45 INFO - TEST-START | kraken 16:14:45 INFO - operating with platform_type : mac_ 16:14:45 INFO - Initialising browser for kraken test... 16:14:45 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp1rIrtl/profile http://localhost:49283/getInfo.html) 16:14:47 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 16:14:47 INFO - PROCESS | 1669 | colorDepth:24 16:14:47 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 16:14:47 INFO - PROCESS | 1669 | __metrics 16:14:47 INFO - PROCESS | 1669 | 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" 16:14:47 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:14:47 INFO - TEST-INFO | 1669: exit 0 16:14:47 INFO - Browser initialized. 16:14:47 INFO - Running cycle 1/1 for kraken test... 16:14:47 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp1rIrtl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:59 INFO - PROCESS | 1671 | RSS: Main: 239353856 16:14:59 INFO - PROCESS | 1671 | 16:15:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:03 INFO - PROCESS | 1671 | RSS: Main: 286363648 16:15:03 INFO - PROCESS | 1671 | 16:15:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 16:15:06 INFO - PROCESS | 1671 | RSS: Main: 299278336 16:15:06 INFO - PROCESS | 1671 | 16:15:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 16:15:10 INFO - PROCESS | 1671 | RSS: Main: 387112960 16:15:10 INFO - PROCESS | 1671 | 16:15:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 16:15:13 INFO - PROCESS | 1671 | RSS: Main: 287825920 16:15:13 INFO - PROCESS | 1671 | 16:15:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:15:16 INFO - PROCESS | 1671 | RSS: Main: 292249600 16:15:16 INFO - PROCESS | 1671 | 16:15:18 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 16:15:19 INFO - PROCESS | 1671 | RSS: Main: 331227136 16:15:19 INFO - PROCESS | 1671 | 16:15:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 16:15:23 INFO - PROCESS | 1671 | RSS: Main: 330543104 16:15:23 INFO - PROCESS | 1671 | 16:15:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 16:15:26 INFO - PROCESS | 1671 | RSS: Main: 328151040 16:15:26 INFO - PROCESS | 1671 | 16:15:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:15:28 INFO - PROCESS | 1671 | RSS: Main: 321622016 16:15:28 INFO - PROCESS | 1671 | 16:15:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:15:31 INFO - PROCESS | 1671 | RSS: Main: 328204288 16:15:31 INFO - PROCESS | 1671 | 16:15:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:15:34 INFO - PROCESS | 1671 | RSS: Main: 330084352 16:15:34 INFO - PROCESS | 1671 | 16:15:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:15:37 INFO - PROCESS | 1671 | RSS: Main: 335884288 16:15:37 INFO - PROCESS | 1671 | 16:15:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:15:41 INFO - PROCESS | 1671 | RSS: Main: 332910592 16:15:41 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 16:15:43 INFO - PROCESS | 1671 | RSS: Main: 398213120 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | __start_tp_report 16:15:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 16:15:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 16:15:43 INFO - PROCESS | 1671 | |i|pagename|runs| 16:15:43 INFO - PROCESS | 1671 | |0;ai-astar;113;113;108;113;114;114;115;113;105;111 16:15:43 INFO - PROCESS | 1671 | |1;audio-beat-detection;154;124;143;192;146;167;141;117;173;119 16:15:43 INFO - PROCESS | 1671 | |2;audio-dft;184;196;261;211;185;188;182;184;182;187 16:15:43 INFO - PROCESS | 1671 | |3;audio-fft;74;76;86;91;58;59;64;110;86;44 16:15:43 INFO - PROCESS | 1671 | |4;audio-oscillator;89;96;139;78;79;78;127;80;77;128 16:15:43 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;90;86;88;88;90;87;91;101;134;72 16:15:43 INFO - PROCESS | 1671 | |6;imaging-darkroom;93;95;95;94;113;90;129;144;95;96 16:15:43 INFO - PROCESS | 1671 | |7;imaging-desaturate;86;85;86;85;83;83;85;83;85;83 16:15:43 INFO - PROCESS | 1671 | |8;json-parse-financial;61;60;59;59;58;59;59;78;59;58 16:15:43 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;62;66;70;72;68;66;66;65;66;67 16:15:43 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;82;95;107;107;104;83;82;82;82;84 16:15:43 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;140;140;139;135;137;137;136;137;176;139 16:15:43 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;198;194;198;206;270;210;198;194;194;199 16:15:43 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;70;74;70;82;70;70;70;71;71;67 16:15:43 INFO - PROCESS | 1671 | __end_tp_report 16:15:43 INFO - PROCESS | 1671 | __start_cc_report 16:15:43 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2111 16:15:43 INFO - PROCESS | 1671 | __end_cc_report 16:15:43 INFO - PROCESS | 1671 | __startTimestamp1461712543577__endTimestamp 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | ------- Summary: start ------- 16:15:43 INFO - PROCESS | 1671 | Number of tests: 14 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.11 (2.7%) stddev-sans-first:3.27 16:15:43 INFO - PROCESS | 1671 | Values: 113.0 113.0 108.0 113.0 114.0 114.0 115.0 113.0 105.0 111.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:150.00 stddev:24.52 (16.3%) stddev-sans-first:25.90 16:15:43 INFO - PROCESS | 1671 | Values: 154.0 124.0 143.0 192.0 146.0 167.0 141.0 117.0 173.0 119.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:196.00 Median:187.50 stddev:24.49 (13.1%) stddev-sans-first:25.58 16:15:43 INFO - PROCESS | 1671 | Values: 184.0 196.0 261.0 211.0 185.0 188.0 182.0 184.0 182.0 187.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:74.80 Median:75.00 stddev:19.30 (25.7%) stddev-sans-first:20.47 16:15:43 INFO - PROCESS | 1671 | Values: 74.0 76.0 86.0 91.0 58.0 59.0 64.0 110.0 86.0 44.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:78.50 stddev:24.55 (31.3%) stddev-sans-first:25.87 16:15:43 INFO - PROCESS | 1671 | Values: 89.0 96.0 139.0 78.0 79.0 78.0 127.0 80.0 77.0 128.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:88.00 stddev:16.13 (18.3%) stddev-sans-first:17.08 16:15:43 INFO - PROCESS | 1671 | Values: 90.0 86.0 88.0 88.0 90.0 87.0 91.0 101.0 134.0 72.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:94.50 stddev:18.34 (19.4%) stddev-sans-first:18.99 16:15:43 INFO - PROCESS | 1671 | Values: 93.0 95.0 95.0 94.0 113.0 90.0 129.0 144.0 95.0 96.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 16:15:43 INFO - PROCESS | 1671 | Values: 86.0 85.0 86.0 85.0 83.0 83.0 85.0 83.0 85.0 83.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:59.00 stddev:6.04 (10.2%) stddev-sans-first:6.40 16:15:43 INFO - PROCESS | 1671 | Values: 61.0 60.0 59.0 59.0 58.0 59.0 59.0 78.0 59.0 58.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:2.74 (4.1%) stddev-sans-first:2.29 16:15:43 INFO - PROCESS | 1671 | Values: 62.0 66.0 70.0 72.0 68.0 66.0 66.0 65.0 66.0 67.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:82.00 stddev:11.22 (13.7%) stddev-sans-first:11.44 16:15:43 INFO - PROCESS | 1671 | Values: 82.0 95.0 107.0 107.0 104.0 83.0 82.0 82.0 82.0 84.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:139.00 stddev:12.20 (8.8%) stddev-sans-first:12.93 16:15:43 INFO - PROCESS | 1671 | Values: 140.0 140.0 139.0 135.0 137.0 137.0 136.0 137.0 176.0 139.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:206.10 Median:198.50 stddev:23.06 (11.6%) stddev-sans-first:24.27 16:15:43 INFO - PROCESS | 1671 | Values: 198.0 194.0 198.0 206.0 270.0 210.0 198.0 194.0 194.0 199.0 16:15:43 INFO - PROCESS | 1671 | 16:15:43 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:70.50 stddev:4.06 (5.8%) stddev-sans-first:4.27 16:15:43 INFO - PROCESS | 1671 | Values: 70.0 74.0 70.0 82.0 70.0 70.0 70.0 71.0 71.0 67.0 16:15:43 INFO - PROCESS | 1671 | -------- Summary: end -------- 16:15:43 INFO - PROCESS | 1671 | 16:15:44 INFO - TEST-INFO | 1671: exit 0 16:15:44 INFO - TEST-OK | kraken | took 59343ms 16:15:44 INFO - SUITE-END | took 1174s 16:15:44 INFO - Completed test suite (00:19:35) 16:15:44 INFO - javascript benchmark 16:15:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2899.2606885244263, 3462.8614855405785, 3463.1861512544547, 3473.9652603473955, 3531.240783231605, 5620.747066382012, 5699.800506982257, 5700.344460387057, 5704.657720536766, 5716.885662286757, 5696.914546281809, 5723.399043100477, 5732.971335143329, 5823.650580965145, 5836.445537673925, 5092.592592592584, 5095.414027386852, 5109.974450127745, 5127.33344665193, 5145.794168233266, 5204.713740744258, 5209.453007434222, 5226.764795584208, 5232.555232805216, 5276.709780962045, 4010.8796736097966, 5078.26365177051, 5113.079645663779, 5187.170052791555, 5190.948090519084, 5131.666441681279, 5141.331626888481, 5152.639315247934, 5183.118869792144, 5185.429602743695, 5079.212722028092, 5124.103281925648, 5149.0, 5189.195674670432, 5195.766190521435, 5569.888602227973, 5621.494065534122, 5661.631993920382, 5695.629784064023, 5752.36723960364, 5887.1463637772285, 6145.718293884107, 6190.814275571695, 6197.442230199259, 6231.875362492725, 5598.529978364583, 5697.715114244271, 6198.62808231503, 6257.9687101564205, 6270.278917924452, 5470.261514695545, 5774.711264436762, 5787.942120578782, 5850.795222167204, 5872.647641141545, 6267.091271765568, 6271.153394291803, 6288.434040936338, 6294.276158241861, 6296.779612713533, 6120.632762034292, 6146.754129834846, 6154.7230374633245, 6171.9691401543605, 6173.9073913891325, 6067.939320606825, 6165.907511387333, 6176.135341052256, 6199.442050215503, 6288.748450061947, 6201.317855035943, 6229.972054611029, 6239.906401403982, 6246.0, 6249.9062514062325, 6260.154879091356, 6273.62358258506, 6284.43440090385, 6293.402126797947, 6295.150154729053, 4789.640776941744, 4910.48439913811, 4913.901721965541, 4923.409190897115, 4953.083679519301, 4407.713498622579, 4456.420665313489, 4481.977590112028, 4482.305242687324, 4485.730856148642, 5696.886062278814, 5701.800436984686, 5708.372079071299, 5713.0, 5717.313922329264, 6137.539684523678, 6142.907856382158, 6156.107364432132, 6240.500759939194, 6246.125542424064, 5726.198332233491, 5729.885402292014, 5748.5688573357165, 5749.080147176432, 5752.856178595569, 5332.413434522199, 5394.379646340721, 5400.567954563626, 5409.972950135303, 5410.215518749759, 6231.189945307081, 6267.9373206268265, 6332.303446620868, 6358.395952384516, 6372.330905254881, 6303.558750887394, 6309.179806625109, 6318.494520438262, 6329.7468101275435, 6333.778317758856, 6318.115463835159, 6331.145295385064, 6332.556721029484, 6336.461400780985, 6339.873202536016, 6087.4521293083835, 6135.2326666699655, 6148.339948214047, 6210.720517576629, 6230.906536402048, 6286.339934306832, 6293.527985401205, 6297.149884765498, 6319.494440444661, 6353.078803573549, 5966.940330596812, 6134.447899689049, 6147.047207682816, 6154.876902462015, 6175.042868355412, 5915.260592425947, 6074.544409169418, 6106.15732346443, 6137.346341658419, 6138.143176733788, 5888.381719919346, 5934.9406505934385, 5958.6424814511265, 5982.282126144891, 5997.70011499432, 5946.108083787466, 6105.931461994044, 6125.203723515914, 6144.877102457836, 6149.354317796746, 5909.6158749681135, 5947.434993675594, 5953.702314884152, 5954.434328738763, 5960.105984102419], "value": 5686.262251767198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.0374279511941, 507.7106049551756, 553.6207697727054, 571.4114462104033, 639.347865177519, 29524.0, 33793.493097603525, 34738.30523389534, 34770.130746731345, 34804.30391392171, 41359.37960930581, 41980.79009604947, 41997.58002419975, 42006.1692905316, 42277.577224227745, 9397.671081512131, 9639.421634701941, 9639.710808675716, 9644.276679249084, 9647.372920760163, 9428.151466368026, 9592.280578956572, 9592.376495527804, 9597.520123993807, 9609.327347085708, 8525.403221774479, 9389.342746007782, 9545.80908381832, 9618.182454491376, 9622.422654640708, 9535.332526723132, 9589.568469418893, 9592.904070959306, 9593.136617704371, 9597.952010239975, 9363.297752668577, 9449.480278584675, 9461.574229159703, 9464.716058518256, 9466.29002824784, 37992.62007379918, 38003.429948550795, 38342.23315533702, 38408.0, 38423.807880960696, 3271.345730853815, 3336.4828451590042, 3386.271951530408, 3476.374252634525, 3514.068771775456, 27431.86284068587, 27778.305542361402, 27963.021294254602, 28383.864645414364, 28393.858030709922, 2663.9600405993924, 2674.826136301154, 2681.4771119631678, 2754.5868119781994, 2868.512352900012, 358636.0, 361106.0, 362919.3372596479, 364173.0, 364464.0, 56076.43923560794, 56678.7166064167, 56959.71520142456, 56980.715096424254, 56999.43000570024, 58866.7056664714, 60067.0, 60141.39858601445, 60184.476940382454, 60185.39814601885, 16275.755863662054, 16489.587760306087, 16494.0, 16506.58733531647, 16523.256453459384, 12571.748565028649, 12595.370231488389, 12611.558595449114, 12633.431495582538, 12637.747245055047, 14819.77770333446, 17789.110544472725, 18334.174962126737, 18349.3577724779, 18393.172307246205, 7161.498695091398, 7571.015767950242, 8139.145389734111, 8139.959300203461, 8157.2250636189465, 901.4185850126631, 927.4296307770672, 967.8451447768323, 1009.7929924365487, 1169.2808922512763, 28249.0, 28473.71526284752, 28812.279693007422, 28965.275868103465, 29165.85417072901, 967.2890425537224, 1072.6138590107555, 1139.726465648255, 1181.8050021746487, 1267.9683007924875, 12036.856498632616, 14705.41178352854, 14723.411063557553, 14816.770619532459, 15054.698906022037, 467634.0, 471172.0, 477905.0, 479062.0, 479361.0, 56264.71867640636, 56900.0, 57154.57113572194, 57289.0, 57374.139387909214, 1376.3324787478066, 1385.8544852790312, 1503.8947273690737, 1525.9847401526065, 1545.5517899808929, 27494.450110998067, 28111.43777124487, 28216.0, 28500.85749571322, 29348.706512935452, 47948.52051479441, 48070.03859922712, 49002.509974899796, 49074.509254906996, 49151.508484914695, 392724.03637981624, 394467.0, 395215.0, 396771.0, 398281.0, 21483.785162148804, 24084.51830963406, 24494.755052449247, 24642.01431942702, 25238.242852714448, 39723.60276397199, 40005.59994400019, 40685.59314406818, 40870.0, 41132.58867411288, 34218.82890585531, 34911.65088349186, 34960.12599684927, 35618.46572301469, 36146.4578031335, 28635.997740078998, 34111.4883276756, 34148.65851341455, 34539.654603453644, 34986.82506587451, 34044.65955340415, 34464.82767586146, 34683.47974780431, 34965.825170873984, 35045.29909401849, 29738.8513057442, 30717.23206919845, 32178.67821321757, 32247.35505289928, 32261.51607725839, 23766.648189485626, 24038.63942040836, 24091.573016961196, 24161.03355865746, 24463.75536244686], "value": 18713.25137233551, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.224635951301, 393.36864332745944, 397.1025482409753, 402.24378169042194, 407.2872473171949, 19266.614667706654, 19740.70388944167, 21042.57914841704, 21075.367738967856, 21118.0, 11848.585299514518, 12105.97099246565, 15031.473898413558, 17636.38272660457, 20909.581808363822, 5332.866678333054, 5499.780008799643, 5530.004599172147, 5531.889362212753, 5544.722763861811, 5600.747966341524, 5930.347661757225, 5937.079752638348, 5947.702614869261, 5952.464278214959, 5882.852928676774, 5907.940920590803, 5922.2005029321135, 5924.911126333109, 6017.247844019497, 6387.105805187278, 6407.743690252408, 6421.967890160519, 6424.196975378078, 6426.6144031358035, 5496.1755736639425, 5701.600887937846, 5715.982774835412, 5721.71391430431, 5734.885302293973, 22331.54844935074, 24878.37804054895, 25452.618210726854, 25640.0, 25928.092516761822, 2044.9591008179752, 2050.2004218354855, 2099.88450635215, 2109.177420805887, 2179.2263746370127, 9817.5582098805, 9851.655192068243, 10104.191664666809, 10155.7461063474, 10293.970602939646, 1696.1180186303177, 1723.5432610358266, 1774.6184570317444, 1796.2904652662125, 1890.8960007199598, 88976.0, 106659.0, 110116.0, 111462.99999999919, 114254.28618570729, 11516.769664606829, 11601.361925094032, 11698.532058717556, 11751.471183796579, 11870.169088163746, 15103.773443398359, 15206.923965380323, 15241.390344386322, 15251.618709532351, 15257.313420896086, 8556.058833528306, 8745.650173993095, 8758.47449153053, 8887.511186884783, 8899.955500222586, 8567.014793298726, 8603.182697643713, 8615.061611137444, 8712.564371781385, 8719.694810681596, 3790.2608991246993, 4554.749488778149, 4643.3963584733765, 4711.858644240679, 4719.309993303853, 1609.5412807349849, 1806.9790568328851, 1872.279172518563, 1981.3659628918608, 1983.2959299448487, 740.7888751705738, 877.3463769491642, 989.4508547756064, 994.3983889746744, 1001.2540657210425, 17756.57947364208, 17905.820941790415, 21025.579488410145, 21621.67567486489, 21899.233526826483, 948.3219498058921, 990.153418826907, 1013.9087482126644, 1015.137133436573, 1104.4256986367045, 10637.553362726461, 11127.888721112848, 11168.0, 11178.44107794607, 11186.993170614684, 602455.0, 606243.0, 607739.0, 623850.0, 629388.0, 92176.0, 93360.0, 117964.41017794856, 123533.0, 124492.0, 1015.7765291635828, 1024.8770147582338, 1046.1578429364436, 1050.1126548067025, 1052.5684469367523, 14850.925745371203, 18336.358227461973, 18476.72284915754, 18477.16852741603, 18845.90577047106, 42413.57586424219, 44682.77658611686, 49184.26223606577, 50160.49839501558, 51573.0, 63775.0, 64582.35417645764, 70424.64787676233, 71084.64457677885, 73381.16547086365, 7841.8039549009445, 8157.75526734199, 8176.427650064438, 8261.917380826355, 8577.970643522567, 12546.686332841387, 12731.681707957376, 12832.29422381778, 13134.60596182116, 13181.07732458757, 9480.715578532656, 9898.554565044446, 10553.261271710906, 10667.359958402521, 11074.280171788809, 10820.080293175168, 10966.945165274441, 10975.560977561128, 11049.624330768924, 11181.049610783175, 11311.547538098384, 11324.037456816262, 11496.367699776258, 11711.238769479956, 11826.053915686896, 8129.512229266263, 8146.429749917449, 8396.076431592643, 8429.957850210709, 8481.842761752625, 11014.953579409943, 11087.113030957666, 11375.488103035548, 11412.54349826031, 11444.42777861087], "value": 9390.8293356693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.103685196752, 1612.5404259785962, 1618.7167245731998, 1732.887362321449, 1817.3820900893702, 7834.412419068572, 8192.098869124398, 8592.785180370494, 8808.119188081204, 8827.161419665137, 8502.829943401128, 8555.272801811854, 8643.697470588531, 8646.827063458742, 8685.392022558424, 2133.765285818559, 2366.160013195317, 2425.454272788626, 2457.8156638252112, 2458.1027924807495, 2480.528699547089, 2502.3493891588137, 2507.0974449198275, 2507.3104896153613, 2510.309664842174, 2428.9392765180837, 2452.546278938402, 2466.4450498637843, 2468.518638865413, 2472.184179220853, 2109.4304537774715, 2348.283773449097, 2430.064425196303, 2439.48770758141, 2444.0712529238863, 2444.2178502879087, 2469.8888550015113, 2474.257722683206, 2476.6037434010473, 2489.054159419427, 8613.526256055915, 8679.0, 8692.261157801595, 8702.825943481159, 8703.47779133254, 5151.845444636667, 5348.1442969124755, 5377.4084850666395, 5381.865453363658, 5388.757505912244, 3357.3956687796185, 3473.513708080871, 3669.027707657473, 3671.834767435445, 3681.4661874028384, 1051.1223128687554, 1053.2995557953952, 1054.8628678271775, 1056.6037735849056, 1059.6873922192972, 11547.018503427134, 11593.304401735923, 11597.304161750322, 11612.477438515287, 11626.476808543552, 4707.29390591414, 4842.15262329091, 4893.119238537026, 4920.581750551171, 4943.703377797344, 9803.656872009446, 9897.455639939872, 9915.107640312262, 9915.504224788732, 9919.50402479873, 5321.308229930161, 5393.2449457076045, 5418.187271909245, 5423.078076726966, 5426.077566813651, 4403.867883963486, 4615.699979501322, 4761.857144285607, 4877.463479017305, 4918.729469879191, 3865.323568375523, 3894.1043559980794, 3963.672169823084, 3966.3257246268204, 3978.7214894957656, 1132.4677401621225, 1319.887809536181, 1330.933453327349, 1345.5223395694584, 1348.3864841497095, 802.2138304461661, 826.0830478169228, 845.9534725590152, 919.1635611593418, 970.4371464550544, 5684.914726279109, 5847.0, 5860.619059761102, 5923.703814809242, 6029.914615369275, 923.0769230769231, 950.5484894675112, 953.9618415263451, 954.71358592422, 1004.603181743222, 3433.261848702541, 3611.7539448890093, 3722.8883133506038, 3866.420036994417, 3881.0491429599365, 10142.340747851365, 10591.629292974709, 10659.0, 10702.839457408145, 10745.462726863781, 10185.388876667424, 10669.519871605797, 10792.676219713421, 10917.781644367069, 10951.945240273748, 6773.830654233683, 8064.677412903418, 8196.83606327882, 8284.875726864102, 8295.336373090138, 5566.721663916869, 5668.291463567054, 5739.71301434935, 5747.971260143672, 5850.970745146247, 9534.380265282734, 9870.753231169278, 9907.900920990985, 10024.849627255451, 10032.64885728996, 10179.389236645826, 10198.59205631796, 10328.948355258175, 10333.689989300334, 10349.223808214263, 6462.967685161544, 6729.89905151433, 6860.862782744417, 6995.195552511526, 7151.8569628608175, 8195.385346098947, 8381.413301069111, 8381.832363352576, 8392.370572207232, 8396.412251142361, 7228.63856807168, 7326.9267307326245, 7348.412127029718, 7482.3639990601405, 7541.321281084729, 7192.676329565077, 7303.525270857377, 7349.228331025379, 7356.117265928123, 7388.298111679382, 6933.064036355229, 6979.616121113388, 7024.5434046786795, 7031.859362812817, 7044.542104763174, 4814.0, 4822.903541929212, 4874.439439464507, 4929.285253638131, 5083.974580127076, 4853.174960256694, 4859.125357435695, 4862.562369386772, 4950.504949505021, 5154.278401023935], "value": 4582.730227514846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.98176109433433, 321.12973840891186, 321.3204073384791, 322.17362465276574, 323.32102584572385, 5020.698758074509, 5134.717590532519, 5157.742112894354, 5233.764480598373, 5243.895122097556, 4165.937510937339, 5152.51051150141, 5153.330067091273, 5201.713905735183, 5206.542168192903, 3981.104251543394, 3985.342418500944, 4003.519577650686, 4010.0977280112033, 4013.478247827793, 3990.9201815963665, 4006.13868018376, 4038.0, 4041.2927737645796, 4042.484068474322, 2964.673885872552, 3252.333271679312, 3568.8750893718725, 3699.3341198584244, 3949.4273330367078, 3898.4542164097047, 3917.216556688645, 3928.921421571567, 3935.134270460494, 3963.9693679643356, 3399.813010284458, 3415.026717385533, 3433.0044287156693, 3433.6909678129086, 3450.861965521376, 4363.80362883671, 4583.670735486705, 4834.679353910143, 5008.8998220035755, 5042.672226305315, 3800.5629352624524, 4262.786860656955, 4333.696641235115, 4462.8884277892985, 4537.342085397599, 5410.3507579090765, 5426.728663566845, 5459.0, 5460.481254280837, 5466.644668096601, 3413.7198550543544, 3747.381682022463, 3766.8304926278383, 3804.8097595120134, 3820.59883712209, 5274.683518988834, 5477.863053423656, 5651.463111004489, 5695.465517844561, 5719.3422756382715, 3745.962540374616, 3834.884953451401, 3840.7503512271614, 3866.2847373235477, 3904.9651842261824, 3351.463765797461, 3727.2731817295908, 3850.172212974224, 3907.5506316773367, 3912.765234085964, 3260.9401944368174, 3846.249981253629, 4357.803898824561, 4510.872281929518, 4519.254323036662, 4211.810468528924, 4445.977770111129, 5097.617678674114, 5331.760070796823, 5430.15832545956, 1349.71776812027, 1426.0445501514012, 1432.5129455985016, 1435.3182238436868, 1435.4904009076627, 792.37798328312, 943.4150826487485, 943.8065196634674, 948.7343543807744, 950.9524523773922, 4248.915021699549, 4804.543568361, 5493.835184944458, 5536.4186760390385, 5544.833654990357, 6139.877202455926, 6152.185644900191, 6161.199044124325, 6202.015355086419, 6285.214348206474, 4930.753462326869, 5137.640365174402, 5205.869853253699, 5210.348706411699, 5489.807856724996, 3015.20097174249, 3073.3085055862252, 3280.803151810899, 3282.720968717638, 3286.983565082207, 5507.0, 5743.454371834752, 6191.288001879841, 6258.0, 6542.934570654328, 6396.776112836122, 6399.488040956712, 6403.615783053032, 6407.391297826699, 6415.230172379344, 6487.318831522716, 6499.642519661369, 6502.0, 6530.477561795045, 6531.575447595891, 5362.391282615278, 5670.8015219467125, 5676.20533125371, 5682.829515114553, 5718.714064296852, 4199.958000419957, 5382.3541175059245, 5387.030334539821, 5584.804531841366, 5644.209810626434, 4490.977545112253, 5734.509027652757, 5759.337676167294, 5787.971060144672, 6010.909836352545, 3951.6245956634075, 3981.800909954549, 3985.860494882665, 4017.1563971566297, 4033.5563088060876, 4707.163661615772, 5466.808661696821, 5592.972035139798, 5627.679668995313, 5646.520045795989, 5416.369004501094, 5473.534749546333, 5476.096444086681, 5489.3687225969525, 5563.554915606823, 4824.807007719652, 4924.704517728947, 5007.29897814299, 5441.238226648194, 5468.4531546845, 5038.294638750651, 5073.133679471087, 5455.781768729206, 5476.1511965643795, 5489.451054894478, 4438.223310920641, 4937.555619994074, 5337.733113344395, 5490.203920431435, 5560.499555040065, 4491.393661855608, 4624.30635404692, 5352.250684904195, 5425.04335137359, 5445.319335083114], "value": 4081.144341978154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.1594051643638, 721.336370539104, 749.9287567681068, 759.7986533568605, 795.7294519863245, 13868.791968120473, 14000.789988150173, 14062.085964412307, 14080.436782528686, 14263.928680356597, 11762.882371176285, 13875.861241387584, 13925.442982280721, 13929.094608850417, 13944.233067181302, 730.4813582356534, 767.0087644060612, 908.1735620585268, 908.1826356279336, 908.5184852028435, 903.8056817784175, 909.8726178335038, 928.475411392561, 931.2549960031947, 932.2728271947891, 750.2947229604182, 870.851955167623, 958.7296831697993, 975.5268694683073, 980.0101897083925, 927.2998885841214, 965.9951700241525, 966.405660518783, 967.1489089601176, 967.6226271754022, 713.8322494213855, 714.0253553898942, 714.0895358418059, 715.0418439291323, 715.2239819795528, 14531.346089426, 14617.78073328901, 14637.194954277511, 14660.560183194415, 14663.70672586553, 12130.636080917586, 12345.69135771604, 12466.189697669623, 12666.49334026638, 12772.233665979978, 9837.458939758311, 9936.155426788731, 10112.848307275397, 10364.067233948905, 10489.79020419595, 3427.845746941394, 3466.861325546975, 3510.508528805969, 3524.365614189445, 3581.3195492856535, 66202.0, 68132.0, 70353.64823175903, 72732.0, 76127.0, 9375.62497500106, 9617.278704097082, 9644.083812037845, 9730.854037189449, 9752.512374381253, 20865.89567052155, 21116.78883211179, 21155.365339039854, 21157.471063223235, 21166.78833211679, 7608.429367797437, 7645.617719114022, 7714.652840622185, 7784.844303113906, 7954.880676789853, 4042.6967977401814, 4070.3283958146576, 4106.630403263721, 4157.0, 4416.492103408085, 3500.579930408367, 3601.8019008954757, 3620.601733809279, 3627.238279961238, 3649.4708267301626, 646.1890327638877, 653.2911790707136, 658.0589756647944, 661.8775526527608, 664.6278084272823, 557.7518004488045, 563.9492445679908, 588.6703446070214, 600.2586805295457, 617.0713076819447, 7354.632268386559, 8197.836043279101, 8340.332773378115, 8359.205875441823, 8424.78938026542, 502.2591677275989, 546.2161797820141, 584.1733946465704, 622.4460230394952, 636.328673249726, 3906.2382835346834, 3951.9012024699614, 3971.099495081897, 3972.0864201233876, 4171.541130475645, 90555.0, 94585.0, 95799.0420095804, 97585.51207243919, 98022.01977980272, 75625.0, 76929.46141077147, 77070.6146469264, 79349.60325198337, 81514.0, 57551.424485755444, 74099.0, 74269.0, 74324.45249826518, 74839.62580187064, 7766.611669416619, 7793.571353575608, 7847.176046515034, 7856.5678887661725, 8019.879701804594, 31566.0, 46045.76977115093, 46143.76928115338, 47330.0, 48103.0, 57813.26560203201, 62394.0, 62532.37467625266, 62620.0, 66563.33436665572, 8680.739577812676, 10046.0, 10231.94884025605, 10301.227407944285, 10684.679459616224, 11324.490397932277, 11532.308061516, 11582.768344632892, 11598.304101753922, 12105.273683579013, 10464.529096190538, 10892.128629709763, 10928.398938058164, 10929.39888306119, 11024.724381890517, 8800.427972181787, 10479.800498753117, 10840.67477975662, 10916.290441121302, 10941.781164376827, 10269.948650257, 10381.480925953823, 10675.46622668879, 10706.0, 10713.678589642012, 8803.955980220058, 8974.057723938893, 9076.546172691207, 9274.907250927405, 9439.48082855422, 8800.735977920673, 8951.0, 9026.503542305236, 9028.954855225682, 9080.772980675536], "value": 6740.827595113439, "unit": "score"}], "name": "dromaeo_css", "value": 7080.389659409278, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 108.0, 113.0, 114.0, 114.0, 115.0, 113.0, 105.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 143.0, 192.0, 146.0, 167.0, 141.0, 117.0, 173.0, 119.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 196.0, 261.0, 211.0, 185.0, 188.0, 182.0, 184.0, 182.0, 187.0], "value": 196.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 86.0, 91.0, 58.0, 59.0, 64.0, 110.0, 86.0, 44.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 96.0, 139.0, 78.0, 79.0, 78.0, 127.0, 80.0, 77.0, 128.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 88.0, 90.0, 87.0, 91.0, 101.0, 134.0, 72.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 95.0, 94.0, 113.0, 90.0, 129.0, 144.0, 95.0, 96.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 83.0, 83.0, 85.0, 83.0, 85.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 58.0, 59.0, 59.0, 78.0, 59.0, 58.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 70.0, 72.0, 68.0, 66.0, 66.0, 65.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 95.0, 107.0, 107.0, 104.0, 83.0, 82.0, 82.0, 82.0, 84.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 139.0, 135.0, 137.0, 137.0, 136.0, 137.0, 176.0, 139.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 194.0, 198.0, 206.0, 270.0, 210.0, 198.0, 194.0, 194.0, 199.0], "value": 206.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 70.0, 82.0, 70.0, 70.0, 70.0, 71.0, 71.0, 67.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1546.6999999999998, "alertThreshold": 2.0}]} 16:15:44 INFO - Return code: 0 16:15:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:15:44 ERROR - # TBPL SUCCESS # 16:15:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:15:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:15:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:15:44 INFO - 2016-04-26 16:15:44.912 screenresolution[1675:9645] starting screenresolution argv=screenresolution get 16:15:44 INFO - 2016-04-26 16:15:44.914 screenresolution[1675:9645] Display 0: 1600x1200x32@60 16:15:44 INFO - 2016-04-26 16:15:44.920 screenresolution[1676:9648] starting screenresolution argv=screenresolution list 16:15:44 INFO - Available Modes on Display 0 16:15:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:15:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:15:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:15:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:15:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:15:45 INFO - Intel Iris: 16:15:45 INFO - Chipset Model: Intel Iris 16:15:45 INFO - Type: GPU 16:15:45 INFO - Bus: Built-In 16:15:45 INFO - VRAM (Dynamic, Max): 1536 MB 16:15:45 INFO - Vendor: Intel (0x8086) 16:15:45 INFO - Device ID: 0x0a2e 16:15:45 INFO - Revision ID: 0x0009 16:15:45 INFO - Displays: 16:15:45 INFO - Display: 16:15:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:15:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:15:45 INFO - Display Serial Number: 1600x1200 60 16:15:45 INFO - Main Display: Yes 16:15:45 INFO - Mirror: Off 16:15:45 INFO - Online: Yes 16:15:45 INFO - Rotation: Supported 16:15:45 INFO - Return code: 0 16:15:45 INFO - Running post-action listener: _resource_record_post_action 16:15:45 INFO - Running post-run listener: _resource_record_post_run 16:15:46 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 37639680; Write bytes: 694588416; Read time: 395; Write time: 1987 16:15:46 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 391244288; Write bytes: 384980480; Read time: 29745; Write time: 728 16:15:46 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35751424; Write bytes: 296013312; Read time: 373; Write time: 1211 16:15:46 INFO - Running post-run listener: _upload_blobber_files 16:15:46 INFO - Blob upload gear active. 16:15:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:15:46 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 16:15:46 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:15:46 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:15:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:15:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:15:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:15:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:47 INFO - (blobuploader) - INFO - Done attempting. 16:15:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:15:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:15:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:48 INFO - (blobuploader) - INFO - Done attempting. 16:15:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:15:48 INFO - Return code: 0 16:15:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:15:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:15:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9de55635348286fb1f46a6df411f8f5f0c1ca2a88af8217d8dd752224ff7a571cec08365dfab84e7171c23b68c8fa04e31059662f361053472aeafb7648158bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53a0ab5380f0ebde0f86f3aa2f400b4ecf51d9d3deb6ace43135a8cba58c65b4ac07a88c406400fe20b7d7d57f846ec11700354906d377d33bb056f8de9fa9c9"} 16:15:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:15:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:15:48 INFO - Contents: 16:15:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9de55635348286fb1f46a6df411f8f5f0c1ca2a88af8217d8dd752224ff7a571cec08365dfab84e7171c23b68c8fa04e31059662f361053472aeafb7648158bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53a0ab5380f0ebde0f86f3aa2f400b4ecf51d9d3deb6ace43135a8cba58c65b4ac07a88c406400fe20b7d7d57f846ec11700354906d377d33bb056f8de9fa9c9"} 16:15:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:15:48 INFO - Copying logs to upload dir... 16:15:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:15:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.280078 ========= master_lag: 1.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-26 16:15:49.551155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:15:49.555279) ========= 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.2mkHymspEN/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.hbaPmf5dBO/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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/Firefox/sha512/9de55635348286fb1f46a6df411f8f5f0c1ca2a88af8217d8dd752224ff7a571cec08365dfab84e7171c23b68c8fa04e31059662f361053472aeafb7648158bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53a0ab5380f0ebde0f86f3aa2f400b4ecf51d9d3deb6ace43135a8cba58c65b4ac07a88c406400fe20b7d7d57f846ec11700354906d377d33bb056f8de9fa9c9"} build_url:https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010408 build_url: 'https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9de55635348286fb1f46a6df411f8f5f0c1ca2a88af8217d8dd752224ff7a571cec08365dfab84e7171c23b68c8fa04e31059662f361053472aeafb7648158bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53a0ab5380f0ebde0f86f3aa2f400b4ecf51d9d3deb6ace43135a8cba58c65b4ac07a88c406400fe20b7d7d57f846ec11700354906d377d33bb056f8de9fa9c9"}' ========= master_lag: 0.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 16:15:50.181350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-26 16:15:50.181837) ========= 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.2mkHymspEN/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.hbaPmf5dBO/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005001 ========= master_lag: 4.85 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-26 16:15:55.036322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:15:55.036653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:15:55.078935) ========= ========= Total master_lag: 6.68 =========