builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0197 starttime: 1461711297.57 results: success (0) buildid: 20160426142000 builduid: 5722bb5f51de428aa5a1b268a481d421 revision: 52072b6bec1416578615ec73027eb80a65d3fcd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:57.571204) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 15:54:57.571612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-04-26 15:54:57.571895) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-04-26 15:55:00.263399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:00.263741) ========= 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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:55:00-- 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% 15.8M=0.001s 2016-04-26 15:55:00 (15.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105499 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:00.478963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:00.479273) ========= 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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.025647 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:00.520430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-26 15:55:00.520783) ========= 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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:55:00,594 truncating revision to first 12 chars 2016-04-26 15:55:00,594 Setting DEBUG logging. 2016-04-26 15:55:00,594 attempt 1/10 2016-04-26 15:55:00,594 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:55:02,353 unpacking tar archive at: mozilla-central-52072b6bec14/testing/mozharness/ program finished with exit code 0 elapsedTime=2.007723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-26 15:55:02.545785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:02.546230) ========= script_repo_revision: 52072b6bec1416578615ec73027eb80a65d3fcd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:02.546679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:02.547000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 15:55:02.561501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-26 15:55:02.562221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:55:02 INFO - MultiFileLogger online at 20160426 15:55:02 in /builds/slave/test 15:55:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:55:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:02 INFO - {'append_to_log': False, 15:55:02 INFO - 'base_work_dir': '/builds/slave/test', 15:55:02 INFO - 'blob_upload_branch': 'Firefox', 15:55:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:02 INFO - 'branch': 'Firefox', 15:55:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:02 INFO - 'config_files': ('talos/mac_config.py',), 15:55:02 INFO - 'default_actions': ('clobber', 15:55:02 INFO - 'read-buildbot-config', 15:55:02 INFO - 'download-and-extract', 15:55:02 INFO - 'populate-webroot', 15:55:02 INFO - 'create-virtualenv', 15:55:02 INFO - 'install', 15:55:02 INFO - 'run-tests'), 15:55:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:02 INFO - 'download_minidump_stackwalk': True, 15:55:02 INFO - 'download_symbols': 'ondemand', 15:55:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:55:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:55:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:55:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:55:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:02 INFO - 'installer_path': 'installer.exe', 15:55:02 INFO - 'log_level': 'info', 15:55:02 INFO - 'log_name': 'talos', 15:55:02 INFO - 'log_to_console': True, 15:55:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:55:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:55:02 INFO - 'opt_config_files': (), 15:55:02 INFO - 'pip_index': False, 15:55:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:02 INFO - 'cmd': ('bash', 15:55:02 INFO - '-c', 15:55:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:02 INFO - 'enabled': True, 15:55:02 INFO - 'halt_on_failure': False, 15:55:02 INFO - 'name': 'check_screen_resolution'},), 15:55:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:02 INFO - 'cmd': ('bash', 15:55:02 INFO - '-c', 15:55:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:02 INFO - 'enabled': True, 15:55:02 INFO - 'halt_on_failure': False, 15:55:02 INFO - 'name': 'check_screen_resolution'},), 15:55:02 INFO - 'run_cmd_checks_enabled': True, 15:55:02 INFO - 'sps_profile': False, 15:55:02 INFO - 'sps_profile_interval': 0, 15:55:02 INFO - 'suite': 'dromaeojs-e10s', 15:55:02 INFO - 'system_bits': '32', 15:55:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:02 INFO - 'title': 't-yosemite-r7-0197', 15:55:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:02 INFO - 'use_talos_json': True, 15:55:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:02 INFO - 'work_dir': 'build'} 15:55:02 INFO - ##### 15:55:02 INFO - ##### Running clobber step. 15:55:02 INFO - ##### 15:55:02 INFO - Running pre-action listener: _resource_record_pre_action 15:55:02 INFO - Running main action method: clobber 15:55:02 INFO - rmtree: /builds/slave/test/build 15:55:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:55:05 INFO - Running post-action listener: _resource_record_post_action 15:55:05 INFO - ##### 15:55:05 INFO - ##### Running read-buildbot-config step. 15:55:05 INFO - ##### 15:55:05 INFO - Running pre-action listener: _resource_record_pre_action 15:55:05 INFO - Running main action method: read_buildbot_config 15:55:05 INFO - Using buildbot properties: 15:55:05 INFO - { 15:55:05 INFO - "project": "", 15:55:05 INFO - "product": "firefox", 15:55:05 INFO - "script_repo_revision": "production", 15:55:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:55:05 INFO - "repository": "", 15:55:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:55:05 INFO - "buildid": "20160426142000", 15:55:05 INFO - "pgo_build": "False", 15:55:05 INFO - "basedir": "/builds/slave/test", 15:55:05 INFO - "buildnumber": 212, 15:55:05 INFO - "slavename": "t-yosemite-r7-0197", 15:55:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:55:05 INFO - "platform": "yosemite_r7", 15:55:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:55:05 INFO - "branch": "mozilla-central", 15:55:05 INFO - "repo_path": "mozilla-central", 15:55:05 INFO - "revision": "52072b6bec1416578615ec73027eb80a65d3fcd4", 15:55:05 INFO - "stage_platform": "macosx64", 15:55:05 INFO - "builduid": "5722bb5f51de428aa5a1b268a481d421", 15:55:05 INFO - "slavebuilddir": "test" 15:55:05 INFO - } 15:55:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 15:55:05 INFO - Running post-action listener: _resource_record_post_action 15:55:05 INFO - ##### 15:55:05 INFO - ##### Running download-and-extract step. 15:55:05 INFO - ##### 15:55:05 INFO - Running pre-action listener: _resource_record_pre_action 15:55:05 INFO - Running main action method: download_and_extract 15:55:05 INFO - mkdir: /builds/slave/test/build/tests 15:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:05 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:55:05 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:55:05 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:55:05 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:55:05 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:55:06 INFO - Downloaded 1199 bytes. 15:55:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 15:55:06 INFO - Using the following test package requirements: 15:55:06 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 15:55:06 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 15:55:06 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 15:55:06 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'jsshell-mac.zip'], 15:55:06 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 15:55:06 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 15:55:06 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 15:55:06 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 15:55:06 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 15:55:06 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:55:06 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 15:55:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:06 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:55:06 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:55:06 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:55:06 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:55:06 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:55:07 INFO - Downloaded 18114038 bytes. 15:55:07 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:55:07 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:55:11 INFO - Return code: 0 15:55:11 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: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 - 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:55:11 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:55:11 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:55:11 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:55:11 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:55:17 INFO - Downloaded 18114038 bytes. 15:55:17 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:55:17 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:55:20 INFO - Return code: 0 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 - 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:55:20 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:55:20 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:55:20 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:55:20 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:55:22 INFO - Downloaded 10840145 bytes. 15:55:22 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:55:22 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:55:22 INFO - Return code: 0 15:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:22 INFO - https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:55:22 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:55:22 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:55:22 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:55:22 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:55:26 INFO - Downloaded 110222485 bytes. 15:55:26 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:55:26 INFO - mkdir: /builds/slave/test/properties 15:55:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:55:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:55:26 INFO - Contents: 15:55:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:55:27 INFO - Running post-action listener: _resource_record_post_action 15:55:27 INFO - Running post-action listener: set_extra_try_arguments 15:55:27 INFO - ##### 15:55:27 INFO - ##### Running populate-webroot step. 15:55:27 INFO - ##### 15:55:27 INFO - Running pre-action listener: _resource_record_pre_action 15:55:27 INFO - Running main action method: populate_webroot 15:55:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:55:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:55:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:55:27 INFO - '--tppagecycles', 15:55:27 INFO - '7'], 15:55:27 INFO - 'tests': ['tsvgm']}}, 15:55:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:55:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:55:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:55:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:55:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:55:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:55:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['damp', 'tps']}, 15:55:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'tests': ['damp', 'tps']}, 15:55:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['dromaeo_dom']}, 15:55:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:55:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['a11yr', 15:55:27 INFO - 'ts_paint', 15:55:27 INFO - 'tpaint', 15:55:27 INFO - 'sessionrestore', 15:55:27 INFO - 'sessionrestore_no_auto_restore', 15:55:27 INFO - 'tabpaint']}, 15:55:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:55:27 INFO - 'ts_paint', 15:55:27 INFO - 'tpaint', 15:55:27 INFO - 'sessionrestore', 15:55:27 INFO - 'sessionrestore_no_auto_restore', 15:55:27 INFO - 'tabpaint']}, 15:55:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:55:27 INFO - 'ts_paint', 15:55:27 INFO - 'tpaint', 15:55:27 INFO - 'sessionrestore', 15:55:27 INFO - 'sessionrestore_no_auto_restore', 15:55:27 INFO - 'tabpaint']}, 15:55:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:55:27 INFO - 'ts_paint', 15:55:27 INFO - 'tpaint', 15:55:27 INFO - 'sessionrestore', 15:55:27 INFO - 'sessionrestore_no_auto_restore', 15:55:27 INFO - 'tabpaint']}, 15:55:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['a11yr', 15:55:27 INFO - 'ts_paint', 15:55:27 INFO - 'tpaint', 15:55:27 INFO - 'sessionrestore', 15:55:27 INFO - 'sessionrestore_no_auto_restore', 15:55:27 INFO - 'tabpaint']}, 15:55:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['a11yr', 15:55:27 INFO - 'ts_paint', 15:55:27 INFO - 'tpaint', 15:55:27 INFO - 'sessionrestore', 15:55:27 INFO - 'sessionrestore_no_auto_restore', 15:55:27 INFO - 'tabpaint']}, 15:55:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['tsvgx', 15:55:27 INFO - 'tsvgr_opacity', 15:55:27 INFO - 'tart', 15:55:27 INFO - 'tscrollx', 15:55:27 INFO - 'cart']}, 15:55:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:55:27 INFO - 'tsvgr_opacity', 15:55:27 INFO - 'tart', 15:55:27 INFO - 'tscrollx', 15:55:27 INFO - 'cart']}, 15:55:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'talos_options': ['--disable-e10s'], 15:55:27 INFO - 'tests': ['tp5o']}, 15:55:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'tests': ['tp5o']}, 15:55:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'talos_options': ['--disable-e10s', 15:55:27 INFO - '--xperf_path', 15:55:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:55:27 INFO - 'tests': ['tp5n']}, 15:55:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:55:27 INFO - 'talos_options': ['--xperf_path', 15:55:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:55:27 INFO - 'tests': ['tp5n']}}, 15:55:27 INFO - 'talos.zip': {'path': '', 15:55:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:55:27 INFO - Running post-action listener: _resource_record_post_action 15:55:27 INFO - ##### 15:55:27 INFO - ##### Running create-virtualenv step. 15:55:27 INFO - ##### 15:55:27 INFO - Running pre-action listener: _resource_record_pre_action 15:55:27 INFO - Running main action method: create_virtualenv 15:55:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:55:27 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:55:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:55:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:55:27 INFO - Using real prefix '/tools/python27' 15:55:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:55:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:55:30 INFO - Installing pip.................done. 15:55:30 INFO - Return code: 0 15:55:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:30 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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:30 INFO - 'HOME': '/Users/cltbld', 15:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:30 INFO - 'LOGNAME': 'cltbld', 15:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:30 INFO - 'MOZ_NO_REMOTE': '1', 15:55:30 INFO - 'NO_EM_RESTART': '1', 15:55:30 INFO - 'PAGER': '/bin/cat', 15:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:30 INFO - 'PWD': '/builds/slave/test', 15:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:30 INFO - 'SHELL': '/bin/bash', 15:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:30 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:30 INFO - 'USER': 'cltbld', 15:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:30 INFO - 'XPC_FLAGS': '0x0', 15:55:30 INFO - 'XPC_SERVICE_NAME': '0', 15:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:31 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:31 INFO - Cleaning up... 15:55:31 INFO - Return code: 0 15:55:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:31 INFO - 'HOME': '/Users/cltbld', 15:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:31 INFO - 'LOGNAME': 'cltbld', 15:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:31 INFO - 'MOZ_NO_REMOTE': '1', 15:55:31 INFO - 'NO_EM_RESTART': '1', 15:55:31 INFO - 'PAGER': '/bin/cat', 15:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:31 INFO - 'PWD': '/builds/slave/test', 15:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:31 INFO - 'SHELL': '/bin/bash', 15:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:31 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:31 INFO - 'USER': 'cltbld', 15:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:31 INFO - 'XPC_FLAGS': '0x0', 15:55:31 INFO - 'XPC_SERVICE_NAME': '0', 15:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:31 INFO - Downloading/unpacking psutil>=0.7.1 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:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:55:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:34 INFO - Installing collected packages: psutil 15:55:34 INFO - Running setup.py install for psutil 15:55:34 INFO - building 'psutil._psutil_osx' extension 15:55:34 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:34 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:34 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:35 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:35 INFO - building 'psutil._psutil_posix' extension 15:55:35 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:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:55:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:55:35 INFO - ^ 15:55:35 INFO - 1 warning generated. 15:55:35 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:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:55:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:55:35 INFO - Successfully installed psutil 15:55:35 INFO - Cleaning up... 15:55:35 INFO - Return code: 0 15:55:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:35 INFO - 'HOME': '/Users/cltbld', 15:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:35 INFO - 'LOGNAME': 'cltbld', 15:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:35 INFO - 'MOZ_NO_REMOTE': '1', 15:55:35 INFO - 'NO_EM_RESTART': '1', 15:55:35 INFO - 'PAGER': '/bin/cat', 15:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:35 INFO - 'PWD': '/builds/slave/test', 15:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:35 INFO - 'SHELL': '/bin/bash', 15:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:35 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:35 INFO - 'USER': 'cltbld', 15:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:35 INFO - 'XPC_FLAGS': '0x0', 15:55:35 INFO - 'XPC_SERVICE_NAME': '0', 15:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:55:38 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:38 INFO - Installing collected packages: mozsystemmonitor 15:55:38 INFO - Running setup.py install for mozsystemmonitor 15:55:38 INFO - Successfully installed mozsystemmonitor 15:55:38 INFO - Cleaning up... 15:55:38 INFO - Return code: 0 15:55:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:55:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:38 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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:38 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:38 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:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:38 INFO - 'HOME': '/Users/cltbld', 15:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:38 INFO - 'LOGNAME': 'cltbld', 15:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:38 INFO - 'MOZ_NO_REMOTE': '1', 15:55:38 INFO - 'NO_EM_RESTART': '1', 15:55:38 INFO - 'PAGER': '/bin/cat', 15:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:38 INFO - 'PWD': '/builds/slave/test', 15:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:38 INFO - 'SHELL': '/bin/bash', 15:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:38 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:38 INFO - 'USER': 'cltbld', 15:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:38 INFO - 'XPC_FLAGS': '0x0', 15:55:38 INFO - 'XPC_SERVICE_NAME': '0', 15:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:55:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:55:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:42 INFO - Downloading docopt-0.6.1.tar.gz 15:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:55:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:55:42 INFO - Running setup.py install for blobuploader 15:55:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:55:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:55:42 INFO - Running setup.py install for requests 15:55:43 INFO - Running setup.py install for docopt 15:55:43 INFO - Successfully installed blobuploader requests docopt 15:55:43 INFO - Cleaning up... 15:55:43 INFO - Return code: 0 15:55:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:43 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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:43 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:43 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:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:43 INFO - 'HOME': '/Users/cltbld', 15:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:43 INFO - 'LOGNAME': 'cltbld', 15:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:43 INFO - 'MOZ_NO_REMOTE': '1', 15:55:43 INFO - 'NO_EM_RESTART': '1', 15:55:43 INFO - 'PAGER': '/bin/cat', 15:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:43 INFO - 'PWD': '/builds/slave/test', 15:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:43 INFO - 'SHELL': '/bin/bash', 15:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:43 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:43 INFO - 'USER': 'cltbld', 15:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:43 INFO - 'XPC_FLAGS': '0x0', 15:55:43 INFO - 'XPC_SERVICE_NAME': '0', 15:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:43 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-3kj8wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:43 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-4MWDby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:43 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-7j9DC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:43 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-AJKA_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-tgqUd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-rsSCxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-H_FeMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-agKFaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-H4clwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-X310AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-mg3sve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-831JQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-qTiqQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:44 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-2lMUtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Oc7_n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-r4x4tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:45 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Nj5Jgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:55:45 INFO - Running setup.py install for manifestparser 15:55:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:55:45 INFO - Running setup.py install for mozcrash 15:55:45 INFO - Running setup.py install for mozdebug 15:55:45 INFO - Running setup.py install for mozdevice 15:55:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:55:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:55:45 INFO - Running setup.py install for mozfile 15:55:46 INFO - Running setup.py install for mozhttpd 15:55:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Running setup.py install for mozinfo 15:55:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Running setup.py install for mozInstall 15:55:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Running setup.py install for mozleak 15:55:46 INFO - Running setup.py install for mozlog 15:55:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:55:46 INFO - Running setup.py install for moznetwork 15:55:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Running setup.py install for mozprocess 15:55:47 INFO - Running setup.py install for mozprofile 15:55:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Running setup.py install for mozrunner 15:55:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Running setup.py install for mozscreenshot 15:55:47 INFO - Running setup.py install for moztest 15:55:47 INFO - Running setup.py install for mozversion 15:55:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:55:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:55:47 INFO - Cleaning up... 15:55:47 INFO - Return code: 0 15:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:47 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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:47 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:47 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:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:47 INFO - 'HOME': '/Users/cltbld', 15:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:47 INFO - 'LOGNAME': 'cltbld', 15:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:47 INFO - 'MOZ_NO_REMOTE': '1', 15:55:47 INFO - 'NO_EM_RESTART': '1', 15:55:47 INFO - 'PAGER': '/bin/cat', 15:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:47 INFO - 'PWD': '/builds/slave/test', 15:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:47 INFO - 'SHELL': '/bin/bash', 15:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:47 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:47 INFO - 'USER': 'cltbld', 15:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:47 INFO - 'XPC_FLAGS': '0x0', 15:55:47 INFO - 'XPC_SERVICE_NAME': '0', 15:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-9QfNbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-xY27oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-m6jF7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-MleId4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-SiC5rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Oum8PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-yrm0VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:48 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-teNqNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-WwX_hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-0n6S2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-UPB7gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-cAVuNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-O8NgE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-xDfDe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Be7J6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-hOKqqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:49 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-37vNtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:55:50 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:50 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:50 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:50 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:50 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:50 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:52 INFO - Downloading blessings-1.6.tar.gz 15:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:55:52 INFO - Installing collected packages: blessings 15:55:52 INFO - Running setup.py install for blessings 15:55:52 INFO - Successfully installed blessings 15:55:52 INFO - Cleaning up... 15:55:52 INFO - Return code: 0 15:55:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:53 INFO - Reading from file tmpfile_stdout 15:55:53 INFO - Current package versions: 15:55:53 INFO - blessings == 1.6 15:55:53 INFO - blobuploader == 1.2.4 15:55:53 INFO - docopt == 0.6.1 15:55:53 INFO - manifestparser == 1.1 15:55:53 INFO - mozInstall == 1.12 15:55:53 INFO - mozcrash == 0.17 15:55:53 INFO - mozdebug == 0.1 15:55:53 INFO - mozdevice == 0.48 15:55:53 INFO - mozfile == 1.2 15:55:53 INFO - mozhttpd == 0.7 15:55:53 INFO - mozinfo == 0.9 15:55:53 INFO - mozleak == 0.1 15:55:53 INFO - mozlog == 3.1 15:55:53 INFO - moznetwork == 0.27 15:55:53 INFO - mozprocess == 0.22 15:55:53 INFO - mozprofile == 0.28 15:55:53 INFO - mozrunner == 6.11 15:55:53 INFO - mozscreenshot == 0.1 15:55:53 INFO - mozsystemmonitor == 0.0 15:55:53 INFO - moztest == 0.7 15:55:53 INFO - mozversion == 1.4 15:55:53 INFO - psutil == 3.1.1 15:55:53 INFO - requests == 1.2.3 15:55:53 INFO - wsgiref == 0.1.2 15:55:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:53 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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:53 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:53 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:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:53 INFO - 'HOME': '/Users/cltbld', 15:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:53 INFO - 'LOGNAME': 'cltbld', 15:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:53 INFO - 'MOZ_NO_REMOTE': '1', 15:55:53 INFO - 'NO_EM_RESTART': '1', 15:55:53 INFO - 'PAGER': '/bin/cat', 15:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:53 INFO - 'PWD': '/builds/slave/test', 15:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:53 INFO - 'SHELL': '/bin/bash', 15:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:53 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:53 INFO - 'USER': 'cltbld', 15:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:53 INFO - 'XPC_FLAGS': '0x0', 15:55:53 INFO - 'XPC_SERVICE_NAME': '0', 15:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Cleaning up... 15:55:53 INFO - Return code: 0 15:55:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:53 INFO - 'HOME': '/Users/cltbld', 15:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:53 INFO - 'LOGNAME': 'cltbld', 15:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:53 INFO - 'MOZ_NO_REMOTE': '1', 15:55:53 INFO - 'NO_EM_RESTART': '1', 15:55:53 INFO - 'PAGER': '/bin/cat', 15:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:53 INFO - 'PWD': '/builds/slave/test', 15:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:53 INFO - 'SHELL': '/bin/bash', 15:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:53 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:53 INFO - 'USER': 'cltbld', 15:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:53 INFO - 'XPC_FLAGS': '0x0', 15:55:53 INFO - 'XPC_SERVICE_NAME': '0', 15:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:53 INFO - Downloading/unpacking jsonschema 15:55:53 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:53 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:53 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:53 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:53 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:53 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:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:55:55 INFO - Downloading/unpacking functools32 (from jsonschema) 15:55:55 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:55 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:55 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:55 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:55 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:55 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:56 INFO - Downloading functools32-3.2.3-2.tar.gz 15:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:55:56 INFO - warning: no files found matching '*.txt' 15:55:56 INFO - no previously-included directories found matching 'build' 15:55:56 INFO - no previously-included directories found matching 'dist' 15:55:56 INFO - no previously-included directories found matching '.git*' 15:55:56 INFO - Installing collected packages: jsonschema, functools32 15:55:56 INFO - Running setup.py install for functools32 15:55:56 INFO - warning: no files found matching '*.txt' 15:55:56 INFO - no previously-included directories found matching 'build' 15:55:56 INFO - no previously-included directories found matching 'dist' 15:55:56 INFO - no previously-included directories found matching '.git*' 15:55:56 INFO - Successfully installed jsonschema functools32 15:55:56 INFO - Cleaning up... 15:55:56 INFO - Return code: 0 15:55:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:57 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 0x11047fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb362dd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, '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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:57 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:57 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:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:55:57 INFO - 'HOME': '/Users/cltbld', 15:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:55:57 INFO - 'LOGNAME': 'cltbld', 15:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:57 INFO - 'MOZ_NO_REMOTE': '1', 15:55:57 INFO - 'NO_EM_RESTART': '1', 15:55:57 INFO - 'PAGER': '/bin/cat', 15:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:57 INFO - 'PWD': '/builds/slave/test', 15:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:55:57 INFO - 'SHELL': '/bin/bash', 15:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:55:57 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:55:57 INFO - 'USER': 'cltbld', 15:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:57 INFO - 'XPC_FLAGS': '0x0', 15:55:57 INFO - 'XPC_SERVICE_NAME': '0', 15:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:57 INFO - Downloading/unpacking flake8 15:55:57 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:57 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:57 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:57 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:57 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:57 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:56:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:56:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:56:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:56:01 INFO - no previously-included directories found matching 'docs/_build' 15:56:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:56:01 INFO - Running setup.py install for pep8 15:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:56:01 INFO - no previously-included directories found matching 'docs/_build' 15:56:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:56:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:56:01 INFO - Cleaning up... 15:56:01 INFO - Return code: 0 15:56:01 INFO - Running post-action listener: _resource_record_post_action 15:56:01 INFO - Running post-action listener: _start_resource_monitoring 15:56:01 INFO - Starting resource monitoring. 15:56:01 INFO - ##### 15:56:01 INFO - ##### Running install step. 15:56:01 INFO - ##### 15:56:01 INFO - Running pre-action listener: _resource_record_pre_action 15:56:01 INFO - Running main action method: install 15:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:01 INFO - Reading from file tmpfile_stdout 15:56:01 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:02 INFO - Reading from file tmpfile_stdout 15:56:02 INFO - Output received: 15:56:02 INFO - Usage: mozinstall [options] installer 15:56:02 INFO - Options: 15:56:02 INFO - -h, --help show this help message and exit 15:56:02 INFO - -d DEST, --destination=DEST 15:56:02 INFO - Directory to install application into. [default: 15:56:02 INFO - "/builds/slave/test"] 15:56:02 INFO - --app=APP Application being installed. [default: firefox] 15:56:02 INFO - mkdir: /builds/slave/test/build/application 15:56:02 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:56:02 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:35 INFO - Reading from file tmpfile_stdout 15:56:35 INFO - Output received: 15:56:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:56:35 INFO - Running post-action listener: _resource_record_post_action 15:56:35 INFO - ##### 15:56:35 INFO - ##### Running run-tests step. 15:56:35 INFO - ##### 15:56:35 INFO - Running pre-action listener: _resource_record_pre_action 15:56:35 INFO - Running main action method: run_tests 15:56:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:56:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:56:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:56:35 INFO - 2016-04-26 15:56:35.610 screenresolution[1638:7468] starting screenresolution argv=screenresolution get 15:56:35 INFO - 2016-04-26 15:56:35.613 screenresolution[1638:7468] Display 0: 1600x1200x32@60 15:56:35 INFO - 2016-04-26 15:56:35.619 screenresolution[1639:7470] starting screenresolution argv=screenresolution list 15:56:35 INFO - Available Modes on Display 0 15:56:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:56:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:56:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:56:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:56:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:56:35 INFO - Intel Iris: 15:56:35 INFO - Chipset Model: Intel Iris 15:56:35 INFO - Type: GPU 15:56:35 INFO - Bus: Built-In 15:56:35 INFO - VRAM (Dynamic, Max): 1536 MB 15:56:35 INFO - Vendor: Intel (0x8086) 15:56:35 INFO - Device ID: 0x0a2e 15:56:35 INFO - Revision ID: 0x0009 15:56:35 INFO - Displays: 15:56:35 INFO - Display: 15:56:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:56:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:56:35 INFO - Display Serial Number: 1600x1200 60 15:56:35 INFO - Main Display: Yes 15:56:35 INFO - Mirror: Off 15:56:35 INFO - Online: Yes 15:56:35 INFO - Rotation: Supported 15:56:35 INFO - Return code: 0 15:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:35 INFO - Python 2.7.3 15:56:35 INFO - Return code: 0 15:56:35 INFO - grabbing minidump binary from tooltool 15:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:35 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 0x11031ee00>, '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 0x110187db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110319b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:35 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:35 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:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:35 INFO - Return code: 0 15:56:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:56:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:56:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:56:37 INFO - Return code: 0 15:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--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-0197', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --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-0197 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yd6Dkbxq7B/Render', 15:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:37 INFO - 'HOME': '/Users/cltbld', 15:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:37 INFO - 'LOGNAME': 'cltbld', 15:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:37 INFO - 'MOZ_NO_REMOTE': '1', 15:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:37 INFO - 'NO_EM_RESTART': '1', 15:56:37 INFO - 'PAGER': '/bin/cat', 15:56:37 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:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:37 INFO - 'PWD': '/builds/slave/test', 15:56:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:37 INFO - 'SHELL': '/bin/bash', 15:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sJfIhH4sOs/Listeners', 15:56:37 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 15:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:37 INFO - 'USER': 'cltbld', 15:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:37 INFO - 'XPC_FLAGS': '0x0', 15:56:37 INFO - 'XPC_SERVICE_NAME': '0', 15:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--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-0197', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:56:37 INFO - mozversion application_buildid: 20160426142000 15:56:37 INFO - mozversion application_changeset: 52072b6bec1416578615ec73027eb80a65d3fcd4 15:56:37 INFO - mozversion application_display_name: Nightly 15:56:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:37 INFO - mozversion application_name: Firefox 15:56:37 INFO - mozversion application_remotingname: firefox 15:56:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:56:37 INFO - mozversion application_vendor: Mozilla 15:56:37 INFO - mozversion application_version: 49.0a1 15:56:37 INFO - mozversion platform_buildid: 20160426142000 15:56:37 INFO - mozversion platform_changeset: 52072b6bec1416578615ec73027eb80a65d3fcd4 15:56:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:56:37 INFO - mozversion platform_version: 49.0a1 15:56:37 INFO - using testdate: 1461711397 15:56:37 INFO - actual date: 1461711397 15:56:37 INFO - starting webserver on 'localhost:49274' 15:56:37 INFO - SUITE-START | Running 2 tests 15:56:37 INFO - TEST-START | dromaeo_css 15:56:37 INFO - operating with platform_type : mac_ 15:56:37 INFO - Initialising browser for dromaeo_css test... 15:56:37 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpQZTwjc/profile http://localhost:49274/getInfo.html) 15:56:40 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 15:56:40 INFO - PROCESS | 1657 | colorDepth:24 15:56:40 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 15:56:40 INFO - PROCESS | 1657 | __metrics 15:56:40 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:56:41 INFO - TEST-INFO | 1657: exit 0 15:56:41 INFO - Browser initialized. 15:56:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:56:41 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpQZTwjc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:56:53 INFO - PROCESS | 1663 | RSS: Main: 249573376 15:56:53 INFO - PROCESS | 1663 | 15:57:42 INFO - PROCESS | 1663 | 1461711462720 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:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 15:59:54 INFO - PROCESS | 1663 | RSS: Main: 261324800 15:59:54 INFO - PROCESS | 1663 | 16:02:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 16:02:57 INFO - PROCESS | 1663 | RSS: Main: 273330176 16:02:57 INFO - PROCESS | 1663 | 16:05:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 16:05:59 INFO - PROCESS | 1663 | RSS: Main: 275275776 16:05:59 INFO - PROCESS | 1663 | 16:09:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 16:09:02 INFO - PROCESS | 1663 | RSS: Main: 276881408 16:09:02 INFO - PROCESS | 1663 | 16:12:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 16:12:05 INFO - PROCESS | 1663 | RSS: Main: 279977984 16:12:05 INFO - PROCESS | 1663 | 16:15:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 16:15:08 INFO - PROCESS | 1663 | RSS: Main: 280956928 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | __start_tp_report 16:15:08 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:15:08 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:15:08 INFO - PROCESS | 1663 | |i|pagename|runs| 16:15:08 INFO - PROCESS | 1663 | |0;dojo.html;3481.860725570977;3483.3381657485074;3483.73871959603;3502.6672466115724;3548.858045678173;5851.590388672795;5894.145348924403;5896.705164741757;5910.349861515235;5923.348431672518;5063.063333283345;5172.732680493275;5810.796622118227;5954.940450595493;6070.635761854292;5239.73801309934;5273.129933560957;5298.4436634153435;5363.839084827461;5386.515213630772;625.6830571557364;4414.690971631987;5297.364316282052;5320.6275560710765;5338.572914166857;5223.347081614779;5241.056609810233;5246.422893481714;5252.973735131319;5286.259923610698;5216.817411390621;5302.70835104073;5325.467453254682;5331.093714068579;5355.277037599952;5206.453322401169;5213.687178769248;5243.475652434764;5260.9736951315;5333.973330133324;5633;5767.884642307173;5801.390853960358;5808;5855.268091488564;5585.134304182858;6079.39206079393;6165.290991535986;6240.781572644935;6273.62358258506;6271.3728627136925;6319.526035547352;6321.209848768904;6323.019931910561;6342.587731797418;6080.452759251644;6094.329623741385;6095.359987201325;6106.542009349317;6118.265808103056;5370.838874833761;6256.562040657111;6289.591176573508;6445.581037232565;6462.386073323027;6159.722812473449;6185.536084793658;6197.349278325801;6203.658798766111;6240.251169859555;6231.2522497300615;6285.779997700059;6287.276963149205;6299.307076221612;6315.368463153648;5756.481916627524;6140.534923917717;6187.319394866561;6255.46828519581;6259.061140828912;6157.753689852356;6201.720922558496;6237.407446292686;6267.122602835607;6273.404026617464;5005.074061298671;5053.84838454847;5083.974580127076;5083.974580127076;5096.796128154906;4369.737815731066;4492.326151077365;4555.954440455619;4561.68068235227;4588.242939914943;5043.52086551777;6017.398260174035;6025.6083354581815;6027.065804800263;6043.576949613573;6285.874282514415;6290.811275661737;6308.3060863305;6316.778912738032;6327.145835312266;5912.201852749824;6003.129546215774;6030.427109424598;6040;6099.237595300588;5544.0575102232715;5546.944530554723;5554.1946417769195;5557.138643510262;5561.332640083135;6389.041643753474;6519.054737063099;6559.180102487189;6560.212774466999;6583.506237032242;5278;5366.329208848894;5408.405075441777;6246.750129994749;6460.935390646034;5776.855578610568;6521.282658907421;6536.8365790855605;6558.475321974135;6560.606363618198;6104.3075792339105;6171.56799024064;6252.218472690914;6278.434940855345;6301.149344838388;6250.249970003629;6308.0853276273765;6322.46259067966;6328.6519241442165;6337.2395312562785;6163.3528479509005;6169.722362493789;6177.536684748752;6182.567220294716;6195.845103872439;5456.754446050017;6077.361877002851;6081.604695694766;6108.35862234459;6177.1969643945995;6005.849853753691;6115.541334399849;6129.08063790435;6141.731496609813;6204.72078756448;6156.854138818557;6243.094751261133;6263.874722505616;6271.62370257786;6284.277308109626;5958.612690175125;6211.099390588249;6213.502919766498;6229.470495007794;6232.688365581612 16:15:08 INFO - PROCESS | 1663 | |1;ext.html;510.93868735751715;511.4297558222581;552.353746117043;601.9345758008322;601.9465934614425;30431;37606.811965940164;38566.4215036774;38569.22861542771;38877.41683874737;41724.748257552325;42046.57953420465;42464.15071698564;42599.78700106495;42679.35980960288;9352.766180845465;9612.855807162898;9614.471204083773;9617.942026377093;9623.470709110996;7704.845903081935;9203.17171454569;9490.905090949105;9605.471699056548;9677.806443871119;9402.38884472507;9544.427334359925;9579.233661307113;9586.089321514444;9618.903810961905;9539.618415263416;9622.903770962306;9626.422414655142;9649.179819715333;9689;9442.10300021497;9553.61785528578;9626.278029147772;9653.613855445774;9678.951605241999;38127.809360953295;38586.228275434616;38681;38692;38701.61298387008;2859.1994241612383;3060.8775648974015;3122.469180239365;3388.339273841602;3420.521127042216;25773.871130644413;26019.869900650567;26624.467510649873;26692;27457.31356716078;2640.405908670553;2648;2682.1685277563824;2749.8075134740575;2758.4069425073703;271704;274734;274855;275951.62024189753;276617;32842.01473955785;33642.49536256958;34471.82764086164;34930;35005.299894001975;34951;35055.82472087623;35213.647863521546;35290.11774705653;35406.29187416237;15328.310226039855;15404.768928466083;15531.378744850306;15533.766993495106;15575.610609734847;13034.087613867128;13113.803292950613;13120.212787232796;13154.473821047051;13160.934195328962;6882.931170688229;7259.41924646027;8053.31546818527;8100.270975612223;8188.713395031145;2665.7067722550505;2757.8621068946472;3426.9485957710654;3439.570053743282;3447.896563103111;826.8057006603443;962.8542034978353;999.1656966432964;1015.9949200254099;1083.3608171179042;23934.88032559861;28911.7108828909;29243;29548.409031819672;29910.700892991226;1014.6398028699853;1075.6168612902454;1092.530212008828;1122.7642195139113;1142.708609304622;13669.38487768033;15189;15508.147051912027;15620;15656.530304090895;461232;465493;466967;475343;475984;58540.73133418013;59412.40587594069;59457.70271148703;59666;59682.10476842851;1442.4205494982978;1452.5714914100365;1467.1069645307962;1473.8747206487353;1494.4470545898087;29029.564556531248;29092;29253.122406327846;29455.55816662709;29760.553591696575;51843.703907401105;52046.73976630244;52268.21597676114;52302.476975231286;52552.47447525629;432316;432970;448985;449825;452045;26183.08359207495;26599.86700066487;26952.595711063957;27005.45989080168;27043.053493127645;44707.32939005853;44834.77582612066;45560.31659525176;45714.31428528508;46263;32955.83522082374;33530.32939341248;34416.483752743225;37212.44181337336;37973.620263797005;36503.817480912425;36705;36936.26127477489;37726.43410348902;38008.04979875525;27722;30566.694333056384;35631.28737425289;35700;36620.63379366172;31957.20106997344;32074.83962580172;32681;33343.66656333405;33396.66413343439;24474.51050979006;24660.876695616407;24859.00563977493;25134.371640709127;25168.874155629106 16:15:08 INFO - PROCESS | 1663 | |2;jquery.html;401.7268257584842;403.7698511848246;404.3247776213723;410.3864722240251;416.79160419790105;19009.334673286437;19791.703124453146;19802.306919257848;19828.702569461453;20881.164753409885;20058.699119513218;20251.594968100628;21243.893780531074;21268.57462850746;21310.14759409622;5423.29497165368;5819.981503236938;5867.647941123525;5870.618409803371;5877.970610146944;5554.944560533486;5734.053881109612;5831.7958871439505;5836.212111364954;5878.50032747217;5812;5904.261967254093;5908.261467316585;5915.290165180184;5927.792527261547;5513.3108361454615;5565.693886836222;5686.402927692595;5692.345380281238;5696.031674615326;5404.216388623628;5461.15352120422;5518;5907.793227237069;5961.076033214858;13097.279649619268;13264.933675331562;13348.33258337089;13462;13503.527376541773;1989.3932350633052;2129.5421484380777;2197.9449864065336;2285.097386532327;2301.7583153768783;9549.427034377959;9868.90131098687;9872.506374681238;9881.11070003696;10087.49562521871;1720.8709346798914;1729.0576635733555;1736.9044702541355;1778.5731424458165;1784.9196786144655;114190;115615.42192289069;117396;118737.99999999914;118813;11551.826722599168;11695.900586344625;11730.765384692259;11775.705607359712;11891.28652280866;14593.41626334956;14626.56120316371;14888.851111488746;14934;15083.4720784772;6693.364130407604;6784.864302713918;8419.242268195892;8789.077146899612;8910.821783564292;8634.740957771277;8690.478571285743;8804.251638610789;8926.152015558511;9028.503432311154;4622.237330840441;4637.003044345482;4723.6929599575915;4756.191447453872;4793.712377257376;1793.3543924187281;1945.7547169811332;2009.6483115454737;2027.9493012674802;2064.194963964055;910.6144422857323;914.9862752058724;986.9013098690074;1006.8741407324085;1033.2715435617872;18571;20027.59944801096;20040.89979550093;20243.493912652008;20574.485637858874;901.4501154295874;927.536231884058;946.9431834089977;1048.6120135549895;1066.168388656849;8892.3330750194;10770.838437423445;10827.24209305341;10928.726781830359;11025.669229923114;452847;534330;621135;643278;643789;87222.56388718143;87711.12288877029;110060.449697751;114738;121019;972.4311277902507;1008.8952596906375;1012.2256473797551;1054;1058.2010582010687;17309;18054.5486362842;18056.90971545134;18086;18093.73343865917;47681.28478072901;48381.51618483911;49766.004679906924;50164.749176253885;50243;68375;68384;68517;68579.65710171417;71617.64191179011;7701.845963080819;7765.844683106419;8029.156938521372;8137.308328792119;8462.83074338522;10886.61896833607;12395.504179832706;12510.87489125097;12761.234325940473;12774.872251277367;5401.270828438111;6818.693158807965;9710.834699836065;10874.836877446687;11066.557337706723;10800.297980631234;10882.29265097766;10929.945350273198;11251.212415130862;11293.983541481306;11046.668599942015;11270.718232044264;11616.361100139573;11652.41737913084;11653.88346116528;8134.552599606842;8225.71210007647;8382.077971423018;8402.41183117176;8403.663853445794;10452.634157804441;11100.333979961228;11149.554017839195;11416.657500275005;11499.655010349703 16:15:08 INFO - PROCESS | 1663 | |3;mootools.html;1577.574055005149;1610.3317123393792;1620.4085508789292;1936.7094935759635;1958.4222654316975;8145.266925976661;8689.52207628581;8749.168828961254;9044.90955090449;9070.501122438263;7279.381252593523;8806.471611703286;8827.161419665137;8932.776680582989;8949.731508054752;2465.420626152857;2506.6240063990367;2508.8118391120647;2511.0458025950206;2515.7861581765574;2442.926712198637;2456.6315052742143;2461.59383701689;2479.2066538707622;2502.8248022638422;2472.431340791619;2475.1337032038823;2484.714257860342;2503.924882253526;2510.435152090783;2468.1731619907355;2477.318737347226;2491.1032028469735;2499.700035995674;2500.6374075758913;1832.9368965999688;2222.14447437736;2430.453148041694;2479.00839664134;2487.8009759219217;8805.647774089093;8842.867356989651;8891.155340242667;8989.05614910438;8994.730158095268;5280.260763493114;5500.477454641803;5541.168824676291;5554.583406244547;5568.721563921828;3308.354870800195;3607.152319204985;3634.018814919983;3669.1560940983454;3687.0597997510463;1031.943243121628;1066.6906597086836;1072.8015317166348;1074.736689511067;1120.3334016260312;11677.70805729855;11827.34949577773;11840.87511686397;11850.11124165691;11859.52561897523;4810.278458231223;4818.927716084261;4954;4992;5010.724410157476;10047.949760251153;10084.344517606332;10117.44354060519;10153.984601539934;10176.440295783803;5383.380911195184;5412.215228791803;5440.156775699773;5445.782168713207;5483.341998960151;4480.126375356775;4823.807047718052;4928.383952005999;5007.349044624249;5037.19404895215;3416.009357286409;4006.6794656427414;4046.0896298333228;4124.484439445069;4159.10579225468;1140.6349968010322;1364.9285311030794;1375.0924389902616;1380.9102408343426;1382.4539306973688;814.3810703865105;822.8116050305068;837.8491871463195;842.439777547936;965.560669895196;5796.217510636095;5842.503387212049;6108.694565271719;6146.416090471398;6168.136460895478;978.6525783346951;988.9159421449114;992.6228033347281;994.4536246137326;1010.2675560218782;3478.704310133667;4013.979930100389;4020.3567429211184;4060.898477538085;4115.97942010288;10718.35689858611;11010.119190464744;11066.557337706401;11103;11120.38837863909;10784.299020563638;10915.56337746497;10925.399103049249;10939.23425360233;11104.222704410775;8269.751907442786;8325.209105135002;8443.36674749384;8490.15098490146;8494.617742201615;5408.37803652585;5843.328017278068;5944.494717949023;5971.223740913653;6102.938970610237;9816.067473589997;10023.298369114093;10185.134263587677;10189.898101018895;10211.387316760722;7987;8136.349092072502;9599.616015359587;9691.224702023963;10495.947520262349;6591.406773390418;6915.446764258948;7154.6064966425265;7206.099237595301;7299.671514781741;8332.125126861592;8398.790030249049;8430.536320502431;8459.619317130868;8464.830703385775;7339.926600733925;7367.410607151308;7466;7605.543667379754;7612.200718924433;6492.831290367779;7384.446166537638;7425.368843648351;7485.88771168422;7512.474126811071;6977.581345119309;6987.720491180499;6998.790036298919;7058.682359293947;7089.964550177217;4861.052094841472;4932.334134891744;5054.494550545063;5055.418626857811;5233.607479439133;4969.503049695001;5032.270320803536;5085;5127.333446652061;5191.558717509054 16:15:08 INFO - PROCESS | 1663 | |4;prototype.html;319.39793489272716;328.06501470808195;332.36020660229053;335.2038907594463;335.5084800766876;5425.186222066692;5485.985092757837;5553.361363443205;5623;5694.345150307716;4483.49802816057;5491.736900512885;5629.408912064236;5666.178404131409;5675.404082571333;3955.2287303975663;4273.636740877029;4293.29160688486;4308.67684923632;4332.415123958257;4143.7720925349095;4227.619514243717;4279.422277992478;4288.7212331198525;4314.590113939171;4149.419081328617;4157.605027522381;4214.199302132601;4227.408162857202;4234.5553716859595;3718.4608231806506;3760.905977350561;4067.8983025424454;4240.957590424087;4268.231718290706;3346.531485592019;3494.6854783069393;3702.8889133326043;3703.962960370389;3714.4799728038097;4200.957990420118;4965.75856035991;5187.533122019036;5341.4925582069645;5444.727763611803;4953.975230123862;4976.576990955737;4979.228219625964;4980.551750342486;4984.2025275955675;5445.618806683534;5571.687749583918;5651.174412793604;6002.759889604411;6034.155218269446;4123.60825721556;4130.339145736668;4130.793460326971;4146.129312844307;4181;4784;5161.7161056141895;6182.69086545671;6329.113924050636;6354.714037868261;3935.7835319057153;4183.707140500136;4210.6735678814;4212.789360531961;4227.830886764556;3678.429843374281;3843.61563843619;4118.9588104118575;4146.730462519927;4162.063535704503;4817.710937343771;4819.469858315582;4825.420949486084;4830.275458681155;4847.612191024709;5791.536677065909;5972.193753843176;5996.310424301174;6024.1566180734735;6058.636481811105;1467.9633009174643;1508.1478964385087;1517.521980576115;1523.588631069605;1524.3597688970658;973.2262851033446;973.481369064262;998.4658207858761;1002.0981116994762;1005.0652892809757;5999.460048595647;6000.249968753906;6014.1580178775;6038.3998240465435;6074.088886666947;6586.440152586988;6587.80236592903;6610.834729131714;6613.768518101843;6701.798946031627;5569.805056822992;5969.611975221596;6011.355003798315;6031.8793624127275;6043.2748070231855;2976.345204055104;3225.5000474926424;3402.166469215058;3444.9827750861086;3480.7295337202245;6448.387403196689;6637.933620663732;6851;6857.040014397889;6869.347411995853;6712.53012289135;6781.898271525931;6791.3548212919695;6795.728170873209;6815.318468153145;5607.579431542569;6560.901586476207;6864.279250678607;6885.931140688629;6905.309469053054;6548.116004339353;6570.5729127606555;6572.244191917991;6592.70332835014;6601.3728695773825;6299.622022678654;6328.272248691275;6486.351364863476;6489.286178520453;6496.545241833026;6795.45636349081;6821.761238356832;6829.224401655506;6859.862802743817;6892.414144797748;3919.1573811630637;4086.8761090700295;4307.956920430881;4316.748143038483;4317.352397140454;4482.99132695141;4773.856784296477;6286.616944272253;6502.772402965874;6603.405693487609;5998.820035398945;6046.2139921809885;6067.423594758491;6080.6351618901235;6182.381761823962;4587.38070360497;4878.609711223165;5330.546903513245;5696.629719068247;6036.939630603813;4710.905781884411;5534.944650553443;5571.749271282721;5883;5919.556033297606;5785.074388097884;5979.820605381846;6016.518678505797;6051.697415129314;6057.454829065406;5296.390915044819;5406.83779486616;5530.391656917816;5547.251121098761;5865 16:15:08 INFO - PROCESS | 1663 | |5;yui.html;637.9489640828734;665.936736010079;713.5041146403246;724.0298000679089;772.2779201446648;14775.704485910275;14845.628859278524;15057.021293615908;15073.849261507381;16084.276207570658;15426.691466170698;15761.527154185364;15785.368585256605;15867.127307998055;15917.52247432576;737.1522748838852;925.5002298758662;942.519315149272;943.5376665433956;944.3908678902104;888.8355654203993;890.688259109313;898.4294972692322;937.9296552758536;939.6523286384047;937.6155776131787;985.7092157813427;986.5412583148834;997.997013001932;998.3909815012872;931.3573634192386;932.1331162019319;938.8122375524854;953.1183655118987;989.9109080182782;691.1498856406598;704.4786857725297;709.226942632533;738.918718940916;740.9555426674417;13822.585322440344;14183.716325673531;15093.39626414942;15200.847991520164;15299.464518741903;12152;12355.196912200678;12358.567450139291;12382.504699811996;12532.937335313265;8413.705520306821;9883.604655813759;9892.428177647787;9996.450195239258;10200.285979981405;3481.147118955872;3482.8258587070545;3485.1112966193714;3501.0547152268746;3611.133328001261;57599.424005760244;75660.62169689171;77465;77949.61025194895;79052.60473697595;9183.448993060305;9275.350725449154;9370.437773733462;9582.520873956275;9644.710658680251;21051.263205787724;21243.575128497654;21271;21321.147154113973;21489.67765483519;7208.747693830691;7212.3869471094495;7228.31331023552;7405.370543503755;7500.287472690085;3983.322835118037;4038.8788336349958;4063.2889244382704;4081.10215752534;4081.3469844824685;3475.6871881530783;3559.3771090059136;3559.94660080099;3568.5717713873983;3576.034470692898;617.9104029915637;621.4779585148497;644.3170239546096;644.9290578036412;653.9967300163469;527.6702061211743;592.1887014789766;610.6549799363346;622.1725105609529;628.2837565175703;7955.0851652060755;8072;8235.217654322949;8429.030661473886;8443.95778021106;491.660754079691;607.6445279511536;613.2150846915955;614.3242433323397;618.4155972605844;3772.8490860365278;3895.9610403896163;3931.744436611611;3938.724289299779;3977.622125898093;67906.32093679099;86393.56803216069;94018.52990735002;94087;94980;53410;72276.277237228;74085.62957185287;74393;75354.6232268846;67270.3272967264;68345.31654683489;68418.65790671115;68610.65694671495;68961;7787.649555769891;8383.203595658402;8474.152584741476;8487.321014318963;8544.273736732199;37900;42883.356749648156;44827.327590086825;45354.54645453503;46485;61599.692001539705;63620.363796363294;64022.39944001437;64168;65865;10701.304415212986;10959.671209863716;11061.281016733887;11271.661850144508;11345.262557933707;11779.293242405483;11798.823017654571;11854.94072529632;11874.228175168586;11961.521539138337;11360.772784544097;11558.42207889619;11563.479643415898;11679.240849344766;11789.882101178879;11046.005859472685;11069.723256918642;11184.273022253528;11204.383758893338;11214.66356009321;11204.159688023268;11236.94381528087;11238.55045798159;11274.436278185894;11277.887221128012;9532.52337383142;9687.66093186735;9876.308658393844;9955.352902061342;10046.799064018825;9322.347435679438;9636.180924621485;9642.662506812228;9707.271954603291;9727.513624318897 16:15:08 INFO - PROCESS | 1663 | __end_tp_report 16:15:08 INFO - PROCESS | 1663 | __start_cc_report 16:15:08 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,415 16:15:08 INFO - PROCESS | 1663 | __end_cc_report 16:15:08 INFO - PROCESS | 1663 | __startTimestamp1461712508070__endTimestamp 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:15:08 INFO - PROCESS | 1663 | Number of tests: 6 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5780.33 Median:6094.33 stddev:762.35 (12.5%) stddev-sans-first:743.06 16:15:08 INFO - PROCESS | 1663 | Values: 3481.9 3483.3 3483.7 3502.7 3548.9 5851.6 5894.1 5896.7 5910.3 5923.3 5063.1 5172.7 5810.8 5954.9 6070.6 5239.7 5273.1 5298.4 5363.8 5386.5 625.7 4414.7 5297.4 5320.6 5338.6 5223.3 5241.1 5246.4 5253.0 5286.3 5216.8 5302.7 5325.5 5331.1 5355.3 5206.5 5213.7 5243.5 5261.0 5334.0 5633.0 5767.9 5801.4 5808.0 5855.3 5585.1 6079.4 6165.3 6240.8 6273.6 6271.4 6319.5 6321.2 6323.0 6342.6 6080.5 6094.3 6095.4 6106.5 6118.3 5370.8 6256.6 6289.6 6445.6 6462.4 6159.7 6185.5 6197.3 6203.7 6240.3 6231.3 6285.8 6287.3 6299.3 6315.4 5756.5 6140.5 6187.3 6255.5 6259.1 6157.8 6201.7 6237.4 6267.1 6273.4 5005.1 5053.8 5084.0 5084.0 5096.8 4369.7 4492.3 4556.0 4561.7 4588.2 5043.5 6017.4 6025.6 6027.1 6043.6 6285.9 6290.8 6308.3 6316.8 6327.1 5912.2 6003.1 6030.4 6040.0 6099.2 5544.1 5546.9 5554.2 5557.1 5561.3 6389.0 6519.1 6559.2 6560.2 6583.5 5278.0 5366.3 5408.4 6246.8 6460.9 5776.9 6521.3 6536.8 6558.5 6560.6 6104.3 6171.6 6252.2 6278.4 6301.1 6250.2 6308.1 6322.5 6328.7 6337.2 6163.4 6169.7 6177.5 6182.6 6195.8 5456.8 6077.4 6081.6 6108.4 6177.2 6005.8 6115.5 6129.1 6141.7 6204.7 6156.9 6243.1 6263.9 6271.6 6284.3 5958.6 6211.1 6213.5 6229.5 6232.7 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:53252.24 Median:35251.88 stddev:107666.78 (305.4%) stddev-sans-first:107896.00 16:15:08 INFO - PROCESS | 1663 | Values: 510.9 511.4 552.4 601.9 601.9 30431.0 37606.8 38566.4 38569.2 38877.4 41724.7 42046.6 42464.2 42599.8 42679.4 9352.8 9612.9 9614.5 9617.9 9623.5 7704.8 9203.2 9490.9 9605.5 9677.8 9402.4 9544.4 9579.2 9586.1 9618.9 9539.6 9622.9 9626.4 9649.2 9689.0 9442.1 9553.6 9626.3 9653.6 9679.0 38127.8 38586.2 38681.0 38692.0 38701.6 2859.2 3060.9 3122.5 3388.3 3420.5 25773.9 26019.9 26624.5 26692.0 27457.3 2640.4 2648.0 2682.2 2749.8 2758.4 271704.0 274734.0 274855.0 275951.6 276617.0 32842.0 33642.5 34471.8 34930.0 35005.3 34951.0 35055.8 35213.6 35290.1 35406.3 15328.3 15404.8 15531.4 15533.8 15575.6 13034.1 13113.8 13120.2 13154.5 13160.9 6882.9 7259.4 8053.3 8100.3 8188.7 2665.7 2757.9 3426.9 3439.6 3447.9 826.8 962.9 999.2 1016.0 1083.4 23934.9 28911.7 29243.0 29548.4 29910.7 1014.6 1075.6 1092.5 1122.8 1142.7 13669.4 15189.0 15508.1 15620.0 15656.5 461232.0 465493.0 466967.0 475343.0 475984.0 58540.7 59412.4 59457.7 59666.0 59682.1 1442.4 1452.6 1467.1 1473.9 1494.4 29029.6 29092.0 29253.1 29455.6 29760.6 51843.7 52046.7 52268.2 52302.5 52552.5 432316.0 432970.0 448985.0 449825.0 452045.0 26183.1 26599.9 26952.6 27005.5 27043.1 44707.3 44834.8 45560.3 45714.3 46263.0 32955.8 33530.3 34416.5 37212.4 37973.6 36503.8 36705.0 36936.3 37726.4 38008.0 27722.0 30566.7 35631.3 35700.0 36620.6 31957.2 32074.8 32681.0 33343.7 33396.7 24474.5 24660.9 24859.0 25134.4 25168.9 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:32990.42 Median:2241.52 stddev:97030.51 (4328.8%) stddev-sans-first:97271.85 16:15:08 INFO - PROCESS | 1663 | Values: 401.7 403.8 404.3 410.4 416.8 19009.3 19791.7 19802.3 19828.7 20881.2 20058.7 20251.6 21243.9 21268.6 21310.1 5423.3 5820.0 5867.6 5870.6 5878.0 5554.9 5734.1 5831.8 5836.2 5878.5 5812.0 5904.3 5908.3 5915.3 5927.8 5513.3 5565.7 5686.4 5692.3 5696.0 5404.2 5461.2 5518.0 5907.8 5961.1 13097.3 13264.9 13348.3 13462.0 13503.5 1989.4 2129.5 2197.9 2285.1 2301.8 9549.4 9868.9 9872.5 9881.1 10087.5 1720.9 1729.1 1736.9 1778.6 1784.9 114190.0 115615.4 117396.0 118738.0 118813.0 11551.8 11695.9 11730.8 11775.7 11891.3 14593.4 14626.6 14888.9 14934.0 15083.5 6693.4 6784.9 8419.2 8789.1 8910.8 8634.7 8690.5 8804.3 8926.2 9028.5 4622.2 4637.0 4723.7 4756.2 4793.7 1793.4 1945.8 2009.6 2027.9 2064.2 910.6 915.0 986.9 1006.9 1033.3 18571.0 20027.6 20040.9 20243.5 20574.5 901.5 927.5 946.9 1048.6 1066.2 8892.3 10770.8 10827.2 10928.7 11025.7 452847.0 534330.0 621135.0 643278.0 643789.0 87222.6 87711.1 110060.4 114738.0 121019.0 972.4 1008.9 1012.2 1054.0 1058.2 17309.0 18054.5 18056.9 18086.0 18093.7 47681.3 48381.5 49766.0 50164.7 50243.0 68375.0 68384.0 68517.0 68579.7 71617.6 7701.8 7765.8 8029.2 8137.3 8462.8 10886.6 12395.5 12510.9 12761.2 12774.9 5401.3 6818.7 9710.8 10874.8 11066.6 10800.3 10882.3 10929.9 11251.2 11294.0 11046.7 11270.7 11616.4 11652.4 11653.9 8134.6 8225.7 8382.1 8402.4 8403.7 10452.6 11100.3 11149.6 11416.7 11499.7 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5758.90 Median:4999.67 stddev:3193.36 (63.9%) stddev-sans-first:3186.86 16:15:08 INFO - PROCESS | 1663 | Values: 1577.6 1610.3 1620.4 1936.7 1958.4 8145.3 8689.5 8749.2 9044.9 9070.5 7279.4 8806.5 8827.2 8932.8 8949.7 2465.4 2506.6 2508.8 2511.0 2515.8 2442.9 2456.6 2461.6 2479.2 2502.8 2472.4 2475.1 2484.7 2503.9 2510.4 2468.2 2477.3 2491.1 2499.7 2500.6 1832.9 2222.1 2430.5 2479.0 2487.8 8805.6 8842.9 8891.2 8989.1 8994.7 5280.3 5500.5 5541.2 5554.6 5568.7 3308.4 3607.2 3634.0 3669.2 3687.1 1031.9 1066.7 1072.8 1074.7 1120.3 11677.7 11827.3 11840.9 11850.1 11859.5 4810.3 4818.9 4954.0 4992.0 5010.7 10047.9 10084.3 10117.4 10154.0 10176.4 5383.4 5412.2 5440.2 5445.8 5483.3 4480.1 4823.8 4928.4 5007.3 5037.2 3416.0 4006.7 4046.1 4124.5 4159.1 1140.6 1364.9 1375.1 1380.9 1382.5 814.4 822.8 837.8 842.4 965.6 5796.2 5842.5 6108.7 6146.4 6168.1 978.7 988.9 992.6 994.5 1010.3 3478.7 4014.0 4020.4 4060.9 4116.0 10718.4 11010.1 11066.6 11103.0 11120.4 10784.3 10915.6 10925.4 10939.2 11104.2 8269.8 8325.2 8443.4 8490.2 8494.6 5408.4 5843.3 5944.5 5971.2 6102.9 9816.1 10023.3 10185.1 10189.9 10211.4 7987.0 8136.3 9599.6 9691.2 10495.9 6591.4 6915.4 7154.6 7206.1 7299.7 8332.1 8398.8 8430.5 8459.6 8464.8 7339.9 7367.4 7466.0 7605.5 7612.2 6492.8 7384.4 7425.4 7485.9 7512.5 6977.6 6987.7 6998.8 7058.7 7090.0 4861.1 4932.3 5054.5 5055.4 5233.6 4969.5 5032.3 5085.0 5127.3 5191.6 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4965.84 Median:5488.86 stddev:1589.65 (29.0%) stddev-sans-first:1555.38 16:15:08 INFO - PROCESS | 1663 | Values: 319.4 328.1 332.4 335.2 335.5 5425.2 5486.0 5553.4 5623.0 5694.3 4483.5 5491.7 5629.4 5666.2 5675.4 3955.2 4273.6 4293.3 4308.7 4332.4 4143.8 4227.6 4279.4 4288.7 4314.6 4149.4 4157.6 4214.2 4227.4 4234.6 3718.5 3760.9 4067.9 4241.0 4268.2 3346.5 3494.7 3702.9 3704.0 3714.5 4201.0 4965.8 5187.5 5341.5 5444.7 4954.0 4976.6 4979.2 4980.6 4984.2 5445.6 5571.7 5651.2 6002.8 6034.2 4123.6 4130.3 4130.8 4146.1 4181.0 4784.0 5161.7 6182.7 6329.1 6354.7 3935.8 4183.7 4210.7 4212.8 4227.8 3678.4 3843.6 4119.0 4146.7 4162.1 4817.7 4819.5 4825.4 4830.3 4847.6 5791.5 5972.2 5996.3 6024.2 6058.6 1468.0 1508.1 1517.5 1523.6 1524.4 973.2 973.5 998.5 1002.1 1005.1 5999.5 6000.2 6014.2 6038.4 6074.1 6586.4 6587.8 6610.8 6613.8 6701.8 5569.8 5969.6 6011.4 6031.9 6043.3 2976.3 3225.5 3402.2 3445.0 3480.7 6448.4 6637.9 6851.0 6857.0 6869.3 6712.5 6781.9 6791.4 6795.7 6815.3 5607.6 6560.9 6864.3 6885.9 6905.3 6548.1 6570.6 6572.2 6592.7 6601.4 6299.6 6328.3 6486.4 6489.3 6496.5 6795.5 6821.8 6829.2 6859.9 6892.4 3919.2 4086.9 4308.0 4316.7 4317.4 4483.0 4773.9 6286.6 6502.8 6603.4 5998.8 6046.2 6067.4 6080.6 6182.4 4587.4 4878.6 5330.5 5696.6 6036.9 4710.9 5534.9 5571.7 5883.0 5919.6 5785.1 5979.8 6016.5 6051.7 6057.5 5296.4 5406.8 5530.4 5547.3 5865.0 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17420.81 Median:625.23 stddev:23919.52 (3825.7%) stddev-sans-first:23953.43 16:15:08 INFO - PROCESS | 1663 | Values: 637.9 665.9 713.5 724.0 772.3 14775.7 14845.6 15057.0 15073.8 16084.3 15426.7 15761.5 15785.4 15867.1 15917.5 737.2 925.5 942.5 943.5 944.4 888.8 890.7 898.4 937.9 939.7 937.6 985.7 986.5 998.0 998.4 931.4 932.1 938.8 953.1 989.9 691.1 704.5 709.2 738.9 741.0 13822.6 14183.7 15093.4 15200.8 15299.5 12152.0 12355.2 12358.6 12382.5 12532.9 8413.7 9883.6 9892.4 9996.5 10200.3 3481.1 3482.8 3485.1 3501.1 3611.1 57599.4 75660.6 77465.0 77949.6 79052.6 9183.4 9275.4 9370.4 9582.5 9644.7 21051.3 21243.6 21271.0 21321.1 21489.7 7208.7 7212.4 7228.3 7405.4 7500.3 3983.3 4038.9 4063.3 4081.1 4081.3 3475.7 3559.4 3559.9 3568.6 3576.0 617.9 621.5 644.3 644.9 654.0 527.7 592.2 610.7 622.2 628.3 7955.1 8072.0 8235.2 8429.0 8444.0 491.7 607.6 613.2 614.3 618.4 3772.8 3896.0 3931.7 3938.7 3977.6 67906.3 86393.6 94018.5 94087.0 94980.0 53410.0 72276.3 74085.6 74393.0 75354.6 67270.3 68345.3 68418.7 68610.7 68961.0 7787.6 8383.2 8474.2 8487.3 8544.3 37900.0 42883.4 44827.3 45354.5 46485.0 61599.7 63620.4 64022.4 64168.0 65865.0 10701.3 10959.7 11061.3 11271.7 11345.3 11779.3 11798.8 11854.9 11874.2 11961.5 11360.8 11558.4 11563.5 11679.2 11789.9 11046.0 11069.7 11184.3 11204.4 11214.7 11204.2 11236.9 11238.6 11274.4 11277.9 9532.5 9687.7 9876.3 9955.4 10046.8 9322.3 9636.2 9642.7 9707.3 9727.5 16:15:08 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:15:08 INFO - PROCESS | 1663 | 16:15:08 INFO - TEST-INFO | 1663: exit 0 16:15:08 INFO - TEST-OK | dromaeo_css | took 1111353ms 16:15:08 INFO - TEST-START | kraken 16:15:08 INFO - operating with platform_type : mac_ 16:15:08 INFO - Initialising browser for kraken test... 16:15:08 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpGY1JM7/profile http://localhost:49274/getInfo.html) 16:15:11 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 16:15:11 INFO - PROCESS | 1672 | colorDepth:24 16:15:11 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 16:15:11 INFO - PROCESS | 1672 | __metrics 16:15:11 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:15:11 INFO - TEST-INFO | 1672: exit 0 16:15:11 INFO - Browser initialized. 16:15:11 INFO - Running cycle 1/1 for kraken test... 16:15:11 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpGY1JM7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:23 INFO - PROCESS | 1675 | RSS: Main: 249528320 16:15:23 INFO - PROCESS | 1675 | 16:15:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:27 INFO - PROCESS | 1675 | RSS: Main: 261447680 16:15:27 INFO - PROCESS | 1675 | 16:15:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 16:15:30 INFO - PROCESS | 1675 | RSS: Main: 270376960 16:15:30 INFO - PROCESS | 1675 | 16:15:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 16:15:34 INFO - PROCESS | 1675 | RSS: Main: 273141760 16:15:34 INFO - PROCESS | 1675 | 16:15:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 16:15:37 INFO - PROCESS | 1675 | RSS: Main: 274681856 16:15:37 INFO - PROCESS | 1675 | 16:15:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:15:40 INFO - PROCESS | 1675 | RSS: Main: 275181568 16:15:40 INFO - PROCESS | 1675 | 16:15:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 16:15:43 INFO - PROCESS | 1675 | RSS: Main: 276291584 16:15:43 INFO - PROCESS | 1675 | 16:15:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 16:15:47 INFO - PROCESS | 1675 | RSS: Main: 276262912 16:15:47 INFO - PROCESS | 1675 | 16:15:50 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 16:15:50 INFO - PROCESS | 1675 | RSS: Main: 276455424 16:15:50 INFO - PROCESS | 1675 | 16:15:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:15:52 INFO - PROCESS | 1675 | RSS: Main: 276013056 16:15:52 INFO - PROCESS | 1675 | 16:15:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:15:55 INFO - PROCESS | 1675 | RSS: Main: 276180992 16:15:55 INFO - PROCESS | 1675 | 16:15:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:15:58 INFO - PROCESS | 1675 | RSS: Main: 276443136 16:15:58 INFO - PROCESS | 1675 | 16:16:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:01 INFO - PROCESS | 1675 | RSS: Main: 276504576 16:16:01 INFO - PROCESS | 1675 | 16:16:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:16:06 INFO - PROCESS | 1675 | RSS: Main: 274882560 16:16:06 INFO - PROCESS | 1675 | 16:16:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 16:16:08 INFO - PROCESS | 1675 | RSS: Main: 277135360 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | __start_tp_report 16:16:08 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 16:16:08 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 16:16:08 INFO - PROCESS | 1675 | |i|pagename|runs| 16:16:08 INFO - PROCESS | 1675 | |0;ai-astar;114;105;117;115;116;128;114;115;117;114 16:16:08 INFO - PROCESS | 1675 | |1;audio-beat-detection;156;123;145;167;120;138;138;119;167;121 16:16:08 INFO - PROCESS | 1675 | |2;audio-dft;193;193;165;225;205;210;175;255;210;251 16:16:08 INFO - PROCESS | 1675 | |3;audio-fft;67;76;71;110;67;80;82;70;128;84 16:16:08 INFO - PROCESS | 1675 | |4;audio-oscillator;80;82;121;76;92;78;101;116;124;157 16:16:08 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;86;90;86;83;129;135;85;87;86 16:16:08 INFO - PROCESS | 1675 | |6;imaging-darkroom;109;150;95;94;95;95;112;151;97;95 16:16:08 INFO - PROCESS | 1675 | |7;imaging-desaturate;90;93;105;142;92;128;91;92;91;90 16:16:08 INFO - PROCESS | 1675 | |8;json-parse-financial;56;61;60;59;60;63;60;76;60;55 16:16:08 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;61;65;64;69;67;78;70;67;69;69 16:16:08 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;96;106;109;81;83;82;85;80;84;82 16:16:08 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;159;164;165;153;164;165;170;140;176;141 16:16:08 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;273;274;234;275;281;194;209;211;230;202 16:16:08 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;70;71;71;77;74;67;67;61;87;103 16:16:08 INFO - PROCESS | 1675 | __end_tp_report 16:16:08 INFO - PROCESS | 1675 | __start_cc_report 16:16:08 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1093 16:16:08 INFO - PROCESS | 1675 | __end_cc_report 16:16:08 INFO - PROCESS | 1675 | __startTimestamp1461712568220__endTimestamp 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | ------- Summary: start ------- 16:16:08 INFO - PROCESS | 1675 | Number of tests: 14 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:5.56 (4.8%) stddev-sans-first:5.87 16:16:08 INFO - PROCESS | 1675 | Values: 114.0 105.0 117.0 115.0 116.0 128.0 114.0 115.0 117.0 114.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:141.50 stddev:18.96 (13.4%) stddev-sans-first:19.13 16:16:08 INFO - PROCESS | 1675 | Values: 156.0 123.0 145.0 167.0 120.0 138.0 138.0 119.0 167.0 121.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:208.20 Median:210.00 stddev:29.35 (14.0%) stddev-sans-first:30.61 16:16:08 INFO - PROCESS | 1675 | Values: 193.0 193.0 165.0 225.0 205.0 210.0 175.0 255.0 210.0 251.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:83.50 Median:73.50 stddev:20.10 (27.3%) stddev-sans-first:20.41 16:16:08 INFO - PROCESS | 1675 | Values: 67.0 76.0 71.0 110.0 67.0 80.0 82.0 70.0 128.0 84.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:77.00 stddev:26.45 (34.4%) stddev-sans-first:26.75 16:16:08 INFO - PROCESS | 1675 | Values: 80.0 82.0 121.0 76.0 92.0 78.0 101.0 116.0 124.0 157.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:86.00 stddev:19.33 (22.5%) stddev-sans-first:20.36 16:16:08 INFO - PROCESS | 1675 | Values: 89.0 86.0 90.0 86.0 83.0 129.0 135.0 85.0 87.0 86.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:109.30 Median:95.00 stddev:22.62 (23.8%) stddev-sans-first:23.99 16:16:08 INFO - PROCESS | 1675 | Values: 109.0 150.0 95.0 94.0 95.0 95.0 112.0 151.0 97.0 95.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:101.40 Median:91.00 stddev:18.54 (20.4%) stddev-sans-first:19.20 16:16:08 INFO - PROCESS | 1675 | Values: 90.0 93.0 105.0 142.0 92.0 128.0 91.0 92.0 91.0 90.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:60.00 stddev:5.75 (9.6%) stddev-sans-first:5.81 16:16:08 INFO - PROCESS | 1675 | Values: 56.0 61.0 60.0 59.0 60.0 63.0 60.0 76.0 60.0 55.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:69.00 stddev:4.51 (6.5%) stddev-sans-first:4.03 16:16:08 INFO - PROCESS | 1675 | Values: 61.0 65.0 64.0 69.0 67.0 78.0 70.0 67.0 69.0 69.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:82.50 stddev:10.84 (13.1%) stddev-sans-first:11.18 16:16:08 INFO - PROCESS | 1675 | Values: 96.0 106.0 109.0 81.0 83.0 82.0 85.0 80.0 84.0 82.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:164.50 stddev:11.78 (7.2%) stddev-sans-first:12.49 16:16:08 INFO - PROCESS | 1675 | Values: 159.0 164.0 165.0 153.0 164.0 165.0 170.0 140.0 176.0 141.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:238.30 Median:253.50 stddev:34.35 (13.6%) stddev-sans-first:34.06 16:16:08 INFO - PROCESS | 1675 | Values: 273.0 274.0 234.0 275.0 281.0 194.0 209.0 211.0 230.0 202.0 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:71.00 stddev:12.08 (17.0%) stddev-sans-first:12.69 16:16:08 INFO - PROCESS | 1675 | Values: 70.0 71.0 71.0 77.0 74.0 67.0 67.0 61.0 87.0 103.0 16:16:08 INFO - PROCESS | 1675 | -------- Summary: end -------- 16:16:08 INFO - PROCESS | 1675 | 16:16:08 INFO - TEST-INFO | 1675: exit 0 16:16:08 INFO - TEST-OK | kraken | took 60387ms 16:16:08 INFO - SUITE-END | took 1171s 16:16:09 INFO - Completed test suite (00:19:32) 16:16:09 INFO - javascript benchmark 16:16:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.860725570977, 3483.3381657485074, 3483.73871959603, 3502.6672466115724, 3548.858045678173, 5851.590388672795, 5894.145348924403, 5896.705164741757, 5910.349861515235, 5923.348431672518, 5063.063333283345, 5172.732680493275, 5810.796622118227, 5954.940450595493, 6070.635761854292, 5239.73801309934, 5273.129933560957, 5298.4436634153435, 5363.839084827461, 5386.515213630772, 625.6830571557364, 4414.690971631987, 5297.364316282052, 5320.6275560710765, 5338.572914166857, 5223.347081614779, 5241.056609810233, 5246.422893481714, 5252.973735131319, 5286.259923610698, 5216.817411390621, 5302.70835104073, 5325.467453254682, 5331.093714068579, 5355.277037599952, 5206.453322401169, 5213.687178769248, 5243.475652434764, 5260.9736951315, 5333.973330133324, 5633.0, 5767.884642307173, 5801.390853960358, 5808.0, 5855.268091488564, 5585.134304182858, 6079.39206079393, 6165.290991535986, 6240.781572644935, 6273.62358258506, 6271.3728627136925, 6319.526035547352, 6321.209848768904, 6323.019931910561, 6342.587731797418, 6080.452759251644, 6094.329623741385, 6095.359987201325, 6106.542009349317, 6118.265808103056, 5370.838874833761, 6256.562040657111, 6289.591176573508, 6445.581037232565, 6462.386073323027, 6159.722812473449, 6185.536084793658, 6197.349278325801, 6203.658798766111, 6240.251169859555, 6231.2522497300615, 6285.779997700059, 6287.276963149205, 6299.307076221612, 6315.368463153648, 5756.481916627524, 6140.534923917717, 6187.319394866561, 6255.46828519581, 6259.061140828912, 6157.753689852356, 6201.720922558496, 6237.407446292686, 6267.122602835607, 6273.404026617464, 5005.074061298671, 5053.84838454847, 5083.974580127076, 5083.974580127076, 5096.796128154906, 4369.737815731066, 4492.326151077365, 4555.954440455619, 4561.68068235227, 4588.242939914943, 5043.52086551777, 6017.398260174035, 6025.6083354581815, 6027.065804800263, 6043.576949613573, 6285.874282514415, 6290.811275661737, 6308.3060863305, 6316.778912738032, 6327.145835312266, 5912.201852749824, 6003.129546215774, 6030.427109424598, 6040.0, 6099.237595300588, 5544.0575102232715, 5546.944530554723, 5554.1946417769195, 5557.138643510262, 5561.332640083135, 6389.041643753474, 6519.054737063099, 6559.180102487189, 6560.212774466999, 6583.506237032242, 5278.0, 5366.329208848894, 5408.405075441777, 6246.750129994749, 6460.935390646034, 5776.855578610568, 6521.282658907421, 6536.8365790855605, 6558.475321974135, 6560.606363618198, 6104.3075792339105, 6171.56799024064, 6252.218472690914, 6278.434940855345, 6301.149344838388, 6250.249970003629, 6308.0853276273765, 6322.46259067966, 6328.6519241442165, 6337.2395312562785, 6163.3528479509005, 6169.722362493789, 6177.536684748752, 6182.567220294716, 6195.845103872439, 5456.754446050017, 6077.361877002851, 6081.604695694766, 6108.35862234459, 6177.1969643945995, 6005.849853753691, 6115.541334399849, 6129.08063790435, 6141.731496609813, 6204.72078756448, 6156.854138818557, 6243.094751261133, 6263.874722505616, 6271.62370257786, 6284.277308109626, 5958.612690175125, 6211.099390588249, 6213.502919766498, 6229.470495007794, 6232.688365581612], "value": 5734.878294299733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.93868735751715, 511.4297558222581, 552.353746117043, 601.9345758008322, 601.9465934614425, 30431.0, 37606.811965940164, 38566.4215036774, 38569.22861542771, 38877.41683874737, 41724.748257552325, 42046.57953420465, 42464.15071698564, 42599.78700106495, 42679.35980960288, 9352.766180845465, 9612.855807162898, 9614.471204083773, 9617.942026377093, 9623.470709110996, 7704.845903081935, 9203.17171454569, 9490.905090949105, 9605.471699056548, 9677.806443871119, 9402.38884472507, 9544.427334359925, 9579.233661307113, 9586.089321514444, 9618.903810961905, 9539.618415263416, 9622.903770962306, 9626.422414655142, 9649.179819715333, 9689.0, 9442.10300021497, 9553.61785528578, 9626.278029147772, 9653.613855445774, 9678.951605241999, 38127.809360953295, 38586.228275434616, 38681.0, 38692.0, 38701.61298387008, 2859.1994241612383, 3060.8775648974015, 3122.469180239365, 3388.339273841602, 3420.521127042216, 25773.871130644413, 26019.869900650567, 26624.467510649873, 26692.0, 27457.31356716078, 2640.405908670553, 2648.0, 2682.1685277563824, 2749.8075134740575, 2758.4069425073703, 271704.0, 274734.0, 274855.0, 275951.62024189753, 276617.0, 32842.01473955785, 33642.49536256958, 34471.82764086164, 34930.0, 35005.299894001975, 34951.0, 35055.82472087623, 35213.647863521546, 35290.11774705653, 35406.29187416237, 15328.310226039855, 15404.768928466083, 15531.378744850306, 15533.766993495106, 15575.610609734847, 13034.087613867128, 13113.803292950613, 13120.212787232796, 13154.473821047051, 13160.934195328962, 6882.931170688229, 7259.41924646027, 8053.31546818527, 8100.270975612223, 8188.713395031145, 2665.7067722550505, 2757.8621068946472, 3426.9485957710654, 3439.570053743282, 3447.896563103111, 826.8057006603443, 962.8542034978353, 999.1656966432964, 1015.9949200254099, 1083.3608171179042, 23934.88032559861, 28911.7108828909, 29243.0, 29548.409031819672, 29910.700892991226, 1014.6398028699853, 1075.6168612902454, 1092.530212008828, 1122.7642195139113, 1142.708609304622, 13669.38487768033, 15189.0, 15508.147051912027, 15620.0, 15656.530304090895, 461232.0, 465493.0, 466967.0, 475343.0, 475984.0, 58540.73133418013, 59412.40587594069, 59457.70271148703, 59666.0, 59682.10476842851, 1442.4205494982978, 1452.5714914100365, 1467.1069645307962, 1473.8747206487353, 1494.4470545898087, 29029.564556531248, 29092.0, 29253.122406327846, 29455.55816662709, 29760.553591696575, 51843.703907401105, 52046.73976630244, 52268.21597676114, 52302.476975231286, 52552.47447525629, 432316.0, 432970.0, 448985.0, 449825.0, 452045.0, 26183.08359207495, 26599.86700066487, 26952.595711063957, 27005.45989080168, 27043.053493127645, 44707.32939005853, 44834.77582612066, 45560.31659525176, 45714.31428528508, 46263.0, 32955.83522082374, 33530.32939341248, 34416.483752743225, 37212.44181337336, 37973.620263797005, 36503.817480912425, 36705.0, 36936.26127477489, 37726.43410348902, 38008.04979875525, 27722.0, 30566.694333056384, 35631.28737425289, 35700.0, 36620.63379366172, 31957.20106997344, 32074.83962580172, 32681.0, 33343.66656333405, 33396.66413343439, 24474.51050979006, 24660.876695616407, 24859.00563977493, 25134.371640709127, 25168.874155629106], "value": 17459.035185126042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.7268257584842, 403.7698511848246, 404.3247776213723, 410.3864722240251, 416.79160419790105, 19009.334673286437, 19791.703124453146, 19802.306919257848, 19828.702569461453, 20881.164753409885, 20058.699119513218, 20251.594968100628, 21243.893780531074, 21268.57462850746, 21310.14759409622, 5423.29497165368, 5819.981503236938, 5867.647941123525, 5870.618409803371, 5877.970610146944, 5554.944560533486, 5734.053881109612, 5831.7958871439505, 5836.212111364954, 5878.50032747217, 5812.0, 5904.261967254093, 5908.261467316585, 5915.290165180184, 5927.792527261547, 5513.3108361454615, 5565.693886836222, 5686.402927692595, 5692.345380281238, 5696.031674615326, 5404.216388623628, 5461.15352120422, 5518.0, 5907.793227237069, 5961.076033214858, 13097.279649619268, 13264.933675331562, 13348.33258337089, 13462.0, 13503.527376541773, 1989.3932350633052, 2129.5421484380777, 2197.9449864065336, 2285.097386532327, 2301.7583153768783, 9549.427034377959, 9868.90131098687, 9872.506374681238, 9881.11070003696, 10087.49562521871, 1720.8709346798914, 1729.0576635733555, 1736.9044702541355, 1778.5731424458165, 1784.9196786144655, 114190.0, 115615.42192289069, 117396.0, 118737.99999999914, 118813.0, 11551.826722599168, 11695.900586344625, 11730.765384692259, 11775.705607359712, 11891.28652280866, 14593.41626334956, 14626.56120316371, 14888.851111488746, 14934.0, 15083.4720784772, 6693.364130407604, 6784.864302713918, 8419.242268195892, 8789.077146899612, 8910.821783564292, 8634.740957771277, 8690.478571285743, 8804.251638610789, 8926.152015558511, 9028.503432311154, 4622.237330840441, 4637.003044345482, 4723.6929599575915, 4756.191447453872, 4793.712377257376, 1793.3543924187281, 1945.7547169811332, 2009.6483115454737, 2027.9493012674802, 2064.194963964055, 910.6144422857323, 914.9862752058724, 986.9013098690074, 1006.8741407324085, 1033.2715435617872, 18571.0, 20027.59944801096, 20040.89979550093, 20243.493912652008, 20574.485637858874, 901.4501154295874, 927.536231884058, 946.9431834089977, 1048.6120135549895, 1066.168388656849, 8892.3330750194, 10770.838437423445, 10827.24209305341, 10928.726781830359, 11025.669229923114, 452847.0, 534330.0, 621135.0, 643278.0, 643789.0, 87222.56388718143, 87711.12288877029, 110060.449697751, 114738.0, 121019.0, 972.4311277902507, 1008.8952596906375, 1012.2256473797551, 1054.0, 1058.2010582010687, 17309.0, 18054.5486362842, 18056.90971545134, 18086.0, 18093.73343865917, 47681.28478072901, 48381.51618483911, 49766.004679906924, 50164.749176253885, 50243.0, 68375.0, 68384.0, 68517.0, 68579.65710171417, 71617.64191179011, 7701.845963080819, 7765.844683106419, 8029.156938521372, 8137.308328792119, 8462.83074338522, 10886.61896833607, 12395.504179832706, 12510.87489125097, 12761.234325940473, 12774.872251277367, 5401.270828438111, 6818.693158807965, 9710.834699836065, 10874.836877446687, 11066.557337706723, 10800.297980631234, 10882.29265097766, 10929.945350273198, 11251.212415130862, 11293.983541481306, 11046.668599942015, 11270.718232044264, 11616.361100139573, 11652.41737913084, 11653.88346116528, 8134.552599606842, 8225.71210007647, 8382.077971423018, 8402.41183117176, 8403.663853445794, 10452.634157804441, 11100.333979961228, 11149.554017839195, 11416.657500275005, 11499.655010349703], "value": 9213.010258187314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.574055005149, 1610.3317123393792, 1620.4085508789292, 1936.7094935759635, 1958.4222654316975, 8145.266925976661, 8689.52207628581, 8749.168828961254, 9044.90955090449, 9070.501122438263, 7279.381252593523, 8806.471611703286, 8827.161419665137, 8932.776680582989, 8949.731508054752, 2465.420626152857, 2506.6240063990367, 2508.8118391120647, 2511.0458025950206, 2515.7861581765574, 2442.926712198637, 2456.6315052742143, 2461.59383701689, 2479.2066538707622, 2502.8248022638422, 2472.431340791619, 2475.1337032038823, 2484.714257860342, 2503.924882253526, 2510.435152090783, 2468.1731619907355, 2477.318737347226, 2491.1032028469735, 2499.700035995674, 2500.6374075758913, 1832.9368965999688, 2222.14447437736, 2430.453148041694, 2479.00839664134, 2487.8009759219217, 8805.647774089093, 8842.867356989651, 8891.155340242667, 8989.05614910438, 8994.730158095268, 5280.260763493114, 5500.477454641803, 5541.168824676291, 5554.583406244547, 5568.721563921828, 3308.354870800195, 3607.152319204985, 3634.018814919983, 3669.1560940983454, 3687.0597997510463, 1031.943243121628, 1066.6906597086836, 1072.8015317166348, 1074.736689511067, 1120.3334016260312, 11677.70805729855, 11827.34949577773, 11840.87511686397, 11850.11124165691, 11859.52561897523, 4810.278458231223, 4818.927716084261, 4954.0, 4992.0, 5010.724410157476, 10047.949760251153, 10084.344517606332, 10117.44354060519, 10153.984601539934, 10176.440295783803, 5383.380911195184, 5412.215228791803, 5440.156775699773, 5445.782168713207, 5483.341998960151, 4480.126375356775, 4823.807047718052, 4928.383952005999, 5007.349044624249, 5037.19404895215, 3416.009357286409, 4006.6794656427414, 4046.0896298333228, 4124.484439445069, 4159.10579225468, 1140.6349968010322, 1364.9285311030794, 1375.0924389902616, 1380.9102408343426, 1382.4539306973688, 814.3810703865105, 822.8116050305068, 837.8491871463195, 842.439777547936, 965.560669895196, 5796.217510636095, 5842.503387212049, 6108.694565271719, 6146.416090471398, 6168.136460895478, 978.6525783346951, 988.9159421449114, 992.6228033347281, 994.4536246137326, 1010.2675560218782, 3478.704310133667, 4013.979930100389, 4020.3567429211184, 4060.898477538085, 4115.97942010288, 10718.35689858611, 11010.119190464744, 11066.557337706401, 11103.0, 11120.38837863909, 10784.299020563638, 10915.56337746497, 10925.399103049249, 10939.23425360233, 11104.222704410775, 8269.751907442786, 8325.209105135002, 8443.36674749384, 8490.15098490146, 8494.617742201615, 5408.37803652585, 5843.328017278068, 5944.494717949023, 5971.223740913653, 6102.938970610237, 9816.067473589997, 10023.298369114093, 10185.134263587677, 10189.898101018895, 10211.387316760722, 7987.0, 8136.349092072502, 9599.616015359587, 9691.224702023963, 10495.947520262349, 6591.406773390418, 6915.446764258948, 7154.6064966425265, 7206.099237595301, 7299.671514781741, 8332.125126861592, 8398.790030249049, 8430.536320502431, 8459.619317130868, 8464.830703385775, 7339.926600733925, 7367.410607151308, 7466.0, 7605.543667379754, 7612.200718924433, 6492.831290367779, 7384.446166537638, 7425.368843648351, 7485.88771168422, 7512.474126811071, 6977.581345119309, 6987.720491180499, 6998.790036298919, 7058.682359293947, 7089.964550177217, 4861.052094841472, 4932.334134891744, 5054.494550545063, 5055.418626857811, 5233.607479439133, 4969.503049695001, 5032.270320803536, 5085.0, 5127.333446652061, 5191.558717509054], "value": 4655.366185048385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.39793489272716, 328.06501470808195, 332.36020660229053, 335.2038907594463, 335.5084800766876, 5425.186222066692, 5485.985092757837, 5553.361363443205, 5623.0, 5694.345150307716, 4483.49802816057, 5491.736900512885, 5629.408912064236, 5666.178404131409, 5675.404082571333, 3955.2287303975663, 4273.636740877029, 4293.29160688486, 4308.67684923632, 4332.415123958257, 4143.7720925349095, 4227.619514243717, 4279.422277992478, 4288.7212331198525, 4314.590113939171, 4149.419081328617, 4157.605027522381, 4214.199302132601, 4227.408162857202, 4234.5553716859595, 3718.4608231806506, 3760.905977350561, 4067.8983025424454, 4240.957590424087, 4268.231718290706, 3346.531485592019, 3494.6854783069393, 3702.8889133326043, 3703.962960370389, 3714.4799728038097, 4200.957990420118, 4965.75856035991, 5187.533122019036, 5341.4925582069645, 5444.727763611803, 4953.975230123862, 4976.576990955737, 4979.228219625964, 4980.551750342486, 4984.2025275955675, 5445.618806683534, 5571.687749583918, 5651.174412793604, 6002.759889604411, 6034.155218269446, 4123.60825721556, 4130.339145736668, 4130.793460326971, 4146.129312844307, 4181.0, 4784.0, 5161.7161056141895, 6182.69086545671, 6329.113924050636, 6354.714037868261, 3935.7835319057153, 4183.707140500136, 4210.6735678814, 4212.789360531961, 4227.830886764556, 3678.429843374281, 3843.61563843619, 4118.9588104118575, 4146.730462519927, 4162.063535704503, 4817.710937343771, 4819.469858315582, 4825.420949486084, 4830.275458681155, 4847.612191024709, 5791.536677065909, 5972.193753843176, 5996.310424301174, 6024.1566180734735, 6058.636481811105, 1467.9633009174643, 1508.1478964385087, 1517.521980576115, 1523.588631069605, 1524.3597688970658, 973.2262851033446, 973.481369064262, 998.4658207858761, 1002.0981116994762, 1005.0652892809757, 5999.460048595647, 6000.249968753906, 6014.1580178775, 6038.3998240465435, 6074.088886666947, 6586.440152586988, 6587.80236592903, 6610.834729131714, 6613.768518101843, 6701.798946031627, 5569.805056822992, 5969.611975221596, 6011.355003798315, 6031.8793624127275, 6043.2748070231855, 2976.345204055104, 3225.5000474926424, 3402.166469215058, 3444.9827750861086, 3480.7295337202245, 6448.387403196689, 6637.933620663732, 6851.0, 6857.040014397889, 6869.347411995853, 6712.53012289135, 6781.898271525931, 6791.3548212919695, 6795.728170873209, 6815.318468153145, 5607.579431542569, 6560.901586476207, 6864.279250678607, 6885.931140688629, 6905.309469053054, 6548.116004339353, 6570.5729127606555, 6572.244191917991, 6592.70332835014, 6601.3728695773825, 6299.622022678654, 6328.272248691275, 6486.351364863476, 6489.286178520453, 6496.545241833026, 6795.45636349081, 6821.761238356832, 6829.224401655506, 6859.862802743817, 6892.414144797748, 3919.1573811630637, 4086.8761090700295, 4307.956920430881, 4316.748143038483, 4317.352397140454, 4482.99132695141, 4773.856784296477, 6286.616944272253, 6502.772402965874, 6603.405693487609, 5998.820035398945, 6046.2139921809885, 6067.423594758491, 6080.6351618901235, 6182.381761823962, 4587.38070360497, 4878.609711223165, 5330.546903513245, 5696.629719068247, 6036.939630603813, 4710.905781884411, 5534.944650553443, 5571.749271282721, 5883.0, 5919.556033297606, 5785.074388097884, 5979.820605381846, 6016.518678505797, 6051.697415129314, 6057.454829065406, 5296.390915044819, 5406.83779486616, 5530.391656917816, 5547.251121098761, 5865.0], "value": 4467.299851951522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.9489640828734, 665.936736010079, 713.5041146403246, 724.0298000679089, 772.2779201446648, 14775.704485910275, 14845.628859278524, 15057.021293615908, 15073.849261507381, 16084.276207570658, 15426.691466170698, 15761.527154185364, 15785.368585256605, 15867.127307998055, 15917.52247432576, 737.1522748838852, 925.5002298758662, 942.519315149272, 943.5376665433956, 944.3908678902104, 888.8355654203993, 890.688259109313, 898.4294972692322, 937.9296552758536, 939.6523286384047, 937.6155776131787, 985.7092157813427, 986.5412583148834, 997.997013001932, 998.3909815012872, 931.3573634192386, 932.1331162019319, 938.8122375524854, 953.1183655118987, 989.9109080182782, 691.1498856406598, 704.4786857725297, 709.226942632533, 738.918718940916, 740.9555426674417, 13822.585322440344, 14183.716325673531, 15093.39626414942, 15200.847991520164, 15299.464518741903, 12152.0, 12355.196912200678, 12358.567450139291, 12382.504699811996, 12532.937335313265, 8413.705520306821, 9883.604655813759, 9892.428177647787, 9996.450195239258, 10200.285979981405, 3481.147118955872, 3482.8258587070545, 3485.1112966193714, 3501.0547152268746, 3611.133328001261, 57599.424005760244, 75660.62169689171, 77465.0, 77949.61025194895, 79052.60473697595, 9183.448993060305, 9275.350725449154, 9370.437773733462, 9582.520873956275, 9644.710658680251, 21051.263205787724, 21243.575128497654, 21271.0, 21321.147154113973, 21489.67765483519, 7208.747693830691, 7212.3869471094495, 7228.31331023552, 7405.370543503755, 7500.287472690085, 3983.322835118037, 4038.8788336349958, 4063.2889244382704, 4081.10215752534, 4081.3469844824685, 3475.6871881530783, 3559.3771090059136, 3559.94660080099, 3568.5717713873983, 3576.034470692898, 617.9104029915637, 621.4779585148497, 644.3170239546096, 644.9290578036412, 653.9967300163469, 527.6702061211743, 592.1887014789766, 610.6549799363346, 622.1725105609529, 628.2837565175703, 7955.0851652060755, 8072.0, 8235.217654322949, 8429.030661473886, 8443.95778021106, 491.660754079691, 607.6445279511536, 613.2150846915955, 614.3242433323397, 618.4155972605844, 3772.8490860365278, 3895.9610403896163, 3931.744436611611, 3938.724289299779, 3977.622125898093, 67906.32093679099, 86393.56803216069, 94018.52990735002, 94087.0, 94980.0, 53410.0, 72276.277237228, 74085.62957185287, 74393.0, 75354.6232268846, 67270.3272967264, 68345.31654683489, 68418.65790671115, 68610.65694671495, 68961.0, 7787.649555769891, 8383.203595658402, 8474.152584741476, 8487.321014318963, 8544.273736732199, 37900.0, 42883.356749648156, 44827.327590086825, 45354.54645453503, 46485.0, 61599.692001539705, 63620.363796363294, 64022.39944001437, 64168.0, 65865.0, 10701.304415212986, 10959.671209863716, 11061.281016733887, 11271.661850144508, 11345.262557933707, 11779.293242405483, 11798.823017654571, 11854.94072529632, 11874.228175168586, 11961.521539138337, 11360.772784544097, 11558.42207889619, 11563.479643415898, 11679.240849344766, 11789.882101178879, 11046.005859472685, 11069.723256918642, 11184.273022253528, 11204.383758893338, 11214.66356009321, 11204.159688023268, 11236.94381528087, 11238.55045798159, 11274.436278185894, 11277.887221128012, 9532.52337383142, 9687.66093186735, 9876.308658393844, 9955.352902061342, 10046.799064018825, 9322.347435679438, 9636.180924621485, 9642.662506812228, 9707.271954603291, 9727.513624318897], "value": 6831.989320222097, "unit": "score"}], "name": "dromaeo_css", "value": 7127.240084273273, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 117.0, 115.0, 116.0, 128.0, 114.0, 115.0, 117.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 145.0, 167.0, 120.0, 138.0, 138.0, 119.0, 167.0, 121.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 193.0, 165.0, 225.0, 205.0, 210.0, 175.0, 255.0, 210.0, 251.0], "value": 208.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 71.0, 110.0, 67.0, 80.0, 82.0, 70.0, 128.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 121.0, 76.0, 92.0, 78.0, 101.0, 116.0, 124.0, 157.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 86.0, 83.0, 129.0, 135.0, 85.0, 87.0, 86.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 150.0, 95.0, 94.0, 95.0, 95.0, 112.0, 151.0, 97.0, 95.0], "value": 109.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 105.0, 142.0, 92.0, 128.0, 91.0, 92.0, 91.0, 90.0], "value": 101.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 60.0, 59.0, 60.0, 63.0, 60.0, 76.0, 60.0, 55.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 64.0, 69.0, 67.0, 78.0, 70.0, 67.0, 69.0, 69.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 109.0, 81.0, 83.0, 82.0, 85.0, 80.0, 84.0, 82.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 165.0, 153.0, 164.0, 165.0, 170.0, 140.0, 176.0, 141.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [273.0, 274.0, 234.0, 275.0, 281.0, 194.0, 209.0, 211.0, 230.0, 202.0], "value": 238.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 77.0, 74.0, 67.0, 67.0, 61.0, 87.0, 103.0], "value": 74.8, "unit": "score"}], "name": "kraken", "value": 1646.1, "alertThreshold": 2.0}]} 16:16:09 INFO - Return code: 0 16:16:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:16:09 ERROR - # TBPL SUCCESS # 16:16:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:16:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:16:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:16:09 INFO - 2016-04-26 16:16:09.504 screenresolution[1680:10507] starting screenresolution argv=screenresolution get 16:16:09 INFO - 2016-04-26 16:16:09.507 screenresolution[1680:10507] Display 0: 1600x1200x32@60 16:16:09 INFO - 2016-04-26 16:16:09.512 screenresolution[1681:10510] starting screenresolution argv=screenresolution list 16:16:09 INFO - Available Modes on Display 0 16:16:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:16:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:16:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:16:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:16:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:16:09 INFO - Intel Iris: 16:16:09 INFO - Chipset Model: Intel Iris 16:16:09 INFO - Type: GPU 16:16:09 INFO - Bus: Built-In 16:16:09 INFO - VRAM (Dynamic, Max): 1536 MB 16:16:09 INFO - Vendor: Intel (0x8086) 16:16:09 INFO - Device ID: 0x0a2e 16:16:09 INFO - Revision ID: 0x0009 16:16:09 INFO - Displays: 16:16:09 INFO - Display: 16:16:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:16:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:16:09 INFO - Display Serial Number: 1600x1200 60 16:16:09 INFO - Main Display: Yes 16:16:09 INFO - Mirror: Off 16:16:09 INFO - Online: Yes 16:16:09 INFO - Rotation: Supported 16:16:09 INFO - Return code: 0 16:16:09 INFO - Running post-action listener: _resource_record_post_action 16:16:09 INFO - Running post-run listener: _resource_record_post_run 16:16:10 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37443072; Write bytes: 697139712; Read time: 392; Write time: 2259 16:16:10 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 376490496; Write bytes: 370882560; Read time: 28316; Write time: 917 16:16:10 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 36488704; Write bytes: 298883584; Read time: 378; Write time: 1289 16:16:10 INFO - Running post-run listener: _upload_blobber_files 16:16:10 INFO - Blob upload gear active. 16:16:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:16:10 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:16:10 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:16:10 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:16:11 INFO - (blobuploader) - INFO - Open directory for files ... 16:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:12 INFO - (blobuploader) - INFO - Done attempting. 16:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:13 INFO - (blobuploader) - INFO - Done attempting. 16:16:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:16:13 INFO - Return code: 0 16:16:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:16:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:16:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89b1b5ada33a50ba222bb3cf376dd86c97394f54d25a9dac4e343abb6875a80592570e6a275d02c6bda874b0ff59b72ee3cd8a8b74ef5010d9321380fa40f46a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51164f6858a5269443071e5918132efe08dc7af8beba1e64c7140fc716267c3fc5026203d7fd2ee78c87859a1208b62b6b800f5684b53d8c6fa518077bc4dc"} 16:16:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:16:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:16:13 INFO - Contents: 16:16:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89b1b5ada33a50ba222bb3cf376dd86c97394f54d25a9dac4e343abb6875a80592570e6a275d02c6bda874b0ff59b72ee3cd8a8b74ef5010d9321380fa40f46a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51164f6858a5269443071e5918132efe08dc7af8beba1e64c7140fc716267c3fc5026203d7fd2ee78c87859a1208b62b6b800f5684b53d8c6fa518077bc4dc"} 16:16:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:16:13 INFO - Copying logs to upload dir... 16:16:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:16:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.803759 ========= master_lag: 7.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-26 16:16:20.522304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-26 16:16:20.530241) ========= 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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89b1b5ada33a50ba222bb3cf376dd86c97394f54d25a9dac4e343abb6875a80592570e6a275d02c6bda874b0ff59b72ee3cd8a8b74ef5010d9321380fa40f46a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51164f6858a5269443071e5918132efe08dc7af8beba1e64c7140fc716267c3fc5026203d7fd2ee78c87859a1208b62b6b800f5684b53d8c6fa518077bc4dc"} 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.011034 build_url: 'https://queue.taskcluster.net/v1/task/Vdd3FcwRQ3uPNXCsmqHhag/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89b1b5ada33a50ba222bb3cf376dd86c97394f54d25a9dac4e343abb6875a80592570e6a275d02c6bda874b0ff59b72ee3cd8a8b74ef5010d9321380fa40f46a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d51164f6858a5269443071e5918132efe08dc7af8beba1e64c7140fc716267c3fc5026203d7fd2ee78c87859a1208b62b6b800f5684b53d8c6fa518077bc4dc"}' ========= master_lag: 1.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-26 16:16:21.636610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:16:21.636958) ========= 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.yd6Dkbxq7B/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.sJfIhH4sOs/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.005087 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 16:16:21.760980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:16:21.761294) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 16:16:21.762348) ========= ========= Total master_lag: 8.51 =========