builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1461844112.06 results: success (0) buildid: 20160428034800 builduid: 2dfa8c73ae054518a25c5747e5d459c4 revision: 830f7765555a3740103c31100118bf318cf785b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.060467) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.060994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.061306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.080241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.080616) ========= 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.nW2ytVD86M/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.44TgSd1tIm/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-28 04:48:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 95.7M=0s 2016-04-28 04:48:32 (95.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.223785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.224185) ========= 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.nW2ytVD86M/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.44TgSd1tIm/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.020065 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.275045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.275682) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 830f7765555a3740103c31100118bf318cf785b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 830f7765555a3740103c31100118bf318cf785b2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nW2ytVD86M/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.44TgSd1tIm/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-28 04:48:32,357 truncating revision to first 12 chars 2016-04-28 04:48:32,357 Setting DEBUG logging. 2016-04-28 04:48:32,357 attempt 1/10 2016-04-28 04:48:32,357 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/830f7765555a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 04:48:32,627 unpacking tar archive at: fx-team-830f7765555a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.803670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.803975) ========= script_repo_revision: 830f7765555a3740103c31100118bf318cf785b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.804363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.804636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 04:48:32.818622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 40 secs) (at 2016-04-28 04:48:32.819105) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nW2ytVD86M/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.44TgSd1tIm/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:48:33 INFO - MultiFileLogger online at 20160428 04:48:33 in /builds/slave/test 04:48:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:48:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:33 INFO - {'append_to_log': False, 04:48:33 INFO - 'base_work_dir': '/builds/slave/test', 04:48:33 INFO - 'blob_upload_branch': 'Fx-Team', 04:48:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:33 INFO - 'branch': 'Fx-Team', 04:48:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:33 INFO - 'config_files': ('talos/mac_config.py',), 04:48:33 INFO - 'default_actions': ('clobber', 04:48:33 INFO - 'read-buildbot-config', 04:48:33 INFO - 'download-and-extract', 04:48:33 INFO - 'populate-webroot', 04:48:33 INFO - 'create-virtualenv', 04:48:33 INFO - 'install', 04:48:33 INFO - 'run-tests'), 04:48:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:33 INFO - 'download_minidump_stackwalk': True, 04:48:33 INFO - 'download_symbols': 'ondemand', 04:48:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:33 INFO - 'installer_path': 'installer.exe', 04:48:33 INFO - 'log_level': 'info', 04:48:33 INFO - 'log_name': 'talos', 04:48:33 INFO - 'log_to_console': True, 04:48:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:33 INFO - 'opt_config_files': (), 04:48:33 INFO - 'pip_index': False, 04:48:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:33 INFO - 'cmd': ('bash', 04:48:33 INFO - '-c', 04:48:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:33 INFO - 'enabled': True, 04:48:33 INFO - 'halt_on_failure': False, 04:48:33 INFO - 'name': 'check_screen_resolution'},), 04:48:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:33 INFO - 'cmd': ('bash', 04:48:33 INFO - '-c', 04:48:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:33 INFO - 'enabled': True, 04:48:33 INFO - 'halt_on_failure': False, 04:48:33 INFO - 'name': 'check_screen_resolution'},), 04:48:33 INFO - 'run_cmd_checks_enabled': True, 04:48:33 INFO - 'sps_profile': False, 04:48:33 INFO - 'sps_profile_interval': 0, 04:48:33 INFO - 'suite': 'dromaeojs', 04:48:33 INFO - 'system_bits': '32', 04:48:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:33 INFO - 'title': 't-yosemite-r7-0111', 04:48:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:33 INFO - 'use_talos_json': True, 04:48:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:33 INFO - 'work_dir': 'build'} 04:48:33 INFO - ##### 04:48:33 INFO - ##### Running clobber step. 04:48:33 INFO - ##### 04:48:33 INFO - Running pre-action listener: _resource_record_pre_action 04:48:33 INFO - Running main action method: clobber 04:48:33 INFO - rmtree: /builds/slave/test/build 04:48:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:33 INFO - Running post-action listener: _resource_record_post_action 04:48:33 INFO - ##### 04:48:33 INFO - ##### Running read-buildbot-config step. 04:48:33 INFO - ##### 04:48:33 INFO - Running pre-action listener: _resource_record_pre_action 04:48:33 INFO - Running main action method: read_buildbot_config 04:48:33 INFO - Using buildbot properties: 04:48:33 INFO - { 04:48:33 INFO - "project": "", 04:48:33 INFO - "product": "firefox", 04:48:33 INFO - "script_repo_revision": "production", 04:48:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:48:33 INFO - "repository": "", 04:48:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:48:33 INFO - "buildid": "20160428034800", 04:48:33 INFO - "pgo_build": "False", 04:48:33 INFO - "basedir": "/builds/slave/test", 04:48:33 INFO - "buildnumber": 741, 04:48:33 INFO - "slavename": "t-yosemite-r7-0111", 04:48:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:48:33 INFO - "platform": "yosemite_r7", 04:48:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:48:33 INFO - "branch": "fx-team", 04:48:33 INFO - "repo_path": "integration/fx-team", 04:48:33 INFO - "revision": "830f7765555a3740103c31100118bf318cf785b2", 04:48:33 INFO - "stage_platform": "macosx64", 04:48:33 INFO - "builduid": "2dfa8c73ae054518a25c5747e5d459c4", 04:48:33 INFO - "slavebuilddir": "test" 04:48:33 INFO - } 04:48:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 04:48:33 INFO - Running post-action listener: _resource_record_post_action 04:48:33 INFO - ##### 04:48:33 INFO - ##### Running download-and-extract step. 04:48:33 INFO - ##### 04:48:33 INFO - Running pre-action listener: _resource_record_pre_action 04:48:33 INFO - Running main action method: download_and_extract 04:48:33 INFO - mkdir: /builds/slave/test/build/tests 04:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:33 INFO - https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:35 INFO - Downloaded 1199 bytes. 04:48:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:48:35 INFO - Using the following test package requirements: 04:48:35 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:48:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 04:48:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'jsshell-mac.zip'], 04:48:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 04:48:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:48:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 04:48:35 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 04:48:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 04:48:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:48:35 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48: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')]} 04:48:35 INFO - https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:36 INFO - Downloaded 18116489 bytes. 04:48:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:48:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:48:39 INFO - Return code: 0 04:48:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:39 INFO - https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:40 INFO - Downloaded 18116489 bytes. 04:48:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:48:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:48:44 INFO - Return code: 0 04:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:44 INFO - https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:45 INFO - Downloaded 10840145 bytes. 04:48:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:48:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:48:45 INFO - Return code: 0 04:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:45 INFO - https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 04:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyDmvbwlTji2thMMRd2eMw/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 04:48:48 INFO - Downloaded 110195318 bytes. 04:48:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:48:48 INFO - mkdir: /builds/slave/test/properties 04:48:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:48:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:48:48 INFO - Contents: 04:48:48 INFO - build_url:https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:48:50 INFO - Running post-action listener: _resource_record_post_action 04:48:50 INFO - Running post-action listener: set_extra_try_arguments 04:48:50 INFO - ##### 04:48:50 INFO - ##### Running populate-webroot step. 04:48:50 INFO - ##### 04:48:50 INFO - Running pre-action listener: _resource_record_pre_action 04:48:50 INFO - Running main action method: populate_webroot 04:48:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:48:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:48:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:48:50 INFO - '--tppagecycles', 04:48:50 INFO - '7'], 04:48:50 INFO - 'tests': ['tsvgm']}}, 04:48:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:48:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:48:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:48:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:48:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['damp', 'tps']}, 04:48:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'tests': ['damp', 'tps']}, 04:48:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['dromaeo_dom']}, 04:48:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:48:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['a11yr', 04:48:50 INFO - 'ts_paint', 04:48:50 INFO - 'tpaint', 04:48:50 INFO - 'sessionrestore', 04:48:50 INFO - 'sessionrestore_no_auto_restore', 04:48:50 INFO - 'tabpaint']}, 04:48:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:48:50 INFO - 'ts_paint', 04:48:50 INFO - 'tpaint', 04:48:50 INFO - 'sessionrestore', 04:48:50 INFO - 'sessionrestore_no_auto_restore', 04:48:50 INFO - 'tabpaint']}, 04:48:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:48:50 INFO - 'ts_paint', 04:48:50 INFO - 'tpaint', 04:48:50 INFO - 'sessionrestore', 04:48:50 INFO - 'sessionrestore_no_auto_restore', 04:48:50 INFO - 'tabpaint']}, 04:48:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:48:50 INFO - 'ts_paint', 04:48:50 INFO - 'tpaint', 04:48:50 INFO - 'sessionrestore', 04:48:50 INFO - 'sessionrestore_no_auto_restore', 04:48:50 INFO - 'tabpaint']}, 04:48:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['a11yr', 04:48:50 INFO - 'ts_paint', 04:48:50 INFO - 'tpaint', 04:48:50 INFO - 'sessionrestore', 04:48:50 INFO - 'sessionrestore_no_auto_restore', 04:48:50 INFO - 'tabpaint']}, 04:48:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['a11yr', 04:48:50 INFO - 'ts_paint', 04:48:50 INFO - 'tpaint', 04:48:50 INFO - 'sessionrestore', 04:48:50 INFO - 'sessionrestore_no_auto_restore', 04:48:50 INFO - 'tabpaint']}, 04:48:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['tsvgx', 04:48:50 INFO - 'tsvgr_opacity', 04:48:50 INFO - 'tart', 04:48:50 INFO - 'tscrollx', 04:48:50 INFO - 'cart']}, 04:48:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:48:50 INFO - 'tsvgr_opacity', 04:48:50 INFO - 'tart', 04:48:50 INFO - 'tscrollx', 04:48:50 INFO - 'cart']}, 04:48:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'talos_options': ['--disable-e10s'], 04:48:50 INFO - 'tests': ['tp5o']}, 04:48:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'tests': ['tp5o']}, 04:48:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'talos_options': ['--disable-e10s', 04:48:50 INFO - '--xperf_path', 04:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:50 INFO - 'tests': ['tp5n']}, 04:48:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:48:50 INFO - 'talos_options': ['--xperf_path', 04:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:50 INFO - 'tests': ['tp5n']}}, 04:48:50 INFO - 'talos.zip': {'path': '', 04:48:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:48:50 INFO - Running post-action listener: _resource_record_post_action 04:48:50 INFO - ##### 04:48:50 INFO - ##### Running create-virtualenv step. 04:48:50 INFO - ##### 04:48:50 INFO - Running pre-action listener: _resource_record_pre_action 04:48:50 INFO - Running main action method: create_virtualenv 04:48:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:48:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:48:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:48:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:48:50 INFO - Using real prefix '/tools/python27' 04:48:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:48:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:48:54 INFO - Installing pip.................done. 04:48:54 INFO - Return code: 0 04:48:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:54 INFO - 'HOME': '/Users/cltbld', 04:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:54 INFO - 'LOGNAME': 'cltbld', 04:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:54 INFO - 'MOZ_NO_REMOTE': '1', 04:48:54 INFO - 'NO_EM_RESTART': '1', 04:48:54 INFO - 'PAGER': '/bin/cat', 04:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:54 INFO - 'PWD': '/builds/slave/test', 04:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:54 INFO - 'SHELL': '/bin/bash', 04:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:48:54 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:54 INFO - 'USER': 'cltbld', 04:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:54 INFO - 'XPC_FLAGS': '0x0', 04:48:54 INFO - 'XPC_SERVICE_NAME': '0', 04:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:48:54 INFO - Cleaning up... 04:48:54 INFO - Return code: 0 04:48:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:54 INFO - 'HOME': '/Users/cltbld', 04:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:54 INFO - 'LOGNAME': 'cltbld', 04:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:54 INFO - 'MOZ_NO_REMOTE': '1', 04:48:54 INFO - 'NO_EM_RESTART': '1', 04:48:54 INFO - 'PAGER': '/bin/cat', 04:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:54 INFO - 'PWD': '/builds/slave/test', 04:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:54 INFO - 'SHELL': '/bin/bash', 04:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:48:54 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:54 INFO - 'USER': 'cltbld', 04:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:54 INFO - 'XPC_FLAGS': '0x0', 04:48:54 INFO - 'XPC_SERVICE_NAME': '0', 04:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:54 INFO - Downloading/unpacking psutil>=0.7.1 04:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:48:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:57 INFO - Installing collected packages: psutil 04:48:57 INFO - Running setup.py install for psutil 04:48:57 INFO - building 'psutil._psutil_osx' extension 04:48:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:48:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:48:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:48:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:48:57 INFO - building 'psutil._psutil_posix' extension 04:48:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:48:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:48:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:48:57 INFO - ^ 04:48:57 INFO - 1 warning generated. 04:48:57 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 04:48:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:58 INFO - Successfully installed psutil 04:48:58 INFO - Cleaning up... 04:48:58 INFO - Return code: 0 04:48:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:58 INFO - 'HOME': '/Users/cltbld', 04:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:58 INFO - 'LOGNAME': 'cltbld', 04:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:58 INFO - 'MOZ_NO_REMOTE': '1', 04:48:58 INFO - 'NO_EM_RESTART': '1', 04:48:58 INFO - 'PAGER': '/bin/cat', 04:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:58 INFO - 'PWD': '/builds/slave/test', 04:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:58 INFO - 'SHELL': '/bin/bash', 04:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:48:58 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:58 INFO - 'USER': 'cltbld', 04:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:58 INFO - 'XPC_FLAGS': '0x0', 04:48:58 INFO - 'XPC_SERVICE_NAME': '0', 04:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:49:00 INFO - Installing collected packages: mozsystemmonitor 04:49:00 INFO - Running setup.py install for mozsystemmonitor 04:49:01 INFO - Successfully installed mozsystemmonitor 04:49:01 INFO - Cleaning up... 04:49:01 INFO - Return code: 0 04:49:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:01 INFO - 'HOME': '/Users/cltbld', 04:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:01 INFO - 'LOGNAME': 'cltbld', 04:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:01 INFO - 'MOZ_NO_REMOTE': '1', 04:49:01 INFO - 'NO_EM_RESTART': '1', 04:49:01 INFO - 'PAGER': '/bin/cat', 04:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:01 INFO - 'PWD': '/builds/slave/test', 04:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:01 INFO - 'SHELL': '/bin/bash', 04:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:01 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:01 INFO - 'USER': 'cltbld', 04:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:01 INFO - 'XPC_FLAGS': '0x0', 04:49:01 INFO - 'XPC_SERVICE_NAME': '0', 04:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:04 INFO - Downloading docopt-0.6.1.tar.gz 04:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:05 INFO - Running setup.py install for blobuploader 04:49:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:05 INFO - Running setup.py install for requests 04:49:05 INFO - Running setup.py install for docopt 04:49:05 INFO - Successfully installed blobuploader requests docopt 04:49:05 INFO - Cleaning up... 04:49:05 INFO - Return code: 0 04:49:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:05 INFO - 'HOME': '/Users/cltbld', 04:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:05 INFO - 'LOGNAME': 'cltbld', 04:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:05 INFO - 'MOZ_NO_REMOTE': '1', 04:49:05 INFO - 'NO_EM_RESTART': '1', 04:49:05 INFO - 'PAGER': '/bin/cat', 04:49:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:05 INFO - 'PWD': '/builds/slave/test', 04:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:05 INFO - 'SHELL': '/bin/bash', 04:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:05 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:05 INFO - 'USER': 'cltbld', 04:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:05 INFO - 'XPC_FLAGS': '0x0', 04:49:05 INFO - 'XPC_SERVICE_NAME': '0', 04:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hYEj6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-um7igb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HbWu7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-oVKIHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sdK2Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Uomjuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hgN4c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:06 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RaxLnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-5LEjlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-7_gYbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-b8Vx0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rIEKQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sdtOms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-joJ_Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-x3OdkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-SZqldx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:07 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-l3j32_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:07 INFO - Running setup.py install for manifestparser 04:49:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:08 INFO - Running setup.py install for mozcrash 04:49:08 INFO - Running setup.py install for mozdebug 04:49:08 INFO - Running setup.py install for mozdevice 04:49:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:08 INFO - Running setup.py install for mozfile 04:49:08 INFO - Running setup.py install for mozhttpd 04:49:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:08 INFO - Running setup.py install for mozinfo 04:49:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:08 INFO - Running setup.py install for mozInstall 04:49:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Running setup.py install for mozleak 04:49:09 INFO - Running setup.py install for mozlog 04:49:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Running setup.py install for moznetwork 04:49:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Running setup.py install for mozprocess 04:49:09 INFO - Running setup.py install for mozprofile 04:49:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:09 INFO - Running setup.py install for mozrunner 04:49:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:10 INFO - Running setup.py install for mozscreenshot 04:49:10 INFO - Running setup.py install for moztest 04:49:10 INFO - Running setup.py install for mozversion 04:49:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:10 INFO - Cleaning up... 04:49:10 INFO - Return code: 0 04:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:10 INFO - 'HOME': '/Users/cltbld', 04:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:10 INFO - 'LOGNAME': 'cltbld', 04:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:10 INFO - 'MOZ_NO_REMOTE': '1', 04:49:10 INFO - 'NO_EM_RESTART': '1', 04:49:10 INFO - 'PAGER': '/bin/cat', 04:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:10 INFO - 'PWD': '/builds/slave/test', 04:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:10 INFO - 'SHELL': '/bin/bash', 04:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:10 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:10 INFO - 'USER': 'cltbld', 04:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:10 INFO - 'XPC_FLAGS': '0x0', 04:49:10 INFO - 'XPC_SERVICE_NAME': '0', 04:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:10 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Gu5LFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:10 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JuZdPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-pyQwQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-tak71o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-I4RWQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2zhD6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sAfa5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Ivy82U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-capn0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-fKQdii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:11 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Il2THG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:12 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)) 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:12 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-iurg8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:12 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-KTZJBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:12 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JyJy1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:12 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-YAPSiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:12 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-5RA2yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:12 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-87kBhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:15 INFO - Downloading blessings-1.6.tar.gz 04:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:15 INFO - Installing collected packages: blessings 04:49:15 INFO - Running setup.py install for blessings 04:49:15 INFO - Successfully installed blessings 04:49:15 INFO - Cleaning up... 04:49:15 INFO - Return code: 0 04:49:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:15 INFO - Reading from file tmpfile_stdout 04:49:15 INFO - Current package versions: 04:49:15 INFO - blessings == 1.6 04:49:15 INFO - blobuploader == 1.2.4 04:49:15 INFO - docopt == 0.6.1 04:49:15 INFO - manifestparser == 1.1 04:49:15 INFO - mozInstall == 1.12 04:49:15 INFO - mozcrash == 0.17 04:49:15 INFO - mozdebug == 0.1 04:49:15 INFO - mozdevice == 0.48 04:49:15 INFO - mozfile == 1.2 04:49:15 INFO - mozhttpd == 0.7 04:49:15 INFO - mozinfo == 0.9 04:49:15 INFO - mozleak == 0.1 04:49:15 INFO - mozlog == 3.1 04:49:15 INFO - moznetwork == 0.27 04:49:15 INFO - mozprocess == 0.22 04:49:15 INFO - mozprofile == 0.28 04:49:15 INFO - mozrunner == 6.11 04:49:15 INFO - mozscreenshot == 0.1 04:49:15 INFO - mozsystemmonitor == 0.0 04:49:15 INFO - moztest == 0.7 04:49:15 INFO - mozversion == 1.4 04:49:15 INFO - psutil == 3.1.1 04:49:15 INFO - requests == 1.2.3 04:49:15 INFO - wsgiref == 0.1.2 04:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:15 INFO - 'HOME': '/Users/cltbld', 04:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:15 INFO - 'NO_EM_RESTART': '1', 04:49:15 INFO - 'PAGER': '/bin/cat', 04:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:15 INFO - 'PWD': '/builds/slave/test', 04:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:15 INFO - 'SHELL': '/bin/bash', 04:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:15 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:15 INFO - 'USER': 'cltbld', 04:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:15 INFO - 'XPC_FLAGS': '0x0', 04:49:15 INFO - 'XPC_SERVICE_NAME': '0', 04:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:49:15 INFO - Cleaning up... 04:49:15 INFO - Return code: 0 04:49:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:15 INFO - 'HOME': '/Users/cltbld', 04:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:16 INFO - 'NO_EM_RESTART': '1', 04:49:16 INFO - 'PAGER': '/bin/cat', 04:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:16 INFO - 'PWD': '/builds/slave/test', 04:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:16 INFO - 'SHELL': '/bin/bash', 04:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:16 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:16 INFO - 'USER': 'cltbld', 04:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:16 INFO - 'XPC_FLAGS': '0x0', 04:49:16 INFO - 'XPC_SERVICE_NAME': '0', 04:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:16 INFO - Downloading/unpacking jsonschema 04:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:18 INFO - Downloading/unpacking functools32 (from jsonschema) 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:19 INFO - warning: no files found matching '*.txt' 04:49:19 INFO - no previously-included directories found matching 'build' 04:49:19 INFO - no previously-included directories found matching 'dist' 04:49:19 INFO - no previously-included directories found matching '.git*' 04:49:19 INFO - Installing collected packages: jsonschema, functools32 04:49:19 INFO - Running setup.py install for functools32 04:49:19 INFO - warning: no files found matching '*.txt' 04:49:19 INFO - no previously-included directories found matching 'build' 04:49:19 INFO - no previously-included directories found matching 'dist' 04:49:19 INFO - no previously-included directories found matching '.git*' 04:49:19 INFO - Successfully installed jsonschema functools32 04:49:19 INFO - Cleaning up... 04:49:19 INFO - Return code: 0 04:49:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f776a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f786420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a93599850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, '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.nW2ytVD86M/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.44TgSd1tIm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:19 INFO - 'HOME': '/Users/cltbld', 04:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:19 INFO - 'LOGNAME': 'cltbld', 04:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:19 INFO - 'MOZ_NO_REMOTE': '1', 04:49:19 INFO - 'NO_EM_RESTART': '1', 04:49:19 INFO - 'PAGER': '/bin/cat', 04:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:19 INFO - 'PWD': '/builds/slave/test', 04:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:19 INFO - 'SHELL': '/bin/bash', 04:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:19 INFO - 'USER': 'cltbld', 04:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:19 INFO - 'XPC_FLAGS': '0x0', 04:49:19 INFO - 'XPC_SERVICE_NAME': '0', 04:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:19 INFO - Downloading/unpacking flake8 04:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:49:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:49:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:23 INFO - no previously-included directories found matching 'docs/_build' 04:49:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:49:23 INFO - Running setup.py install for pep8 04:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:23 INFO - no previously-included directories found matching 'docs/_build' 04:49:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:49:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:49:23 INFO - Cleaning up... 04:49:23 INFO - Return code: 0 04:49:23 INFO - Running post-action listener: _resource_record_post_action 04:49:23 INFO - Running post-action listener: _start_resource_monitoring 04:49:23 INFO - Starting resource monitoring. 04:49:23 INFO - ##### 04:49:23 INFO - ##### Running install step. 04:49:23 INFO - ##### 04:49:23 INFO - Running pre-action listener: _resource_record_pre_action 04:49:23 INFO - Running main action method: install 04:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:24 INFO - Reading from file tmpfile_stdout 04:49:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:24 INFO - Reading from file tmpfile_stdout 04:49:24 INFO - Output received: 04:49:24 INFO - Usage: mozinstall [options] installer 04:49:24 INFO - Options: 04:49:24 INFO - -h, --help show this help message and exit 04:49:24 INFO - -d DEST, --destination=DEST 04:49:24 INFO - Directory to install application into. [default: 04:49:24 INFO - "/builds/slave/test"] 04:49:24 INFO - --app=APP Application being installed. [default: firefox] 04:49:24 INFO - mkdir: /builds/slave/test/build/application 04:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:49:57 INFO - Reading from file tmpfile_stdout 04:49:57 INFO - Output received: 04:49:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:49:57 INFO - Running post-action listener: _resource_record_post_action 04:49:57 INFO - ##### 04:49:57 INFO - ##### Running run-tests step. 04:49:57 INFO - ##### 04:49:57 INFO - Running pre-action listener: _resource_record_pre_action 04:49:57 INFO - Running main action method: run_tests 04:49:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:49:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:49:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:49:57 INFO - 2016-04-28 04:49:57.634 screenresolution[2416:10425] starting screenresolution argv=screenresolution get 04:49:57 INFO - 2016-04-28 04:49:57.637 screenresolution[2416:10425] Display 0: 1600x1200x32@60 04:49:57 INFO - 2016-04-28 04:49:57.643 screenresolution[2417:10427] starting screenresolution argv=screenresolution list 04:49:57 INFO - Available Modes on Display 0 04:49:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:49:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:49:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:49:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:49:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:49:57 INFO - Intel Iris: 04:49:57 INFO - Chipset Model: Intel Iris 04:49:57 INFO - Type: GPU 04:49:57 INFO - Bus: Built-In 04:49:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:49:57 INFO - Vendor: Intel (0x8086) 04:49:57 INFO - Device ID: 0x0a2e 04:49:57 INFO - Revision ID: 0x0009 04:49:57 INFO - Displays: 04:49:57 INFO - Display: 04:49:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:49:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:49:57 INFO - Display Serial Number: 1600x1200 60 04:49:57 INFO - Main Display: Yes 04:49:57 INFO - Mirror: Off 04:49:57 INFO - Online: Yes 04:49:57 INFO - Rotation: Supported 04:49:57 INFO - Return code: 0 04:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:57 INFO - Python 2.7.3 04:49:57 INFO - Return code: 0 04:49:57 INFO - grabbing minidump binary from tooltool 04:49: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')]} 04:49:57 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 0x10f615e00>, '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 0x10f43edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f610b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:57 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 04:49:57 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 04:49:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:57 INFO - Return code: 0 04:49:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:49:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:49:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:49:59 INFO - Return code: 0 04:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nW2ytVD86M/Render', 04:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:59 INFO - 'HOME': '/Users/cltbld', 04:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:59 INFO - 'LOGNAME': 'cltbld', 04:49:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:59 INFO - 'MOZ_NO_REMOTE': '1', 04:49:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:59 INFO - 'NO_EM_RESTART': '1', 04:49:59 INFO - 'PAGER': '/bin/cat', 04:49:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:59 INFO - 'PWD': '/builds/slave/test', 04:49:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:59 INFO - 'SHELL': '/bin/bash', 04:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.44TgSd1tIm/Listeners', 04:49:59 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:59 INFO - 'USER': 'cltbld', 04:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:59 INFO - 'XPC_FLAGS': '0x0', 04:49:59 INFO - 'XPC_SERVICE_NAME': '0', 04:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:49:59 INFO - mozversion application_buildid: 20160428034800 04:49:59 INFO - mozversion application_changeset: 830f7765555a3740103c31100118bf318cf785b2 04:49:59 INFO - mozversion application_display_name: Nightly 04:49:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:59 INFO - mozversion application_name: Firefox 04:49:59 INFO - mozversion application_remotingname: firefox 04:49:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:49:59 INFO - mozversion application_vendor: Mozilla 04:49:59 INFO - mozversion application_version: 49.0a1 04:49:59 INFO - mozversion platform_buildid: 20160428034800 04:49:59 INFO - mozversion platform_changeset: 830f7765555a3740103c31100118bf318cf785b2 04:49:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:49:59 INFO - mozversion platform_version: 49.0a1 04:49:59 INFO - using testdate: 1461844199 04:49:59 INFO - actual date: 1461844199 04:49:59 INFO - starting webserver on 'localhost:49643' 04:49:59 INFO - SUITE-START | Running 2 tests 04:49:59 INFO - TEST-START | dromaeo_css 04:49:59 INFO - operating with platform_type : mac_ 04:49:59 INFO - Initialising browser for dromaeo_css test... 04:49:59 INFO - TEST-INFO | started process 2435 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp9l_Afj/profile http://localhost:49643/getInfo.html) 04:50:01 INFO - PROCESS | 2435 | __metrics Screen width/height:1600/1200 04:50:01 INFO - PROCESS | 2435 | colorDepth:24 04:50:01 INFO - PROCESS | 2435 | Browser inner width/height: 1024/689 04:50:01 INFO - PROCESS | 2435 | __metrics 04:50:01 INFO - PROCESS | 2435 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:50:01 ERROR - PROCESS | 2435 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:50:02 INFO - TEST-INFO | 2435: exit 0 04:50:02 INFO - Browser initialized. 04:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:02 INFO - TEST-INFO | started process 2437 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp9l_Afj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:14 INFO - PROCESS | 2437 | RSS: Main: 239636480 04:50:14 INFO - PROCESS | 2437 | 04:51:05 INFO - PROCESS | 2437 | 1461844265419 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] 04:53:16 INFO - PROCESS | 2437 | Cycle 1(1): loaded http://localhost:49643/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49643/tests/dromaeo/cssquery-ext.html) 04:53:17 INFO - PROCESS | 2437 | RSS: Main: 345665536 04:53:17 INFO - PROCESS | 2437 | 04:56:20 INFO - PROCESS | 2437 | Cycle 1(1): loaded http://localhost:49643/tests/dromaeo/cssquery-ext.html (next: http://localhost:49643/tests/dromaeo/cssquery-jquery.html) 04:56:20 INFO - PROCESS | 2437 | RSS: Main: 377335808 04:56:20 INFO - PROCESS | 2437 | 04:59:23 INFO - PROCESS | 2437 | Cycle 1(1): loaded http://localhost:49643/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49643/tests/dromaeo/cssquery-mootools.html) 04:59:23 INFO - PROCESS | 2437 | RSS: Main: 377311232 04:59:23 INFO - PROCESS | 2437 | 05:02:25 INFO - PROCESS | 2437 | Cycle 1(1): loaded http://localhost:49643/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49643/tests/dromaeo/cssquery-prototype.html) 05:02:26 INFO - PROCESS | 2437 | RSS: Main: 379682816 05:02:26 INFO - PROCESS | 2437 | 05:05:29 INFO - PROCESS | 2437 | Cycle 1(1): loaded http://localhost:49643/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49643/tests/dromaeo/cssquery-yui.html) 05:05:30 INFO - PROCESS | 2437 | RSS: Main: 344727552 05:05:30 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | Cycle 1(1): loaded http://localhost:49643/tests/dromaeo/cssquery-yui.html (next: http://localhost:49643/tests/dromaeo/cssquery-dojo.html) 05:08:33 INFO - PROCESS | 2437 | RSS: Main: 382652416 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | __start_tp_report 05:08:33 INFO - PROCESS | 2437 | _x_x_mozilla_page_load 05:08:33 INFO - PROCESS | 2437 | _x_x_mozilla_page_load_details 05:08:33 INFO - PROCESS | 2437 | |i|pagename|runs| 05:08:33 INFO - PROCESS | 2437 | |0;dojo.html;2840.28992751812;3324.9501257481143;3383.849491173002;3407.318536292742;3451.5167876497294;5562.527185189264;5612.438756124386;5615.185798059279;5627.606067575266;5645.294338207724;5591.888162236753;5649.915251271234;5653.830385088454;5663.5186009189165;5668.659880407178;5088.18589025755;5092.694438333693;5103.362079740033;5138.229265610151;5177.275181474596;5176.870578235536;5177.938522602857;5179.507946745072;5187.714675692835;5190.325257716491;5131.102057140004;5159.638825282232;5165.431802501722;5167.302414174094;5186.1442861927735;5156.922646160292;5195.142801437758;5225.947740522623;5230.816921407771;5260.132078207092;4957.231629097496;5046.394432668067;5056.016949999481;5127.923081153748;5144.84565463033;5531.944680553183;5563.972180139073;5570.61005729595;5585.1063829787445;5591.832245032656;6098.57309988301;6139.570230083896;6140.815775526741;6150.231221097363;6152.046432802923;5963.612365196292;6073.478015924046;6113.1722649372705;6184;6202.782902598387;5741.339745929188;5744.885102297931;5774.191613174159;5776.33572139201;5790.189373487715;6149.046897730859;6174.413430724074;6180.690965451709;6190.845228869224;6198.597091189058;5822.475977162076;5924.940750592526;6003.7898673546215;6068.271807383054;6084.361142080106;6166.537509686791;6175.475084617768;6179.84550386244;6190.164327815687;6207.844803879939;6081.939180608226;6130.724117414727;6149.5080393568405;6167.506599472032;6168.074788781719;6036.577439579188;6098.91636565712;6126.908096378558;6182.443580077815;6190.535709821781;4816.301636262722;4831.396075490564;4855.5387238212315;4864.562189402971;4867.245576935581;4278.914421711548;4428.6678499112695;4447.666425018072;4447.73313601185;4461.330800379969;5661.575381846378;5674.659520428788;5686.061799803069;5692.9146062809095;5712.171735098387;6131.356207598227;6175.84560385985;6189.659568723673;6189.96905015472;6192.504599632019;4978.128827455181;5543.722813859291;5650.5479561634975;5657.20799088128;5666.716664166775;5268.736563171903;5285.233641122016;5308.946910530845;5322.281491998608;5348.705821179872;6146.0166373380935;6163.322034576193;6179.62922224668;6183.196184496077;6205.9760139576465;6080.179175811209;6151.5386346025125;6181.629102253879;6186.690665466798;6208.944479438416;6177.96911015442;6206.813795586139;6218.595791273553;6241.750329986749;6250.874982500415;6070;6079.513638908965;6084.452399284086;6095.573309868267;6115.917861975053;6036.909446358396;6110.847228819315;6172.475339596184;6173.629582225081;6194.783182588588;6050.42520960508;6051.152838602688;6063.363346848694;6070.696465176812;6127.816165515042;6013.037913933749;6056.3035250946705;6061;6070.150178974859;6092.390760923872;5683.573731970201;5687.3459552152035;5856.297244330707;5920.73356698941;5951.256092988377;5031;5962.07587823888;5975.910361344497;5986.281646202484;6011.519078473799;5716.199732037435;5807.070868660994;5822.475977162076;5831.912521312269;5834.679092649775 05:08:33 INFO - PROCESS | 2437 | |1;ext.html;504.8964962182753;507.13786562843177;529.3885562175689;574.5719439017931;597.0506894038483;25229.873850630745;29962.700372996263;29965.400691986146;30104.247393815167;30128.548071778914;30496.695033049662;37051.258974820485;38512.422313665316;38537.614623853755;38545.61454385455;9209.677661281856;9423.246140308793;9435.622575096988;9449.291303152291;9451;7898.447108702393;8268.173182681743;9468.337216394855;9482.383645063082;9500.097490738368;8413.789655258606;8528.658853645878;8535.445196062266;8538.316934645214;9745.951270243639;11157.497912593954;11267.943660281728;11273.54905803775;11277.548898044068;11285.943570282096;8227.42408031438;11164.385958772264;11166.776664466664;11169.832452513137;11185.217034807567;28691.42617147666;35423.82288088569;35638.821805891064;36087.917362479166;36168.63831361679;3180.475221588435;3299.6205436374644;3307.6196237432523;3500.475391638068;3606.8737594184076;25937.22188334334;26290;26305.3423664408;26305.605415918777;26456.603150952753;2701.3381721478167;2703.8377697338224;2716.4567086582565;2832.872520736572;2927.502324604822;340043;341111;341183.2940835305;341202;341477;32038.679613204036;32824;33454.498182527284;55445;55709.49307281101;33707.78652668416;33831.830840845636;33985.66014339825;34054.65945340564;34092.31815363729;14463.638409039648;14611.415543378145;14627.488037918834;14638.82889368848;14675.633109172142;12491.125621206429;12560.434780434902;12561.183523070971;12573.245605263714;12579.622611321674;7832.451728379073;7848.7645370638975;7857.960710196527;7926.841463170705;7938.087119981276;3101.8604162812726;3180.6978337057944;3248.512723091555;3303.5705358303267;3311.1391038330207;935.2704890185666;1038.2472707287307;1040.1886528507775;1058.4178701714027;1138.1577632552016;27620.44759104847;27698.5845212322;28485.287867803472;28501.71498285032;28574.428511429654;1016.2632091733434;1041.1358572385054;1068.1454836131063;1084.0568705226503;1161.692151579832;13660.86339136596;13862.4455021798;13988.720225595634;13999.440022399194;14217.004809663224;411476;474470;486187;488375;488952;42700.359494607605;43507.56492435098;50922.981540368986;52495.16266930639;52583.478734733064;1443.5741456270425;1463.817022872141;1473.24864319198;1483.339913738376;1483.4140514496714;26556.46887062209;27046.323841904108;27512.312192195357;27635.170944871687;27789.583156253077;46559.76720116378;46876.7656161717;48014.759926200146;48017;48153.5184648149;332375.7480614078;339668;401559;402879.98560008185;421796;24510.87744561266;24832.875835620707;24851.378715532257;24890.751092488845;24945.75054249434;40018.599814001485;40961.975950601474;41418.792906035276;41462.37806432966;42370;32545.674543254263;33638.3937472579;34372.14069648179;34565.65434345725;35430.645693542734;33819;34085.31829363448;34464.104474254156;34778;34980.30039399147;33561;34491;34552.30895382028;34814.47778283378;34832.82583587066;29043.564346534396;30189.849050754605;30240.941567045047;30249.395012100074;30292.22880469938;23372.532549349256;23662.509302871444;23785.048598056575;23967.880160599783;24120.87939560291 05:08:33 INFO - PROCESS | 2437 | |2;jquery.html;351.3201954218587;358.924625828576;359.955005624297;366.19619934244326;373.72531189575676;18385.356512522063;19163.0418479076;19656.312029078985;19821.504462388446;19867.20531178753;18974;19554.217831286765;19611.921344326056;19835.801641983577;19932.50168745782;5734.655920644754;5925.88148237035;5948.910766338508;5952.58331916766;5966.224390829186;5360.383555891083;5662.518685911702;5667.603267771257;5668.093105103184;5695;5650.039493286151;5657.377688454267;5667.716614169296;5671.234383358255;5918.940810591882;6207.503399728033;6389.393007664265;6399.36006399361;6399.87200255997;6403.4877209823335;5249.265102885599;5510;5519.613627046108;5525.944740552583;5539.362973258087;11869;12094.39970406358;12133.757324853454;12156.209846359958;18925.33761318361;2127.106615221611;2152.397328747953;2366.9585382431846;2455.7789798918006;2642.405458771761;8719.825603487894;8850.291976641918;9119.589618467118;9172.08279172084;9307.301952353533;1686.6205103851657;1689.5184872311456;1692.213120898788;1707.8719096067844;1725.9137043147919;99621;99895.50052249765;100464;101359.49320253351;102263;10094.990500949847;10187.439690817077;10193.490325483845;10202.285839991278;10316.071553560216;12562.937185314198;12634.494620215271;12642.87357126417;12645.557405490948;12653.493860245488;6648.96675516629;8044.316233120133;8229.135940726137;8322.16778322163;8327.541985190872;8423.663053477792;8439.113893041265;8449.281811046007;8556.61495232716;8607.397482176188;4001.4998125234347;4025.577314382006;4027.859024934113;4091.6931230157857;4101.446304748881;1596.2497626115708;1685.595457090314;1764.2942822870955;1774.1306759687918;1789.9284028638708;749.4379215588309;812.5206128384164;900.7252787899754;976.6549567730494;1086.2613422872523;18846.905765471085;19369.32207372735;19401.708974365396;19644.70532942007;20058.39824805258;851.9223182673923;926.1294383279695;955.6416343871049;1029.6396261308482;1033.5245786938092;10302.381857088598;10700.571977120984;10747.086497647631;10752.19358548112;10789.892101079045;562039;567815;569976;585838;586370.1362986316;107540;111297;111890;113353.43323283331;113859.43070284762;1001.8096561653263;1022.223110436074;1026.3687831983277;1042.0517329230515;1048.192891473561;16566;17212.569685757455;17683.823161768218;17708.734368984216;17745.556361091076;44917.877053073935;46218;46872.06255874932;48867.5113248863;49252.507474924794;46676.7666161667;64874;65045.69908601896;70429;70469;7072.575645461289;7285.890711639436;7345.375643070185;7419.258074192753;7613.162552119152;10115.696529104138;11845.822312665145;12135.148240163731;12145.939270303592;12307.138500305251;10347.741306467398;10361.844572331573;10382.532786024798;10546.20903432261;10767.838482422614;10178.389296642225;10247.538860751432;10558.472076395996;10579.682609521727;10675.14598832076;10564;10660.360378377321;10683.786324273626;10913.781724365626;10976.835347469634;7386.778396648109;7454.291842274975;7518.323350898227;7527.698892044257;7784.182660820532;9814.165795907427;10526.999935006163;10560.947195263974;10828.24202305831;10859.402732849769 05:08:33 INFO - PROCESS | 2437 | |3;mootools.html;1413.8162038934936;1581.691570143822;1593.936242550298;1833.495788658119;1967.5376286572643;7852.489588176772;8566.314694824414;8778.736637900858;8787.692430764924;8788.209061184492;8450.112738162497;8674.089220631837;8687.652493900236;8687.913120868789;8703.65185392585;2356.3637817789186;2389.0682633772844;2390.521895620874;2393.581123303415;2396.2930935374106;2343.308723926446;2352.729436114843;2390;2401.7478164792706;2405.398650337416;2363.7990770784504;2376.5128148729555;2390.3546042568496;2400.927972160838;2401.0275838285525;2317.768223177669;2355.0815182079004;2361.964570531452;2363.2555744940373;2375.251795684354;2323.3378487131085;2342.8828558572004;2357.846739961897;2359.8702071386065;2361.055577768889;8589.699360522414;8617.526036068013;8724.52015139167;8729.563521823884;8756.255718263956;4576.771161441948;5149.45930677281;5373.892522149574;5393.1370980643305;5404.729763511848;3350.8324583770714;3443.345764304774;3516.261585067139;3524.5065690803053;3525.841337139809;934.1779234273863;952.4904176265734;957.6600306891023;973.5570315506499;980.764616492044;11627.76744465106;11715;11752.765959574208;11753.706157346049;11764.705882352924;4513.842015529506;4710.6702530823195;4934.3338649282605;4951.183054795918;4967.552920237196;9076.909230907739;9126;9140.725778226664;9142.131497507726;9153.267738580898;5240.030594340059;5274.657147285414;5278.5513231375;5281.234221037928;5282.075636763551;4028.7582745035393;4445.666575006888;4795.544423279783;4864.051509955525;4917.87705307363;3294.7364210863075;3398.4392575225306;3501.964980350215;3624.3838547447;3649.489071529988;998.8513209808633;1069.5614797932965;1076.3272954403499;1089.1722291058852;1091.4542728635681;704.3519961635205;839.928606068491;890.9287257019423;908.9864800747251;934.3272843552631;5767;5789.768409263666;5791.044477661138;5999.610025348338;6038.373595784817;919.7562645898843;962.9951850240844;970.277143528062;976.3507267666922;977.1449981266392;3562.28754249146;3658.067192865802;3771.8868433947027;3773.6981041516615;3775.7923314217983;9322.394044387092;10231.181505479544;10696.518656660313;10720.517576709066;10894.455277236106;10724;10827.296225745302;10860.239783215098;10861.728456788644;10866.836997445045;7640.159582445926;8153.8776918346275;8222.62998165084;8225.177482251727;8243.587820609066;4526.864194074183;5561.1658251261015;5561.277033985556;5827.271591051119;5853.619514731528;8893.777655558662;9625.759356016155;9903.702888913343;9939.900600993897;9961.003899609981;7925.603719813871;9976.750581235527;9997.400155990665;10057.899421005697;10116.08955194036;8192;8382.790430239293;8390.202930721573;8395.622197001028;8407.45351552147;6959.791206263821;8055.637496312563;8307.169283071886;8308.83382332362;8348.87476687838;7375.926240737524;7484.850302993801;7485.989391432087;7578.166401695698;7655.770326890202;7326.96336518314;7350.485466017328;7413.1104267488245;7445.664945077377;7487.925120748723;6911.136107986502;7055.4708396871465;7064.823379415556;7065.975433562207;7069.328413800681;4721.480637129982;4787.18617834962;4885.706857588556;4928.088303663833;5031.949680503149;4017.9598204017584;4442.600165985077;4818.975905120452;4871.3667223260745;4983.6760610560195 05:08:33 INFO - PROCESS | 2437 | |4;prototype.html;251.96976362836463;291.966423861256;292.34514687100886;297.57892581996475;297.58486910759484;5336.943922618809;5358.276632654591;5395.73021348933;5410.648307859987;5454.427285135063;4918.803247870081;5301.151815709478;5308.495692909168;5334.7996700742315;5387.346626915756;3177.094528059498;3864.7294689371756;3948.743331683446;3953.3674612062077;4055.371417430288;3299.967000330002;3984.2031593681236;4027.295223335919;4051.392291156321;4064.2074795414906;4022.356422972325;4025.8188381522755;4029.37544680575;4050;4052.9189416211657;3823.4073718573663;3848.4034974578985;3877.728559000871;3926.666233370153;4053.878383648466;3342.364950659367;3481.8781342652887;3493.0394141611005;3514.68367846895;3525.9118522037156;4184.790760461965;5048.400073961912;5127.9230811537855;5136.614753893473;5204.34945631796;4266.568056207962;4444.266695995157;4506.233940230169;4604.6876640157725;4630.72215667061;4766.189747742892;4925.753712314406;5075.949240507584;5320.920186197211;5578.3543854563;3599.892003239907;3720.441933709938;3738.831752571141;3741.345264578688;3759.642833930772;5768.250127483442;5915.438033386821;5950.613210141327;5961.463468287875;5990.675175277719;3720.2931443025736;3739.3082279778328;3740.8129593520216;3783.2055268393397;3802.5817160112365;3804.524434445694;3832.9425058624142;3837.808109594565;3844.154286057063;3847.499825022729;3836.8081595920094;4527.705699129612;4535.705179163344;4537.84452385121;4553.635709143261;5363.919541206885;5414.40441551429;5445.292112025411;5589.74846131925;5692.776053148593;1371.7050834070724;1394.6583087143513;1395.874371306567;1400.271858633505;1401.9579412617638;774.5004472115454;863.9481631102154;894.4230971023653;908.6728777640044;913.2648218184426;4388.802503887333;4871.2206047032305;5091.210862316347;5245.082110630625;5282.392524859613;4764.785584648699;5486;5576.048383065976;5802.303723553201;5823.5341172706085;4965.379327584052;5053.772580233898;5303.893922121536;5336.973315133399;5360.91958620621;2874.8131371460786;3378.8141652209365;3381.7801842880135;3388.3900897838625;3402.0644322811427;6121.50023244308;6444.967775161094;6680;6710.496712746563;6750.143710479658;6259.217597800275;6491.058796474485;6588.439982601437;6610;6652.301508341555;5754;6632.403083722488;6644.900326495203;6653.434458071119;6663.700133493908;4646.07406741303;5064.46823083571;5960.701964901824;5980.252468441445;6504.1219435375615;4829.806807727651;5434.728263586726;5696.487316141567;5841.591088623755;5867.9413205867395;5751.97124014394;6177.382261773966;6179.938200617937;6195.845103872259;6230.006397952611;3349.547811045478;3775.754575952554;3782.3569993100687;3800.904977375588;3803.7337386382687;5526.171074338881;5643.492085712305;5684.261046063985;5899.342407707249;5957.672328021827;5382.766152046856;5783.570900222001;5787.363390027178;5809.738561764646;5818.389069147678;5723.942760572341;5731.598788084794;5748.252727145445;5778.855528611818;5802.9399563154475;5572.247746554163;5639.295088113986;5643.830685079454;5655.123455864347;5742.215025712442;5166.328377311076;5245.7114858683135;5259.342582177228;5401.810936617199;5672.461116193955;4988.201887697951;5148.742562871917;5641.464060914206;5697.601167918206;5715.542756579381 05:08:33 INFO - PROCESS | 2437 | |5;yui.html;649.3311888754583;655.4461480049357;662.4898827902515;669.6517810738413;751.1361933776155;11328.433578321092;14577.56267311981;15065.774013389795;15084;15397.768178545717;13427.731445371086;14122.64693382666;14170.29148542574;14171.149731016147;14200.786988195185;695.944324454045;723.7322190789415;871.6600525794945;874.7332063720579;884.3014018925041;865.6277800545763;900.6442455230181;901.7069452427954;901.711452335253;902.5848109869468;947.8436058050413;952.3095755577186;953.0993211415181;954.5990683912773;956.1585804492038;734.3684431389001;760.7185341423709;762.0284137724391;944.489975413276;949.9240060795154;565.3752603373255;688.786476192377;698.1168821440881;701.2741812224324;701.7649087555624;14951.626209344744;15026.323815428332;15050.32273547693;15059.472918447911;15062.472813451586;11859.703507412383;12138.211016283913;12342.13605047647;12530.971690133874;12611.432485538173;9653.71038868835;9849.409035457895;9923.751906202331;10084.546195421224;10166.491675416273;3380.7464440167087;3499.8950031499094;3503.3869072912394;3571.8035508047046;3730.5336832895887;73211.63394183049;73721;74000.62999684968;74088;75017.62491187564;9135.269178465707;9136;9168.954155229181;9194.90805091954;9590.328676992543;20426.69359959602;20453.38639840807;20471.692924606145;20482.692759608617;20497.2825951091;7167.677454514559;7209.35115839577;7307.415406767446;7386.852262954818;7447.180810110884;3878.553966293856;3921.274564205631;3932.7640341579595;3938.448617193595;3996.640302372742;3472.4964880092753;3549.0949807798847;3555.8933232003083;3558.928821423557;3562.1985053362787;596.758312883283;608.8477880529867;614.7418084404471;615.7813976038532;616.5345164400849;558.8546977785805;589.9292084949748;604.6553464525178;618.0574623698806;632.8765890651371;7690.384769218561;8039.678412863537;8049.195080492021;8094.109647938722;8418.353401879513;455.43980903488233;504.97222652754454;523.6596212461855;551.239289780109;579.6782785554058;3747.7001839852746;3754.4368344748505;3784.848606055782;3794.9810250948567;4004.279229738675;95861.56207656891;96320;97632;98237;98377.50811245898;80542.19457805464;80875;82754;83437;83542.58228708818;62244;72203.91694124593;72680.90978635325;73706.62933706587;73781.26218737851;7516.586587737727;7723.266289702469;7977.760667179994;8039.477433966774;8176.141505141874;33872;40822.59177408188;41151.794241028605;41612.37581436341;42134.36798447964;60615;61312.69343653253;62836.37163628305;63059.054114187406;63096.36903630905;8946.86579701292;10949.178811589321;11244.606438774603;11306.378149201873;11664.358460284766;11973.580924667594;12189.817152742893;12323.50705971787;12533.435995380047;12832.037597180435;10169.88131305541;11279.492422841156;11840.940795295968;11853.703657408289;11929.105317101426;9910.454924979196;10692.98416650417;10979.780404391708;11181.888181118411;11384.43077846121;11030.669079927615;11031.393273370042;11375.943120284346;11434.828477572677;11505.252158609663;7713.92286077132;9386.108319709616;9766.46284454362;9782.755431113994;9841.360311579725;8564.700235491728;9579.568919398504;9599.712008639752;9642.807143857224;9802.264830137625 05:08:33 INFO - PROCESS | 2437 | __end_tp_report 05:08:33 INFO - PROCESS | 2437 | __start_cc_report 05:08:33 INFO - PROCESS | 2437 | _x_x_mozilla_cycle_collect,1175 05:08:33 INFO - PROCESS | 2437 | __end_cc_report 05:08:33 INFO - PROCESS | 2437 | __startTimestamp1461845313869__endTimestamp 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | ------- Summary: start ------- 05:08:33 INFO - PROCESS | 2437 | Number of tests: 6 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | [#0] dojo.html Cycles:165 Average:5658.48 Median:5831.91 stddev:632.35 (10.8%) stddev-sans-first:594.39 05:08:33 INFO - PROCESS | 2437 | Values: 2840.3 3325.0 3383.8 3407.3 3451.5 5562.5 5612.4 5615.2 5627.6 5645.3 5591.9 5649.9 5653.8 5663.5 5668.7 5088.2 5092.7 5103.4 5138.2 5177.3 5176.9 5177.9 5179.5 5187.7 5190.3 5131.1 5159.6 5165.4 5167.3 5186.1 5156.9 5195.1 5225.9 5230.8 5260.1 4957.2 5046.4 5056.0 5127.9 5144.8 5531.9 5564.0 5570.6 5585.1 5591.8 6098.6 6139.6 6140.8 6150.2 6152.0 5963.6 6073.5 6113.2 6184.0 6202.8 5741.3 5744.9 5774.2 5776.3 5790.2 6149.0 6174.4 6180.7 6190.8 6198.6 5822.5 5924.9 6003.8 6068.3 6084.4 6166.5 6175.5 6179.8 6190.2 6207.8 6081.9 6130.7 6149.5 6167.5 6168.1 6036.6 6098.9 6126.9 6182.4 6190.5 4816.3 4831.4 4855.5 4864.6 4867.2 4278.9 4428.7 4447.7 4447.7 4461.3 5661.6 5674.7 5686.1 5692.9 5712.2 6131.4 6175.8 6189.7 6190.0 6192.5 4978.1 5543.7 5650.5 5657.2 5666.7 5268.7 5285.2 5308.9 5322.3 5348.7 6146.0 6163.3 6179.6 6183.2 6206.0 6080.2 6151.5 6181.6 6186.7 6208.9 6178.0 6206.8 6218.6 6241.8 6250.9 6070.0 6079.5 6084.5 6095.6 6115.9 6036.9 6110.8 6172.5 6173.6 6194.8 6050.4 6051.2 6063.4 6070.7 6127.8 6013.0 6056.3 6061.0 6070.2 6092.4 5683.6 5687.3 5856.3 5920.7 5951.3 5031.0 5962.1 5975.9 5986.3 6011.5 5716.2 5807.1 5822.5 5831.9 5834.7 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | [#1] ext.html Cycles:180 Average:52178.41 Median:167843.44 stddev:106645.10 (63.5%) stddev-sans-first:106873.69 05:08:33 INFO - PROCESS | 2437 | Values: 504.9 507.1 529.4 574.6 597.1 25229.9 29962.7 29965.4 30104.2 30128.5 30496.7 37051.3 38512.4 38537.6 38545.6 9209.7 9423.2 9435.6 9449.3 9451.0 7898.4 8268.2 9468.3 9482.4 9500.1 8413.8 8528.7 8535.4 8538.3 9746.0 11157.5 11267.9 11273.5 11277.5 11285.9 8227.4 11164.4 11166.8 11169.8 11185.2 28691.4 35423.8 35638.8 36087.9 36168.6 3180.5 3299.6 3307.6 3500.5 3606.9 25937.2 26290.0 26305.3 26305.6 26456.6 2701.3 2703.8 2716.5 2832.9 2927.5 340043.0 341111.0 341183.3 341202.0 341477.0 32038.7 32824.0 33454.5 55445.0 55709.5 33707.8 33831.8 33985.7 34054.7 34092.3 14463.6 14611.4 14627.5 14638.8 14675.6 12491.1 12560.4 12561.2 12573.2 12579.6 7832.5 7848.8 7858.0 7926.8 7938.1 3101.9 3180.7 3248.5 3303.6 3311.1 935.3 1038.2 1040.2 1058.4 1138.2 27620.4 27698.6 28485.3 28501.7 28574.4 1016.3 1041.1 1068.1 1084.1 1161.7 13660.9 13862.4 13988.7 13999.4 14217.0 411476.0 474470.0 486187.0 488375.0 488952.0 42700.4 43507.6 50923.0 52495.2 52583.5 1443.6 1463.8 1473.2 1483.3 1483.4 26556.5 27046.3 27512.3 27635.2 27789.6 46559.8 46876.8 48014.8 48017.0 48153.5 332375.7 339668.0 401559.0 402880.0 421796.0 24510.9 24832.9 24851.4 24890.8 24945.8 40018.6 40962.0 41418.8 41462.4 42370.0 32545.7 33638.4 34372.1 34565.7 35430.6 33819.0 34085.3 34464.1 34778.0 34980.3 33561.0 34491.0 34552.3 34814.5 34832.8 29043.6 30189.8 30240.9 30249.4 30292.2 23372.5 23662.5 23785.0 23967.9 24120.9 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | [#2] jquery.html Cycles:180 Average:32126.25 Median:2139.75 stddev:95272.05 (4452.5%) stddev-sans-first:95509.43 05:08:33 INFO - PROCESS | 2437 | Values: 351.3 358.9 360.0 366.2 373.7 18385.4 19163.0 19656.3 19821.5 19867.2 18974.0 19554.2 19611.9 19835.8 19932.5 5734.7 5925.9 5948.9 5952.6 5966.2 5360.4 5662.5 5667.6 5668.1 5695.0 5650.0 5657.4 5667.7 5671.2 5918.9 6207.5 6389.4 6399.4 6399.9 6403.5 5249.3 5510.0 5519.6 5525.9 5539.4 11869.0 12094.4 12133.8 12156.2 18925.3 2127.1 2152.4 2367.0 2455.8 2642.4 8719.8 8850.3 9119.6 9172.1 9307.3 1686.6 1689.5 1692.2 1707.9 1725.9 99621.0 99895.5 100464.0 101359.5 102263.0 10095.0 10187.4 10193.5 10202.3 10316.1 12562.9 12634.5 12642.9 12645.6 12653.5 6649.0 8044.3 8229.1 8322.2 8327.5 8423.7 8439.1 8449.3 8556.6 8607.4 4001.5 4025.6 4027.9 4091.7 4101.4 1596.2 1685.6 1764.3 1774.1 1789.9 749.4 812.5 900.7 976.7 1086.3 18846.9 19369.3 19401.7 19644.7 20058.4 851.9 926.1 955.6 1029.6 1033.5 10302.4 10700.6 10747.1 10752.2 10789.9 562039.0 567815.0 569976.0 585838.0 586370.1 107540.0 111297.0 111890.0 113353.4 113859.4 1001.8 1022.2 1026.4 1042.1 1048.2 16566.0 17212.6 17683.8 17708.7 17745.6 44917.9 46218.0 46872.1 48867.5 49252.5 46676.8 64874.0 65045.7 70429.0 70469.0 7072.6 7285.9 7345.4 7419.3 7613.2 10115.7 11845.8 12135.1 12145.9 12307.1 10347.7 10361.8 10382.5 10546.2 10767.8 10178.4 10247.5 10558.5 10579.7 10675.1 10564.0 10660.4 10683.8 10913.8 10976.8 7386.8 7454.3 7518.3 7527.7 7784.2 9814.2 10527.0 10560.9 10828.2 10859.4 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | [#3] mootools.html Cycles:180 Average:5621.59 Median:5279.89 stddev:3174.43 (60.1%) stddev-sans-first:3167.58 05:08:33 INFO - PROCESS | 2437 | Values: 1413.8 1581.7 1593.9 1833.5 1967.5 7852.5 8566.3 8778.7 8787.7 8788.2 8450.1 8674.1 8687.7 8687.9 8703.7 2356.4 2389.1 2390.5 2393.6 2396.3 2343.3 2352.7 2390.0 2401.7 2405.4 2363.8 2376.5 2390.4 2400.9 2401.0 2317.8 2355.1 2362.0 2363.3 2375.3 2323.3 2342.9 2357.8 2359.9 2361.1 8589.7 8617.5 8724.5 8729.6 8756.3 4576.8 5149.5 5373.9 5393.1 5404.7 3350.8 3443.3 3516.3 3524.5 3525.8 934.2 952.5 957.7 973.6 980.8 11627.8 11715.0 11752.8 11753.7 11764.7 4513.8 4710.7 4934.3 4951.2 4967.6 9076.9 9126.0 9140.7 9142.1 9153.3 5240.0 5274.7 5278.6 5281.2 5282.1 4028.8 4445.7 4795.5 4864.1 4917.9 3294.7 3398.4 3502.0 3624.4 3649.5 998.9 1069.6 1076.3 1089.2 1091.5 704.4 839.9 890.9 909.0 934.3 5767.0 5789.8 5791.0 5999.6 6038.4 919.8 963.0 970.3 976.4 977.1 3562.3 3658.1 3771.9 3773.7 3775.8 9322.4 10231.2 10696.5 10720.5 10894.5 10724.0 10827.3 10860.2 10861.7 10866.8 7640.2 8153.9 8222.6 8225.2 8243.6 4526.9 5561.2 5561.3 5827.3 5853.6 8893.8 9625.8 9903.7 9939.9 9961.0 7925.6 9976.8 9997.4 10057.9 10116.1 8192.0 8382.8 8390.2 8395.6 8407.5 6959.8 8055.6 8307.2 8308.8 8348.9 7375.9 7484.9 7486.0 7578.2 7655.8 7327.0 7350.5 7413.1 7445.7 7487.9 6911.1 7055.5 7064.8 7066.0 7069.3 4721.5 4787.2 4885.7 4928.1 5031.9 4018.0 4442.6 4819.0 4871.4 4983.7 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | [#4] prototype.html Cycles:180 Average:4641.38 Median:5224.72 stddev:1488.38 (28.5%) stddev-sans-first:1455.64 05:08:33 INFO - PROCESS | 2437 | Values: 252.0 292.0 292.3 297.6 297.6 5336.9 5358.3 5395.7 5410.6 5454.4 4918.8 5301.2 5308.5 5334.8 5387.3 3177.1 3864.7 3948.7 3953.4 4055.4 3300.0 3984.2 4027.3 4051.4 4064.2 4022.4 4025.8 4029.4 4050.0 4052.9 3823.4 3848.4 3877.7 3926.7 4053.9 3342.4 3481.9 3493.0 3514.7 3525.9 4184.8 5048.4 5127.9 5136.6 5204.3 4266.6 4444.3 4506.2 4604.7 4630.7 4766.2 4925.8 5075.9 5320.9 5578.4 3599.9 3720.4 3738.8 3741.3 3759.6 5768.3 5915.4 5950.6 5961.5 5990.7 3720.3 3739.3 3740.8 3783.2 3802.6 3804.5 3832.9 3837.8 3844.2 3847.5 3836.8 4527.7 4535.7 4537.8 4553.6 5363.9 5414.4 5445.3 5589.7 5692.8 1371.7 1394.7 1395.9 1400.3 1402.0 774.5 863.9 894.4 908.7 913.3 4388.8 4871.2 5091.2 5245.1 5282.4 4764.8 5486.0 5576.0 5802.3 5823.5 4965.4 5053.8 5303.9 5337.0 5360.9 2874.8 3378.8 3381.8 3388.4 3402.1 6121.5 6445.0 6680.0 6710.5 6750.1 6259.2 6491.1 6588.4 6610.0 6652.3 5754.0 6632.4 6644.9 6653.4 6663.7 4646.1 5064.5 5960.7 5980.3 6504.1 4829.8 5434.7 5696.5 5841.6 5867.9 5752.0 6177.4 6179.9 6195.8 6230.0 3349.5 3775.8 3782.4 3800.9 3803.7 5526.2 5643.5 5684.3 5899.3 5957.7 5382.8 5783.6 5787.4 5809.7 5818.4 5723.9 5731.6 5748.3 5778.9 5802.9 5572.2 5639.3 5643.8 5655.1 5742.2 5166.3 5245.7 5259.3 5401.8 5672.5 4988.2 5148.7 5641.5 5697.6 5715.5 05:08:33 INFO - PROCESS | 2437 | 05:08:33 INFO - PROCESS | 2437 | [#5] yui.html Cycles:180 Average:17831.34 Median:617.30 stddev:25471.62 (4126.3%) stddev-sans-first:25510.40 05:08:33 INFO - PROCESS | 2437 | Values: 649.3 655.4 662.5 669.7 751.1 11328.4 14577.6 15065.8 15084.0 15397.8 13427.7 14122.6 14170.3 14171.1 14200.8 695.9 723.7 871.7 874.7 884.3 865.6 900.6 901.7 901.7 902.6 947.8 952.3 953.1 954.6 956.2 734.4 760.7 762.0 944.5 949.9 565.4 688.8 698.1 701.3 701.8 14951.6 15026.3 15050.3 15059.5 15062.5 11859.7 12138.2 12342.1 12531.0 12611.4 9653.7 9849.4 9923.8 10084.5 10166.5 3380.7 3499.9 3503.4 3571.8 3730.5 73211.6 73721.0 74000.6 74088.0 75017.6 9135.3 9136.0 9169.0 9194.9 9590.3 20426.7 20453.4 20471.7 20482.7 20497.3 7167.7 7209.4 7307.4 7386.9 7447.2 3878.6 3921.3 3932.8 3938.4 3996.6 3472.5 3549.1 3555.9 3558.9 3562.2 596.8 608.8 614.7 615.8 616.5 558.9 589.9 604.7 618.1 632.9 7690.4 8039.7 8049.2 8094.1 8418.4 455.4 505.0 523.7 551.2 579.7 3747.7 3754.4 3784.8 3795.0 4004.3 95861.6 96320.0 97632.0 98237.0 98377.5 80542.2 80875.0 82754.0 83437.0 83542.6 62244.0 72203.9 72680.9 73706.6 73781.3 7516.6 7723.3 7977.8 8039.5 8176.1 33872.0 40822.6 41151.8 41612.4 42134.4 60615.0 61312.7 62836.4 63059.1 63096.4 8946.9 10949.2 11244.6 11306.4 11664.4 11973.6 12189.8 12323.5 12533.4 12832.0 10169.9 11279.5 11840.9 11853.7 11929.1 9910.5 10693.0 10979.8 11181.9 11384.4 11030.7 11031.4 11375.9 11434.8 11505.3 7713.9 9386.1 9766.5 9782.8 9841.4 8564.7 9579.6 9599.7 9642.8 9802.3 05:08:33 INFO - PROCESS | 2437 | -------- Summary: end -------- 05:08:33 INFO - PROCESS | 2437 | 05:08:34 INFO - TEST-INFO | 2437: exit 0 05:08:34 INFO - TEST-OK | dromaeo_css | took 1115315ms 05:08:34 INFO - TEST-START | kraken 05:08:34 INFO - operating with platform_type : mac_ 05:08:34 INFO - Initialising browser for kraken test... 05:08:34 INFO - TEST-INFO | started process 2442 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpkiakte/profile http://localhost:49643/getInfo.html) 05:08:36 INFO - PROCESS | 2442 | __metrics Screen width/height:1600/1200 05:08:36 INFO - PROCESS | 2442 | colorDepth:24 05:08:36 INFO - PROCESS | 2442 | Browser inner width/height: 1024/689 05:08:36 INFO - PROCESS | 2442 | __metrics 05:08:36 INFO - PROCESS | 2442 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:08:36 ERROR - PROCESS | 2442 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:08:37 INFO - TEST-INFO | 2442: exit 0 05:08:37 INFO - Browser initialized. 05:08:37 INFO - Running cycle 1/1 for kraken test... 05:08:37 INFO - TEST-INFO | started process 2444 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpkiakte/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:49 INFO - PROCESS | 2444 | RSS: Main: 239435776 05:08:49 INFO - PROCESS | 2444 | 05:08:52 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49643/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:52 INFO - PROCESS | 2444 | RSS: Main: 286752768 05:08:52 INFO - PROCESS | 2444 | 05:08:55 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49643/tests/kraken/driver.html?testName=audio-dft) 05:08:56 INFO - PROCESS | 2444 | RSS: Main: 299479040 05:08:56 INFO - PROCESS | 2444 | 05:09:00 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49643/tests/kraken/driver.html?testName=audio-fft) 05:09:00 INFO - PROCESS | 2444 | RSS: Main: 386940928 05:09:00 INFO - PROCESS | 2444 | 05:09:02 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49643/tests/kraken/driver.html?testName=audio-oscillator) 05:09:03 INFO - PROCESS | 2444 | RSS: Main: 286392320 05:09:03 INFO - PROCESS | 2444 | 05:09:05 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49643/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:06 INFO - PROCESS | 2444 | RSS: Main: 290910208 05:09:06 INFO - PROCESS | 2444 | 05:09:08 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49643/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:09 INFO - PROCESS | 2444 | RSS: Main: 327360512 05:09:09 INFO - PROCESS | 2444 | 05:09:12 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49643/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:12 INFO - PROCESS | 2444 | RSS: Main: 331005952 05:09:12 INFO - PROCESS | 2444 | 05:09:15 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49643/tests/kraken/driver.html?testName=json-parse-financial) 05:09:16 INFO - PROCESS | 2444 | RSS: Main: 328962048 05:09:16 INFO - PROCESS | 2444 | 05:09:17 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49643/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:18 INFO - PROCESS | 2444 | RSS: Main: 321531904 05:09:18 INFO - PROCESS | 2444 | 05:09:20 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:20 INFO - PROCESS | 2444 | RSS: Main: 328187904 05:09:20 INFO - PROCESS | 2444 | 05:09:23 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:23 INFO - PROCESS | 2444 | RSS: Main: 329965568 05:09:23 INFO - PROCESS | 2444 | 05:09:26 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:27 INFO - PROCESS | 2444 | RSS: Main: 327651328 05:09:27 INFO - PROCESS | 2444 | 05:09:30 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:31 INFO - PROCESS | 2444 | RSS: Main: 328232960 05:09:31 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | Cycle 1(1): loaded http://localhost:49643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49643/tests/kraken/driver.html?testName=ai-astar) 05:09:33 INFO - PROCESS | 2444 | RSS: Main: 393678848 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | __start_tp_report 05:09:33 INFO - PROCESS | 2444 | _x_x_mozilla_page_load 05:09:33 INFO - PROCESS | 2444 | _x_x_mozilla_page_load_details 05:09:33 INFO - PROCESS | 2444 | |i|pagename|runs| 05:09:33 INFO - PROCESS | 2444 | |0;ai-astar;112;111;108;111;112;112;112;112;107;113 05:09:33 INFO - PROCESS | 2444 | |1;audio-beat-detection;181;148;166;169;117;144;150;145;215;136 05:09:33 INFO - PROCESS | 2444 | |2;audio-dft;184;184;186;206;243;185;185;183;181;181 05:09:33 INFO - PROCESS | 2444 | |3;audio-fft;78;73;94;95;82;84;84;89;89;55 05:09:33 INFO - PROCESS | 2444 | |4;audio-oscillator;95;98;140;78;81;80;126;79;77;127 05:09:33 INFO - PROCESS | 2444 | |5;imaging-gaussian-blur;88;84;88;86;87;85;87;84;87;85 05:09:33 INFO - PROCESS | 2444 | |6;imaging-darkroom;94;93;94;93;93;95;95;94;93;94 05:09:33 INFO - PROCESS | 2444 | |7;imaging-desaturate;84;84;84;86;85;84;83;85;84;84 05:09:33 INFO - PROCESS | 2444 | |8;json-parse-financial;61;62;59;58;60;58;58;79;60;58 05:09:33 INFO - PROCESS | 2444 | |9;json-stringify-tinderbox;65;71;64;72;70;65;68;67;68;67 05:09:33 INFO - PROCESS | 2444 | |10;stanford-crypto-aes;84;82;83;98;107;106;82;82;82;83 05:09:33 INFO - PROCESS | 2444 | |11;stanford-crypto-ccm;155;157;129;128;189;153;153;135;232;143 05:09:33 INFO - PROCESS | 2444 | |12;stanford-crypto-pbkdf2;201;201;198;199;199;199;198;198;207;205 05:09:33 INFO - PROCESS | 2444 | |13;stanford-crypto-sha256-iterative;70;70;71;69;70;70;71;69;76;91 05:09:33 INFO - PROCESS | 2444 | __end_tp_report 05:09:33 INFO - PROCESS | 2444 | __start_cc_report 05:09:33 INFO - PROCESS | 2444 | _x_x_mozilla_cycle_collect,1983 05:09:33 INFO - PROCESS | 2444 | __end_cc_report 05:09:33 INFO - PROCESS | 2444 | __startTimestamp1461845373361__endTimestamp 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | ------- Summary: start ------- 05:09:33 INFO - PROCESS | 2444 | Number of tests: 14 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:1.94 (1.7%) stddev-sans-first:2.03 05:09:33 INFO - PROCESS | 2444 | Values: 112.0 111.0 108.0 111.0 112.0 112.0 112.0 112.0 107.0 113.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#1] audio-beat-detection Cycles:10 Average:157.10 Median:158.00 stddev:27.18 (17.2%) stddev-sans-first:27.42 05:09:33 INFO - PROCESS | 2444 | Values: 181.0 148.0 166.0 169.0 117.0 144.0 150.0 145.0 215.0 136.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#2] audio-dft Cycles:10 Average:191.80 Median:185.00 stddev:19.38 (10.5%) stddev-sans-first:20.35 05:09:33 INFO - PROCESS | 2444 | Values: 184.0 184.0 186.0 206.0 243.0 185.0 185.0 183.0 181.0 181.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#3] audio-fft Cycles:10 Average:82.30 Median:86.50 stddev:11.76 (13.6%) stddev-sans-first:12.37 05:09:33 INFO - PROCESS | 2444 | Values: 78.0 73.0 94.0 95.0 82.0 84.0 84.0 89.0 89.0 55.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:79.50 stddev:24.07 (30.3%) stddev-sans-first:25.50 05:09:33 INFO - PROCESS | 2444 | Values: 95.0 98.0 140.0 78.0 81.0 80.0 126.0 79.0 77.0 127.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.45 05:09:33 INFO - PROCESS | 2444 | Values: 88.0 84.0 88.0 86.0 87.0 85.0 87.0 84.0 87.0 85.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 05:09:33 INFO - PROCESS | 2444 | Values: 94.0 93.0 94.0 93.0 93.0 95.0 95.0 94.0 93.0 94.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 05:09:33 INFO - PROCESS | 2444 | Values: 84.0 84.0 84.0 86.0 85.0 84.0 83.0 85.0 84.0 84.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:60.00 stddev:6.38 (10.6%) stddev-sans-first:6.76 05:09:33 INFO - PROCESS | 2444 | Values: 61.0 62.0 59.0 58.0 60.0 58.0 58.0 79.0 60.0 58.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:2.67 (3.9%) stddev-sans-first:2.65 05:09:33 INFO - PROCESS | 2444 | Values: 65.0 71.0 64.0 72.0 70.0 65.0 68.0 67.0 68.0 67.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:82.50 stddev:10.47 (12.7%) stddev-sans-first:10.96 05:09:33 INFO - PROCESS | 2444 | Values: 84.0 82.0 83.0 98.0 107.0 106.0 82.0 82.0 82.0 83.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#11] stanford-crypto-ccm Cycles:10 Average:157.40 Median:154.00 stddev:31.60 (20.5%) stddev-sans-first:33.51 05:09:33 INFO - PROCESS | 2444 | Values: 155.0 157.0 129.0 128.0 189.0 153.0 153.0 135.0 232.0 143.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.50 Median:200.00 stddev:3.14 (1.6%) stddev-sans-first:3.32 05:09:33 INFO - PROCESS | 2444 | Values: 201.0 201.0 198.0 199.0 199.0 199.0 198.0 198.0 207.0 205.0 05:09:33 INFO - PROCESS | 2444 | 05:09:33 INFO - PROCESS | 2444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:70.50 stddev:6.73 (9.6%) stddev-sans-first:7.07 05:09:33 INFO - PROCESS | 2444 | Values: 70.0 70.0 71.0 69.0 70.0 70.0 71.0 69.0 76.0 91.0 05:09:33 INFO - PROCESS | 2444 | -------- Summary: end -------- 05:09:33 INFO - PROCESS | 2444 | 05:09:34 INFO - TEST-INFO | 2444: exit 0 05:09:34 INFO - TEST-OK | kraken | took 59676ms 05:09:34 INFO - SUITE-END | took 1174s 05:09:34 INFO - Completed test suite (00:19:35) 05:09:34 INFO - javascript benchmark 05:09:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2840.28992751812, 3324.9501257481143, 3383.849491173002, 3407.318536292742, 3451.5167876497294, 5562.527185189264, 5612.438756124386, 5615.185798059279, 5627.606067575266, 5645.294338207724, 5591.888162236753, 5649.915251271234, 5653.830385088454, 5663.5186009189165, 5668.659880407178, 5088.18589025755, 5092.694438333693, 5103.362079740033, 5138.229265610151, 5177.275181474596, 5176.870578235536, 5177.938522602857, 5179.507946745072, 5187.714675692835, 5190.325257716491, 5131.102057140004, 5159.638825282232, 5165.431802501722, 5167.302414174094, 5186.1442861927735, 5156.922646160292, 5195.142801437758, 5225.947740522623, 5230.816921407771, 5260.132078207092, 4957.231629097496, 5046.394432668067, 5056.016949999481, 5127.923081153748, 5144.84565463033, 5531.944680553183, 5563.972180139073, 5570.61005729595, 5585.1063829787445, 5591.832245032656, 6098.57309988301, 6139.570230083896, 6140.815775526741, 6150.231221097363, 6152.046432802923, 5963.612365196292, 6073.478015924046, 6113.1722649372705, 6184.0, 6202.782902598387, 5741.339745929188, 5744.885102297931, 5774.191613174159, 5776.33572139201, 5790.189373487715, 6149.046897730859, 6174.413430724074, 6180.690965451709, 6190.845228869224, 6198.597091189058, 5822.475977162076, 5924.940750592526, 6003.7898673546215, 6068.271807383054, 6084.361142080106, 6166.537509686791, 6175.475084617768, 6179.84550386244, 6190.164327815687, 6207.844803879939, 6081.939180608226, 6130.724117414727, 6149.5080393568405, 6167.506599472032, 6168.074788781719, 6036.577439579188, 6098.91636565712, 6126.908096378558, 6182.443580077815, 6190.535709821781, 4816.301636262722, 4831.396075490564, 4855.5387238212315, 4864.562189402971, 4867.245576935581, 4278.914421711548, 4428.6678499112695, 4447.666425018072, 4447.73313601185, 4461.330800379969, 5661.575381846378, 5674.659520428788, 5686.061799803069, 5692.9146062809095, 5712.171735098387, 6131.356207598227, 6175.84560385985, 6189.659568723673, 6189.96905015472, 6192.504599632019, 4978.128827455181, 5543.722813859291, 5650.5479561634975, 5657.20799088128, 5666.716664166775, 5268.736563171903, 5285.233641122016, 5308.946910530845, 5322.281491998608, 5348.705821179872, 6146.0166373380935, 6163.322034576193, 6179.62922224668, 6183.196184496077, 6205.9760139576465, 6080.179175811209, 6151.5386346025125, 6181.629102253879, 6186.690665466798, 6208.944479438416, 6177.96911015442, 6206.813795586139, 6218.595791273553, 6241.750329986749, 6250.874982500415, 6070.0, 6079.513638908965, 6084.452399284086, 6095.573309868267, 6115.917861975053, 6036.909446358396, 6110.847228819315, 6172.475339596184, 6173.629582225081, 6194.783182588588, 6050.42520960508, 6051.152838602688, 6063.363346848694, 6070.696465176812, 6127.816165515042, 6013.037913933749, 6056.3035250946705, 6061.0, 6070.150178974859, 6092.390760923872, 5683.573731970201, 5687.3459552152035, 5856.297244330707, 5920.73356698941, 5951.256092988377, 5031.0, 5962.07587823888, 5975.910361344497, 5986.281646202484, 6011.519078473799, 5716.199732037435, 5807.070868660994, 5822.475977162076, 5831.912521312269, 5834.679092649775], "value": 5617.449085960966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.8964962182753, 507.13786562843177, 529.3885562175689, 574.5719439017931, 597.0506894038483, 25229.873850630745, 29962.700372996263, 29965.400691986146, 30104.247393815167, 30128.548071778914, 30496.695033049662, 37051.258974820485, 38512.422313665316, 38537.614623853755, 38545.61454385455, 9209.677661281856, 9423.246140308793, 9435.622575096988, 9449.291303152291, 9451.0, 7898.447108702393, 8268.173182681743, 9468.337216394855, 9482.383645063082, 9500.097490738368, 8413.789655258606, 8528.658853645878, 8535.445196062266, 8538.316934645214, 9745.951270243639, 11157.497912593954, 11267.943660281728, 11273.54905803775, 11277.548898044068, 11285.943570282096, 8227.42408031438, 11164.385958772264, 11166.776664466664, 11169.832452513137, 11185.217034807567, 28691.42617147666, 35423.82288088569, 35638.821805891064, 36087.917362479166, 36168.63831361679, 3180.475221588435, 3299.6205436374644, 3307.6196237432523, 3500.475391638068, 3606.8737594184076, 25937.22188334334, 26290.0, 26305.3423664408, 26305.605415918777, 26456.603150952753, 2701.3381721478167, 2703.8377697338224, 2716.4567086582565, 2832.872520736572, 2927.502324604822, 340043.0, 341111.0, 341183.2940835305, 341202.0, 341477.0, 32038.679613204036, 32824.0, 33454.498182527284, 55445.0, 55709.49307281101, 33707.78652668416, 33831.830840845636, 33985.66014339825, 34054.65945340564, 34092.31815363729, 14463.638409039648, 14611.415543378145, 14627.488037918834, 14638.82889368848, 14675.633109172142, 12491.125621206429, 12560.434780434902, 12561.183523070971, 12573.245605263714, 12579.622611321674, 7832.451728379073, 7848.7645370638975, 7857.960710196527, 7926.841463170705, 7938.087119981276, 3101.8604162812726, 3180.6978337057944, 3248.512723091555, 3303.5705358303267, 3311.1391038330207, 935.2704890185666, 1038.2472707287307, 1040.1886528507775, 1058.4178701714027, 1138.1577632552016, 27620.44759104847, 27698.5845212322, 28485.287867803472, 28501.71498285032, 28574.428511429654, 1016.2632091733434, 1041.1358572385054, 1068.1454836131063, 1084.0568705226503, 1161.692151579832, 13660.86339136596, 13862.4455021798, 13988.720225595634, 13999.440022399194, 14217.004809663224, 411476.0, 474470.0, 486187.0, 488375.0, 488952.0, 42700.359494607605, 43507.56492435098, 50922.981540368986, 52495.16266930639, 52583.478734733064, 1443.5741456270425, 1463.817022872141, 1473.24864319198, 1483.339913738376, 1483.4140514496714, 26556.46887062209, 27046.323841904108, 27512.312192195357, 27635.170944871687, 27789.583156253077, 46559.76720116378, 46876.7656161717, 48014.759926200146, 48017.0, 48153.5184648149, 332375.7480614078, 339668.0, 401559.0, 402879.98560008185, 421796.0, 24510.87744561266, 24832.875835620707, 24851.378715532257, 24890.751092488845, 24945.75054249434, 40018.599814001485, 40961.975950601474, 41418.792906035276, 41462.37806432966, 42370.0, 32545.674543254263, 33638.3937472579, 34372.14069648179, 34565.65434345725, 35430.645693542734, 33819.0, 34085.31829363448, 34464.104474254156, 34778.0, 34980.30039399147, 33561.0, 34491.0, 34552.30895382028, 34814.47778283378, 34832.82583587066, 29043.564346534396, 30189.849050754605, 30240.941567045047, 30249.395012100074, 30292.22880469938, 23372.532549349256, 23662.509302871444, 23785.048598056575, 23967.880160599783, 24120.87939560291], "value": 17024.22210360006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.3201954218587, 358.924625828576, 359.955005624297, 366.19619934244326, 373.72531189575676, 18385.356512522063, 19163.0418479076, 19656.312029078985, 19821.504462388446, 19867.20531178753, 18974.0, 19554.217831286765, 19611.921344326056, 19835.801641983577, 19932.50168745782, 5734.655920644754, 5925.88148237035, 5948.910766338508, 5952.58331916766, 5966.224390829186, 5360.383555891083, 5662.518685911702, 5667.603267771257, 5668.093105103184, 5695.0, 5650.039493286151, 5657.377688454267, 5667.716614169296, 5671.234383358255, 5918.940810591882, 6207.503399728033, 6389.393007664265, 6399.36006399361, 6399.87200255997, 6403.4877209823335, 5249.265102885599, 5510.0, 5519.613627046108, 5525.944740552583, 5539.362973258087, 11869.0, 12094.39970406358, 12133.757324853454, 12156.209846359958, 18925.33761318361, 2127.106615221611, 2152.397328747953, 2366.9585382431846, 2455.7789798918006, 2642.405458771761, 8719.825603487894, 8850.291976641918, 9119.589618467118, 9172.08279172084, 9307.301952353533, 1686.6205103851657, 1689.5184872311456, 1692.213120898788, 1707.8719096067844, 1725.9137043147919, 99621.0, 99895.50052249765, 100464.0, 101359.49320253351, 102263.0, 10094.990500949847, 10187.439690817077, 10193.490325483845, 10202.285839991278, 10316.071553560216, 12562.937185314198, 12634.494620215271, 12642.87357126417, 12645.557405490948, 12653.493860245488, 6648.96675516629, 8044.316233120133, 8229.135940726137, 8322.16778322163, 8327.541985190872, 8423.663053477792, 8439.113893041265, 8449.281811046007, 8556.61495232716, 8607.397482176188, 4001.4998125234347, 4025.577314382006, 4027.859024934113, 4091.6931230157857, 4101.446304748881, 1596.2497626115708, 1685.595457090314, 1764.2942822870955, 1774.1306759687918, 1789.9284028638708, 749.4379215588309, 812.5206128384164, 900.7252787899754, 976.6549567730494, 1086.2613422872523, 18846.905765471085, 19369.32207372735, 19401.708974365396, 19644.70532942007, 20058.39824805258, 851.9223182673923, 926.1294383279695, 955.6416343871049, 1029.6396261308482, 1033.5245786938092, 10302.381857088598, 10700.571977120984, 10747.086497647631, 10752.19358548112, 10789.892101079045, 562039.0, 567815.0, 569976.0, 585838.0, 586370.1362986316, 107540.0, 111297.0, 111890.0, 113353.43323283331, 113859.43070284762, 1001.8096561653263, 1022.223110436074, 1026.3687831983277, 1042.0517329230515, 1048.192891473561, 16566.0, 17212.569685757455, 17683.823161768218, 17708.734368984216, 17745.556361091076, 44917.877053073935, 46218.0, 46872.06255874932, 48867.5113248863, 49252.507474924794, 46676.7666161667, 64874.0, 65045.69908601896, 70429.0, 70469.0, 7072.575645461289, 7285.890711639436, 7345.375643070185, 7419.258074192753, 7613.162552119152, 10115.696529104138, 11845.822312665145, 12135.148240163731, 12145.939270303592, 12307.138500305251, 10347.741306467398, 10361.844572331573, 10382.532786024798, 10546.20903432261, 10767.838482422614, 10178.389296642225, 10247.538860751432, 10558.472076395996, 10579.682609521727, 10675.14598832076, 10564.0, 10660.360378377321, 10683.786324273626, 10913.781724365626, 10976.835347469634, 7386.778396648109, 7454.291842274975, 7518.323350898227, 7527.698892044257, 7784.182660820532, 9814.165795907427, 10526.999935006163, 10560.947195263974, 10828.24202305831, 10859.402732849769], "value": 8869.975311907272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.8162038934936, 1581.691570143822, 1593.936242550298, 1833.495788658119, 1967.5376286572643, 7852.489588176772, 8566.314694824414, 8778.736637900858, 8787.692430764924, 8788.209061184492, 8450.112738162497, 8674.089220631837, 8687.652493900236, 8687.913120868789, 8703.65185392585, 2356.3637817789186, 2389.0682633772844, 2390.521895620874, 2393.581123303415, 2396.2930935374106, 2343.308723926446, 2352.729436114843, 2390.0, 2401.7478164792706, 2405.398650337416, 2363.7990770784504, 2376.5128148729555, 2390.3546042568496, 2400.927972160838, 2401.0275838285525, 2317.768223177669, 2355.0815182079004, 2361.964570531452, 2363.2555744940373, 2375.251795684354, 2323.3378487131085, 2342.8828558572004, 2357.846739961897, 2359.8702071386065, 2361.055577768889, 8589.699360522414, 8617.526036068013, 8724.52015139167, 8729.563521823884, 8756.255718263956, 4576.771161441948, 5149.45930677281, 5373.892522149574, 5393.1370980643305, 5404.729763511848, 3350.8324583770714, 3443.345764304774, 3516.261585067139, 3524.5065690803053, 3525.841337139809, 934.1779234273863, 952.4904176265734, 957.6600306891023, 973.5570315506499, 980.764616492044, 11627.76744465106, 11715.0, 11752.765959574208, 11753.706157346049, 11764.705882352924, 4513.842015529506, 4710.6702530823195, 4934.3338649282605, 4951.183054795918, 4967.552920237196, 9076.909230907739, 9126.0, 9140.725778226664, 9142.131497507726, 9153.267738580898, 5240.030594340059, 5274.657147285414, 5278.5513231375, 5281.234221037928, 5282.075636763551, 4028.7582745035393, 4445.666575006888, 4795.544423279783, 4864.051509955525, 4917.87705307363, 3294.7364210863075, 3398.4392575225306, 3501.964980350215, 3624.3838547447, 3649.489071529988, 998.8513209808633, 1069.5614797932965, 1076.3272954403499, 1089.1722291058852, 1091.4542728635681, 704.3519961635205, 839.928606068491, 890.9287257019423, 908.9864800747251, 934.3272843552631, 5767.0, 5789.768409263666, 5791.044477661138, 5999.610025348338, 6038.373595784817, 919.7562645898843, 962.9951850240844, 970.277143528062, 976.3507267666922, 977.1449981266392, 3562.28754249146, 3658.067192865802, 3771.8868433947027, 3773.6981041516615, 3775.7923314217983, 9322.394044387092, 10231.181505479544, 10696.518656660313, 10720.517576709066, 10894.455277236106, 10724.0, 10827.296225745302, 10860.239783215098, 10861.728456788644, 10866.836997445045, 7640.159582445926, 8153.8776918346275, 8222.62998165084, 8225.177482251727, 8243.587820609066, 4526.864194074183, 5561.1658251261015, 5561.277033985556, 5827.271591051119, 5853.619514731528, 8893.777655558662, 9625.759356016155, 9903.702888913343, 9939.900600993897, 9961.003899609981, 7925.603719813871, 9976.750581235527, 9997.400155990665, 10057.899421005697, 10116.08955194036, 8192.0, 8382.790430239293, 8390.202930721573, 8395.622197001028, 8407.45351552147, 6959.791206263821, 8055.637496312563, 8307.169283071886, 8308.83382332362, 8348.87476687838, 7375.926240737524, 7484.850302993801, 7485.989391432087, 7578.166401695698, 7655.770326890202, 7326.96336518314, 7350.485466017328, 7413.1104267488245, 7445.664945077377, 7487.925120748723, 6911.136107986502, 7055.4708396871465, 7064.823379415556, 7065.975433562207, 7069.328413800681, 4721.480637129982, 4787.18617834962, 4885.706857588556, 4928.088303663833, 5031.949680503149, 4017.9598204017584, 4442.600165985077, 4818.975905120452, 4871.3667223260745, 4983.6760610560195], "value": 4496.033726534046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.96976362836463, 291.966423861256, 292.34514687100886, 297.57892581996475, 297.58486910759484, 5336.943922618809, 5358.276632654591, 5395.73021348933, 5410.648307859987, 5454.427285135063, 4918.803247870081, 5301.151815709478, 5308.495692909168, 5334.7996700742315, 5387.346626915756, 3177.094528059498, 3864.7294689371756, 3948.743331683446, 3953.3674612062077, 4055.371417430288, 3299.967000330002, 3984.2031593681236, 4027.295223335919, 4051.392291156321, 4064.2074795414906, 4022.356422972325, 4025.8188381522755, 4029.37544680575, 4050.0, 4052.9189416211657, 3823.4073718573663, 3848.4034974578985, 3877.728559000871, 3926.666233370153, 4053.878383648466, 3342.364950659367, 3481.8781342652887, 3493.0394141611005, 3514.68367846895, 3525.9118522037156, 4184.790760461965, 5048.400073961912, 5127.9230811537855, 5136.614753893473, 5204.34945631796, 4266.568056207962, 4444.266695995157, 4506.233940230169, 4604.6876640157725, 4630.72215667061, 4766.189747742892, 4925.753712314406, 5075.949240507584, 5320.920186197211, 5578.3543854563, 3599.892003239907, 3720.441933709938, 3738.831752571141, 3741.345264578688, 3759.642833930772, 5768.250127483442, 5915.438033386821, 5950.613210141327, 5961.463468287875, 5990.675175277719, 3720.2931443025736, 3739.3082279778328, 3740.8129593520216, 3783.2055268393397, 3802.5817160112365, 3804.524434445694, 3832.9425058624142, 3837.808109594565, 3844.154286057063, 3847.499825022729, 3836.8081595920094, 4527.705699129612, 4535.705179163344, 4537.84452385121, 4553.635709143261, 5363.919541206885, 5414.40441551429, 5445.292112025411, 5589.74846131925, 5692.776053148593, 1371.7050834070724, 1394.6583087143513, 1395.874371306567, 1400.271858633505, 1401.9579412617638, 774.5004472115454, 863.9481631102154, 894.4230971023653, 908.6728777640044, 913.2648218184426, 4388.802503887333, 4871.2206047032305, 5091.210862316347, 5245.082110630625, 5282.392524859613, 4764.785584648699, 5486.0, 5576.048383065976, 5802.303723553201, 5823.5341172706085, 4965.379327584052, 5053.772580233898, 5303.893922121536, 5336.973315133399, 5360.91958620621, 2874.8131371460786, 3378.8141652209365, 3381.7801842880135, 3388.3900897838625, 3402.0644322811427, 6121.50023244308, 6444.967775161094, 6680.0, 6710.496712746563, 6750.143710479658, 6259.217597800275, 6491.058796474485, 6588.439982601437, 6610.0, 6652.301508341555, 5754.0, 6632.403083722488, 6644.900326495203, 6653.434458071119, 6663.700133493908, 4646.07406741303, 5064.46823083571, 5960.701964901824, 5980.252468441445, 6504.1219435375615, 4829.806807727651, 5434.728263586726, 5696.487316141567, 5841.591088623755, 5867.9413205867395, 5751.97124014394, 6177.382261773966, 6179.938200617937, 6195.845103872259, 6230.006397952611, 3349.547811045478, 3775.754575952554, 3782.3569993100687, 3800.904977375588, 3803.7337386382687, 5526.171074338881, 5643.492085712305, 5684.261046063985, 5899.342407707249, 5957.672328021827, 5382.766152046856, 5783.570900222001, 5787.363390027178, 5809.738561764646, 5818.389069147678, 5723.942760572341, 5731.598788084794, 5748.252727145445, 5778.855528611818, 5802.9399563154475, 5572.247746554163, 5639.295088113986, 5643.830685079454, 5655.123455864347, 5742.215025712442, 5166.328377311076, 5245.7114858683135, 5259.342582177228, 5401.810936617199, 5672.461116193955, 4988.201887697951, 5148.742562871917, 5641.464060914206, 5697.601167918206, 5715.542756579381], "value": 4161.331914859668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.3311888754583, 655.4461480049357, 662.4898827902515, 669.6517810738413, 751.1361933776155, 11328.433578321092, 14577.56267311981, 15065.774013389795, 15084.0, 15397.768178545717, 13427.731445371086, 14122.64693382666, 14170.29148542574, 14171.149731016147, 14200.786988195185, 695.944324454045, 723.7322190789415, 871.6600525794945, 874.7332063720579, 884.3014018925041, 865.6277800545763, 900.6442455230181, 901.7069452427954, 901.711452335253, 902.5848109869468, 947.8436058050413, 952.3095755577186, 953.0993211415181, 954.5990683912773, 956.1585804492038, 734.3684431389001, 760.7185341423709, 762.0284137724391, 944.489975413276, 949.9240060795154, 565.3752603373255, 688.786476192377, 698.1168821440881, 701.2741812224324, 701.7649087555624, 14951.626209344744, 15026.323815428332, 15050.32273547693, 15059.472918447911, 15062.472813451586, 11859.703507412383, 12138.211016283913, 12342.13605047647, 12530.971690133874, 12611.432485538173, 9653.71038868835, 9849.409035457895, 9923.751906202331, 10084.546195421224, 10166.491675416273, 3380.7464440167087, 3499.8950031499094, 3503.3869072912394, 3571.8035508047046, 3730.5336832895887, 73211.63394183049, 73721.0, 74000.62999684968, 74088.0, 75017.62491187564, 9135.269178465707, 9136.0, 9168.954155229181, 9194.90805091954, 9590.328676992543, 20426.69359959602, 20453.38639840807, 20471.692924606145, 20482.692759608617, 20497.2825951091, 7167.677454514559, 7209.35115839577, 7307.415406767446, 7386.852262954818, 7447.180810110884, 3878.553966293856, 3921.274564205631, 3932.7640341579595, 3938.448617193595, 3996.640302372742, 3472.4964880092753, 3549.0949807798847, 3555.8933232003083, 3558.928821423557, 3562.1985053362787, 596.758312883283, 608.8477880529867, 614.7418084404471, 615.7813976038532, 616.5345164400849, 558.8546977785805, 589.9292084949748, 604.6553464525178, 618.0574623698806, 632.8765890651371, 7690.384769218561, 8039.678412863537, 8049.195080492021, 8094.109647938722, 8418.353401879513, 455.43980903488233, 504.97222652754454, 523.6596212461855, 551.239289780109, 579.6782785554058, 3747.7001839852746, 3754.4368344748505, 3784.848606055782, 3794.9810250948567, 4004.279229738675, 95861.56207656891, 96320.0, 97632.0, 98237.0, 98377.50811245898, 80542.19457805464, 80875.0, 82754.0, 83437.0, 83542.58228708818, 62244.0, 72203.91694124593, 72680.90978635325, 73706.62933706587, 73781.26218737851, 7516.586587737727, 7723.266289702469, 7977.760667179994, 8039.477433966774, 8176.141505141874, 33872.0, 40822.59177408188, 41151.794241028605, 41612.37581436341, 42134.36798447964, 60615.0, 61312.69343653253, 62836.37163628305, 63059.054114187406, 63096.36903630905, 8946.86579701292, 10949.178811589321, 11244.606438774603, 11306.378149201873, 11664.358460284766, 11973.580924667594, 12189.817152742893, 12323.50705971787, 12533.435995380047, 12832.037597180435, 10169.88131305541, 11279.492422841156, 11840.940795295968, 11853.703657408289, 11929.105317101426, 9910.454924979196, 10692.98416650417, 10979.780404391708, 11181.888181118411, 11384.43077846121, 11030.669079927615, 11031.393273370042, 11375.943120284346, 11434.828477572677, 11505.252158609663, 7713.92286077132, 9386.108319709616, 9766.46284454362, 9782.755431113994, 9841.360311579725, 8564.700235491728, 9579.568919398504, 9599.712008639752, 9642.807143857224, 9802.264830137625], "value": 6691.6373178895865, "unit": "score"}], "name": "dromaeo_css", "value": 6881.667538225319, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 108.0, 111.0, 112.0, 112.0, 112.0, 112.0, 107.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 148.0, 166.0, 169.0, 117.0, 144.0, 150.0, 145.0, 215.0, 136.0], "value": 157.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 206.0, 243.0, 185.0, 185.0, 183.0, 181.0, 181.0], "value": 191.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 94.0, 95.0, 82.0, 84.0, 84.0, 89.0, 89.0, 55.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 140.0, 78.0, 81.0, 80.0, 126.0, 79.0, 77.0, 127.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 86.0, 87.0, 85.0, 87.0, 84.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 95.0, 95.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 85.0, 84.0, 83.0, 85.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 59.0, 58.0, 60.0, 58.0, 58.0, 79.0, 60.0, 58.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 64.0, 72.0, 70.0, 65.0, 68.0, 67.0, 68.0, 67.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 98.0, 107.0, 106.0, 82.0, 82.0, 82.0, 83.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 129.0, 128.0, 189.0, 153.0, 153.0, 135.0, 232.0, 143.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 201.0, 198.0, 199.0, 199.0, 199.0, 198.0, 198.0, 207.0, 205.0], "value": 200.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 69.0, 70.0, 70.0, 71.0, 69.0, 76.0, 91.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1553.0000000000002, "alertThreshold": 2.0}]} 05:09:34 INFO - Return code: 0 05:09:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:09:34 ERROR - # TBPL SUCCESS # 05:09:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:34 INFO - 2016-04-28 05:09:34.679 screenresolution[2448:12300] starting screenresolution argv=screenresolution get 05:09:34 INFO - 2016-04-28 05:09:34.683 screenresolution[2448:12300] Display 0: 1600x1200x32@60 05:09:34 INFO - 2016-04-28 05:09:34.690 screenresolution[2449:12303] starting screenresolution argv=screenresolution list 05:09:34 INFO - Available Modes on Display 0 05:09:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:34 INFO - Intel Iris: 05:09:34 INFO - Chipset Model: Intel Iris 05:09:34 INFO - Type: GPU 05:09:34 INFO - Bus: Built-In 05:09:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:34 INFO - Vendor: Intel (0x8086) 05:09:34 INFO - Device ID: 0x0a2e 05:09:34 INFO - Revision ID: 0x0009 05:09:34 INFO - Displays: 05:09:34 INFO - Display: 05:09:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:34 INFO - Display Serial Number: 1600x1200 60 05:09:34 INFO - Main Display: Yes 05:09:34 INFO - Mirror: Off 05:09:34 INFO - Online: Yes 05:09:34 INFO - Rotation: Supported 05:09:34 INFO - Return code: 0 05:09:34 INFO - Running post-action listener: _resource_record_post_action 05:09:34 INFO - Running post-run listener: _resource_record_post_run 05:09:35 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 28201472; Write bytes: 693763584; Read time: 276; Write time: 2411 05:09:35 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378477056; Write bytes: 372969984; Read time: 28221; Write time: 743 05:09:35 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 28201472; Write bytes: 295496704; Read time: 276; Write time: 1613 05:09:35 INFO - Running post-run listener: _upload_blobber_files 05:09:35 INFO - Blob upload gear active. 05:09:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:35 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 05:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:09:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:09:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:09:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:37 INFO - (blobuploader) - INFO - Done attempting. 05:09:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:09:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:09:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:38 INFO - (blobuploader) - INFO - Done attempting. 05:09:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:38 INFO - Return code: 0 05:09:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28d669bbe952a2c98f3dae6e4f7dddccbd20e2ea400f41ca01614f7bd59cd0ef1517077c912b1b72cad51c37cc1da70b5f68ab60b13b9a1777a5bfd293e5d316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0d9ed0269cd369548583fa73c120a692b1bf52e6e992a6c6ca4c117200f56a07e4d6aa028a268ac386b2842564b90108d4c1d3bac82756a16b195a8714a66a"} 05:09:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:38 INFO - Contents: 05:09:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28d669bbe952a2c98f3dae6e4f7dddccbd20e2ea400f41ca01614f7bd59cd0ef1517077c912b1b72cad51c37cc1da70b5f68ab60b13b9a1777a5bfd293e5d316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0d9ed0269cd369548583fa73c120a692b1bf52e6e992a6c6ca4c117200f56a07e4d6aa028a268ac386b2842564b90108d4c1d3bac82756a16b195a8714a66a"} 05:09:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:38 INFO - Copying logs to upload dir... 05:09:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.264536 ========= master_lag: 155.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 40 secs) (at 2016-04-28 05:12:13.806132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-28 05:12:13.809657) ========= 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.nW2ytVD86M/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.44TgSd1tIm/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28d669bbe952a2c98f3dae6e4f7dddccbd20e2ea400f41ca01614f7bd59cd0ef1517077c912b1b72cad51c37cc1da70b5f68ab60b13b9a1777a5bfd293e5d316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0d9ed0269cd369548583fa73c120a692b1bf52e6e992a6c6ca4c117200f56a07e4d6aa028a268ac386b2842564b90108d4c1d3bac82756a16b195a8714a66a"} build_url:https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011655 build_url: 'https://queue.taskcluster.net/v1/task/RyDmvbwlTji2thMMRd2eMw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28d669bbe952a2c98f3dae6e4f7dddccbd20e2ea400f41ca01614f7bd59cd0ef1517077c912b1b72cad51c37cc1da70b5f68ab60b13b9a1777a5bfd293e5d316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d0d9ed0269cd369548583fa73c120a692b1bf52e6e992a6c6ca4c117200f56a07e4d6aa028a268ac386b2842564b90108d4c1d3bac82756a16b195a8714a66a"}' ========= master_lag: 8.80 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-04-28 05:12:22.625557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2016-04-28 05:12:22.625873) ========= 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.nW2ytVD86M/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.44TgSd1tIm/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005275 ========= master_lag: 19.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 19 secs) (at 2016-04-28 05:12:42.228452) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-28 05:12:42.228748) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-28 05:12:43.443048) ========= ========= Total master_lag: 184.19 =========