builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0094 starttime: 1462839827.43 results: success (0) buildid: 20160509151608 builduid: fb9008fecaf946f99b5b59751abd7be3 revision: 687f1eb881d82a76ddc02e71c1778c82de125407 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.427794) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.428335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.428682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.450228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.450605) ========= 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.M16BkT0C2A/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.UkD83v16vb/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-09 17:23:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-05-09 17:23:47 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.599888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.600259) ========= 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.M16BkT0C2A/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.UkD83v16vb/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.027717 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:47.649394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 17:23:47.649934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 687f1eb881d82a76ddc02e71c1778c82de125407 --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 687f1eb881d82a76ddc02e71c1778c82de125407 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M16BkT0C2A/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.UkD83v16vb/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-09 17:23:47,727 truncating revision to first 12 chars 2016-05-09 17:23:47,727 Setting DEBUG logging. 2016-05-09 17:23:47,727 attempt 1/10 2016-05-09 17:23:47,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/687f1eb881d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 17:23:48,737 unpacking tar archive at: fx-team-687f1eb881d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 17:23:48.922228) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:48.922611) ========= script_repo_revision: 687f1eb881d82a76ddc02e71c1778c82de125407 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:48.923125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:48.923430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 17:23:48.937130) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-09 17:23:48.937633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M16BkT0C2A/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.UkD83v16vb/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:23:49 INFO - MultiFileLogger online at 20160509 17:23:49 in /builds/slave/test 17:23:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:23:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:23:49 INFO - {'append_to_log': False, 17:23:49 INFO - 'base_work_dir': '/builds/slave/test', 17:23:49 INFO - 'blob_upload_branch': 'Fx-Team', 17:23:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:23:49 INFO - 'branch': 'Fx-Team', 17:23:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:23:49 INFO - 'config_files': ('talos/mac_config.py',), 17:23:49 INFO - 'default_actions': ('clobber', 17:23:49 INFO - 'read-buildbot-config', 17:23:49 INFO - 'download-and-extract', 17:23:49 INFO - 'populate-webroot', 17:23:49 INFO - 'create-virtualenv', 17:23:49 INFO - 'install', 17:23:49 INFO - 'run-tests'), 17:23:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:23:49 INFO - 'download_minidump_stackwalk': True, 17:23:49 INFO - 'download_symbols': 'ondemand', 17:23:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:23:49 INFO - 'tooltool.py': '/tools/tooltool.py', 17:23:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:23:49 INFO - '/tools/misc-python/virtualenv.py')}, 17:23:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:23:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:23:49 INFO - 'installer_path': 'installer.exe', 17:23:49 INFO - 'log_level': 'info', 17:23:49 INFO - 'log_name': 'talos', 17:23:49 INFO - 'log_to_console': True, 17:23:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:23:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:23:49 INFO - 'opt_config_files': (), 17:23:49 INFO - 'pip_index': False, 17:23:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:23:49 INFO - 'cmd': ('bash', 17:23:49 INFO - '-c', 17:23:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:23:49 INFO - 'enabled': True, 17:23:49 INFO - 'halt_on_failure': False, 17:23:49 INFO - 'name': 'check_screen_resolution'},), 17:23:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:23:49 INFO - 'cmd': ('bash', 17:23:49 INFO - '-c', 17:23:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:23:49 INFO - 'enabled': True, 17:23:49 INFO - 'halt_on_failure': False, 17:23:49 INFO - 'name': 'check_screen_resolution'},), 17:23:49 INFO - 'run_cmd_checks_enabled': True, 17:23:49 INFO - 'sps_profile': False, 17:23:49 INFO - 'sps_profile_interval': 0, 17:23:49 INFO - 'suite': 'dromaeojs-e10s', 17:23:49 INFO - 'system_bits': '32', 17:23:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:23:49 INFO - 'title': 't-yosemite-r7-0094', 17:23:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:23:49 INFO - 'use_talos_json': True, 17:23:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:23:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:23:49 INFO - 'work_dir': 'build'} 17:23:49 INFO - ##### 17:23:49 INFO - ##### Running clobber step. 17:23:49 INFO - ##### 17:23:49 INFO - Running pre-action listener: _resource_record_pre_action 17:23:49 INFO - Running main action method: clobber 17:23:49 INFO - rmtree: /builds/slave/test/build 17:23:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:23:51 INFO - Running post-action listener: _resource_record_post_action 17:23:51 INFO - ##### 17:23:51 INFO - ##### Finished clobber step (success) 17:23:51 INFO - ##### 17:23:51 INFO - ##### 17:23:51 INFO - ##### Running read-buildbot-config step. 17:23:51 INFO - ##### 17:23:51 INFO - Running pre-action listener: _resource_record_pre_action 17:23:51 INFO - Running main action method: read_buildbot_config 17:23:51 INFO - Using buildbot properties: 17:23:51 INFO - { 17:23:51 INFO - "project": "", 17:23:51 INFO - "product": "firefox", 17:23:51 INFO - "script_repo_revision": "production", 17:23:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:23:51 INFO - "repository": "", 17:23:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:23:51 INFO - "buildid": "20160509151608", 17:23:51 INFO - "pgo_build": "False", 17:23:51 INFO - "basedir": "/builds/slave/test", 17:23:51 INFO - "buildnumber": 671, 17:23:51 INFO - "slavename": "t-yosemite-r7-0094", 17:23:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:23:51 INFO - "platform": "yosemite_r7", 17:23:51 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:23:51 INFO - "branch": "fx-team", 17:23:51 INFO - "repo_path": "integration/fx-team", 17:23:51 INFO - "revision": "687f1eb881d82a76ddc02e71c1778c82de125407", 17:23:51 INFO - "stage_platform": "macosx64", 17:23:51 INFO - "builduid": "fb9008fecaf946f99b5b59751abd7be3", 17:23:51 INFO - "slavebuilddir": "test" 17:23:51 INFO - } 17:23:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 17:23:51 INFO - Running post-action listener: _resource_record_post_action 17:23:51 INFO - ##### 17:23:51 INFO - ##### Finished read-buildbot-config step (success) 17:23:51 INFO - ##### 17:23:51 INFO - ##### 17:23:51 INFO - ##### Running download-and-extract step. 17:23:51 INFO - ##### 17:23:51 INFO - Running pre-action listener: _resource_record_pre_action 17:23:51 INFO - Running main action method: download_and_extract 17:23:51 INFO - mkdir: /builds/slave/test/build/tests 17:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:51 INFO - https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 17:23:51 INFO - Downloaded 1199 bytes. 17:23:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:23:51 INFO - Using the following test package requirements: 17:23:51 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:23:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 17:23:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 17:23:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'jsshell-mac.zip'], 17:23:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 17:23:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:23:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 17:23:51 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 17:23:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 17:23:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:23:51 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 17:23:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:51 INFO - https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:23:52 INFO - Downloaded 18146584 bytes. 17:23:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:23:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:23:56 INFO - Return code: 0 17:23:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:23:56 INFO - https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:23:57 INFO - Downloaded 18146584 bytes. 17:23:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:23:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:24:00 INFO - Return code: 0 17:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:00 INFO - https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:24:01 INFO - Downloaded 10840152 bytes. 17:24:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:24:01 INFO - Return code: 0 17:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:01 INFO - https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 17:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 17:24:05 INFO - Downloaded 110419471 bytes. 17:24:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:24:05 INFO - mkdir: /builds/slave/test/properties 17:24:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:05 INFO - Contents: 17:24:05 INFO - build_url:https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:24:06 INFO - Running post-action listener: _resource_record_post_action 17:24:06 INFO - Running post-action listener: set_extra_try_arguments 17:24:06 INFO - ##### 17:24:06 INFO - ##### Finished download-and-extract step (success) 17:24:06 INFO - ##### 17:24:06 INFO - ##### 17:24:06 INFO - ##### Running populate-webroot step. 17:24:06 INFO - ##### 17:24:06 INFO - Running pre-action listener: _resource_record_pre_action 17:24:06 INFO - Running main action method: populate_webroot 17:24:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:06 INFO - '--tppagecycles', 17:24:06 INFO - '7'], 17:24:06 INFO - 'tests': ['tsvgm']}}, 17:24:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['damp', 'tps']}, 17:24:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'tests': ['damp', 'tps']}, 17:24:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['dromaeo_dom']}, 17:24:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['a11yr', 17:24:06 INFO - 'ts_paint', 17:24:06 INFO - 'tpaint', 17:24:06 INFO - 'sessionrestore', 17:24:06 INFO - 'sessionrestore_no_auto_restore', 17:24:06 INFO - 'tabpaint']}, 17:24:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:06 INFO - 'ts_paint', 17:24:06 INFO - 'tpaint', 17:24:06 INFO - 'sessionrestore', 17:24:06 INFO - 'sessionrestore_no_auto_restore', 17:24:06 INFO - 'tabpaint']}, 17:24:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:06 INFO - 'ts_paint', 17:24:06 INFO - 'tpaint', 17:24:06 INFO - 'sessionrestore', 17:24:06 INFO - 'sessionrestore_no_auto_restore', 17:24:06 INFO - 'tabpaint']}, 17:24:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:06 INFO - 'ts_paint', 17:24:06 INFO - 'tpaint', 17:24:06 INFO - 'sessionrestore', 17:24:06 INFO - 'sessionrestore_no_auto_restore', 17:24:06 INFO - 'tabpaint']}, 17:24:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['a11yr', 17:24:06 INFO - 'ts_paint', 17:24:06 INFO - 'tpaint', 17:24:06 INFO - 'sessionrestore', 17:24:06 INFO - 'sessionrestore_no_auto_restore', 17:24:06 INFO - 'tabpaint']}, 17:24:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['a11yr', 17:24:06 INFO - 'ts_paint', 17:24:06 INFO - 'tpaint', 17:24:06 INFO - 'sessionrestore', 17:24:06 INFO - 'sessionrestore_no_auto_restore', 17:24:06 INFO - 'tabpaint']}, 17:24:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['tsvgx', 17:24:06 INFO - 'tsvgr_opacity', 17:24:06 INFO - 'tart', 17:24:06 INFO - 'tscrollx', 17:24:06 INFO - 'cart']}, 17:24:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:06 INFO - 'tsvgr_opacity', 17:24:06 INFO - 'tart', 17:24:06 INFO - 'tscrollx', 17:24:06 INFO - 'cart']}, 17:24:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'talos_options': ['--disable-e10s'], 17:24:06 INFO - 'tests': ['tp5o']}, 17:24:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'tests': ['tp5o']}, 17:24:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'talos_options': ['--disable-e10s', 17:24:06 INFO - '--xperf_path', 17:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:06 INFO - 'tests': ['tp5n']}, 17:24:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:06 INFO - 'talos_options': ['--xperf_path', 17:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:06 INFO - 'tests': ['tp5n']}}, 17:24:06 INFO - 'talos.zip': {'path': '', 17:24:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:06 INFO - Running post-action listener: _resource_record_post_action 17:24:06 INFO - ##### 17:24:06 INFO - ##### Finished populate-webroot step (success) 17:24:06 INFO - ##### 17:24:06 INFO - ##### 17:24:06 INFO - ##### Running create-virtualenv step. 17:24:06 INFO - ##### 17:24:06 INFO - Running pre-action listener: _resource_record_pre_action 17:24:06 INFO - Running main action method: create_virtualenv 17:24:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:24:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:06 INFO - Using real prefix '/tools/python27' 17:24:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:07 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:10 INFO - Installing pip.................done. 17:24:10 INFO - Return code: 0 17:24:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:10 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:10 INFO - 'HOME': '/Users/cltbld', 17:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:10 INFO - 'LOGNAME': 'cltbld', 17:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:10 INFO - 'MOZ_NO_REMOTE': '1', 17:24:10 INFO - 'NO_EM_RESTART': '1', 17:24:10 INFO - 'PAGER': '/bin/cat', 17:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:10 INFO - 'PWD': '/builds/slave/test', 17:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:10 INFO - 'SHELL': '/bin/bash', 17:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:10 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:10 INFO - 'USER': 'cltbld', 17:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:10 INFO - 'XPC_FLAGS': '0x0', 17:24:10 INFO - 'XPC_SERVICE_NAME': '0', 17:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:24:10 INFO - Cleaning up... 17:24:10 INFO - Return code: 0 17:24:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:10 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:10 INFO - 'HOME': '/Users/cltbld', 17:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:10 INFO - 'LOGNAME': 'cltbld', 17:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:10 INFO - 'MOZ_NO_REMOTE': '1', 17:24:10 INFO - 'NO_EM_RESTART': '1', 17:24:10 INFO - 'PAGER': '/bin/cat', 17:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:10 INFO - 'PWD': '/builds/slave/test', 17:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:10 INFO - 'SHELL': '/bin/bash', 17:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:10 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:10 INFO - 'USER': 'cltbld', 17:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:10 INFO - 'XPC_FLAGS': '0x0', 17:24:10 INFO - 'XPC_SERVICE_NAME': '0', 17:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:10 INFO - Downloading/unpacking psutil>=0.7.1 17:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:13 INFO - Installing collected packages: psutil 17:24:13 INFO - Running setup.py install for psutil 17:24:13 INFO - building 'psutil._psutil_osx' extension 17:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:24:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:24:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:24:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:24:14 INFO - building 'psutil._psutil_posix' extension 17:24:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:24:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:24:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:24:14 INFO - ^ 17:24:14 INFO - 1 warning generated. 17:24:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:14 INFO - Successfully installed psutil 17:24:14 INFO - Cleaning up... 17:24:14 INFO - Return code: 0 17:24:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:14 INFO - 'HOME': '/Users/cltbld', 17:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:14 INFO - 'LOGNAME': 'cltbld', 17:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:14 INFO - 'MOZ_NO_REMOTE': '1', 17:24:14 INFO - 'NO_EM_RESTART': '1', 17:24:14 INFO - 'PAGER': '/bin/cat', 17:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:14 INFO - 'PWD': '/builds/slave/test', 17:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:14 INFO - 'SHELL': '/bin/bash', 17:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:14 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:14 INFO - 'USER': 'cltbld', 17:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:14 INFO - 'XPC_FLAGS': '0x0', 17:24:14 INFO - 'XPC_SERVICE_NAME': '0', 17:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:24:17 INFO - Installing collected packages: mozsystemmonitor 17:24:17 INFO - Running setup.py install for mozsystemmonitor 17:24:17 INFO - Successfully installed mozsystemmonitor 17:24:17 INFO - Cleaning up... 17:24:18 INFO - Return code: 0 17:24:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:18 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:18 INFO - 'HOME': '/Users/cltbld', 17:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:18 INFO - 'LOGNAME': 'cltbld', 17:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:18 INFO - 'MOZ_NO_REMOTE': '1', 17:24:18 INFO - 'NO_EM_RESTART': '1', 17:24:18 INFO - 'PAGER': '/bin/cat', 17:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:18 INFO - 'PWD': '/builds/slave/test', 17:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:18 INFO - 'SHELL': '/bin/bash', 17:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:18 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:18 INFO - 'USER': 'cltbld', 17:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:18 INFO - 'XPC_FLAGS': '0x0', 17:24:18 INFO - 'XPC_SERVICE_NAME': '0', 17:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:18 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:20 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:21 INFO - Downloading docopt-0.6.1.tar.gz 17:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:22 INFO - Running setup.py install for blobuploader 17:24:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:22 INFO - Running setup.py install for requests 17:24:22 INFO - Running setup.py install for docopt 17:24:22 INFO - Successfully installed blobuploader requests docopt 17:24:22 INFO - Cleaning up... 17:24:22 INFO - Return code: 0 17:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:22 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:22 INFO - 'HOME': '/Users/cltbld', 17:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:22 INFO - 'LOGNAME': 'cltbld', 17:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:22 INFO - 'MOZ_NO_REMOTE': '1', 17:24:22 INFO - 'NO_EM_RESTART': '1', 17:24:22 INFO - 'PAGER': '/bin/cat', 17:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:22 INFO - 'PWD': '/builds/slave/test', 17:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:22 INFO - 'SHELL': '/bin/bash', 17:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:22 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:22 INFO - 'USER': 'cltbld', 17:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:22 INFO - 'XPC_FLAGS': '0x0', 17:24:22 INFO - 'XPC_SERVICE_NAME': '0', 17:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-HZNGUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-p61Ug1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-S439bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-zqcDjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0t8HeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-qCz0nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-J3gW4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:23 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Hx8iv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-YDXHKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-dkIO8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-p9FsV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jhzkWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ftvPhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-iasxvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-WruQhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-axKkmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:24 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-9Y7UjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:24 INFO - Running setup.py install for manifestparser 17:24:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozcrash 17:24:25 INFO - Running setup.py install for mozdebug 17:24:25 INFO - Running setup.py install for mozdevice 17:24:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozfile 17:24:25 INFO - Running setup.py install for mozhttpd 17:24:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozinfo 17:24:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:25 INFO - Running setup.py install for mozInstall 17:24:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Running setup.py install for mozleak 17:24:26 INFO - Running setup.py install for mozlog 17:24:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Running setup.py install for moznetwork 17:24:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Running setup.py install for mozprocess 17:24:26 INFO - Running setup.py install for mozprofile 17:24:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:24:26 INFO - Running setup.py install for mozrunner 17:24:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:24:27 INFO - Running setup.py install for mozscreenshot 17:24:27 INFO - Running setup.py install for moztest 17:24:27 INFO - Running setup.py install for mozversion 17:24:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:24:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:27 INFO - Cleaning up... 17:24:27 INFO - Return code: 0 17:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:27 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:27 INFO - 'HOME': '/Users/cltbld', 17:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:27 INFO - 'LOGNAME': 'cltbld', 17:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:27 INFO - 'MOZ_NO_REMOTE': '1', 17:24:27 INFO - 'NO_EM_RESTART': '1', 17:24:27 INFO - 'PAGER': '/bin/cat', 17:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:27 INFO - 'PWD': '/builds/slave/test', 17:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:27 INFO - 'SHELL': '/bin/bash', 17:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:27 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:27 INFO - 'USER': 'cltbld', 17:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:27 INFO - 'XPC_FLAGS': '0x0', 17:24:27 INFO - 'XPC_SERVICE_NAME': '0', 17:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:27 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-lDT3Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:27 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-PW4X9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-5dFmFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-eu7gJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-3Z27MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-h4ktyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-nqqKvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ejvKpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-O5sRVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-YnZESX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vGImec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-qzioGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-2cfZ88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-zX7el0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-meYOCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-FvOjkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-KZEq4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:24:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:32 INFO - Downloading blessings-1.6.tar.gz 17:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:32 INFO - Installing collected packages: blessings 17:24:32 INFO - Running setup.py install for blessings 17:24:32 INFO - Successfully installed blessings 17:24:32 INFO - Cleaning up... 17:24:32 INFO - Return code: 0 17:24:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:24:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:32 INFO - Reading from file tmpfile_stdout 17:24:32 INFO - Current package versions: 17:24:32 INFO - blessings == 1.6 17:24:32 INFO - blobuploader == 1.2.4 17:24:32 INFO - docopt == 0.6.1 17:24:32 INFO - manifestparser == 1.1 17:24:32 INFO - mozInstall == 1.12 17:24:32 INFO - mozcrash == 0.17 17:24:32 INFO - mozdebug == 0.1 17:24:32 INFO - mozdevice == 0.48 17:24:32 INFO - mozfile == 1.2 17:24:32 INFO - mozhttpd == 0.7 17:24:32 INFO - mozinfo == 0.9 17:24:32 INFO - mozleak == 0.1 17:24:32 INFO - mozlog == 3.1 17:24:32 INFO - moznetwork == 0.27 17:24:32 INFO - mozprocess == 0.22 17:24:32 INFO - mozprofile == 0.28 17:24:32 INFO - mozrunner == 6.11 17:24:32 INFO - mozscreenshot == 0.1 17:24:32 INFO - mozsystemmonitor == 0.0 17:24:32 INFO - moztest == 0.7 17:24:32 INFO - mozversion == 1.4 17:24:32 INFO - psutil == 3.1.1 17:24:32 INFO - requests == 1.2.3 17:24:32 INFO - wsgiref == 0.1.2 17:24:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:32 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:32 INFO - 'HOME': '/Users/cltbld', 17:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:32 INFO - 'LOGNAME': 'cltbld', 17:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:32 INFO - 'MOZ_NO_REMOTE': '1', 17:24:32 INFO - 'NO_EM_RESTART': '1', 17:24:32 INFO - 'PAGER': '/bin/cat', 17:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:32 INFO - 'PWD': '/builds/slave/test', 17:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:32 INFO - 'SHELL': '/bin/bash', 17:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:32 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:32 INFO - 'USER': 'cltbld', 17:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:32 INFO - 'XPC_FLAGS': '0x0', 17:24:32 INFO - 'XPC_SERVICE_NAME': '0', 17:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:24:32 INFO - Cleaning up... 17:24:33 INFO - Return code: 0 17:24:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:33 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:33 INFO - 'HOME': '/Users/cltbld', 17:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:33 INFO - 'LOGNAME': 'cltbld', 17:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:33 INFO - 'MOZ_NO_REMOTE': '1', 17:24:33 INFO - 'NO_EM_RESTART': '1', 17:24:33 INFO - 'PAGER': '/bin/cat', 17:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:33 INFO - 'PWD': '/builds/slave/test', 17:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:33 INFO - 'SHELL': '/bin/bash', 17:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:33 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:33 INFO - 'USER': 'cltbld', 17:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:33 INFO - 'XPC_FLAGS': '0x0', 17:24:33 INFO - 'XPC_SERVICE_NAME': '0', 17:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:33 INFO - Downloading/unpacking jsonschema 17:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:35 INFO - Downloading/unpacking functools32 (from jsonschema) 17:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:36 INFO - warning: no files found matching '*.txt' 17:24:36 INFO - no previously-included directories found matching 'build' 17:24:36 INFO - no previously-included directories found matching 'dist' 17:24:36 INFO - no previously-included directories found matching '.git*' 17:24:36 INFO - Installing collected packages: jsonschema, functools32 17:24:36 INFO - Running setup.py install for functools32 17:24:36 INFO - warning: no files found matching '*.txt' 17:24:36 INFO - no previously-included directories found matching 'build' 17:24:36 INFO - no previously-included directories found matching 'dist' 17:24:36 INFO - no previously-included directories found matching '.git*' 17:24:36 INFO - Successfully installed jsonschema functools32 17:24:36 INFO - Cleaning up... 17:24:36 INFO - Return code: 0 17:24:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:36 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 0x102750a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102756570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc989494c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, '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.M16BkT0C2A/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.UkD83v16vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:36 INFO - 'HOME': '/Users/cltbld', 17:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:36 INFO - 'LOGNAME': 'cltbld', 17:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:36 INFO - 'MOZ_NO_REMOTE': '1', 17:24:36 INFO - 'NO_EM_RESTART': '1', 17:24:36 INFO - 'PAGER': '/bin/cat', 17:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:36 INFO - 'PWD': '/builds/slave/test', 17:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:36 INFO - 'SHELL': '/bin/bash', 17:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:24:36 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:36 INFO - 'USER': 'cltbld', 17:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:36 INFO - 'XPC_FLAGS': '0x0', 17:24:36 INFO - 'XPC_SERVICE_NAME': '0', 17:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:36 INFO - Downloading/unpacking flake8 17:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:24:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:24:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:24:40 INFO - no previously-included directories found matching 'docs/_build' 17:24:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:24:40 INFO - Running setup.py install for pep8 17:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:24:40 INFO - no previously-included directories found matching 'docs/_build' 17:24:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:24:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:24:40 INFO - Cleaning up... 17:24:40 INFO - Return code: 0 17:24:40 INFO - Running post-action listener: _resource_record_post_action 17:24:40 INFO - Running post-action listener: _start_resource_monitoring 17:24:40 INFO - Starting resource monitoring. 17:24:40 INFO - ##### 17:24:40 INFO - ##### Finished create-virtualenv step (success) 17:24:40 INFO - ##### 17:24:40 INFO - ##### 17:24:40 INFO - ##### Running install step. 17:24:40 INFO - ##### 17:24:40 INFO - Running pre-action listener: _resource_record_pre_action 17:24:40 INFO - Running main action method: install 17:24:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:41 INFO - Reading from file tmpfile_stdout 17:24:41 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:24:41 INFO - Reading from file tmpfile_stdout 17:24:41 INFO - Output received: 17:24:41 INFO - Usage: mozinstall [options] installer 17:24:41 INFO - Options: 17:24:41 INFO - -h, --help show this help message and exit 17:24:41 INFO - -d DEST, --destination=DEST 17:24:41 INFO - Directory to install application into. [default: 17:24:41 INFO - "/builds/slave/test"] 17:24:41 INFO - --app=APP Application being installed. [default: firefox] 17:24:41 INFO - mkdir: /builds/slave/test/build/application 17:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:25:14 INFO - Reading from file tmpfile_stdout 17:25:14 INFO - Output received: 17:25:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:25:14 INFO - Running post-action listener: _resource_record_post_action 17:25:14 INFO - ##### 17:25:14 INFO - ##### Finished install step (success) 17:25:14 INFO - ##### 17:25:14 INFO - ##### 17:25:14 INFO - ##### Running run-tests step. 17:25:14 INFO - ##### 17:25:14 INFO - Running pre-action listener: _resource_record_pre_action 17:25:14 INFO - Running main action method: run_tests 17:25:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:25:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:25:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:25:14 INFO - 2016-05-09 17:25:14.588 screenresolution[1639:7392] starting screenresolution argv=screenresolution get 17:25:14 INFO - 2016-05-09 17:25:14.591 screenresolution[1639:7392] Display 0: 1600x1200x32@60 17:25:14 INFO - 2016-05-09 17:25:14.596 screenresolution[1640:7394] starting screenresolution argv=screenresolution list 17:25:14 INFO - Available Modes on Display 0 17:25:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:25:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:25:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:25:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:25:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:25:14 INFO - Intel Iris: 17:25:14 INFO - Chipset Model: Intel Iris 17:25:14 INFO - Type: GPU 17:25:14 INFO - Bus: Built-In 17:25:14 INFO - VRAM (Dynamic, Max): 1536 MB 17:25:14 INFO - Vendor: Intel (0x8086) 17:25:14 INFO - Device ID: 0x0a2e 17:25:14 INFO - Revision ID: 0x0009 17:25:14 INFO - Displays: 17:25:14 INFO - Display: 17:25:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:25:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:25:14 INFO - Display Serial Number: 1600x1200 60 17:25:14 INFO - Main Display: Yes 17:25:14 INFO - Mirror: Off 17:25:14 INFO - Online: Yes 17:25:14 INFO - Rotation: Supported 17:25:14 INFO - Return code: 0 17:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:14 INFO - Python 2.7.3 17:25:14 INFO - Return code: 0 17:25:14 INFO - grabbing minidump binary from tooltool 17:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:14 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 0x1025f4d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:25:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:25:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:14 INFO - Return code: 0 17:25:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:25:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:25:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:25:16 INFO - Return code: 0 17:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M16BkT0C2A/Render', 17:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:16 INFO - 'HOME': '/Users/cltbld', 17:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:16 INFO - 'LOGNAME': 'cltbld', 17:25:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:16 INFO - 'MOZ_NO_REMOTE': '1', 17:25:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:16 INFO - 'NO_EM_RESTART': '1', 17:25:16 INFO - 'PAGER': '/bin/cat', 17:25:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:16 INFO - 'PWD': '/builds/slave/test', 17:25:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:16 INFO - 'SHELL': '/bin/bash', 17:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UkD83v16vb/Listeners', 17:25:16 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 17:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:16 INFO - 'USER': 'cltbld', 17:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:16 INFO - 'XPC_FLAGS': '0x0', 17:25:16 INFO - 'XPC_SERVICE_NAME': '0', 17:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:25:16 INFO - mozversion application_buildid: 20160509151608 17:25:16 INFO - mozversion application_changeset: 687f1eb881d82a76ddc02e71c1778c82de125407 17:25:16 INFO - mozversion application_display_name: Nightly 17:25:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:16 INFO - mozversion application_name: Firefox 17:25:16 INFO - mozversion application_remotingname: firefox 17:25:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:25:16 INFO - mozversion application_vendor: Mozilla 17:25:16 INFO - mozversion application_version: 49.0a1 17:25:16 INFO - mozversion platform_buildid: 20160509151608 17:25:16 INFO - mozversion platform_changeset: 687f1eb881d82a76ddc02e71c1778c82de125407 17:25:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:25:16 INFO - mozversion platform_version: 49.0a1 17:25:16 INFO - using testdate: 1462839916 17:25:16 INFO - actual date: 1462839916 17:25:16 INFO - starting webserver on 'localhost:49277' 17:25:16 INFO - SUITE-START | Running 2 tests 17:25:16 INFO - TEST-START | dromaeo_css 17:25:16 INFO - operating with platform_type : mac_ 17:25:16 INFO - Initialising browser for dromaeo_css test... 17:25:16 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpGZtcMS/profile http://localhost:49277/getInfo.html) 17:25:19 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 17:25:19 INFO - PROCESS | 1658 | colorDepth:24 17:25:19 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 17:25:19 INFO - PROCESS | 1658 | __metrics 17:25:19 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 17:25:20 INFO - TEST-INFO | 1658: exit 0 17:25:20 INFO - Browser initialized. 17:25:20 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpGZtcMS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:32 INFO - PROCESS | 1661 | RSS: Main: 250052608 17:25:32 INFO - PROCESS | 1661 | 17:26:21 INFO - PROCESS | 1661 | 1462839981931 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:28:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 17:28:34 INFO - PROCESS | 1661 | RSS: Main: 263254016 17:28:34 INFO - PROCESS | 1661 | 17:31:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 17:31:37 INFO - PROCESS | 1661 | RSS: Main: 273797120 17:31:37 INFO - PROCESS | 1661 | 17:34:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 17:34:39 INFO - PROCESS | 1661 | RSS: Main: 275836928 17:34:39 INFO - PROCESS | 1661 | 17:37:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 17:37:42 INFO - PROCESS | 1661 | RSS: Main: 277450752 17:37:42 INFO - PROCESS | 1661 | 17:40:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 17:40:45 INFO - PROCESS | 1661 | RSS: Main: 280272896 17:40:45 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 17:43:48 INFO - PROCESS | 1661 | RSS: Main: 281333760 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | __start_tp_report 17:43:48 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 17:43:48 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 17:43:48 INFO - PROCESS | 1661 | |i|pagename|runs| 17:43:48 INFO - PROCESS | 1661 | |0;dojo.html;3492.8602855885756;3508.614052454231;3533.469979503076;3549.964500354996;3555.520004799352;5738.655680659163;5852.481720302004;5888.558358123142;5901.085331773582;5984.311804142525;5614.578906582013;5648.830535083944;5723.141528770687;5843.977303971798;5888.116782482619;5129.6409251352425;5187.559057480119;5203.661761985459;5215.895682086356;5254.605904557155;616.5672248966031;5203.791848326063;5218.556422704056;5229.8169564065265;5282.815101471449;5310.36275646921;5344.759485823109;5349.973250133744;5364.544013758816;5389.703566303851;5238.79044838206;5397;5420.051490989061;5423.349198096214;5443.428440013781;5204.3234379530795;5253.50091741284;5269.815556455505;5269.973650131763;5291.1798671206025;5633.267675202238;5660.235868157828;5733.856653583652;5757.510611597977;5791.884162316772;6208.161898143738;6233.376662333776;6295.464885484739;6326.335734747831;6328.557001009931;6256.5307601930035;6300.117983482271;6327.620342779402;6335.6198628082;6336.841578960517;4523.982104026601;5571.220029195916;5879;5890.087036509305;5890.087036509348;6224.62652240867;6261.68691565429;6270.2475702915945;6288.654124023223;6290.559660823698;6272.937270627326;6275.748970041239;6279.340669229665;6312.368763123743;6313;6286.497080233662;6304.842378940563;6329.208848893888;6331.905021424683;6349.682515874188;4603;5422.810201642924;5444.965456563319;6013.428724271187;6117.296510901214;6190.7523699052435;6232.034034724625;6234.314225435199;6284.842878928063;6319;4971.254311853251;4973.701577905337;4981.352424184905;5015.14742493777;5053.166227572483;4422.756748378806;4459.866204013885;4468.084042771224;4473.127740090651;4529.68292219548;5578.414266501959;5869.295684517885;5893.5579831512805;5903.76384944606;5933.554983376264;6208.782692605737;6281.152044473937;6281.842953926097;6294.181756371642;6312.4634406076;5230.163173892159;5349.010433069894;5650.378458369576;5654.575906807006;5875.823725288248;4868.123737727243;5270.92093618596;5470.042742520043;5483.7806487740845;5556.749946252428;6218.875622487525;6298.244210694746;6335.588186767845;6398.936010639834;6415.454686351713;6223.844403889939;6276.811695649138;6284.622922624474;6285.842853928689;6298.055291706098;6362.650054246876;6395.872082558416;6396.104545363746;6398.520110991787;6406.807795766134;6129.481048574228;6187.535934804818;6188.319284878749;6289.685515724104;6300.117983482224;6225.875482490415;6231.781887633911;6269.592476489013;6288.371162883675;6296.055591661104;6266.310705822265;6272.874542509216;6272.968635156795;6288.6855657217875;6297.338779428094;4689.296605509201;6060.212172417558;6074.301455332693;6200.906986395298;6246.562740608114;4823.2282834746275;5741.913871292018;5945.851353716192;5973.611715238496;6039.698015099315;6160.845978850564;6244.344343844013;6247.344028877084;6251.624902505864;6252.062190671436;5908.970455147697;6090.482309003784;6095.664738439428;6101.145839582373;6136.846578835565 17:43:48 INFO - PROCESS | 1661 | |1;ext.html;523.0167285503253;533.8932213557289;534.7459956520653;562.4010428893229;580.3500079910501;38684.61315386845;41381.37927931084;41400.37899431503;41403.79298103509;41437.549685761005;41910.7904460478;42577.36133957985;42599.361009584805;42689.14621707564;42719;9637.662681806156;9829.361091529028;9851.605935762562;9856.90143098567;9880.357776744524;9714.65998690046;9785.657501987433;9792;9807;9821.754456138582;9723.854142187838;9730.464824434688;9757.316987810857;9831;9854.556544955458;9733.659321923735;9801.803963920718;9813.165880900133;9833.90166098337;9835.557399917021;8579.785505362415;9606.567704453317;9653.565589548487;9727;9749.07383798538;32996.34007319864;34449.483257751155;35979.64020359789;39146.412803807965;39333.213335733126;2775.306173456636;2861.5850701648146;2897.5219088850527;2957.624704512412;3260.6413294537583;26211.868940655364;27425;27676.861615691992;27732.861335693393;28398.290042749097;2472.929033797703;2649.867506624661;2777.8611069446647;2780.3466185446405;2785.665720113579;445465;455485;458728;461969;463392;34769.652303477145;35041.12397190039;35329.82335088308;35369.82315088408;35393;35603.10992225215;36762.44856327157;37302.62697373046;37764.811175944495;39309;17122.058286794345;17262.741058884127;17367.65264694699;17374.652506950042;17393.56516087108;13182.60452186436;13233.602991910066;13243.933780331037;13252.602421927357;13292.800607990888;20079.899600501903;20199.39401817948;20228.494287642632;20253.79746202519;20268.493287667927;7053.929460705327;8077.515349079074;8078.636461359253;8160.83678326442;8191.836163276701;950.254050570299;1013.4527355228095;1025.3335332034237;1081.9513121909533;1133.41629061032;29599.40801183964;29824.552631710543;29877;30152.643131059154;30286.242843929078;982.6609819612222;1062.8592509135485;1149.7987852125846;1155.9768804623861;1166.719987203065;14136.646583835281;15305.15821629821;15386.461473848361;15619.062856228662;16065.036097834167;678638;690521;693392;694435;695310;60148;60389;61000;61331;61339.07991380133;1390.610629023875;1425.3514650833845;1437.1233547535994;1444.6316189371644;1451.1583281696592;29402.705972939995;29501.11496655104;29590;30053;30224;51572.74213628908;51770.964580708925;52644.473555263954;53091.46908530865;53114;610688;611792;611843;612743;616544;26425.942962281293;26593.601095983962;26925.596116057885;26970.112092153362;27381.86309068442;46129.30806037845;46238.30642540432;46760;47456.28815567838;47525.81185470252;37097.443538347485;37338.62661373351;37844.05389865275;38282.80858595689;38553;31206.843965780936;36518.53925843043;37889.4316585257;38265.426018609185;38514.614853852225;37417.625823742506;37643.81178094092;38080;38478.42282365823;38890.80554597322;32096;32460;32701.836490817393;32759;33298.667013329556;22978.885105574365;24726.876365618056;24797.752022480265;24893.377665557782;25222 17:43:48 INFO - PROCESS | 1661 | |2;jquery.html;333.7313462662557;381.2051871847198;385.92088621832517;396.3321802762344;406.8169323804289;19116.70854772446;19719.704204436945;21621.891890540544;21960.45098872527;22081.227157049507;12357.814632780493;12525.060620453456;15088.943773935829;20269.898650506726;21556.676649850266;4609.469910960249;5297.973510132453;5454.018276710191;5496.395396506381;5519.806806761764;4379.824807007716;5139.820106296281;5337.946620533803;5359.115745901941;5382.9730851345685;5350.250964864922;5365.114756065244;5365.839024829262;5372.677639341652;5375.865603359908;5490.149026900816;5844.444777746107;5913.497352725045;5952.642841429506;6026.668533230671;4045.575214602454;5278.841634750964;5283.233931080011;5330.92003619946;5778.566607504454;11835.934765871027;12953.740925181537;16092.83907160925;25583.872080639663;25795.226143215546;2001.35956493922;2020.595880823841;2035.989820050905;2063.515073957619;2230.695043399613;9984.90015099847;10038.996100389975;10170.389776613427;13021.739565208738;13489.65103489653;1750.6323672028889;1761.5772214668516;1784.5449410400395;1792.4353828543967;1800.2259028617689;124510.37744811308;126391.944322227;131421.34289328588;132231;133148.33425832907;11512.251703639236;11608.6517404478;11915.808419158187;11965.880341196651;12105.757884842254;15324.23378831054;15344.769828452581;15373.692526149638;15380.92309538445;15427.922860385626;8703.042665306812;8740.737777866674;8776.341774366949;8828.337874659426;8830.337724670675;7090.92909070913;8610.87083693745;8615.439996400213;8627.784305392415;8759.649614015496;4637.930431043537;4699.530046995342;4726.905461890743;4739.928901066487;4819.349387832668;1697.8217287184914;1955.7653081630294;2010.577778666467;2032.6138033773536;2035.1757538197053;920.6225447566466;925.2644147902433;946.5409276500892;980.1962390839443;1023.1456733627356;18812.717809232872;19010.33463828787;19688.310909118398;20041.39875803728;20175.798242017685;928.7538802217417;955.7349082674107;969.0938972061005;971.9951400242953;978.7797745507204;7439;10692.518836652369;10739.301945373525;10749.301295415773;10762.784744305227;563799;579590;601386;606395.9360406428;609071;106079.46960265304;127891;135962.640373595;139438.3028084853;148210;968.8207681578931;989.2778271861581;1004.2167109654481;1004.457592899826;1013.2096964367657;13453.932730336286;15680.13759243207;17089.743653844955;17386.913065434594;18234.36179733703;38003;44418.8459838827;50527;54684.72657636686;56690;84095.579522102;84420.15579844368;84578;85629.57185214035;85897.5640974354;7866.488678235896;7934.841303173789;7967.163447838126;8094.392920530866;8099.554524501209;9168.404053736485;12094.213876098025;12125.75748485043;12213.328266945404;12348.753024939271;10430.582776688847;10434.634787782696;10543.947280263856;10676.519556619816;10751.086157676373;9939.950300248453;10141.188704903738;10389.116925061455;10575.995280448346;10588.364698118137;10650.254482186172;10658.307210031324;10929.672109836718;10944.671659850217;11025.889741102486;7931.127575966754;8017.518948863087;8027.2775450209765;8129.9187008129165;8206.58967051633;9902.207823374258;10548.472576370998;10815.621453249414;10852.728681783019;11022.779544408906 17:43:48 INFO - PROCESS | 1661 | |3;mootools.html;1553.650428653553;1598.2168737318714;1826.4977131288895;1920.299090831846;1985.8510611704125;7767.378609711223;8344.165583441652;8346.582670866463;8839.779005524864;8850.380473366868;7525.924740752591;8474.830503389943;8547.829043419144;8654.783630409243;8664.263537599312;2347.3310106619574;2371.537550177716;2371.762823717632;2383.6067048936907;2387.4270175158013;2360.775726305998;2366.905323787055;2405.9759402406016;2412.9758702413014;2415.0219161239725;1999.270266352778;2348.835581509295;2381.2380038387723;2395.161693407311;2404.927852164429;2359.3629719975684;2363.527294541099;2374.715034195899;2380.0241900820665;2382.5949588569983;2300.919467818635;2365.9171928982405;2372.9762702372927;2376.9049238030457;2382.344855164826;8636.870446943301;8685.739427817112;8721.433106848099;8742.650293988232;8750.69372571957;5145.588352931756;5252.8686782830355;5254.97372513135;5316.9202461963105;5346.946530534723;3369.4608862582113;3464.185916309665;3493.1092571394133;3558.822058897045;3564.697000754939;1007.6271779441654;1030.5568605499632;1045.242199405425;1046.8115739166947;1048.5176818663424;11242.156838237082;11295.717607059807;11396.715082123013;11398.487068081957;11428.200025998183;3716.9628303716618;4543.114092751948;4617.538246175355;4627.028324051987;4637.698549594265;8952.597133129026;8981.910180898238;9029.41308814938;9037.322200834964;9061.048589897966;5132.435432102466;5185.040767458032;5202.81790137351;5203.2195170723935;5234.3718753749035;3614.9335945896023;4655.348251244761;4812.133815913099;4815.711057336571;4815.807367705323;3735.4396840474146;3756.042209236627;3836.827342769582;3865.323568375523;3869.96130038696;1041.4532370505544;1190.3512585640847;1195.0857593940643;1203.8796120387892;1206.1858245684305;827.6027506796771;837.4514692876176;852.624845068168;886.7851044069666;942.7218970403748;4545.863624091283;5873.295204575393;5901.380355062743;6027.879442411215;6177.289611694623;927.9164875161268;979.5543027922279;980.7302991677345;996.7159359582629;1030.4126647810826;3723.236736469017;3869.7484663496784;4033.616806403387;4040.6969477288735;4067.633912947849;10248.692539223835;10674.306170098918;10759.946200268949;10785.622503212508;10796.56813727442;10568.15454763617;10574.206934479946;10686.091682206945;10707.518161682743;10800.945995269973;7544.773656790305;7909.327707144842;8033.919660803317;8069.6368663410285;8161.918380816234;5625.634333768292;5782.132680098019;5829.446202610745;5835.7373918174635;5895.29256489224;9787.559559819683;9919.15687166599;9931.304808663324;9951.651692190739;10001.449920254456;9464.716058518256;9882.25883058759;9901.653442129491;10056.245781566266;10078.496075196357;6383.36166383358;6907.93092069093;7048.753293634698;7661.425393095652;8103.594820259082;8078.676852925817;8194.959025204837;8268.37987150954;8271.875921861298;8280.71017514384;7114.181869085121;7279.963600182177;7331.193568707545;7385.446091543263;7555;7058.11773528309;7253.238409966877;7261.963690181516;7265.891011634935;7290.890636640349;6815.284395138439;6943.201531823703;6996.685149168198;6998.930010699828;7027.437804975488;4797.592204662643;4807.495213002584;4861.343718598086;5010.073136469765;5027.49725027509;4966.981768737328;5004.899902002013;5039.118154323052;5103.4386217516785;5276.182191760283 17:43:48 INFO - PROCESS | 1661 | |4;prototype.html;305.3480818452606;308.8649214138041;319.1781163503977;324.76292306616165;330.55540298298797;4323.589259020388;4845.563899249067;5021.3221215135945;5453.618246722726;5472;5314.927178400418;5331.120365139747;5333.626646134772;5343.72891521103;5364.946350536494;3415.7267418606516;3502.6672466115806;4075.5924407559305;4118.279301122307;4146.170765846828;3825.7321987460887;3862.7489213201193;4137.1518838638;4163.583641635827;4164.354525048622;3432.5709286339206;3875.1087249932534;4047.4298820249205;4051.4327994080704;4122.216778812016;3442.6213116557283;4079.77561234132;4102.953746794578;4116.691248156385;4140.3168477201525;3169.6513383527795;3306.470964645669;3572.4105522588743;3588.910277243064;3604.062943634674;4026.3960405939342;4686.625069994427;4751.667383283171;4916.975415122937;4977.278294647292;4574.5425457453985;4599.517050709695;4611.976940115312;4632.888106854364;4647.6281897448125;5584.972075139598;5599.524040456566;5640.661560306395;5644.915326270109;5652.777916587546;3654.0998680685893;3758.830852611639;3787.5454945406727;3915.451836742858;3929.6463318301203;5208.817691380784;5846.444587764156;5853;5912.320083190445;5919.260092488439;3333.516640087174;3566;3593.8203089845924;3801.6198380161763;3994.9201015979515;3851.4993050903763;4020.3567429211184;4032.1734044520804;4037.6164264394833;4069.6337329640473;4603.562661547147;4612.97693511537;4619.0530941156985;4638.281066434708;4655.6973796703105;4560.950981274259;4604.7927843247135;5221.399539052982;5470.495613706263;5675.489205971482;1235.3699613197334;1303.3027330378202;1317.8418589769096;1323.7490571409926;1330.8669133086614;826.4669288309007;897.4525539420948;906.7370462565914;922.262190247799;931.7142343565836;4439.1121775645;4563.383943167696;4583.518730533246;4945.727984960861;4972.676776009548;4766.737829419415;5335.9594878999;5437.918431223535;5554.972225138848;5616.85957851057;3979.925420136547;4675.906481870344;4746.786394612251;4963.734247766796;5010.073136469765;2604.361931326837;2634.6574945256993;2989.8206107633177;2993.550967354914;3013.789034767545;5587.916181257285;5938.317093534212;5962.314333851576;5970.31341395745;5973.522118230531;5336.519713225751;5617.157426385993;5696.316442026983;5872.265966754156;5927.081302398135;5861.677607731531;5898.026825573904;5936.5250779937505;5936.673482958392;5943.503728434068;4852.636052296021;4972.378452693413;5441.5102640762525;5560.277163968658;5749.942500574941;4879.243717223836;5602.663840169603;5613.663180209201;5615.831525054255;5633.943660563506;5867.442592953663;5890.14592884038;5936.495397891055;5943.762249509971;5951.672658003851;3079.6920307969026;3219.243477782766;3602.621724718867;3669.9816500917323;3756.117312431522;5055.545000949932;5643.319423273912;5676.20533125371;5748.022836117953;5888.939990801526;5053.664581376274;5302.390225124006;5696;5697.982922039869;5732.455416735404;4918.868660208101;5375.704336261543;5708.088874673863;5709.143628455765;5717.485426311652;4998.550130488274;5582;5584.609077364546;5644.689542075225;5649;4512.9097418052115;4811.398575178103;5670.858228544319;5706.40220738194;5720.3707592164;5155.922661160011;5312.442193569774;5426.67439953604;5594.384617692132;5627.634203776905 17:43:48 INFO - PROCESS | 1661 | |5;yui.html;647.3688154049805;666.9366410191033;668.6924014953121;728.395431791613;775.5928137727694;14704.26478676066;14825.110493370405;15161.09033457992;15472.458463953764;15511.534653960385;11890.405479726001;14307.78538321926;14343.42626294947;14352.067115637476;14383.280835958212;727.9272072792731;797.366093955304;916.8349697054527;943.6414162618196;947.7251597036885;939.7744541310104;944.0936700767237;945.6690158444524;947.7109481608106;951.8381875081253;1007.6070332570304;1009.8333774927165;1010.7372083258332;1013.8479228115768;1014.2595904989362;931.8741969834088;948.127722495306;994.7413672445144;1000.6847842929491;1004.9899501004969;687.2611942162146;746.6453434618567;748.2031636307315;748.9438292128112;751.1286907187637;14383.208923509203;14881.255937203097;14884.181370024644;14912.70174596502;14917.254137293092;11227.38249396291;12062.095342849321;12464.937675311656;12709;12736.61790146297;9874.90125098747;9896.604135834557;9903.207743380512;9940;9984.25118116137;3297.7032067113837;3451.2924850405607;3477.9739976706933;3571.5178450909057;3603.3153700796765;80269;80286.79569806457;80664;81729.18270817335;81815.59092204561;7697.384209263246;9233.076692330713;9345.205657519187;9442.433453992646;9508.619655213852;19581.412557623295;19590.5102372439;19595.706064409045;19646.017699115273;19648.21407143698;7214.6031968241205;7258.818529536804;7485.588292643848;7587.051618547682;7772.650230739518;4145.606167414091;4148;4158.896027599334;4175.749455032707;4196.454460920061;3359.7816141950693;3470.687638112582;3486.564179477565;3494.266204097117;3499.6675315844955;483.6300230323805;630.5145038320468;637.1334984421184;642.8071578526424;649.8862699027651;456.8697921092539;492.94755696588044;496.7565892712617;559.6642014791092;575.3383608849856;5779.711014449261;7611.809704757315;7952.80707893809;7961.721339753197;8430.651095824762;446.43080072906656;545.6971579932678;574.4743559642964;586.1617886422372;586.3930831589284;3735.8879233623034;3764.265968136242;3914.1388894443176;4002.7198096133575;4004.70086746943;68500.3149968494;84513.57743211245;87183;87264.56367718121;94896;63045;81328.18671813325;81657.59171204225;82320.58839705883;83555.5822220885;73937;74411.62794185994;75248.24751752413;75285;76186.9999999989;7645.350145237495;7653.732119376018;7837.843243135219;7844.116912315763;7950.24472675095;41513.792431037655;41981.37027944522;43247;43747.78126109349;44205.55794442014;57621.4237857616;60043.699781500814;60609.69695151496;60822;60912.69543652431;10101.494925253855;10173.389596624227;10315.690529284133;10492.422916739653;10655.094316983143;11038.668839934493;11248.437578120898;11376.431178441211;11645.6506304811;11712.824307635563;8164.346852251687;9465.574049167666;10556.15550755953;10688.305260158066;10703.625373111903;10586;10667.46662666848;10761.192910531585;11010.724731881446;11048.834267486154;10340.896591034294;10452.111570516287;10601.098906593026;10786.73033174177;10897.182711296842;8707.25988290977;8831.867521987047;8931.19619234272;8954.238889694188;9104.362694611578;8689.391742577958;8927.285817134743;8994.955025225094;9019.278457723498;9122.635094596408 17:43:48 INFO - PROCESS | 1661 | __end_tp_report 17:43:48 INFO - PROCESS | 1661 | __start_cc_report 17:43:48 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,413 17:43:48 INFO - PROCESS | 1661 | __end_cc_report 17:43:48 INFO - PROCESS | 1661 | __startTimestamp1462841028291__endTimestamp 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | ------- Summary: start ------- 17:43:48 INFO - PROCESS | 1661 | Number of tests: 6 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5734.38 Median:5984.31 stddev:765.86 (12.8%) stddev-sans-first:747.75 17:43:48 INFO - PROCESS | 1661 | Values: 3492.9 3508.6 3533.5 3550.0 3555.5 5738.7 5852.5 5888.6 5901.1 5984.3 5614.6 5648.8 5723.1 5844.0 5888.1 5129.6 5187.6 5203.7 5215.9 5254.6 616.6 5203.8 5218.6 5229.8 5282.8 5310.4 5344.8 5350.0 5364.5 5389.7 5238.8 5397.0 5420.1 5423.3 5443.4 5204.3 5253.5 5269.8 5270.0 5291.2 5633.3 5660.2 5733.9 5757.5 5791.9 6208.2 6233.4 6295.5 6326.3 6328.6 6256.5 6300.1 6327.6 6335.6 6336.8 4524.0 5571.2 5879.0 5890.1 5890.1 6224.6 6261.7 6270.2 6288.7 6290.6 6272.9 6275.7 6279.3 6312.4 6313.0 6286.5 6304.8 6329.2 6331.9 6349.7 4603.0 5422.8 5445.0 6013.4 6117.3 6190.8 6232.0 6234.3 6284.8 6319.0 4971.3 4973.7 4981.4 5015.1 5053.2 4422.8 4459.9 4468.1 4473.1 4529.7 5578.4 5869.3 5893.6 5903.8 5933.6 6208.8 6281.2 6281.8 6294.2 6312.5 5230.2 5349.0 5650.4 5654.6 5875.8 4868.1 5270.9 5470.0 5483.8 5556.7 6218.9 6298.2 6335.6 6398.9 6415.5 6223.8 6276.8 6284.6 6285.8 6298.1 6362.7 6395.9 6396.1 6398.5 6406.8 6129.5 6187.5 6188.3 6289.7 6300.1 6225.9 6231.8 6269.6 6288.4 6296.1 6266.3 6272.9 6273.0 6288.7 6297.3 4689.3 6060.2 6074.3 6200.9 6246.6 4823.2 5741.9 5945.9 5973.6 6039.7 6160.8 6244.3 6247.3 6251.6 6252.1 5909.0 6090.5 6095.7 6101.1 6136.8 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:70238.24 Median:37804.43 stddev:159469.15 (421.8%) stddev-sans-first:159830.60 17:43:48 INFO - PROCESS | 1661 | Values: 523.0 533.9 534.7 562.4 580.4 38684.6 41381.4 41400.4 41403.8 41437.5 41910.8 42577.4 42599.4 42689.1 42719.0 9637.7 9829.4 9851.6 9856.9 9880.4 9714.7 9785.7 9792.0 9807.0 9821.8 9723.9 9730.5 9757.3 9831.0 9854.6 9733.7 9801.8 9813.2 9833.9 9835.6 8579.8 9606.6 9653.6 9727.0 9749.1 32996.3 34449.5 35979.6 39146.4 39333.2 2775.3 2861.6 2897.5 2957.6 3260.6 26211.9 27425.0 27676.9 27732.9 28398.3 2472.9 2649.9 2777.9 2780.3 2785.7 445465.0 455485.0 458728.0 461969.0 463392.0 34769.7 35041.1 35329.8 35369.8 35393.0 35603.1 36762.4 37302.6 37764.8 39309.0 17122.1 17262.7 17367.7 17374.7 17393.6 13182.6 13233.6 13243.9 13252.6 13292.8 20079.9 20199.4 20228.5 20253.8 20268.5 7053.9 8077.5 8078.6 8160.8 8191.8 950.3 1013.5 1025.3 1082.0 1133.4 29599.4 29824.6 29877.0 30152.6 30286.2 982.7 1062.9 1149.8 1156.0 1166.7 14136.6 15305.2 15386.5 15619.1 16065.0 678638.0 690521.0 693392.0 694435.0 695310.0 60148.0 60389.0 61000.0 61331.0 61339.1 1390.6 1425.4 1437.1 1444.6 1451.2 29402.7 29501.1 29590.0 30053.0 30224.0 51572.7 51771.0 52644.5 53091.5 53114.0 610688.0 611792.0 611843.0 612743.0 616544.0 26425.9 26593.6 26925.6 26970.1 27381.9 46129.3 46238.3 46760.0 47456.3 47525.8 37097.4 37338.6 37844.1 38282.8 38553.0 31206.8 36518.5 37889.4 38265.4 38514.6 37417.6 37643.8 38080.0 38478.4 38890.8 32096.0 32460.0 32701.8 32759.0 33298.7 22978.9 24726.9 24797.8 24893.4 25222.0 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34856.20 Median:12155.96 stddev:99500.74 (818.5%) stddev-sans-first:99746.10 17:43:48 INFO - PROCESS | 1661 | Values: 333.7 381.2 385.9 396.3 406.8 19116.7 19719.7 21621.9 21960.5 22081.2 12357.8 12525.1 15088.9 20269.9 21556.7 4609.5 5298.0 5454.0 5496.4 5519.8 4379.8 5139.8 5337.9 5359.1 5383.0 5350.3 5365.1 5365.8 5372.7 5375.9 5490.1 5844.4 5913.5 5952.6 6026.7 4045.6 5278.8 5283.2 5330.9 5778.6 11835.9 12953.7 16092.8 25583.9 25795.2 2001.4 2020.6 2036.0 2063.5 2230.7 9984.9 10039.0 10170.4 13021.7 13489.7 1750.6 1761.6 1784.5 1792.4 1800.2 124510.4 126391.9 131421.3 132231.0 133148.3 11512.3 11608.7 11915.8 11965.9 12105.8 15324.2 15344.8 15373.7 15380.9 15427.9 8703.0 8740.7 8776.3 8828.3 8830.3 7090.9 8610.9 8615.4 8627.8 8759.6 4637.9 4699.5 4726.9 4739.9 4819.3 1697.8 1955.8 2010.6 2032.6 2035.2 920.6 925.3 946.5 980.2 1023.1 18812.7 19010.3 19688.3 20041.4 20175.8 928.8 955.7 969.1 972.0 978.8 7439.0 10692.5 10739.3 10749.3 10762.8 563799.0 579590.0 601386.0 606395.9 609071.0 106079.5 127891.0 135962.6 139438.3 148210.0 968.8 989.3 1004.2 1004.5 1013.2 13453.9 15680.1 17089.7 17386.9 18234.4 38003.0 44418.8 50527.0 54684.7 56690.0 84095.6 84420.2 84578.0 85629.6 85897.6 7866.5 7934.8 7967.2 8094.4 8099.6 9168.4 12094.2 12125.8 12213.3 12348.8 10430.6 10434.6 10543.9 10676.5 10751.1 9940.0 10141.2 10389.1 10576.0 10588.4 10650.3 10658.3 10929.7 10944.7 11025.9 7931.1 8017.5 8027.3 8129.9 8206.6 9902.2 10548.5 10815.6 10852.7 11022.8 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5602.19 Median:5018.79 stddev:3116.24 (62.1%) stddev-sans-first:3110.13 17:43:48 INFO - PROCESS | 1661 | Values: 1553.7 1598.2 1826.5 1920.3 1985.9 7767.4 8344.2 8346.6 8839.8 8850.4 7525.9 8474.8 8547.8 8654.8 8664.3 2347.3 2371.5 2371.8 2383.6 2387.4 2360.8 2366.9 2406.0 2413.0 2415.0 1999.3 2348.8 2381.2 2395.2 2404.9 2359.4 2363.5 2374.7 2380.0 2382.6 2300.9 2365.9 2373.0 2376.9 2382.3 8636.9 8685.7 8721.4 8742.7 8750.7 5145.6 5252.9 5255.0 5316.9 5346.9 3369.5 3464.2 3493.1 3558.8 3564.7 1007.6 1030.6 1045.2 1046.8 1048.5 11242.2 11295.7 11396.7 11398.5 11428.2 3717.0 4543.1 4617.5 4627.0 4637.7 8952.6 8981.9 9029.4 9037.3 9061.0 5132.4 5185.0 5202.8 5203.2 5234.4 3614.9 4655.3 4812.1 4815.7 4815.8 3735.4 3756.0 3836.8 3865.3 3870.0 1041.5 1190.4 1195.1 1203.9 1206.2 827.6 837.5 852.6 886.8 942.7 4545.9 5873.3 5901.4 6027.9 6177.3 927.9 979.6 980.7 996.7 1030.4 3723.2 3869.7 4033.6 4040.7 4067.6 10248.7 10674.3 10759.9 10785.6 10796.6 10568.2 10574.2 10686.1 10707.5 10800.9 7544.8 7909.3 8033.9 8069.6 8161.9 5625.6 5782.1 5829.4 5835.7 5895.3 9787.6 9919.2 9931.3 9951.7 10001.4 9464.7 9882.3 9901.7 10056.2 10078.5 6383.4 6907.9 7048.8 7661.4 8103.6 8078.7 8195.0 8268.4 8271.9 8280.7 7114.2 7280.0 7331.2 7385.4 7555.0 7058.1 7253.2 7262.0 7265.9 7290.9 6815.3 6943.2 6996.7 6998.9 7027.4 4797.6 4807.5 4861.3 5010.1 5027.5 4967.0 5004.9 5039.1 5103.4 5276.2 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4498.89 Median:4954.73 stddev:1399.41 (28.2%) stddev-sans-first:1367.48 17:43:48 INFO - PROCESS | 1661 | Values: 305.3 308.9 319.2 324.8 330.6 4323.6 4845.6 5021.3 5453.6 5472.0 5314.9 5331.1 5333.6 5343.7 5364.9 3415.7 3502.7 4075.6 4118.3 4146.2 3825.7 3862.7 4137.2 4163.6 4164.4 3432.6 3875.1 4047.4 4051.4 4122.2 3442.6 4079.8 4103.0 4116.7 4140.3 3169.7 3306.5 3572.4 3588.9 3604.1 4026.4 4686.6 4751.7 4917.0 4977.3 4574.5 4599.5 4612.0 4632.9 4647.6 5585.0 5599.5 5640.7 5644.9 5652.8 3654.1 3758.8 3787.5 3915.5 3929.6 5208.8 5846.4 5853.0 5912.3 5919.3 3333.5 3566.0 3593.8 3801.6 3994.9 3851.5 4020.4 4032.2 4037.6 4069.6 4603.6 4613.0 4619.1 4638.3 4655.7 4561.0 4604.8 5221.4 5470.5 5675.5 1235.4 1303.3 1317.8 1323.7 1330.9 826.5 897.5 906.7 922.3 931.7 4439.1 4563.4 4583.5 4945.7 4972.7 4766.7 5336.0 5437.9 5555.0 5616.9 3979.9 4675.9 4746.8 4963.7 5010.1 2604.4 2634.7 2989.8 2993.6 3013.8 5587.9 5938.3 5962.3 5970.3 5973.5 5336.5 5617.2 5696.3 5872.3 5927.1 5861.7 5898.0 5936.5 5936.7 5943.5 4852.6 4972.4 5441.5 5560.3 5749.9 4879.2 5602.7 5613.7 5615.8 5633.9 5867.4 5890.1 5936.5 5943.8 5951.7 3079.7 3219.2 3602.6 3670.0 3756.1 5055.5 5643.3 5676.2 5748.0 5888.9 5053.7 5302.4 5696.0 5698.0 5732.5 4918.9 5375.7 5708.1 5709.1 5717.5 4998.6 5582.0 5584.6 5644.7 5649.0 4512.9 4811.4 5670.9 5706.4 5720.4 5155.9 5312.4 5426.7 5594.4 5627.6 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17555.96 Median:3182.94 stddev:24938.66 (783.5%) stddev-sans-first:24976.30 17:43:48 INFO - PROCESS | 1661 | Values: 647.4 666.9 668.7 728.4 775.6 14704.3 14825.1 15161.1 15472.5 15511.5 11890.4 14307.8 14343.4 14352.1 14383.3 727.9 797.4 916.8 943.6 947.7 939.8 944.1 945.7 947.7 951.8 1007.6 1009.8 1010.7 1013.8 1014.3 931.9 948.1 994.7 1000.7 1005.0 687.3 746.6 748.2 748.9 751.1 14383.2 14881.3 14884.2 14912.7 14917.3 11227.4 12062.1 12464.9 12709.0 12736.6 9874.9 9896.6 9903.2 9940.0 9984.3 3297.7 3451.3 3478.0 3571.5 3603.3 80269.0 80286.8 80664.0 81729.2 81815.6 7697.4 9233.1 9345.2 9442.4 9508.6 19581.4 19590.5 19595.7 19646.0 19648.2 7214.6 7258.8 7485.6 7587.1 7772.7 4145.6 4148.0 4158.9 4175.7 4196.5 3359.8 3470.7 3486.6 3494.3 3499.7 483.6 630.5 637.1 642.8 649.9 456.9 492.9 496.8 559.7 575.3 5779.7 7611.8 7952.8 7961.7 8430.7 446.4 545.7 574.5 586.2 586.4 3735.9 3764.3 3914.1 4002.7 4004.7 68500.3 84513.6 87183.0 87264.6 94896.0 63045.0 81328.2 81657.6 82320.6 83555.6 73937.0 74411.6 75248.2 75285.0 76187.0 7645.4 7653.7 7837.8 7844.1 7950.2 41513.8 41981.4 43247.0 43747.8 44205.6 57621.4 60043.7 60609.7 60822.0 60912.7 10101.5 10173.4 10315.7 10492.4 10655.1 11038.7 11248.4 11376.4 11645.7 11712.8 8164.3 9465.6 10556.2 10688.3 10703.6 10586.0 10667.5 10761.2 11010.7 11048.8 10340.9 10452.1 10601.1 10786.7 10897.2 8707.3 8831.9 8931.2 8954.2 9104.4 8689.4 8927.3 8995.0 9019.3 9122.6 17:43:48 INFO - PROCESS | 1661 | -------- Summary: end -------- 17:43:48 INFO - PROCESS | 1661 | 17:43:48 INFO - TEST-INFO | 1661: exit 0 17:43:48 INFO - TEST-OK | dromaeo_css | took 1112635ms 17:43:48 INFO - TEST-START | kraken 17:43:48 INFO - operating with platform_type : mac_ 17:43:48 INFO - Initialising browser for kraken test... 17:43:48 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpMaM1_G/profile http://localhost:49277/getInfo.html) 17:43:52 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 17:43:52 INFO - PROCESS | 1674 | colorDepth:24 17:43:52 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 17:43:52 INFO - PROCESS | 1674 | __metrics 17:43:52 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 17:43:52 INFO - TEST-INFO | 1674: exit 0 17:43:52 INFO - Browser initialized. 17:43:52 INFO - Running cycle 1/1 for kraken test... 17:43:52 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpMaM1_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:04 INFO - PROCESS | 1677 | RSS: Main: 250011648 17:44:04 INFO - PROCESS | 1677 | 17:44:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:08 INFO - PROCESS | 1677 | RSS: Main: 261861376 17:44:08 INFO - PROCESS | 1677 | 17:44:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 17:44:12 INFO - PROCESS | 1677 | RSS: Main: 266584064 17:44:12 INFO - PROCESS | 1677 | 17:44:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 17:44:16 INFO - PROCESS | 1677 | RSS: Main: 266850304 17:44:16 INFO - PROCESS | 1677 | 17:44:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 17:44:18 INFO - PROCESS | 1677 | RSS: Main: 267472896 17:44:18 INFO - PROCESS | 1677 | 17:44:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:21 INFO - PROCESS | 1677 | RSS: Main: 268075008 17:44:21 INFO - PROCESS | 1677 | 17:44:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:25 INFO - PROCESS | 1677 | RSS: Main: 267948032 17:44:25 INFO - PROCESS | 1677 | 17:44:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:29 INFO - PROCESS | 1677 | RSS: Main: 269541376 17:44:29 INFO - PROCESS | 1677 | 17:44:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 17:44:32 INFO - PROCESS | 1677 | RSS: Main: 270835712 17:44:32 INFO - PROCESS | 1677 | 17:44:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:35 INFO - PROCESS | 1677 | RSS: Main: 270704640 17:44:35 INFO - PROCESS | 1677 | 17:44:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:37 INFO - PROCESS | 1677 | RSS: Main: 270856192 17:44:37 INFO - PROCESS | 1677 | 17:44:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:40 INFO - PROCESS | 1677 | RSS: Main: 271253504 17:44:40 INFO - PROCESS | 1677 | 17:44:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:44 INFO - PROCESS | 1677 | RSS: Main: 271372288 17:44:44 INFO - PROCESS | 1677 | 17:44:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:48 INFO - PROCESS | 1677 | RSS: Main: 271577088 17:44:48 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 17:44:50 INFO - PROCESS | 1677 | RSS: Main: 273444864 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | __start_tp_report 17:44:50 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 17:44:50 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 17:44:50 INFO - PROCESS | 1677 | |i|pagename|runs| 17:44:50 INFO - PROCESS | 1677 | |0;ai-astar;116;117;112;112;132;169;155;115;119;166 17:44:50 INFO - PROCESS | 1677 | |1;audio-beat-detection;160;120;132;242;151;131;170;143;204;146 17:44:50 INFO - PROCESS | 1677 | |2;audio-dft;207;212;215;197;204;237;194;193;199;196 17:44:50 INFO - PROCESS | 1677 | |3;audio-fft;75;78;77;175;56;62;83;91;157;52 17:44:50 INFO - PROCESS | 1677 | |4;audio-oscillator;80;84;137;79;81;88;121;84;94;164 17:44:50 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;121;115;88;103;89;86;106;130;108;78 17:44:50 INFO - PROCESS | 1677 | |6;imaging-darkroom;94;96;95;96;118;151;97;95;95;118 17:44:50 INFO - PROCESS | 1677 | |7;imaging-desaturate;96;91;95;90;91;90;91;92;92;103 17:44:50 INFO - PROCESS | 1677 | |8;json-parse-financial;61;63;61;60;63;61;62;122;61;60 17:44:50 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;66;65;63;74;80;75;69;69;99;71 17:44:50 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;87;89;89;87;86;86;88;86;85;86 17:44:50 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;139;137;140;155;160;155;155;135;249;166 17:44:50 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;234;232;176;173;168;169;171;221;233;238 17:44:50 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;67;68;68;65;69;76;89;88;68;65 17:44:50 INFO - PROCESS | 1677 | __end_tp_report 17:44:50 INFO - PROCESS | 1677 | __start_cc_report 17:44:50 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1064 17:44:50 INFO - PROCESS | 1677 | __end_cc_report 17:44:50 INFO - PROCESS | 1677 | __startTimestamp1462841090289__endTimestamp 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | ------- Summary: start ------- 17:44:50 INFO - PROCESS | 1677 | Number of tests: 14 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:131.30 Median:125.50 stddev:23.07 (18.4%) stddev-sans-first:23.79 17:44:50 INFO - PROCESS | 1677 | Values: 116.0 117.0 112.0 112.0 132.0 169.0 155.0 115.0 119.0 166.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:159.90 Median:155.50 stddev:37.34 (24.0%) stddev-sans-first:39.61 17:44:50 INFO - PROCESS | 1677 | Values: 160.0 120.0 132.0 242.0 151.0 131.0 170.0 143.0 204.0 146.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:205.40 Median:205.50 stddev:13.43 (6.5%) stddev-sans-first:14.23 17:44:50 INFO - PROCESS | 1677 | Values: 207.0 212.0 215.0 197.0 204.0 237.0 194.0 193.0 199.0 196.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:90.60 Median:76.00 stddev:41.74 (54.9%) stddev-sans-first:43.89 17:44:50 INFO - PROCESS | 1677 | Values: 75.0 78.0 77.0 175.0 56.0 62.0 83.0 91.0 157.0 52.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:82.50 stddev:29.41 (35.7%) stddev-sans-first:30.18 17:44:50 INFO - PROCESS | 1677 | Values: 80.0 84.0 137.0 79.0 81.0 88.0 121.0 84.0 94.0 164.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:102.40 Median:104.00 stddev:16.87 (16.2%) stddev-sans-first:16.50 17:44:50 INFO - PROCESS | 1677 | Values: 121.0 115.0 88.0 103.0 89.0 86.0 106.0 130.0 108.0 78.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:95.00 stddev:18.55 (19.5%) stddev-sans-first:19.21 17:44:50 INFO - PROCESS | 1677 | Values: 94.0 96.0 95.0 96.0 118.0 151.0 97.0 95.0 95.0 118.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:91.50 stddev:4.01 (4.4%) stddev-sans-first:4.12 17:44:50 INFO - PROCESS | 1677 | Values: 96.0 91.0 95.0 90.0 91.0 90.0 91.0 92.0 92.0 103.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:61.00 stddev:19.21 (31.5%) stddev-sans-first:20.24 17:44:50 INFO - PROCESS | 1677 | Values: 61.0 63.0 61.0 60.0 63.0 61.0 62.0 122.0 61.0 60.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:72.50 stddev:10.43 (14.4%) stddev-sans-first:10.74 17:44:50 INFO - PROCESS | 1677 | Values: 66.0 65.0 63.0 74.0 80.0 75.0 69.0 69.0 99.0 71.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.37 (1.6%) stddev-sans-first:1.45 17:44:50 INFO - PROCESS | 1677 | Values: 87.0 89.0 89.0 87.0 86.0 86.0 88.0 86.0 85.0 86.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:159.10 Median:155.00 stddev:33.36 (21.5%) stddev-sans-first:34.59 17:44:50 INFO - PROCESS | 1677 | Values: 139.0 137.0 140.0 155.0 160.0 155.0 155.0 135.0 249.0 166.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.50 Median:226.50 stddev:32.08 (14.2%) stddev-sans-first:31.80 17:44:50 INFO - PROCESS | 1677 | Values: 234.0 232.0 176.0 173.0 168.0 169.0 171.0 221.0 233.0 238.0 17:44:50 INFO - PROCESS | 1677 | 17:44:50 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:68.50 stddev:9.07 (13.2%) stddev-sans-first:9.41 17:44:50 INFO - PROCESS | 1677 | Values: 67.0 68.0 68.0 65.0 69.0 76.0 89.0 88.0 68.0 65.0 17:44:50 INFO - PROCESS | 1677 | -------- Summary: end -------- 17:44:50 INFO - PROCESS | 1677 | 17:44:51 INFO - TEST-INFO | 1677: exit 0 17:44:51 INFO - TEST-OK | kraken | took 62174ms 17:44:51 INFO - SUITE-END | took 1174s 17:44:51 INFO - Completed test suite (00:19:35) 17:44:51 INFO - javascript benchmark 17:44:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3492.8602855885756, 3508.614052454231, 3533.469979503076, 3549.964500354996, 3555.520004799352, 5738.655680659163, 5852.481720302004, 5888.558358123142, 5901.085331773582, 5984.311804142525, 5614.578906582013, 5648.830535083944, 5723.141528770687, 5843.977303971798, 5888.116782482619, 5129.6409251352425, 5187.559057480119, 5203.661761985459, 5215.895682086356, 5254.605904557155, 616.5672248966031, 5203.791848326063, 5218.556422704056, 5229.8169564065265, 5282.815101471449, 5310.36275646921, 5344.759485823109, 5349.973250133744, 5364.544013758816, 5389.703566303851, 5238.79044838206, 5397.0, 5420.051490989061, 5423.349198096214, 5443.428440013781, 5204.3234379530795, 5253.50091741284, 5269.815556455505, 5269.973650131763, 5291.1798671206025, 5633.267675202238, 5660.235868157828, 5733.856653583652, 5757.510611597977, 5791.884162316772, 6208.161898143738, 6233.376662333776, 6295.464885484739, 6326.335734747831, 6328.557001009931, 6256.5307601930035, 6300.117983482271, 6327.620342779402, 6335.6198628082, 6336.841578960517, 4523.982104026601, 5571.220029195916, 5879.0, 5890.087036509305, 5890.087036509348, 6224.62652240867, 6261.68691565429, 6270.2475702915945, 6288.654124023223, 6290.559660823698, 6272.937270627326, 6275.748970041239, 6279.340669229665, 6312.368763123743, 6313.0, 6286.497080233662, 6304.842378940563, 6329.208848893888, 6331.905021424683, 6349.682515874188, 4603.0, 5422.810201642924, 5444.965456563319, 6013.428724271187, 6117.296510901214, 6190.7523699052435, 6232.034034724625, 6234.314225435199, 6284.842878928063, 6319.0, 4971.254311853251, 4973.701577905337, 4981.352424184905, 5015.14742493777, 5053.166227572483, 4422.756748378806, 4459.866204013885, 4468.084042771224, 4473.127740090651, 4529.68292219548, 5578.414266501959, 5869.295684517885, 5893.5579831512805, 5903.76384944606, 5933.554983376264, 6208.782692605737, 6281.152044473937, 6281.842953926097, 6294.181756371642, 6312.4634406076, 5230.163173892159, 5349.010433069894, 5650.378458369576, 5654.575906807006, 5875.823725288248, 4868.123737727243, 5270.92093618596, 5470.042742520043, 5483.7806487740845, 5556.749946252428, 6218.875622487525, 6298.244210694746, 6335.588186767845, 6398.936010639834, 6415.454686351713, 6223.844403889939, 6276.811695649138, 6284.622922624474, 6285.842853928689, 6298.055291706098, 6362.650054246876, 6395.872082558416, 6396.104545363746, 6398.520110991787, 6406.807795766134, 6129.481048574228, 6187.535934804818, 6188.319284878749, 6289.685515724104, 6300.117983482224, 6225.875482490415, 6231.781887633911, 6269.592476489013, 6288.371162883675, 6296.055591661104, 6266.310705822265, 6272.874542509216, 6272.968635156795, 6288.6855657217875, 6297.338779428094, 4689.296605509201, 6060.212172417558, 6074.301455332693, 6200.906986395298, 6246.562740608114, 4823.2282834746275, 5741.913871292018, 5945.851353716192, 5973.611715238496, 6039.698015099315, 6160.845978850564, 6244.344343844013, 6247.344028877084, 6251.624902505864, 6252.062190671436, 5908.970455147697, 6090.482309003784, 6095.664738439428, 6101.145839582373, 6136.846578835565], "value": 5690.092696786333, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.0167285503253, 533.8932213557289, 534.7459956520653, 562.4010428893229, 580.3500079910501, 38684.61315386845, 41381.37927931084, 41400.37899431503, 41403.79298103509, 41437.549685761005, 41910.7904460478, 42577.36133957985, 42599.361009584805, 42689.14621707564, 42719.0, 9637.662681806156, 9829.361091529028, 9851.605935762562, 9856.90143098567, 9880.357776744524, 9714.65998690046, 9785.657501987433, 9792.0, 9807.0, 9821.754456138582, 9723.854142187838, 9730.464824434688, 9757.316987810857, 9831.0, 9854.556544955458, 9733.659321923735, 9801.803963920718, 9813.165880900133, 9833.90166098337, 9835.557399917021, 8579.785505362415, 9606.567704453317, 9653.565589548487, 9727.0, 9749.07383798538, 32996.34007319864, 34449.483257751155, 35979.64020359789, 39146.412803807965, 39333.213335733126, 2775.306173456636, 2861.5850701648146, 2897.5219088850527, 2957.624704512412, 3260.6413294537583, 26211.868940655364, 27425.0, 27676.861615691992, 27732.861335693393, 28398.290042749097, 2472.929033797703, 2649.867506624661, 2777.8611069446647, 2780.3466185446405, 2785.665720113579, 445465.0, 455485.0, 458728.0, 461969.0, 463392.0, 34769.652303477145, 35041.12397190039, 35329.82335088308, 35369.82315088408, 35393.0, 35603.10992225215, 36762.44856327157, 37302.62697373046, 37764.811175944495, 39309.0, 17122.058286794345, 17262.741058884127, 17367.65264694699, 17374.652506950042, 17393.56516087108, 13182.60452186436, 13233.602991910066, 13243.933780331037, 13252.602421927357, 13292.800607990888, 20079.899600501903, 20199.39401817948, 20228.494287642632, 20253.79746202519, 20268.493287667927, 7053.929460705327, 8077.515349079074, 8078.636461359253, 8160.83678326442, 8191.836163276701, 950.254050570299, 1013.4527355228095, 1025.3335332034237, 1081.9513121909533, 1133.41629061032, 29599.40801183964, 29824.552631710543, 29877.0, 30152.643131059154, 30286.242843929078, 982.6609819612222, 1062.8592509135485, 1149.7987852125846, 1155.9768804623861, 1166.719987203065, 14136.646583835281, 15305.15821629821, 15386.461473848361, 15619.062856228662, 16065.036097834167, 678638.0, 690521.0, 693392.0, 694435.0, 695310.0, 60148.0, 60389.0, 61000.0, 61331.0, 61339.07991380133, 1390.610629023875, 1425.3514650833845, 1437.1233547535994, 1444.6316189371644, 1451.1583281696592, 29402.705972939995, 29501.11496655104, 29590.0, 30053.0, 30224.0, 51572.74213628908, 51770.964580708925, 52644.473555263954, 53091.46908530865, 53114.0, 610688.0, 611792.0, 611843.0, 612743.0, 616544.0, 26425.942962281293, 26593.601095983962, 26925.596116057885, 26970.112092153362, 27381.86309068442, 46129.30806037845, 46238.30642540432, 46760.0, 47456.28815567838, 47525.81185470252, 37097.443538347485, 37338.62661373351, 37844.05389865275, 38282.80858595689, 38553.0, 31206.843965780936, 36518.53925843043, 37889.4316585257, 38265.426018609185, 38514.614853852225, 37417.625823742506, 37643.81178094092, 38080.0, 38478.42282365823, 38890.80554597322, 32096.0, 32460.0, 32701.836490817393, 32759.0, 33298.667013329556, 22978.885105574365, 24726.876365618056, 24797.752022480265, 24893.377665557782, 25222.0], "value": 19407.032094444945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.7313462662557, 381.2051871847198, 385.92088621832517, 396.3321802762344, 406.8169323804289, 19116.70854772446, 19719.704204436945, 21621.891890540544, 21960.45098872527, 22081.227157049507, 12357.814632780493, 12525.060620453456, 15088.943773935829, 20269.898650506726, 21556.676649850266, 4609.469910960249, 5297.973510132453, 5454.018276710191, 5496.395396506381, 5519.806806761764, 4379.824807007716, 5139.820106296281, 5337.946620533803, 5359.115745901941, 5382.9730851345685, 5350.250964864922, 5365.114756065244, 5365.839024829262, 5372.677639341652, 5375.865603359908, 5490.149026900816, 5844.444777746107, 5913.497352725045, 5952.642841429506, 6026.668533230671, 4045.575214602454, 5278.841634750964, 5283.233931080011, 5330.92003619946, 5778.566607504454, 11835.934765871027, 12953.740925181537, 16092.83907160925, 25583.872080639663, 25795.226143215546, 2001.35956493922, 2020.595880823841, 2035.989820050905, 2063.515073957619, 2230.695043399613, 9984.90015099847, 10038.996100389975, 10170.389776613427, 13021.739565208738, 13489.65103489653, 1750.6323672028889, 1761.5772214668516, 1784.5449410400395, 1792.4353828543967, 1800.2259028617689, 124510.37744811308, 126391.944322227, 131421.34289328588, 132231.0, 133148.33425832907, 11512.251703639236, 11608.6517404478, 11915.808419158187, 11965.880341196651, 12105.757884842254, 15324.23378831054, 15344.769828452581, 15373.692526149638, 15380.92309538445, 15427.922860385626, 8703.042665306812, 8740.737777866674, 8776.341774366949, 8828.337874659426, 8830.337724670675, 7090.92909070913, 8610.87083693745, 8615.439996400213, 8627.784305392415, 8759.649614015496, 4637.930431043537, 4699.530046995342, 4726.905461890743, 4739.928901066487, 4819.349387832668, 1697.8217287184914, 1955.7653081630294, 2010.577778666467, 2032.6138033773536, 2035.1757538197053, 920.6225447566466, 925.2644147902433, 946.5409276500892, 980.1962390839443, 1023.1456733627356, 18812.717809232872, 19010.33463828787, 19688.310909118398, 20041.39875803728, 20175.798242017685, 928.7538802217417, 955.7349082674107, 969.0938972061005, 971.9951400242953, 978.7797745507204, 7439.0, 10692.518836652369, 10739.301945373525, 10749.301295415773, 10762.784744305227, 563799.0, 579590.0, 601386.0, 606395.9360406428, 609071.0, 106079.46960265304, 127891.0, 135962.640373595, 139438.3028084853, 148210.0, 968.8207681578931, 989.2778271861581, 1004.2167109654481, 1004.457592899826, 1013.2096964367657, 13453.932730336286, 15680.13759243207, 17089.743653844955, 17386.913065434594, 18234.36179733703, 38003.0, 44418.8459838827, 50527.0, 54684.72657636686, 56690.0, 84095.579522102, 84420.15579844368, 84578.0, 85629.57185214035, 85897.5640974354, 7866.488678235896, 7934.841303173789, 7967.163447838126, 8094.392920530866, 8099.554524501209, 9168.404053736485, 12094.213876098025, 12125.75748485043, 12213.328266945404, 12348.753024939271, 10430.582776688847, 10434.634787782696, 10543.947280263856, 10676.519556619816, 10751.086157676373, 9939.950300248453, 10141.188704903738, 10389.116925061455, 10575.995280448346, 10588.364698118137, 10650.254482186172, 10658.307210031324, 10929.672109836718, 10944.671659850217, 11025.889741102486, 7931.127575966754, 8017.518948863087, 8027.2775450209765, 8129.9187008129165, 8206.58967051633, 9902.207823374258, 10548.472576370998, 10815.621453249414, 10852.728681783019, 11022.779544408906], "value": 9259.045178368597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1553.650428653553, 1598.2168737318714, 1826.4977131288895, 1920.299090831846, 1985.8510611704125, 7767.378609711223, 8344.165583441652, 8346.582670866463, 8839.779005524864, 8850.380473366868, 7525.924740752591, 8474.830503389943, 8547.829043419144, 8654.783630409243, 8664.263537599312, 2347.3310106619574, 2371.537550177716, 2371.762823717632, 2383.6067048936907, 2387.4270175158013, 2360.775726305998, 2366.905323787055, 2405.9759402406016, 2412.9758702413014, 2415.0219161239725, 1999.270266352778, 2348.835581509295, 2381.2380038387723, 2395.161693407311, 2404.927852164429, 2359.3629719975684, 2363.527294541099, 2374.715034195899, 2380.0241900820665, 2382.5949588569983, 2300.919467818635, 2365.9171928982405, 2372.9762702372927, 2376.9049238030457, 2382.344855164826, 8636.870446943301, 8685.739427817112, 8721.433106848099, 8742.650293988232, 8750.69372571957, 5145.588352931756, 5252.8686782830355, 5254.97372513135, 5316.9202461963105, 5346.946530534723, 3369.4608862582113, 3464.185916309665, 3493.1092571394133, 3558.822058897045, 3564.697000754939, 1007.6271779441654, 1030.5568605499632, 1045.242199405425, 1046.8115739166947, 1048.5176818663424, 11242.156838237082, 11295.717607059807, 11396.715082123013, 11398.487068081957, 11428.200025998183, 3716.9628303716618, 4543.114092751948, 4617.538246175355, 4627.028324051987, 4637.698549594265, 8952.597133129026, 8981.910180898238, 9029.41308814938, 9037.322200834964, 9061.048589897966, 5132.435432102466, 5185.040767458032, 5202.81790137351, 5203.2195170723935, 5234.3718753749035, 3614.9335945896023, 4655.348251244761, 4812.133815913099, 4815.711057336571, 4815.807367705323, 3735.4396840474146, 3756.042209236627, 3836.827342769582, 3865.323568375523, 3869.96130038696, 1041.4532370505544, 1190.3512585640847, 1195.0857593940643, 1203.8796120387892, 1206.1858245684305, 827.6027506796771, 837.4514692876176, 852.624845068168, 886.7851044069666, 942.7218970403748, 4545.863624091283, 5873.295204575393, 5901.380355062743, 6027.879442411215, 6177.289611694623, 927.9164875161268, 979.5543027922279, 980.7302991677345, 996.7159359582629, 1030.4126647810826, 3723.236736469017, 3869.7484663496784, 4033.616806403387, 4040.6969477288735, 4067.633912947849, 10248.692539223835, 10674.306170098918, 10759.946200268949, 10785.622503212508, 10796.56813727442, 10568.15454763617, 10574.206934479946, 10686.091682206945, 10707.518161682743, 10800.945995269973, 7544.773656790305, 7909.327707144842, 8033.919660803317, 8069.6368663410285, 8161.918380816234, 5625.634333768292, 5782.132680098019, 5829.446202610745, 5835.7373918174635, 5895.29256489224, 9787.559559819683, 9919.15687166599, 9931.304808663324, 9951.651692190739, 10001.449920254456, 9464.716058518256, 9882.25883058759, 9901.653442129491, 10056.245781566266, 10078.496075196357, 6383.36166383358, 6907.93092069093, 7048.753293634698, 7661.425393095652, 8103.594820259082, 8078.676852925817, 8194.959025204837, 8268.37987150954, 8271.875921861298, 8280.71017514384, 7114.181869085121, 7279.963600182177, 7331.193568707545, 7385.446091543263, 7555.0, 7058.11773528309, 7253.238409966877, 7261.963690181516, 7265.891011634935, 7290.890636640349, 6815.284395138439, 6943.201531823703, 6996.685149168198, 6998.930010699828, 7027.437804975488, 4797.592204662643, 4807.495213002584, 4861.343718598086, 5010.073136469765, 5027.49725027509, 4966.981768737328, 5004.899902002013, 5039.118154323052, 5103.4386217516785, 5276.182191760283], "value": 4521.687097498467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.3480818452606, 308.8649214138041, 319.1781163503977, 324.76292306616165, 330.55540298298797, 4323.589259020388, 4845.563899249067, 5021.3221215135945, 5453.618246722726, 5472.0, 5314.927178400418, 5331.120365139747, 5333.626646134772, 5343.72891521103, 5364.946350536494, 3415.7267418606516, 3502.6672466115806, 4075.5924407559305, 4118.279301122307, 4146.170765846828, 3825.7321987460887, 3862.7489213201193, 4137.1518838638, 4163.583641635827, 4164.354525048622, 3432.5709286339206, 3875.1087249932534, 4047.4298820249205, 4051.4327994080704, 4122.216778812016, 3442.6213116557283, 4079.77561234132, 4102.953746794578, 4116.691248156385, 4140.3168477201525, 3169.6513383527795, 3306.470964645669, 3572.4105522588743, 3588.910277243064, 3604.062943634674, 4026.3960405939342, 4686.625069994427, 4751.667383283171, 4916.975415122937, 4977.278294647292, 4574.5425457453985, 4599.517050709695, 4611.976940115312, 4632.888106854364, 4647.6281897448125, 5584.972075139598, 5599.524040456566, 5640.661560306395, 5644.915326270109, 5652.777916587546, 3654.0998680685893, 3758.830852611639, 3787.5454945406727, 3915.451836742858, 3929.6463318301203, 5208.817691380784, 5846.444587764156, 5853.0, 5912.320083190445, 5919.260092488439, 3333.516640087174, 3566.0, 3593.8203089845924, 3801.6198380161763, 3994.9201015979515, 3851.4993050903763, 4020.3567429211184, 4032.1734044520804, 4037.6164264394833, 4069.6337329640473, 4603.562661547147, 4612.97693511537, 4619.0530941156985, 4638.281066434708, 4655.6973796703105, 4560.950981274259, 4604.7927843247135, 5221.399539052982, 5470.495613706263, 5675.489205971482, 1235.3699613197334, 1303.3027330378202, 1317.8418589769096, 1323.7490571409926, 1330.8669133086614, 826.4669288309007, 897.4525539420948, 906.7370462565914, 922.262190247799, 931.7142343565836, 4439.1121775645, 4563.383943167696, 4583.518730533246, 4945.727984960861, 4972.676776009548, 4766.737829419415, 5335.9594878999, 5437.918431223535, 5554.972225138848, 5616.85957851057, 3979.925420136547, 4675.906481870344, 4746.786394612251, 4963.734247766796, 5010.073136469765, 2604.361931326837, 2634.6574945256993, 2989.8206107633177, 2993.550967354914, 3013.789034767545, 5587.916181257285, 5938.317093534212, 5962.314333851576, 5970.31341395745, 5973.522118230531, 5336.519713225751, 5617.157426385993, 5696.316442026983, 5872.265966754156, 5927.081302398135, 5861.677607731531, 5898.026825573904, 5936.5250779937505, 5936.673482958392, 5943.503728434068, 4852.636052296021, 4972.378452693413, 5441.5102640762525, 5560.277163968658, 5749.942500574941, 4879.243717223836, 5602.663840169603, 5613.663180209201, 5615.831525054255, 5633.943660563506, 5867.442592953663, 5890.14592884038, 5936.495397891055, 5943.762249509971, 5951.672658003851, 3079.6920307969026, 3219.243477782766, 3602.621724718867, 3669.9816500917323, 3756.117312431522, 5055.545000949932, 5643.319423273912, 5676.20533125371, 5748.022836117953, 5888.939990801526, 5053.664581376274, 5302.390225124006, 5696.0, 5697.982922039869, 5732.455416735404, 4918.868660208101, 5375.704336261543, 5708.088874673863, 5709.143628455765, 5717.485426311652, 4998.550130488274, 5582.0, 5584.609077364546, 5644.689542075225, 5649.0, 4512.9097418052115, 4811.398575178103, 5670.858228544319, 5706.40220738194, 5720.3707592164, 5155.922661160011, 5312.442193569774, 5426.67439953604, 5594.384617692132, 5627.634203776905], "value": 4058.9915530930375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.3688154049805, 666.9366410191033, 668.6924014953121, 728.395431791613, 775.5928137727694, 14704.26478676066, 14825.110493370405, 15161.09033457992, 15472.458463953764, 15511.534653960385, 11890.405479726001, 14307.78538321926, 14343.42626294947, 14352.067115637476, 14383.280835958212, 727.9272072792731, 797.366093955304, 916.8349697054527, 943.6414162618196, 947.7251597036885, 939.7744541310104, 944.0936700767237, 945.6690158444524, 947.7109481608106, 951.8381875081253, 1007.6070332570304, 1009.8333774927165, 1010.7372083258332, 1013.8479228115768, 1014.2595904989362, 931.8741969834088, 948.127722495306, 994.7413672445144, 1000.6847842929491, 1004.9899501004969, 687.2611942162146, 746.6453434618567, 748.2031636307315, 748.9438292128112, 751.1286907187637, 14383.208923509203, 14881.255937203097, 14884.181370024644, 14912.70174596502, 14917.254137293092, 11227.38249396291, 12062.095342849321, 12464.937675311656, 12709.0, 12736.61790146297, 9874.90125098747, 9896.604135834557, 9903.207743380512, 9940.0, 9984.25118116137, 3297.7032067113837, 3451.2924850405607, 3477.9739976706933, 3571.5178450909057, 3603.3153700796765, 80269.0, 80286.79569806457, 80664.0, 81729.18270817335, 81815.59092204561, 7697.384209263246, 9233.076692330713, 9345.205657519187, 9442.433453992646, 9508.619655213852, 19581.412557623295, 19590.5102372439, 19595.706064409045, 19646.017699115273, 19648.21407143698, 7214.6031968241205, 7258.818529536804, 7485.588292643848, 7587.051618547682, 7772.650230739518, 4145.606167414091, 4148.0, 4158.896027599334, 4175.749455032707, 4196.454460920061, 3359.7816141950693, 3470.687638112582, 3486.564179477565, 3494.266204097117, 3499.6675315844955, 483.6300230323805, 630.5145038320468, 637.1334984421184, 642.8071578526424, 649.8862699027651, 456.8697921092539, 492.94755696588044, 496.7565892712617, 559.6642014791092, 575.3383608849856, 5779.711014449261, 7611.809704757315, 7952.80707893809, 7961.721339753197, 8430.651095824762, 446.43080072906656, 545.6971579932678, 574.4743559642964, 586.1617886422372, 586.3930831589284, 3735.8879233623034, 3764.265968136242, 3914.1388894443176, 4002.7198096133575, 4004.70086746943, 68500.3149968494, 84513.57743211245, 87183.0, 87264.56367718121, 94896.0, 63045.0, 81328.18671813325, 81657.59171204225, 82320.58839705883, 83555.5822220885, 73937.0, 74411.62794185994, 75248.24751752413, 75285.0, 76186.9999999989, 7645.350145237495, 7653.732119376018, 7837.843243135219, 7844.116912315763, 7950.24472675095, 41513.792431037655, 41981.37027944522, 43247.0, 43747.78126109349, 44205.55794442014, 57621.4237857616, 60043.699781500814, 60609.69695151496, 60822.0, 60912.69543652431, 10101.494925253855, 10173.389596624227, 10315.690529284133, 10492.422916739653, 10655.094316983143, 11038.668839934493, 11248.437578120898, 11376.431178441211, 11645.6506304811, 11712.824307635563, 8164.346852251687, 9465.574049167666, 10556.15550755953, 10688.305260158066, 10703.625373111903, 10586.0, 10667.46662666848, 10761.192910531585, 11010.724731881446, 11048.834267486154, 10340.896591034294, 10452.111570516287, 10601.098906593026, 10786.73033174177, 10897.182711296842, 8707.25988290977, 8831.867521987047, 8931.19619234272, 8954.238889694188, 9104.362694611578, 8689.391742577958, 8927.285817134743, 8994.955025225094, 9019.278457723498, 9122.635094596408], "value": 6666.759221386774, "unit": "score"}], "name": "dromaeo_css", "value": 7072.18973391813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 112.0, 112.0, 132.0, 169.0, 155.0, 115.0, 119.0, 166.0], "value": 131.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 120.0, 132.0, 242.0, 151.0, 131.0, 170.0, 143.0, 204.0, 146.0], "value": 159.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 212.0, 215.0, 197.0, 204.0, 237.0, 194.0, 193.0, 199.0, 196.0], "value": 205.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 77.0, 175.0, 56.0, 62.0, 83.0, 91.0, 157.0, 52.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 137.0, 79.0, 81.0, 88.0, 121.0, 84.0, 94.0, 164.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 115.0, 88.0, 103.0, 89.0, 86.0, 106.0, 130.0, 108.0, 78.0], "value": 102.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 118.0, 151.0, 97.0, 95.0, 95.0, 118.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 91.0, 95.0, 90.0, 91.0, 90.0, 91.0, 92.0, 92.0, 103.0], "value": 93.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 60.0, 63.0, 61.0, 62.0, 122.0, 61.0, 60.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 63.0, 74.0, 80.0, 75.0, 69.0, 69.0, 99.0, 71.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 89.0, 87.0, 86.0, 86.0, 88.0, 86.0, 85.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 140.0, 155.0, 160.0, 155.0, 155.0, 135.0, 249.0, 166.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [234.0, 232.0, 176.0, 173.0, 168.0, 169.0, 171.0, 221.0, 233.0, 238.0], "value": 201.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 69.0, 76.0, 89.0, 88.0, 68.0, 65.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1649.7, "alertThreshold": 2.0}]} 17:44:51 INFO - Return code: 0 17:44:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:44:51 ERROR - # TBPL SUCCESS # 17:44:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:51 INFO - 2016-05-09 17:44:51.613 screenresolution[1682:10578] starting screenresolution argv=screenresolution get 17:44:51 INFO - 2016-05-09 17:44:51.615 screenresolution[1682:10578] Display 0: 1600x1200x32@60 17:44:51 INFO - 2016-05-09 17:44:51.621 screenresolution[1683:10581] starting screenresolution argv=screenresolution list 17:44:51 INFO - Available Modes on Display 0 17:44:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:51 INFO - Intel Iris: 17:44:51 INFO - Chipset Model: Intel Iris 17:44:51 INFO - Type: GPU 17:44:51 INFO - Bus: Built-In 17:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:51 INFO - Vendor: Intel (0x8086) 17:44:51 INFO - Device ID: 0x0a2e 17:44:51 INFO - Revision ID: 0x0009 17:44:51 INFO - Displays: 17:44:51 INFO - Display: 17:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:51 INFO - Display Serial Number: 1600x1200 60 17:44:51 INFO - Main Display: Yes 17:44:51 INFO - Mirror: Off 17:44:51 INFO - Online: Yes 17:44:51 INFO - Rotation: Supported 17:44:51 INFO - Return code: 0 17:44:51 INFO - Running post-action listener: _resource_record_post_action 17:44:51 INFO - ##### 17:44:51 INFO - ##### Finished run-tests step (success) 17:44:51 INFO - ##### 17:44:51 INFO - Running post-run listener: _resource_record_post_run 17:44:52 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37922304; Write bytes: 699364864; Read time: 397; Write time: 1951 17:44:52 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382421504; Write bytes: 376108544; Read time: 28632; Write time: 669 17:44:52 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36951552; Write bytes: 300531712; Read time: 380; Write time: 1232 17:44:52 INFO - Running post-run listener: _upload_blobber_files 17:44:52 INFO - Blob upload gear active. 17:44:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:44:52 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 17:44:52 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'] 17:44:52 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 17:44:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:54 INFO - (blobuploader) - INFO - Done attempting. 17:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:55 INFO - (blobuploader) - INFO - Done attempting. 17:44:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:55 INFO - Return code: 0 17:44:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:44:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e6d626f83a9acfd3fcbcaa3b97bab23d0184cb8053e4ad7fdff7555ed2092374ec7df5952539f0c27e8173d6e6f83801078eb8a4e36fc8af07efe4727b4c1fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a19f1b9f9450baab0b5b4de669438778e8e0f544197567d7ac7d27bacb0c64ba1c4308422b64cb30a5b00e44bb4c3ea58163fb16d2ba7ffcff8fa6b6d3ea2d3"} 17:44:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:44:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:44:55 INFO - Contents: 17:44:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e6d626f83a9acfd3fcbcaa3b97bab23d0184cb8053e4ad7fdff7555ed2092374ec7df5952539f0c27e8173d6e6f83801078eb8a4e36fc8af07efe4727b4c1fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a19f1b9f9450baab0b5b4de669438778e8e0f544197567d7ac7d27bacb0c64ba1c4308422b64cb30a5b00e44bb4c3ea58163fb16d2ba7ffcff8fa6b6d3ea2d3"} 17:44:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:55 INFO - Copying logs to upload dir... 17:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:44:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.296289 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-09 17:44:55.273817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:44:55.277394) ========= 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.M16BkT0C2A/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.UkD83v16vb/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e6d626f83a9acfd3fcbcaa3b97bab23d0184cb8053e4ad7fdff7555ed2092374ec7df5952539f0c27e8173d6e6f83801078eb8a4e36fc8af07efe4727b4c1fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a19f1b9f9450baab0b5b4de669438778e8e0f544197567d7ac7d27bacb0c64ba1c4308422b64cb30a5b00e44bb4c3ea58163fb16d2ba7ffcff8fa6b6d3ea2d3"} build_url:https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/C_Lm80WVSWigxnwB4ZlEpg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e6d626f83a9acfd3fcbcaa3b97bab23d0184cb8053e4ad7fdff7555ed2092374ec7df5952539f0c27e8173d6e6f83801078eb8a4e36fc8af07efe4727b4c1fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a19f1b9f9450baab0b5b4de669438778e8e0f544197567d7ac7d27bacb0c64ba1c4308422b64cb30a5b00e44bb4c3ea58163fb16d2ba7ffcff8fa6b6d3ea2d3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:44:55.304811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:44:55.305119) ========= 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.M16BkT0C2A/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.UkD83v16vb/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005175 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:44:55.356561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:44:55.357369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:44:55.358174) ========= ========= Total master_lag: 0.16 =========