builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0078 starttime: 1462559573.57 results: success (0) buildid: 20160506093416 builduid: d7e76a5802534f1d87fe6a7ae2743057 revision: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.569140) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.569653) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.569956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.596112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.596497) ========= 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.V4N3UZkqbO/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.rePFjFhP95/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-06 11:32:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2016-05-06 11:32:53 (14.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.768126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.769385) ========= 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.V4N3UZkqbO/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.rePFjFhP95/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.019494 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.819118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:53.822536) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 --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 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V4N3UZkqbO/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.rePFjFhP95/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-06 11:32:53,979 truncating revision to first 12 chars 2016-05-06 11:32:53,979 Setting DEBUG logging. 2016-05-06 11:32:53,979 attempt 1/10 2016-05-06 11:32:53,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98730e9d1455?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 11:32:54,218 unpacking tar archive at: fx-team-98730e9d1455/testing/mozharness/ program finished with exit code 0 elapsedTime=0.478928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:54.321963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:54.322524) ========= script_repo_revision: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:54.323161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:54.323565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 11:32:54.342624) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-06 11:32:54.343161) ========= /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.V4N3UZkqbO/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.rePFjFhP95/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:32:54 INFO - MultiFileLogger online at 20160506 11:32:54 in /builds/slave/test 11:32:54 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 11:32:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:32:54 INFO - {'append_to_log': False, 11:32:54 INFO - 'base_work_dir': '/builds/slave/test', 11:32:54 INFO - 'blob_upload_branch': 'Fx-Team', 11:32:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:32:54 INFO - 'branch': 'Fx-Team', 11:32:54 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:54 INFO - 'config_files': ('talos/mac_config.py',), 11:32:54 INFO - 'default_actions': ('clobber', 11:32:54 INFO - 'read-buildbot-config', 11:32:54 INFO - 'download-and-extract', 11:32:54 INFO - 'populate-webroot', 11:32:54 INFO - 'create-virtualenv', 11:32:54 INFO - 'install', 11:32:54 INFO - 'run-tests'), 11:32:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:54 INFO - 'download_minidump_stackwalk': True, 11:32:54 INFO - 'download_symbols': 'ondemand', 11:32:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:54 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:54 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:54 INFO - 'installer_path': 'installer.exe', 11:32:54 INFO - 'log_level': 'info', 11:32:54 INFO - 'log_name': 'talos', 11:32:54 INFO - 'log_to_console': True, 11:32:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:32:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:32:54 INFO - 'opt_config_files': (), 11:32:54 INFO - 'pip_index': False, 11:32:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:32:54 INFO - 'cmd': ('bash', 11:32:54 INFO - '-c', 11:32:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:32:54 INFO - 'enabled': True, 11:32:54 INFO - 'halt_on_failure': False, 11:32:54 INFO - 'name': 'check_screen_resolution'},), 11:32:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:32:54 INFO - 'cmd': ('bash', 11:32:54 INFO - '-c', 11:32:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:32:54 INFO - 'enabled': True, 11:32:54 INFO - 'halt_on_failure': False, 11:32:54 INFO - 'name': 'check_screen_resolution'},), 11:32:54 INFO - 'run_cmd_checks_enabled': True, 11:32:54 INFO - 'sps_profile': False, 11:32:54 INFO - 'sps_profile_interval': 0, 11:32:54 INFO - 'suite': 'dromaeojs-e10s', 11:32:54 INFO - 'system_bits': '32', 11:32:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:54 INFO - 'title': 't-yosemite-r7-0078', 11:32:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:54 INFO - 'use_talos_json': True, 11:32:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:32:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:54 INFO - 'work_dir': 'build'} 11:32:54 INFO - ##### 11:32:54 INFO - ##### Running clobber step. 11:32:54 INFO - ##### 11:32:54 INFO - Running pre-action listener: _resource_record_pre_action 11:32:54 INFO - Running main action method: clobber 11:32:54 INFO - rmtree: /builds/slave/test/build 11:32:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:32:55 INFO - Running post-action listener: _resource_record_post_action 11:32:55 INFO - ##### 11:32:55 INFO - ##### Finished clobber step (success) 11:32:55 INFO - ##### 11:32:55 INFO - ##### 11:32:55 INFO - ##### Running read-buildbot-config step. 11:32:55 INFO - ##### 11:32:55 INFO - Running pre-action listener: _resource_record_pre_action 11:32:55 INFO - Running main action method: read_buildbot_config 11:32:55 INFO - Using buildbot properties: 11:32:55 INFO - { 11:32:55 INFO - "project": "", 11:32:55 INFO - "product": "firefox", 11:32:55 INFO - "script_repo_revision": "production", 11:32:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:32:55 INFO - "repository": "", 11:32:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:32:55 INFO - "buildid": "20160506093416", 11:32:55 INFO - "pgo_build": "False", 11:32:55 INFO - "basedir": "/builds/slave/test", 11:32:55 INFO - "buildnumber": 750, 11:32:55 INFO - "slavename": "t-yosemite-r7-0078", 11:32:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:32:55 INFO - "platform": "yosemite_r7", 11:32:55 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:32:55 INFO - "branch": "fx-team", 11:32:55 INFO - "repo_path": "integration/fx-team", 11:32:55 INFO - "revision": "98730e9d1455e5819b67a7bdfcd0bc976e509ff1", 11:32:55 INFO - "stage_platform": "macosx64", 11:32:55 INFO - "builduid": "d7e76a5802534f1d87fe6a7ae2743057", 11:32:55 INFO - "slavebuilddir": "test" 11:32:55 INFO - } 11:32:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 11:32:55 INFO - Running post-action listener: _resource_record_post_action 11:32:55 INFO - ##### 11:32:55 INFO - ##### Finished read-buildbot-config step (success) 11:32:55 INFO - ##### 11:32:55 INFO - ##### 11:32:55 INFO - ##### Running download-and-extract step. 11:32:55 INFO - ##### 11:32:55 INFO - Running pre-action listener: _resource_record_pre_action 11:32:55 INFO - Running main action method: download_and_extract 11:32:55 INFO - mkdir: /builds/slave/test/build/tests 11:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:55 INFO - https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 11:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 11:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:32:57 INFO - Downloaded 1199 bytes. 11:32:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 11:32:57 INFO - Using the following test package requirements: 11:32:57 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 11:32:57 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 11:32:57 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 11:32:57 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'jsshell-mac.zip'], 11:32:57 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 11:32:57 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 11:32:57 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 11:32:57 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 11:32:57 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 11:32:57 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:32:57 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 11:32:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:57 INFO - https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:32:59 INFO - Downloaded 18145029 bytes. 11:32:59 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'] 11:32:59 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 11:33:02 INFO - Return code: 0 11:33:02 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 11:33:02 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')]} 11:33:02 INFO - https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:33:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:33:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:33:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:33:03 INFO - Downloaded 18145029 bytes. 11:33:03 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'] 11:33:03 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 11:33:07 INFO - Return code: 0 11:33:07 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')]} 11:33:07 INFO - https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:33:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:33:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:33:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:33:08 INFO - Downloaded 10840152 bytes. 11:33:08 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'] 11:33:08 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 11:33:08 INFO - Return code: 0 11:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:08 INFO - https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:33:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:33:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:33:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 11:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SpeYAu74SHSN26WX07cFWg/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 11:33:11 INFO - Downloaded 110452096 bytes. 11:33:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:33:11 INFO - mkdir: /builds/slave/test/properties 11:33:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:33:11 INFO - Writing to file /builds/slave/test/properties/build_url 11:33:11 INFO - Contents: 11:33:11 INFO - build_url:https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:33:12 INFO - Running post-action listener: _resource_record_post_action 11:33:12 INFO - Running post-action listener: set_extra_try_arguments 11:33:12 INFO - ##### 11:33:12 INFO - ##### Finished download-and-extract step (success) 11:33:12 INFO - ##### 11:33:12 INFO - ##### 11:33:12 INFO - ##### Running populate-webroot step. 11:33:12 INFO - ##### 11:33:12 INFO - Running pre-action listener: _resource_record_pre_action 11:33:12 INFO - Running main action method: populate_webroot 11:33:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:33:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:33:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:33:12 INFO - '--tppagecycles', 11:33:12 INFO - '7'], 11:33:12 INFO - 'tests': ['tsvgm']}}, 11:33:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:33:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:33:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:33:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:33:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:33:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['damp', 'tps']}, 11:33:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'tests': ['damp', 'tps']}, 11:33:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['dromaeo_dom']}, 11:33:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:33:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['a11yr', 11:33:12 INFO - 'ts_paint', 11:33:12 INFO - 'tpaint', 11:33:12 INFO - 'sessionrestore', 11:33:12 INFO - 'sessionrestore_no_auto_restore', 11:33:12 INFO - 'tabpaint']}, 11:33:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:33:12 INFO - 'ts_paint', 11:33:12 INFO - 'tpaint', 11:33:12 INFO - 'sessionrestore', 11:33:12 INFO - 'sessionrestore_no_auto_restore', 11:33:12 INFO - 'tabpaint']}, 11:33:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:33:12 INFO - 'ts_paint', 11:33:12 INFO - 'tpaint', 11:33:12 INFO - 'sessionrestore', 11:33:12 INFO - 'sessionrestore_no_auto_restore', 11:33:12 INFO - 'tabpaint']}, 11:33:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:33:12 INFO - 'ts_paint', 11:33:12 INFO - 'tpaint', 11:33:12 INFO - 'sessionrestore', 11:33:12 INFO - 'sessionrestore_no_auto_restore', 11:33:12 INFO - 'tabpaint']}, 11:33:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['a11yr', 11:33:12 INFO - 'ts_paint', 11:33:12 INFO - 'tpaint', 11:33:12 INFO - 'sessionrestore', 11:33:12 INFO - 'sessionrestore_no_auto_restore', 11:33:12 INFO - 'tabpaint']}, 11:33:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['a11yr', 11:33:12 INFO - 'ts_paint', 11:33:12 INFO - 'tpaint', 11:33:12 INFO - 'sessionrestore', 11:33:12 INFO - 'sessionrestore_no_auto_restore', 11:33:12 INFO - 'tabpaint']}, 11:33:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['tsvgx', 11:33:12 INFO - 'tsvgr_opacity', 11:33:12 INFO - 'tart', 11:33:12 INFO - 'tscrollx', 11:33:12 INFO - 'cart']}, 11:33:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:33:12 INFO - 'tsvgr_opacity', 11:33:12 INFO - 'tart', 11:33:12 INFO - 'tscrollx', 11:33:12 INFO - 'cart']}, 11:33:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'talos_options': ['--disable-e10s'], 11:33:12 INFO - 'tests': ['tp5o']}, 11:33:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'tests': ['tp5o']}, 11:33:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'talos_options': ['--disable-e10s', 11:33:12 INFO - '--xperf_path', 11:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:12 INFO - 'tests': ['tp5n']}, 11:33:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:33:12 INFO - 'talos_options': ['--xperf_path', 11:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:33:12 INFO - 'tests': ['tp5n']}}, 11:33:12 INFO - 'talos.zip': {'path': '', 11:33:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:33:12 INFO - Running post-action listener: _resource_record_post_action 11:33:12 INFO - ##### 11:33:12 INFO - ##### Finished populate-webroot step (success) 11:33:12 INFO - ##### 11:33:12 INFO - ##### 11:33:12 INFO - ##### Running create-virtualenv step. 11:33:12 INFO - ##### 11:33:12 INFO - Running pre-action listener: _resource_record_pre_action 11:33:12 INFO - Running main action method: create_virtualenv 11:33:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:33:12 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 11:33:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:33:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:33:12 INFO - Using real prefix '/tools/python27' 11:33:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:33:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:33:16 INFO - Installing pip.................done. 11:33:16 INFO - Return code: 0 11:33:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:33:16 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')]} 11:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:16 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')]} 11:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:16 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:16 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 11:33:16 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 11:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:16 INFO - 'HOME': '/Users/cltbld', 11:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:16 INFO - 'LOGNAME': 'cltbld', 11:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:16 INFO - 'MOZ_NO_REMOTE': '1', 11:33:16 INFO - 'NO_EM_RESTART': '1', 11:33:16 INFO - 'PAGER': '/bin/cat', 11:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:16 INFO - 'PWD': '/builds/slave/test', 11:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:16 INFO - 'SHELL': '/bin/bash', 11:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:16 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:16 INFO - 'USER': 'cltbld', 11:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:16 INFO - 'XPC_FLAGS': '0x0', 11:33:16 INFO - 'XPC_SERVICE_NAME': '0', 11:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:16 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 11:33:16 INFO - Cleaning up... 11:33:16 INFO - Return code: 0 11:33:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:33:16 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')]} 11:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:16 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')]} 11:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:16 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:16 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 11:33:16 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 11:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:16 INFO - 'HOME': '/Users/cltbld', 11:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:16 INFO - 'LOGNAME': 'cltbld', 11:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:16 INFO - 'MOZ_NO_REMOTE': '1', 11:33:16 INFO - 'NO_EM_RESTART': '1', 11:33:16 INFO - 'PAGER': '/bin/cat', 11:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:16 INFO - 'PWD': '/builds/slave/test', 11:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:16 INFO - 'SHELL': '/bin/bash', 11:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:16 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:16 INFO - 'USER': 'cltbld', 11:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:16 INFO - 'XPC_FLAGS': '0x0', 11:33:16 INFO - 'XPC_SERVICE_NAME': '0', 11:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:17 INFO - Downloading/unpacking psutil>=0.7.1 11:33:17 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 11:33:17 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 11:33:17 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 11:33:17 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 11:33:17 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 11:33:17 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 11:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:33:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:19 INFO - Installing collected packages: psutil 11:33:19 INFO - Running setup.py install for psutil 11:33:19 INFO - building 'psutil._psutil_osx' extension 11:33:19 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 11:33:20 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 11:33:20 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 11:33:20 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 11:33:20 INFO - building 'psutil._psutil_posix' extension 11:33:20 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 11:33:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:33:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:33:20 INFO - ^ 11:33:20 INFO - 1 warning generated. 11:33:20 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 11:33:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:33:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:33:20 INFO - Successfully installed psutil 11:33:20 INFO - Cleaning up... 11:33:20 INFO - Return code: 0 11:33:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:20 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:20 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 11:33:20 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 11:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:20 INFO - 'HOME': '/Users/cltbld', 11:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:20 INFO - 'LOGNAME': 'cltbld', 11:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:20 INFO - 'MOZ_NO_REMOTE': '1', 11:33:20 INFO - 'NO_EM_RESTART': '1', 11:33:20 INFO - 'PAGER': '/bin/cat', 11:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:20 INFO - 'PWD': '/builds/slave/test', 11:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:20 INFO - 'SHELL': '/bin/bash', 11:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:20 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:20 INFO - 'USER': 'cltbld', 11:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:20 INFO - 'XPC_FLAGS': '0x0', 11:33:20 INFO - 'XPC_SERVICE_NAME': '0', 11:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:33: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 11:33: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 11:33: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 11:33: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 11:33: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 11:33: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 11:33:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:33:23 INFO - Installing collected packages: mozsystemmonitor 11:33:23 INFO - Running setup.py install for mozsystemmonitor 11:33:23 INFO - Successfully installed mozsystemmonitor 11:33:23 INFO - Cleaning up... 11:33:23 INFO - Return code: 0 11:33:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:33:23 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')]} 11:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:23 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')]} 11:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:23 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:23 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 11:33:23 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 11:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:23 INFO - 'HOME': '/Users/cltbld', 11:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:23 INFO - 'LOGNAME': 'cltbld', 11:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:23 INFO - 'MOZ_NO_REMOTE': '1', 11:33:23 INFO - 'NO_EM_RESTART': '1', 11:33:23 INFO - 'PAGER': '/bin/cat', 11:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:23 INFO - 'PWD': '/builds/slave/test', 11:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:23 INFO - 'SHELL': '/bin/bash', 11:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:23 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:23 INFO - 'USER': 'cltbld', 11:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:23 INFO - 'XPC_FLAGS': '0x0', 11:33:23 INFO - 'XPC_SERVICE_NAME': '0', 11:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:33:23 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 11:33:23 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 11:33:23 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 11:33:23 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 11:33:23 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 11:33:23 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 11:33:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:33:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:26 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 11:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:33:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:26 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 11:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:27 INFO - Downloading docopt-0.6.1.tar.gz 11:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:33:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:33:27 INFO - Running setup.py install for blobuploader 11:33:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:33:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:33:27 INFO - Running setup.py install for requests 11:33:28 INFO - Running setup.py install for docopt 11:33:28 INFO - Successfully installed blobuploader requests docopt 11:33:28 INFO - Cleaning up... 11:33:28 INFO - Return code: 0 11:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:28 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')]} 11:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:28 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')]} 11:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:28 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:28 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 11:33:28 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 11:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:28 INFO - 'HOME': '/Users/cltbld', 11:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:28 INFO - 'LOGNAME': 'cltbld', 11:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:28 INFO - 'MOZ_NO_REMOTE': '1', 11:33:28 INFO - 'NO_EM_RESTART': '1', 11:33:28 INFO - 'PAGER': '/bin/cat', 11:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:28 INFO - 'PWD': '/builds/slave/test', 11:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:28 INFO - 'SHELL': '/bin/bash', 11:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:28 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:28 INFO - 'USER': 'cltbld', 11:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:28 INFO - 'XPC_FLAGS': '0x0', 11:33:28 INFO - 'XPC_SERVICE_NAME': '0', 11:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:28 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TuhTVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:28 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-zouf85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:28 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hZedwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:28 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-0ukrPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hKRp97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7kVcBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7N9f6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-W2MziF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5D0Prs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WO3k5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XAAdEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-nB9f3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-K5devP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:29 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5jesPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:30 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-8pySGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:30 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JnBTr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:30 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-udvjGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:33:30 INFO - Running setup.py install for manifestparser 11:33:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:33:30 INFO - Running setup.py install for mozcrash 11:33:30 INFO - Running setup.py install for mozdebug 11:33:30 INFO - Running setup.py install for mozdevice 11:33:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:33:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:33:30 INFO - Running setup.py install for mozfile 11:33:31 INFO - Running setup.py install for mozhttpd 11:33:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Running setup.py install for mozinfo 11:33:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Running setup.py install for mozInstall 11:33:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Running setup.py install for mozleak 11:33:31 INFO - Running setup.py install for mozlog 11:33:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:33:31 INFO - Running setup.py install for moznetwork 11:33:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:33:32 INFO - Running setup.py install for mozprocess 11:33:32 INFO - Running setup.py install for mozprofile 11:33:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:33:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:33:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:33:32 INFO - Running setup.py install for mozrunner 11:33:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:33:32 INFO - Running setup.py install for mozscreenshot 11:33:32 INFO - Running setup.py install for moztest 11:33:32 INFO - Running setup.py install for mozversion 11:33:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:33:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:33:32 INFO - Cleaning up... 11:33:32 INFO - Return code: 0 11:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33: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')]} 11:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33: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')]} 11:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:32 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:32 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 11:33:32 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 11:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:32 INFO - 'HOME': '/Users/cltbld', 11:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:32 INFO - 'LOGNAME': 'cltbld', 11:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:32 INFO - 'MOZ_NO_REMOTE': '1', 11:33:32 INFO - 'NO_EM_RESTART': '1', 11:33:32 INFO - 'PAGER': '/bin/cat', 11:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:32 INFO - 'PWD': '/builds/slave/test', 11:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:32 INFO - 'SHELL': '/bin/bash', 11:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:32 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:32 INFO - 'USER': 'cltbld', 11:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:32 INFO - 'XPC_FLAGS': '0x0', 11:33:32 INFO - 'XPC_SERVICE_NAME': '0', 11:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-RuLmI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-cVIVCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-GgdGkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-0C_dZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-crT556-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-yBseqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-w5jSN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:33:33 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)) 11:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:33:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-SDvRkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-NPk9Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-eRmxCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-tY7npA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-W2KNOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-3NFzRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-rtlEwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-trkaNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JEfGWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:33:34 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)) 11:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:33:34 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-iLeVir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:33:34 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)) 11:33:35 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)) 11:33:35 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)) 11:33:35 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)) 11:33:35 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)) 11:33:35 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)) 11:33:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:33: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 11:33: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 11:33: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 11:33: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 11:33: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 11:33: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 11:33:37 INFO - Downloading blessings-1.6.tar.gz 11:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:33:37 INFO - Installing collected packages: blessings 11:33:37 INFO - Running setup.py install for blessings 11:33:37 INFO - Successfully installed blessings 11:33:37 INFO - Cleaning up... 11:33:37 INFO - Return code: 0 11:33:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:33:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:38 INFO - Reading from file tmpfile_stdout 11:33:38 INFO - Current package versions: 11:33:38 INFO - blessings == 1.6 11:33:38 INFO - blobuploader == 1.2.4 11:33:38 INFO - docopt == 0.6.1 11:33:38 INFO - manifestparser == 1.1 11:33:38 INFO - mozInstall == 1.12 11:33:38 INFO - mozcrash == 0.17 11:33:38 INFO - mozdebug == 0.1 11:33:38 INFO - mozdevice == 0.48 11:33:38 INFO - mozfile == 1.2 11:33:38 INFO - mozhttpd == 0.7 11:33:38 INFO - mozinfo == 0.9 11:33:38 INFO - mozleak == 0.1 11:33:38 INFO - mozlog == 3.1 11:33:38 INFO - moznetwork == 0.27 11:33:38 INFO - mozprocess == 0.22 11:33:38 INFO - mozprofile == 0.28 11:33:38 INFO - mozrunner == 6.11 11:33:38 INFO - mozscreenshot == 0.1 11:33:38 INFO - mozsystemmonitor == 0.0 11:33:38 INFO - moztest == 0.7 11:33:38 INFO - mozversion == 1.4 11:33:38 INFO - psutil == 3.1.1 11:33:38 INFO - requests == 1.2.3 11:33:38 INFO - wsgiref == 0.1.2 11:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:38 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:38 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 11:33:38 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 11:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:38 INFO - 'HOME': '/Users/cltbld', 11:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:38 INFO - 'LOGNAME': 'cltbld', 11:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:38 INFO - 'MOZ_NO_REMOTE': '1', 11:33:38 INFO - 'NO_EM_RESTART': '1', 11:33:38 INFO - 'PAGER': '/bin/cat', 11:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:38 INFO - 'PWD': '/builds/slave/test', 11:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:38 INFO - 'SHELL': '/bin/bash', 11:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:38 INFO - 'USER': 'cltbld', 11:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:38 INFO - 'XPC_FLAGS': '0x0', 11:33:38 INFO - 'XPC_SERVICE_NAME': '0', 11:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 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)) 11:33:38 INFO - Cleaning up... 11:33:38 INFO - Return code: 0 11:33:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:38 INFO - 'HOME': '/Users/cltbld', 11:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:38 INFO - 'LOGNAME': 'cltbld', 11:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:38 INFO - 'MOZ_NO_REMOTE': '1', 11:33:38 INFO - 'NO_EM_RESTART': '1', 11:33:38 INFO - 'PAGER': '/bin/cat', 11:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:38 INFO - 'PWD': '/builds/slave/test', 11:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:38 INFO - 'SHELL': '/bin/bash', 11:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:38 INFO - 'USER': 'cltbld', 11:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:38 INFO - 'XPC_FLAGS': '0x0', 11:33:38 INFO - 'XPC_SERVICE_NAME': '0', 11:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:38 INFO - Downloading/unpacking jsonschema 11:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:33:41 INFO - Downloading/unpacking functools32 (from jsonschema) 11:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:33:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:33:41 INFO - warning: no files found matching '*.txt' 11:33:41 INFO - no previously-included directories found matching 'build' 11:33:41 INFO - no previously-included directories found matching 'dist' 11:33:41 INFO - no previously-included directories found matching '.git*' 11:33:41 INFO - Installing collected packages: jsonschema, functools32 11:33:41 INFO - Running setup.py install for functools32 11:33:41 INFO - warning: no files found matching '*.txt' 11:33:41 INFO - no previously-included directories found matching 'build' 11:33:41 INFO - no previously-included directories found matching 'dist' 11:33:41 INFO - no previously-included directories found matching '.git*' 11:33:41 INFO - Successfully installed jsonschema functools32 11:33:41 INFO - Cleaning up... 11:33:41 INFO - Return code: 0 11:33:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:33:41 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')]} 11:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:41 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')]} 11:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:33:41 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 0x10349ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ae420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86d3c769b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, '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.V4N3UZkqbO/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.rePFjFhP95/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 11:33:41 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 11:33:41 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 11:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:33:41 INFO - 'HOME': '/Users/cltbld', 11:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:33:41 INFO - 'LOGNAME': 'cltbld', 11:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:41 INFO - 'MOZ_NO_REMOTE': '1', 11:33:41 INFO - 'NO_EM_RESTART': '1', 11:33:41 INFO - 'PAGER': '/bin/cat', 11:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:41 INFO - 'PWD': '/builds/slave/test', 11:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:33:41 INFO - 'SHELL': '/bin/bash', 11:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:33:41 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:33:41 INFO - 'USER': 'cltbld', 11:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:41 INFO - 'XPC_FLAGS': '0x0', 11:33:41 INFO - 'XPC_SERVICE_NAME': '0', 11:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:42 INFO - Downloading/unpacking flake8 11:33:42 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 11:33:42 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 11:33:42 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 11:33:42 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 11:33:42 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 11:33:42 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 11:33:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:33:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:33:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 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 11:33:44 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 11:33:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:33:45 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 11:33:45 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 11:33:45 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 11:33:45 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 11:33:45 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 11:33:45 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 11:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:33:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:33:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:33:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:33:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:33:45 INFO - no previously-included directories found matching 'docs/_build' 11:33:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:33:45 INFO - Running setup.py install for pep8 11:33:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:33:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:33:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:33:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:33:46 INFO - no previously-included directories found matching 'docs/_build' 11:33:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:33:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:33:46 INFO - Cleaning up... 11:33:46 INFO - Return code: 0 11:33:46 INFO - Running post-action listener: _resource_record_post_action 11:33:46 INFO - Running post-action listener: _start_resource_monitoring 11:33:46 INFO - Starting resource monitoring. 11:33:46 INFO - ##### 11:33:46 INFO - ##### Finished create-virtualenv step (success) 11:33:46 INFO - ##### 11:33:46 INFO - ##### 11:33:46 INFO - ##### Running install step. 11:33:46 INFO - ##### 11:33:46 INFO - Running pre-action listener: _resource_record_pre_action 11:33:46 INFO - Running main action method: install 11:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:46 INFO - Reading from file tmpfile_stdout 11:33:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:33:46 INFO - Reading from file tmpfile_stdout 11:33:46 INFO - Output received: 11:33:46 INFO - Usage: mozinstall [options] installer 11:33:46 INFO - Options: 11:33:46 INFO - -h, --help show this help message and exit 11:33:46 INFO - -d DEST, --destination=DEST 11:33:46 INFO - Directory to install application into. [default: 11:33:46 INFO - "/builds/slave/test"] 11:33:46 INFO - --app=APP Application being installed. [default: firefox] 11:33:46 INFO - mkdir: /builds/slave/test/build/application 11:33:46 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'] 11:33:46 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 11:34:19 INFO - Reading from file tmpfile_stdout 11:34:19 INFO - Output received: 11:34:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:34:19 INFO - Running post-action listener: _resource_record_post_action 11:34:19 INFO - ##### 11:34:19 INFO - ##### Finished install step (success) 11:34:19 INFO - ##### 11:34:19 INFO - ##### 11:34:19 INFO - ##### Running run-tests step. 11:34:19 INFO - ##### 11:34:19 INFO - Running pre-action listener: _resource_record_pre_action 11:34:19 INFO - Running main action method: run_tests 11:34:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:34:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:34:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:34:19 INFO - 2016-05-06 11:34:19.725 screenresolution[1911:19883] starting screenresolution argv=screenresolution get 11:34:19 INFO - 2016-05-06 11:34:19.728 screenresolution[1911:19883] Display 0: 1600x1200x32@60 11:34:19 INFO - 2016-05-06 11:34:19.734 screenresolution[1912:19886] starting screenresolution argv=screenresolution list 11:34:19 INFO - Available Modes on Display 0 11:34:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:34:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:34:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:34:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:34:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:34:19 INFO - Intel Iris: 11:34:19 INFO - Chipset Model: Intel Iris 11:34:19 INFO - Type: GPU 11:34:19 INFO - Bus: Built-In 11:34:19 INFO - VRAM (Dynamic, Max): 1536 MB 11:34:19 INFO - Vendor: Intel (0x8086) 11:34:19 INFO - Device ID: 0x0a2e 11:34:19 INFO - Revision ID: 0x0009 11:34:19 INFO - Displays: 11:34:19 INFO - Display: 11:34:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:34:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:34:19 INFO - Display Serial Number: 1600x1200 60 11:34:19 INFO - Main Display: Yes 11:34:19 INFO - Mirror: Off 11:34:19 INFO - Online: Yes 11:34:19 INFO - Rotation: Supported 11:34:19 INFO - Return code: 0 11:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:19 INFO - Python 2.7.3 11:34:19 INFO - Return code: 0 11:34:19 INFO - grabbing minidump binary from tooltool 11:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:19 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 0x10333de00>, '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 0x1031a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103338b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:19 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 11:34:19 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 11:34:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:20 INFO - Return code: 0 11:34:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:34:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:34:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:34:21 INFO - Return code: 0 11:34:21 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/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 11:34:21 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/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --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 11:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4N3UZkqbO/Render', 11:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:34:21 INFO - 'HOME': '/Users/cltbld', 11:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:34:21 INFO - 'LOGNAME': 'cltbld', 11:34:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:21 INFO - 'MOZ_NO_REMOTE': '1', 11:34:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:21 INFO - 'NO_EM_RESTART': '1', 11:34:21 INFO - 'PAGER': '/bin/cat', 11:34:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:21 INFO - 'PWD': '/builds/slave/test', 11:34:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:34:21 INFO - 'SHELL': '/bin/bash', 11:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rePFjFhP95/Listeners', 11:34:21 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 11:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:34:21 INFO - 'USER': 'cltbld', 11:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:21 INFO - 'XPC_FLAGS': '0x0', 11:34:21 INFO - 'XPC_SERVICE_NAME': '0', 11:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:34:21 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/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 11:34:21 INFO - mozversion application_buildid: 20160506093416 11:34:21 INFO - mozversion application_changeset: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 11:34:21 INFO - mozversion application_display_name: Nightly 11:34:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:21 INFO - mozversion application_name: Firefox 11:34:21 INFO - mozversion application_remotingname: firefox 11:34:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:34:21 INFO - mozversion application_vendor: Mozilla 11:34:21 INFO - mozversion application_version: 49.0a1 11:34:21 INFO - mozversion platform_buildid: 20160506093416 11:34:21 INFO - mozversion platform_changeset: 98730e9d1455e5819b67a7bdfcd0bc976e509ff1 11:34:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:34:21 INFO - mozversion platform_version: 49.0a1 11:34:21 INFO - using testdate: 1462559661 11:34:21 INFO - actual date: 1462559661 11:34:21 INFO - starting webserver on 'localhost:55307' 11:34:21 INFO - SUITE-START | Running 2 tests 11:34:21 INFO - TEST-START | dromaeo_css 11:34:21 INFO - operating with platform_type : mac_ 11:34:21 INFO - Initialising browser for dromaeo_css test... 11:34:21 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmptlSttN/profile http://localhost:55307/getInfo.html) 11:34:24 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 11:34:24 INFO - PROCESS | 1930 | colorDepth:24 11:34:24 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 11:34:24 INFO - PROCESS | 1930 | __metrics 11:34:24 ERROR - PROCESS | 1930 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:34:25 INFO - TEST-INFO | 1930: exit 0 11:34:25 INFO - Browser initialized. 11:34:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:34:25 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmptlSttN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:37 INFO - PROCESS | 1933 | RSS: Main: 250048512 11:34:37 INFO - PROCESS | 1933 | 11:35:26 INFO - PROCESS | 1933 | 1462559726824 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] 11:37:37 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:55307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55307/tests/dromaeo/cssquery-ext.html) 11:37:39 INFO - PROCESS | 1933 | RSS: Main: 263589888 11:37:39 INFO - PROCESS | 1933 | 11:40:41 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:55307/tests/dromaeo/cssquery-ext.html (next: http://localhost:55307/tests/dromaeo/cssquery-jquery.html) 11:40:42 INFO - PROCESS | 1933 | RSS: Main: 275619840 11:40:42 INFO - PROCESS | 1933 | 11:43:43 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:55307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55307/tests/dromaeo/cssquery-mootools.html) 11:43:44 INFO - PROCESS | 1933 | RSS: Main: 277585920 11:43:44 INFO - PROCESS | 1933 | 11:46:46 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:55307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55307/tests/dromaeo/cssquery-prototype.html) 11:46:47 INFO - PROCESS | 1933 | RSS: Main: 279015424 11:46:47 INFO - PROCESS | 1933 | 11:49:49 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:55307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55307/tests/dromaeo/cssquery-yui.html) 11:49:50 INFO - PROCESS | 1933 | RSS: Main: 282550272 11:49:50 INFO - PROCESS | 1933 | 11:52:52 INFO - PROCESS | 1933 | Cycle 1(1): loaded http://localhost:55307/tests/dromaeo/cssquery-yui.html (next: http://localhost:55307/tests/dromaeo/cssquery-dojo.html) 11:52:53 INFO - PROCESS | 1933 | RSS: Main: 283189248 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | __start_tp_report 11:52:53 INFO - PROCESS | 1933 | _x_x_mozilla_page_load 11:52:53 INFO - PROCESS | 1933 | _x_x_mozilla_page_load_details 11:52:53 INFO - PROCESS | 1933 | |i|pagename|runs| 11:52:53 INFO - PROCESS | 1933 | |0;dojo.html;2774.972250277497;3520.7887526748395;3540.433530635099;3550.165711057901;3552.626974167714;4601.884952876179;5790.826275211745;5848.093545500449;5944.108383742441;5975.701214939252;5755.942440575593;5806.651600903938;5884.558658100649;5885.352611212763;5885.970570147143;5206.7656955437005;5235.293235413209;5241.973790131044;5315.601329900253;5345.812896548621;4861.442959281659;5378.408375078739;5391.029614669358;5437.728113594324;5449.182622606601;5169.198774190007;5236.7905283788605;5302.708351040691;5317.8404647860625;5347.197920311945;5301.390340110859;5322.813701520428;5328.254044433782;5330.493603107738;5365.463453654643;5156.871078223037;5240.34495688039;5307.2835167252315;5312.787488500456;5370.919436208421;5543.002259593312;5650.152477128422;5690.800821971211;5783.9710801446145;5785.884282314372;4842.854714358575;5084.949150508484;5529.557635389199;6206.751729930797;6259;5322.0686379883755;6261.217347831521;6278.497720182374;6313.905291420587;6349.968250158766;6013.75944962201;6059.21230240066;6077.392260773931;6112.816615501453;6121.908171377433;5416;6424.100625912376;6472.644004579699;6474.870502589922;6497.577657452251;6121.910283036266;6182.969085154546;6262.843428914313;6323.399277068671;6344.746210151635;6258.561900666909;6325.683715814283;6340.4293613575;6358.109864618957;6366;6140.013486850375;6231.75072997075;6267.467265282502;6310.5898116622275;6379.904301435482;5514.751836167382;6201.472874805602;6342.587731797418;6348;6357.713902874381;4580.427446569179;4996.4254110777;5004.874878128003;5019.774110164978;5025.246213068069;4443.911121777546;4487.237169681162;4489.2592722201125;4489.438820147481;4501.212287849613;5843.824685259449;6013.729382177812;6032.125341825411;6053.909191362133;6072.483838873657;6338.049292606146;6353.428191462791;6366.299707032223;6379.872402551923;6383.36166383358;6093.664848433379;6095.329513753483;6125.846853828601;6144.569880108439;6152.78465253714;5395.946040539623;5397.541208997201;5443.346798384219;5473.8357849264585;5522.723863806794;6418.903716444257;6467.062275969958;6475.158229430144;6476.902846457307;6489.999999999905;5541.362743284574;5657.943420565742;5853.239078919713;6164.89031974249;6299.748010079546;5191.792328306826;6434.002729576923;6506.121673574007;6509.251436084722;6568.441682457044;6291.905621415774;6302.810915672537;6303.716332765129;6370.936290637034;6373.139626150596;6160.876782464416;6348.9047664286;6356.3325850785;6358.809235722936;6361.395667411589;5968;6151.477124444473;6173.104899789595;6191.659458729813;6207.379262073757;6191.473724733448;6235.594686345373;6271.184745982993;6284.717187726655;6291.528135389955;5993.190919225849;6004.039353703386;6091.664958427329;6155.446009859134;6178.567500274938;5601.935632229864;5968.164456976114;6153.261608606996;6241.375862413723;6280.654563998841;6187.504999600112;6202.100695399052;6216.316205217513;6227.283862355887;6228.34602366745 11:52:53 INFO - PROCESS | 1933 | |1;ext.html;501.2656458288609;515.8968206358728;544.4473859033079;550.675101690003;568.6247076929227;37988.86033418999;38749.806250968744;40991.59008409915;41007.58992410075;41128.58871411285;37039.888803335874;39750;42586;42698.573014269845;42746.93132671685;9349.018353072948;9625.941146473882;9633.855492167622;9638.228941684649;9658.855117173249;7582.848343033136;9458.905410945905;9477.34146524359;9596.856047159263;9601.991790861965;9534.856977145348;9556.569954352071;9595.328327017112;9640.325177237597;9698.108868770592;8582.755500452462;9258.814823703487;9576.42541447512;9672.371295865816;9679.70960871175;7977.60111994398;9499.24006079512;9543.904560954372;9600.90399096007;9601.951990240073;32316.838415808004;39474.81575552738;39633.60366396328;39635.20729585392;39829.60170398288;2553.4637726077544;3037.3925214956876;3075.6770539093295;3597.190632107781;3942.8368631253848;27928.720712792816;28428.573571396446;28938.42123157546;29862;29927;2603.7396260374;2694.568868980973;2817.0281252967693;2825.2795537138104;2838.233676907244;421952;511551;515831;516078;519061;35717.64282357195;67914;68323;69005.65497172483;69144;29931.551026734618;37618.623813761515;38079.619203807604;38103.42844857329;38109.80945095257;15268.389264429521;15645.687086258438;15760.290786914617;16046.598835028984;16060;13232.272225027717;13297.401616927262;13371.130876492996;13377.13048651854;13392.933035334956;8279.917200828035;8322.292605128632;8377.204165604258;8461.23848853606;8486.575671216538;3400.523926650271;3428.2800611871785;3449.120474279043;3453.8963831085107;3472.9652703472643;964.7636329099415;988.2341185581089;1026.071405378134;1080.0873262093519;1128.4019469681082;27486.80105591548;30170.84914575413;30492;30608.477586987727;30906.072817815053;766.2988365645483;1037.2169012395593;1054.7995880782628;1172.7537217184488;1261.4890969157507;12426.5650702225;14300;15247.542573722805;15679.68640627181;15693;681854;682067;685817;686722;687794;61702.382976170564;61728.69135654293;62332.68833655893;62357;62447;1423.6440889777555;1469.3576665604132;1471.6762312291494;1483.473366954737;1483.6735918098002;29753.85123074371;29777;29866.656000479597;30452.84773576118;30473.54289685701;54512;55082.72458637681;55478.72260638832;55699.16451253153;55783;524916;546731;558280;558539;559309;27741.722582773913;28178.577321340606;28279.858600706866;28485;28639.856800715865;48060.27909581429;48112.27831582459;48826.26760598665;49028.50971490382;49215;39538.604613953496;39977.80011099926;40005.99985000398;40287;40897;38682.80658596689;38747;39548;40043.599564003984;40268.1946361077;38379;38610;38768.836934891995;39326.213475730896;39367.80316098401;25363.36591585225;33936.32127357488;34679;34934.30131397409;34964.65035349614;24513.896874640326;24898.50202995966;25202.865871036214;25434.872825635754;25715.742842572083 11:52:53 INFO - PROCESS | 1933 | |2;jquery.html;388.31462468742666;404.5004419541867;407.2486262845052;408.0858876117498;430.1740657936761;20024.799752002476;21232.787672123275;21263.25578604749;21508;21988.780112198874;16866.156692165372;20831.791682083214;21106.366808995717;21692;22023.77976220241;5729.885402291951;5895.675737834417;5920;5973.88052238955;5985.820425387245;4186.937195942048;5525.696086715229;5943.88112237755;5994.790182343619;6478.060681201223;5435.592330575203;5476.890462190754;6421.7752378666755;6481.254655714606;6505.739770409178;5210.817621383252;5844.707764611752;6404.871902561923;6479;6582.637954912478;4678.929816052762;5627.521660658849;5640;5759.568032397587;5770.826875193751;25325;25770.355741106436;25898.352541186432;26093.825777840044;26623.46753064928;1826.8538516918616;2116.1429621003517;2191.7808219178114;2210.9005094770773;2250.414892128042;15029.473968411054;15043.172625505593;15238.247601525856;15417.614559635987;15806.604834879105;1726.464795913271;1745.903975281359;1757.79785324688;1768.8142745011717;1803.0624075480678;119543;120994;123057.38471307587;124037.75962240352;124233;9639.987801280904;10917.617883374203;11672.416379181008;11726.179167458367;11791.08716992985;14516.419343226364;14604.853951460562;14799.260036998106;14853.851461485463;14895.03182293169;8900.510471924106;8976.955115224382;9098.408603440888;9177.174054335143;9192.264618830477;7821.374290056782;9093.863592046124;9121.817563648823;9257.305702072372;9272.119148680864;6612.371824676648;6940.687669054904;7048.506604537633;7072.257412971564;7091.219965803757;1478.9573350787668;1592.6655402365402;1866.2348437140706;1928.3540014095154;1981.8216360527333;855.9172646602053;919.1360121485782;931.7204838548544;1048.219076787798;1090.3948308688755;16097.758533622005;16447.91776041136;20500;20977.95110244482;21908.780912190992;912.6349460215966;974.770928831724;1013.5033833421718;1071.116329028539;1086.7556647638567;9808;10876.673699789018;11379.829302560469;11421.828672569918;11428.542858285742;619305;629312;636323;639588;640438;131708.3414582921;133648.3317583406;134853;136394;137759;1073.6188653028219;1074.5164675895878;1095.7205912492263;1097.25386737018;1103.194667892443;18487.89072655645;18641.254349825856;18875.829279633017;18896.716549252047;18901.43295701131;52001.47998520118;53500;53665;54435;54587.90824183415;78327;78369.43261134632;79361.60319198367;79425.8086128697;80840;7981.2018798119725;8321.459105158145;8430.241278284984;8492.108328625405;8812.206901378906;9674.22606191489;10683.57265709394;12699.936500317439;12996.155249908727;13262.53581124656;10723.839142412715;10777.892221078002;11238.325700458;11468.31190128595;11490.655280341269;10827.783444330911;11036.779264414507;11092.778144436905;11310.660680179279;11523.8271425927;10556.15550755953;11385.259958102697;11417.60038398652;11492.023178029962;11736.06111511094;8281.710140145065;8341.749747507585;8498.532580707873;8504.829903401773;8528.061913189667;10604.257701960789;11308.982191602796;11545.422728863356;11582.71043223926;11600.593979210687 11:52:53 INFO - PROCESS | 1933 | |3;mootools.html;1595.361855257897;1603.9358425662974;1869.2336142181707;1940.3111895277168;1975.3876298347504;7835.451518393715;7923.3661307095435;8385.287250583708;8408.075111737711;8519.3610479214;8620.525871077089;8654.22112009919;8823.382363234576;8829.823403531926;8873.91126088739;2459.0655550890638;2490.4645501217233;2495.189063554343;2497.475530138673;2498.8750562471805;2444.181199298237;2486.2292689266296;2497.5379554782426;2506.9373265668414;2514.1954574536157;2467.0748469324003;2474.5669507836146;2486.4032632168332;2498.1381423408893;2498.4253621667026;2414.263649586875;2428.599281118622;2430.684011078566;2458.9016439342404;2467.962980555293;2430.3195105370523;2451.9141830035865;2465.815063870217;2471.505698860235;2487.44032592667;8642.783930401727;8718.128187181232;8803.77990550235;8814.647414103429;8825.382223244376;5322.92015619766;5507.421720719347;5527.143292789624;5529.474699903502;5539.778408863641;3619.2218672985173;3624.3294990426593;3638.4718418264392;3690.3541880170865;3716.535433070866;834.5743670727911;1050.070687441612;1056.1550759392455;1058.8147074261974;1062.829947208443;11638.709032274177;11776.64670059891;11782.410879456078;11807.704807379798;11833.822492662617;4882.2432522959;4910.48439913811;5003.77483013258;5009.5491405773655;5041.966396888629;10016;10057.094861462503;10058.748531286776;10066.496675166212;10076.899231007743;5345.438728933406;5374.623776335698;5425.26758887553;5437.401885792559;5499.670019798745;4485.439320084989;4868.099401610713;4971.801127954914;5026.220935754964;5041.319421878073;4040.474738284004;4100.856470023535;4102.138550904284;4129.613716752235;4164.7917604119675;1141.57191053355;1375.3467103125936;1376.078027721429;1378.1593228130832;1397.343248673122;772.7527191298731;894.6580129805292;896.3680605173467;924.8797656304772;929.7768535551419;4366.388705581221;5843.393066906549;5943.3462319144855;6069.666168360694;6121.989871671124;959.8704174936433;973.4159504297506;1003.1523362758458;1020.811149937264;1023.1712313026472;3939.6848252140335;4014.337634290368;4046.9595304046584;4093.9765058735316;4131.029208136086;10392.06471417576;10614.522346494427;10865.185111116698;10892.074173695166;10908.890911090946;10763.83854242187;10764.892351076389;10838.729031774112;10941.4529273536;10967.122630189566;7812.882806757903;8167.42828002046;8307.252347288651;8341.95829020851;8379.120192379713;6030.698465076816;6053.303870055;6128.233970753656;6175.197224360804;6194.845128871814;9918.20654347636;10191.898081019095;10224.233182511192;10236.948815255875;10253.897461025294;6859.971004349388;8249.958750206211;10020.398776073458;10115.7471063224;10201.54093065799;6917.584944903322;6962.443004559522;7387.9261207387235;7625.923740762521;7725.266099720518;7027.332403421667;8506.064332923497;8583.313334933315;8604.397692161489;8618.569071546272;7498.250174982458;7563;7588.165301816906;7665.041869766279;7727.227277272228;6380.947143721234;7376.926230737624;7485.850282994201;7491.10106787189;7622.085349758065;7005.8248543784775;7049;7083.327083927019;7147.213806481387;7188.712451501881;4839.080574690797;4858.1012512685265;5007.799688012438;5022.573081288131;5192.013517431676;4802.951970480391;4956.504349565014;5064.34163558735;5126.410462796677;5299.33758280215 11:52:53 INFO - PROCESS | 1933 | |4;prototype.html;316.8954245099118;323.3274788440045;330.978930000947;336.76407584166105;337.13188539510736;4594.3338215958665;5333.466653334664;5500.779968801248;5521.282233309669;5546.306711661047;4764.690295130823;5418.83743487695;5446.836594902149;5461.098918678414;5519.69641669708;4001.3397789364794;4160.43834082398;4164.8125834337525;4191.329387298033;4204.495460544724;3803.315403227418;3821.7515861469055;3998.1608460108387;4059.7970101494807;4135.648469880049;3138.686131386866;3687.760295580792;3872.5352957645123;3873.3028054950096;4074.348104303312;3391.9830400848086;4036.8385264589383;4068.816903239361;4072.511298644182;4104.968040819784;3108.5648009278493;3146.433641944449;3408.642092580293;3449.344624521333;3567.1973805893726;4300.903269666246;4895.853124406273;5038.168702164138;5117.437081920985;5181.922271165936;3907.7264591478606;3986.926798065019;4627.606653434462;4670.953290467086;4688.898108944395;4959.975200123977;5074.13739664258;5260.684358938438;5677.290338707661;5701.403606990049;3275.4922986937063;3294.5387645729616;3675.1333959511626;3890.961090389088;3909.6767747414756;5290.650884024588;5294.364676238837;5962.940370596325;5963.389884731142;5982.222311099573;3579.89023402746;3681.742278040565;3908.511436070491;3917.8236979335998;3951.209758048402;3148.449021421242;3387.5257463955068;3656.433252845813;4025.611164148364;4118.519850726132;4323.156984388077;4482.4172857528965;4619.214733495314;4662.6269898408045;4677.204875171229;5529.364123125812;5738.569607279387;5757.740901659436;5763.204845649857;5776.5089967352405;1135.2904434728296;1278.4502663854632;1297.5718013055669;1304.5825335892614;1306.137948953686;859.7979474823411;868.8574524500262;879.2131042716733;892.125716797542;895.820835832836;4635.635825728902;4786.133407970894;5088.898222035538;5107.923381149286;5115.488451154929;5047.268146118792;5136.768845401966;5528.419515950848;5680.971595141998;5691.516221121168;4447.73313601185;4506.436695413074;4578.679492435497;4874.926876096862;4987.351644286292;2563.3850674075584;2573.6139579063292;2593.9092131775674;2676.5449873521547;2925.9707402926124;5346.34263378354;5748.741306641211;5825.33008703996;5882.705864706833;5903.970480147572;4735.384400028043;5388.595855310868;5617.915731264035;5753.5547392358085;5769.1923130761725;4698.929516057262;5796.913046304308;5856.502197313191;5871.794487193013;5937.851553711192;4822.614190864792;5086.516780905808;5613.298337707786;5636.689982051026;5682.8295151143875;4594.093451217707;4952.331435256195;5157.203800465453;5337.866553336197;5556.333240011225;5086.669366491166;5330.440303768049;5830.163498497959;5875.41245875409;5895.64626122434;3054.09904078293;3419.794812311269;3726.366517691945;3735.5991503186306;3742.2889650967318;4859.635527335393;5013.799448022184;5088.150635644051;5245.265662807134;5347.144456886879;4993.425756038102;5628.155776633538;5698.660814708623;5711.914321285267;5718.198082939413;4908.674657842291;5591.8881622368135;5623.831285061455;5689.77240910359;5692.203091567267;4946.703197808143;5226.111561034557;5529.806456774155;5569.693666848362;5585.106382978704;5065.656666600026;5657.915131272952;5686.914696279477;5711.572581652698;5729.455701708331;4627.005193883331;5111.361079865017;5417.51242388187;5586.748596313257;5598.412166722598 11:52:53 INFO - PROCESS | 1933 | |5;yui.html;739.3936971683222;742.9145648250451;752.5071078443618;752.7628796928964;812.1594150054694;14737.778933315996;14737.852621473809;15058.774118388219;15118.941674082818;15183.316750746215;13876.502229598667;13891.722165556683;14054.859451405482;14055;14068.718625627507;744.162816831065;920.3051695969534;927.9907200928005;931.4923366765096;940.0223767282052;933.7898972731115;951.1772316945827;951.8191543606728;952.200151872427;953.0993211415215;1007.2395341517145;1007.6876168387787;1011.4841430870273;1011.514473052935;1013.9961438176226;959.4627008874983;969.4280374578997;995.2933417273745;1004.7437903334603;1006.66276797273;734.709789633092;752.1538269446872;752.5033477904557;754.2344520311888;759.3279947246672;14514.419423223058;14656.193909334983;14714.632134196623;14735.263236838222;14736.484223052248;12686.492540298377;12693.682657933625;12739;12820.102592818506;13154.934225328812;9952.203823694088;10221.131203847608;10276.280660353777;10480.58077676892;10608.522616482276;3486.4247399179103;3541.557305336833;3639.5450568678916;3669.7614655047605;3681.5029970953847;65923;85350.57324713399;85403;87380.56309718538;87841.56079219563;9492.525373731423;9558.474283914313;9621.374610650286;9661.32370734056;9882.555285012191;21756;21765.45586360322;21814.45463863416;21867;22479.775202248096;6062.363451837582;7414.184439711627;7600.467967242351;7619.276168763959;7661.080670319486;3932.6853851691794;4047.838086476508;4047.98800299925;4052.49343832021;4065.776382299002;2969.584258203853;3047.83236921967;3512.877049303262;3608.8195590220384;3629.274145170976;625.5058503781961;635.8887194740902;637.2735082006516;642.958207716497;646.4537465841356;584.6287607369351;586.7359688140353;591.1959734760723;601.4767152577199;627.7834147219202;8065.7176998805935;8148.511089334659;8178.5092894426525;8237.588120593946;8274.710385136492;562.0192763627496;570.349801226602;598.1297212555721;616.0451300484322;624.950003999679;3892.591277915835;3930.4300876373336;3935.5474120475938;3970.821313040862;4061.0246981066675;94815.20397694303;94820;96700.06599867964;97818.02181978231;97959;79985.20014799778;80312;82566.58716706379;83691;85223;56326.43673563294;63876.04185937122;73534;74635.88046179312;75050.62474687591;8126.267559888396;8386.622601983048;8405.747827565183;8471.6021856393;8540;44252.77873610611;44798.552014479435;45190;45372.092558149314;46064.309035365164;61922.380776193466;62473.68763156155;62559.6872015637;62979.6851015742;63374.683126584074;10810.459477026274;10914.890851091388;11016.449177540931;11073;11550.653480395602;11985.760284794082;12016.699582510508;12069.939650302043;12215.69460763488;12409.503619855466;11088.002079812855;11487.368194749035;11642.185047046964;11729.882701173221;11823.586174483851;11183.88816111861;11252.324860508395;11430;11738.060955123741;12029.879701202875;9138;11425.485853136795;11430.657080287605;11964.222325549159;12145.574904878287;9447.797675462607;9456.952715236379;9501.192398646193;9652.35541440715;9706.980767019644;8856.202941735275;9866.260030497884;9898.356606820533;9911.10800028001;10022.699319020441 11:52:53 INFO - PROCESS | 1933 | __end_tp_report 11:52:53 INFO - PROCESS | 1933 | __start_cc_report 11:52:53 INFO - PROCESS | 1933 | _x_x_mozilla_cycle_collect,412 11:52:53 INFO - PROCESS | 1933 | __end_cc_report 11:52:53 INFO - PROCESS | 1933 | __startTimestamp1462560773131__endTimestamp 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | ------- Summary: start ------- 11:52:53 INFO - PROCESS | 1933 | Number of tests: 6 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | [#0] dojo.html Cycles:165 Average:5799.05 Median:6077.39 stddev:676.97 (11.1%) stddev-sans-first:636.13 11:52:53 INFO - PROCESS | 1933 | Values: 2775.0 3520.8 3540.4 3550.2 3552.6 4601.9 5790.8 5848.1 5944.1 5975.7 5755.9 5806.7 5884.6 5885.4 5886.0 5206.8 5235.3 5242.0 5315.6 5345.8 4861.4 5378.4 5391.0 5437.7 5449.2 5169.2 5236.8 5302.7 5317.8 5347.2 5301.4 5322.8 5328.3 5330.5 5365.5 5156.9 5240.3 5307.3 5312.8 5370.9 5543.0 5650.2 5690.8 5784.0 5785.9 4842.9 5084.9 5529.6 6206.8 6259.0 5322.1 6261.2 6278.5 6313.9 6350.0 6013.8 6059.2 6077.4 6112.8 6121.9 5416.0 6424.1 6472.6 6474.9 6497.6 6121.9 6183.0 6262.8 6323.4 6344.7 6258.6 6325.7 6340.4 6358.1 6366.0 6140.0 6231.8 6267.5 6310.6 6379.9 5514.8 6201.5 6342.6 6348.0 6357.7 4580.4 4996.4 5004.9 5019.8 5025.2 4443.9 4487.2 4489.3 4489.4 4501.2 5843.8 6013.7 6032.1 6053.9 6072.5 6338.0 6353.4 6366.3 6379.9 6383.4 6093.7 6095.3 6125.8 6144.6 6152.8 5395.9 5397.5 5443.3 5473.8 5522.7 6418.9 6467.1 6475.2 6476.9 6490.0 5541.4 5657.9 5853.2 6164.9 6299.7 5191.8 6434.0 6506.1 6509.3 6568.4 6291.9 6302.8 6303.7 6370.9 6373.1 6160.9 6348.9 6356.3 6358.8 6361.4 5968.0 6151.5 6173.1 6191.7 6207.4 6191.5 6235.6 6271.2 6284.7 6291.5 5993.2 6004.0 6091.7 6155.4 6178.6 5601.9 5968.2 6153.3 6241.4 6280.7 6187.5 6202.1 6216.3 6227.3 6228.3 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | [#1] ext.html Cycles:180 Average:70032.97 Median:39543.30 stddev:156192.52 (395.0%) stddev-sans-first:156543.43 11:52:53 INFO - PROCESS | 1933 | Values: 501.3 515.9 544.4 550.7 568.6 37988.9 38749.8 40991.6 41007.6 41128.6 37039.9 39750.0 42586.0 42698.6 42746.9 9349.0 9625.9 9633.9 9638.2 9658.9 7582.8 9458.9 9477.3 9596.9 9602.0 9534.9 9556.6 9595.3 9640.3 9698.1 8582.8 9258.8 9576.4 9672.4 9679.7 7977.6 9499.2 9543.9 9600.9 9602.0 32316.8 39474.8 39633.6 39635.2 39829.6 2553.5 3037.4 3075.7 3597.2 3942.8 27928.7 28428.6 28938.4 29862.0 29927.0 2603.7 2694.6 2817.0 2825.3 2838.2 421952.0 511551.0 515831.0 516078.0 519061.0 35717.6 67914.0 68323.0 69005.7 69144.0 29931.6 37618.6 38079.6 38103.4 38109.8 15268.4 15645.7 15760.3 16046.6 16060.0 13232.3 13297.4 13371.1 13377.1 13392.9 8279.9 8322.3 8377.2 8461.2 8486.6 3400.5 3428.3 3449.1 3453.9 3473.0 964.8 988.2 1026.1 1080.1 1128.4 27486.8 30170.8 30492.0 30608.5 30906.1 766.3 1037.2 1054.8 1172.8 1261.5 12426.6 14300.0 15247.5 15679.7 15693.0 681854.0 682067.0 685817.0 686722.0 687794.0 61702.4 61728.7 62332.7 62357.0 62447.0 1423.6 1469.4 1471.7 1483.5 1483.7 29753.9 29777.0 29866.7 30452.8 30473.5 54512.0 55082.7 55478.7 55699.2 55783.0 524916.0 546731.0 558280.0 558539.0 559309.0 27741.7 28178.6 28279.9 28485.0 28639.9 48060.3 48112.3 48826.3 49028.5 49215.0 39538.6 39977.8 40006.0 40287.0 40897.0 38682.8 38747.0 39548.0 40043.6 40268.2 38379.0 38610.0 38768.8 39326.2 39367.8 25363.4 33936.3 34679.0 34934.3 34964.7 24513.9 24898.5 25202.9 25434.9 25715.7 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | [#2] jquery.html Cycles:180 Average:36605.84 Median:21800.39 stddev:105570.45 (484.3%) stddev-sans-first:105831.58 11:52:53 INFO - PROCESS | 1933 | Values: 388.3 404.5 407.2 408.1 430.2 20024.8 21232.8 21263.3 21508.0 21988.8 16866.2 20831.8 21106.4 21692.0 22023.8 5729.9 5895.7 5920.0 5973.9 5985.8 4186.9 5525.7 5943.9 5994.8 6478.1 5435.6 5476.9 6421.8 6481.3 6505.7 5210.8 5844.7 6404.9 6479.0 6582.6 4678.9 5627.5 5640.0 5759.6 5770.8 25325.0 25770.4 25898.4 26093.8 26623.5 1826.9 2116.1 2191.8 2210.9 2250.4 15029.5 15043.2 15238.2 15417.6 15806.6 1726.5 1745.9 1757.8 1768.8 1803.1 119543.0 120994.0 123057.4 124037.8 124233.0 9640.0 10917.6 11672.4 11726.2 11791.1 14516.4 14604.9 14799.3 14853.9 14895.0 8900.5 8977.0 9098.4 9177.2 9192.3 7821.4 9093.9 9121.8 9257.3 9272.1 6612.4 6940.7 7048.5 7072.3 7091.2 1479.0 1592.7 1866.2 1928.4 1981.8 855.9 919.1 931.7 1048.2 1090.4 16097.8 16447.9 20500.0 20978.0 21908.8 912.6 974.8 1013.5 1071.1 1086.8 9808.0 10876.7 11379.8 11421.8 11428.5 619305.0 629312.0 636323.0 639588.0 640438.0 131708.3 133648.3 134853.0 136394.0 137759.0 1073.6 1074.5 1095.7 1097.3 1103.2 18487.9 18641.3 18875.8 18896.7 18901.4 52001.5 53500.0 53665.0 54435.0 54587.9 78327.0 78369.4 79361.6 79425.8 80840.0 7981.2 8321.5 8430.2 8492.1 8812.2 9674.2 10683.6 12699.9 12996.2 13262.5 10723.8 10777.9 11238.3 11468.3 11490.7 10827.8 11036.8 11092.8 11310.7 11523.8 10556.2 11385.3 11417.6 11492.0 11736.1 8281.7 8341.7 8498.5 8504.8 8528.1 10604.3 11309.0 11545.4 11582.7 11600.6 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | [#3] mootools.html Cycles:180 Average:5748.28 Median:4896.36 stddev:3155.60 (64.4%) stddev-sans-first:3149.02 11:52:53 INFO - PROCESS | 1933 | Values: 1595.4 1603.9 1869.2 1940.3 1975.4 7835.5 7923.4 8385.3 8408.1 8519.4 8620.5 8654.2 8823.4 8829.8 8873.9 2459.1 2490.5 2495.2 2497.5 2498.9 2444.2 2486.2 2497.5 2506.9 2514.2 2467.1 2474.6 2486.4 2498.1 2498.4 2414.3 2428.6 2430.7 2458.9 2468.0 2430.3 2451.9 2465.8 2471.5 2487.4 8642.8 8718.1 8803.8 8814.6 8825.4 5322.9 5507.4 5527.1 5529.5 5539.8 3619.2 3624.3 3638.5 3690.4 3716.5 834.6 1050.1 1056.2 1058.8 1062.8 11638.7 11776.6 11782.4 11807.7 11833.8 4882.2 4910.5 5003.8 5009.5 5042.0 10016.0 10057.1 10058.7 10066.5 10076.9 5345.4 5374.6 5425.3 5437.4 5499.7 4485.4 4868.1 4971.8 5026.2 5041.3 4040.5 4100.9 4102.1 4129.6 4164.8 1141.6 1375.3 1376.1 1378.2 1397.3 772.8 894.7 896.4 924.9 929.8 4366.4 5843.4 5943.3 6069.7 6122.0 959.9 973.4 1003.2 1020.8 1023.2 3939.7 4014.3 4047.0 4094.0 4131.0 10392.1 10614.5 10865.2 10892.1 10908.9 10763.8 10764.9 10838.7 10941.5 10967.1 7812.9 8167.4 8307.3 8342.0 8379.1 6030.7 6053.3 6128.2 6175.2 6194.8 9918.2 10191.9 10224.2 10236.9 10253.9 6860.0 8250.0 10020.4 10115.7 10201.5 6917.6 6962.4 7387.9 7625.9 7725.3 7027.3 8506.1 8583.3 8604.4 8618.6 7498.3 7563.0 7588.2 7665.0 7727.2 6380.9 7376.9 7485.9 7491.1 7622.1 7005.8 7049.0 7083.3 7147.2 7188.7 4839.1 4858.1 5007.8 5022.6 5192.0 4803.0 4956.5 5064.3 5126.4 5299.3 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | [#4] prototype.html Cycles:180 Average:4455.70 Median:4990.39 stddev:1395.06 (28.0%) stddev-sans-first:1363.95 11:52:53 INFO - PROCESS | 1933 | Values: 316.9 323.3 331.0 336.8 337.1 4594.3 5333.5 5500.8 5521.3 5546.3 4764.7 5418.8 5446.8 5461.1 5519.7 4001.3 4160.4 4164.8 4191.3 4204.5 3803.3 3821.8 3998.2 4059.8 4135.6 3138.7 3687.8 3872.5 3873.3 4074.3 3392.0 4036.8 4068.8 4072.5 4105.0 3108.6 3146.4 3408.6 3449.3 3567.2 4300.9 4895.9 5038.2 5117.4 5181.9 3907.7 3986.9 4627.6 4671.0 4688.9 4960.0 5074.1 5260.7 5677.3 5701.4 3275.5 3294.5 3675.1 3891.0 3909.7 5290.7 5294.4 5962.9 5963.4 5982.2 3579.9 3681.7 3908.5 3917.8 3951.2 3148.4 3387.5 3656.4 4025.6 4118.5 4323.2 4482.4 4619.2 4662.6 4677.2 5529.4 5738.6 5757.7 5763.2 5776.5 1135.3 1278.5 1297.6 1304.6 1306.1 859.8 868.9 879.2 892.1 895.8 4635.6 4786.1 5088.9 5107.9 5115.5 5047.3 5136.8 5528.4 5681.0 5691.5 4447.7 4506.4 4578.7 4874.9 4987.4 2563.4 2573.6 2593.9 2676.5 2926.0 5346.3 5748.7 5825.3 5882.7 5904.0 4735.4 5388.6 5617.9 5753.6 5769.2 4698.9 5796.9 5856.5 5871.8 5937.9 4822.6 5086.5 5613.3 5636.7 5682.8 4594.1 4952.3 5157.2 5337.9 5556.3 5086.7 5330.4 5830.2 5875.4 5895.6 3054.1 3419.8 3726.4 3735.6 3742.3 4859.6 5013.8 5088.2 5245.3 5347.1 4993.4 5628.2 5698.7 5711.9 5718.2 4908.7 5591.9 5623.8 5689.8 5692.2 4946.7 5226.1 5529.8 5569.7 5585.1 5065.7 5657.9 5686.9 5711.6 5729.5 4627.0 5111.4 5417.5 5586.7 5598.4 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - PROCESS | 1933 | [#5] yui.html Cycles:180 Average:18297.66 Median:588.97 stddev:26003.28 (4415.1%) stddev-sans-first:26042.80 11:52:53 INFO - PROCESS | 1933 | Values: 739.4 742.9 752.5 752.8 812.2 14737.8 14737.9 15058.8 15118.9 15183.3 13876.5 13891.7 14054.9 14055.0 14068.7 744.2 920.3 928.0 931.5 940.0 933.8 951.2 951.8 952.2 953.1 1007.2 1007.7 1011.5 1011.5 1014.0 959.5 969.4 995.3 1004.7 1006.7 734.7 752.2 752.5 754.2 759.3 14514.4 14656.2 14714.6 14735.3 14736.5 12686.5 12693.7 12739.0 12820.1 13154.9 9952.2 10221.1 10276.3 10480.6 10608.5 3486.4 3541.6 3639.5 3669.8 3681.5 65923.0 85350.6 85403.0 87380.6 87841.6 9492.5 9558.5 9621.4 9661.3 9882.6 21756.0 21765.5 21814.5 21867.0 22479.8 6062.4 7414.2 7600.5 7619.3 7661.1 3932.7 4047.8 4048.0 4052.5 4065.8 2969.6 3047.8 3512.9 3608.8 3629.3 625.5 635.9 637.3 643.0 646.5 584.6 586.7 591.2 601.5 627.8 8065.7 8148.5 8178.5 8237.6 8274.7 562.0 570.3 598.1 616.0 625.0 3892.6 3930.4 3935.5 3970.8 4061.0 94815.2 94820.0 96700.1 97818.0 97959.0 79985.2 80312.0 82566.6 83691.0 85223.0 56326.4 63876.0 73534.0 74635.9 75050.6 8126.3 8386.6 8405.7 8471.6 8540.0 44252.8 44798.6 45190.0 45372.1 46064.3 61922.4 62473.7 62559.7 62979.7 63374.7 10810.5 10914.9 11016.4 11073.0 11550.7 11985.8 12016.7 12069.9 12215.7 12409.5 11088.0 11487.4 11642.2 11729.9 11823.6 11183.9 11252.3 11430.0 11738.1 12029.9 9138.0 11425.5 11430.7 11964.2 12145.6 9447.8 9457.0 9501.2 9652.4 9707.0 8856.2 9866.3 9898.4 9911.1 10022.7 11:52:53 INFO - PROCESS | 1933 | -------- Summary: end -------- 11:52:53 INFO - PROCESS | 1933 | 11:52:53 INFO - TEST-INFO | 1933: exit 0 11:52:53 INFO - TEST-OK | dromaeo_css | took 1112417ms 11:52:53 INFO - TEST-START | kraken 11:52:53 INFO - operating with platform_type : mac_ 11:52:53 INFO - Initialising browser for kraken test... 11:52:53 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpp1LlxC/profile http://localhost:55307/getInfo.html) 11:52:56 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 11:52:56 INFO - PROCESS | 1939 | colorDepth:24 11:52:56 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 11:52:56 INFO - PROCESS | 1939 | __metrics 11:52:56 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:52:57 INFO - TEST-INFO | 1939: exit 0 11:52:57 INFO - Browser initialized. 11:52:57 INFO - Running cycle 1/1 for kraken test... 11:52:57 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpp1LlxC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:09 INFO - PROCESS | 1942 | RSS: Main: 250314752 11:53:09 INFO - PROCESS | 1942 | 11:53:12 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55307/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:13 INFO - PROCESS | 1942 | RSS: Main: 261910528 11:53:13 INFO - PROCESS | 1942 | 11:53:16 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55307/tests/kraken/driver.html?testName=audio-dft) 11:53:16 INFO - PROCESS | 1942 | RSS: Main: 266690560 11:53:16 INFO - PROCESS | 1942 | 11:53:20 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55307/tests/kraken/driver.html?testName=audio-fft) 11:53:20 INFO - PROCESS | 1942 | RSS: Main: 267108352 11:53:20 INFO - PROCESS | 1942 | 11:53:22 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55307/tests/kraken/driver.html?testName=audio-oscillator) 11:53:23 INFO - PROCESS | 1942 | RSS: Main: 267653120 11:53:23 INFO - PROCESS | 1942 | 11:53:25 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:26 INFO - PROCESS | 1942 | RSS: Main: 268259328 11:53:26 INFO - PROCESS | 1942 | 11:53:29 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55307/tests/kraken/driver.html?testName=imaging-darkroom) 11:53:29 INFO - PROCESS | 1942 | RSS: Main: 268615680 11:53:29 INFO - PROCESS | 1942 | 11:53:32 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55307/tests/kraken/driver.html?testName=imaging-desaturate) 11:53:33 INFO - PROCESS | 1942 | RSS: Main: 268845056 11:53:33 INFO - PROCESS | 1942 | 11:53:36 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55307/tests/kraken/driver.html?testName=json-parse-financial) 11:53:37 INFO - PROCESS | 1942 | RSS: Main: 268877824 11:53:37 INFO - PROCESS | 1942 | 11:53:38 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:53:39 INFO - PROCESS | 1942 | RSS: Main: 268292096 11:53:39 INFO - PROCESS | 1942 | 11:53:41 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:53:42 INFO - PROCESS | 1942 | RSS: Main: 268349440 11:53:42 INFO - PROCESS | 1942 | 11:53:44 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:53:45 INFO - PROCESS | 1942 | RSS: Main: 268468224 11:53:45 INFO - PROCESS | 1942 | 11:53:48 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:53:48 INFO - PROCESS | 1942 | RSS: Main: 268484608 11:53:48 INFO - PROCESS | 1942 | 11:53:51 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:53:52 INFO - PROCESS | 1942 | RSS: Main: 268443648 11:53:52 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:55307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55307/tests/kraken/driver.html?testName=ai-astar) 11:53:54 INFO - PROCESS | 1942 | RSS: Main: 270249984 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | __start_tp_report 11:53:54 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 11:53:54 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 11:53:54 INFO - PROCESS | 1942 | |i|pagename|runs| 11:53:54 INFO - PROCESS | 1942 | |0;ai-astar;159;149;107;115;117;115;108;115;116;101 11:53:54 INFO - PROCESS | 1942 | |1;audio-beat-detection;162;114;174;198;144;134;168;119;218;151 11:53:54 INFO - PROCESS | 1942 | |2;audio-dft;199;221;228;227;195;224;219;204;200;199 11:53:54 INFO - PROCESS | 1942 | |3;audio-fft;70;80;75;155;84;88;86;58;137;58 11:53:54 INFO - PROCESS | 1942 | |4;audio-oscillator;103;138;143;78;83;89;126;117;119;164 11:53:54 INFO - PROCESS | 1942 | |5;imaging-gaussian-blur;87;85;87;85;131;131;92;92;136;122 11:53:54 INFO - PROCESS | 1942 | |6;imaging-darkroom;149;154;95;95;93;94;94;94;94;95 11:53:54 INFO - PROCESS | 1942 | |7;imaging-desaturate;139;145;83;152;145;91;88;90;89;92 11:53:54 INFO - PROCESS | 1942 | |8;json-parse-financial;60;64;60;61;64;84;83;81;62;61 11:53:54 INFO - PROCESS | 1942 | |9;json-stringify-tinderbox;65;66;69;81;68;95;62;74;101;103 11:53:54 INFO - PROCESS | 1942 | |10;stanford-crypto-aes;89;88;92;100;88;85;87;86;85;89 11:53:54 INFO - PROCESS | 1942 | |11;stanford-crypto-ccm;172;156;140;155;140;132;155;179;255;193 11:53:54 INFO - PROCESS | 1942 | |12;stanford-crypto-pbkdf2;167;172;169;169;172;166;199;232;223;170 11:53:54 INFO - PROCESS | 1942 | |13;stanford-crypto-sha256-iterative;68;67;82;89;86;76;66;68;68;92 11:53:54 INFO - PROCESS | 1942 | __end_tp_report 11:53:54 INFO - PROCESS | 1942 | __start_cc_report 11:53:54 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,1083 11:53:54 INFO - PROCESS | 1942 | __end_cc_report 11:53:54 INFO - PROCESS | 1942 | __startTimestamp1462560834503__endTimestamp 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | ------- Summary: start ------- 11:53:54 INFO - PROCESS | 1942 | Number of tests: 14 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#0] ai-astar Cycles:10 Average:120.20 Median:115.50 stddev:18.67 (16.2%) stddev-sans-first:13.52 11:53:54 INFO - PROCESS | 1942 | Values: 159.0 149.0 107.0 115.0 117.0 115.0 108.0 115.0 116.0 101.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#1] audio-beat-detection Cycles:10 Average:158.20 Median:165.00 stddev:33.08 (20.0%) stddev-sans-first:35.06 11:53:54 INFO - PROCESS | 1942 | Values: 162.0 114.0 174.0 198.0 144.0 134.0 168.0 119.0 218.0 151.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#2] audio-dft Cycles:10 Average:211.60 Median:220.00 stddev:13.28 (6.0%) stddev-sans-first:13.29 11:53:54 INFO - PROCESS | 1942 | Values: 199.0 221.0 228.0 227.0 195.0 224.0 219.0 204.0 200.0 199.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#3] audio-fft Cycles:10 Average:89.10 Median:77.50 stddev:32.07 (41.4%) stddev-sans-first:33.26 11:53:54 INFO - PROCESS | 1942 | Values: 70.0 80.0 75.0 155.0 84.0 88.0 86.0 58.0 137.0 58.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#4] audio-oscillator Cycles:10 Average:116.00 Median:153.50 stddev:28.00 (18.2%) stddev-sans-first:29.30 11:53:54 INFO - PROCESS | 1942 | Values: 103.0 138.0 143.0 78.0 83.0 89.0 126.0 117.0 119.0 164.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#5] imaging-gaussian-blur Cycles:10 Average:104.80 Median:86.00 stddev:22.08 (25.7%) stddev-sans-first:22.46 11:53:54 INFO - PROCESS | 1942 | Values: 87.0 85.0 87.0 85.0 131.0 131.0 92.0 92.0 136.0 122.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:94.00 stddev:24.18 (25.7%) stddev-sans-first:19.93 11:53:54 INFO - PROCESS | 1942 | Values: 149.0 154.0 95.0 95.0 93.0 94.0 94.0 94.0 94.0 95.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#7] imaging-desaturate Cycles:10 Average:111.40 Median:88.50 stddev:29.39 (33.2%) stddev-sans-first:29.43 11:53:54 INFO - PROCESS | 1942 | Values: 139.0 145.0 83.0 152.0 145.0 91.0 88.0 90.0 89.0 92.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:64.00 stddev:10.24 (16.0%) stddev-sans-first:10.45 11:53:54 INFO - PROCESS | 1942 | Values: 60.0 64.0 60.0 61.0 64.0 84.0 83.0 81.0 62.0 61.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:68.50 stddev:15.69 (22.9%) stddev-sans-first:15.88 11:53:54 INFO - PROCESS | 1942 | Values: 65.0 66.0 69.0 81.0 68.0 95.0 62.0 74.0 101.0 103.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.00 stddev:4.43 (5.0%) stddev-sans-first:4.70 11:53:54 INFO - PROCESS | 1942 | Values: 89.0 88.0 92.0 100.0 88.0 85.0 87.0 86.0 85.0 89.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#11] stanford-crypto-ccm Cycles:10 Average:167.70 Median:164.00 stddev:36.02 (22.0%) stddev-sans-first:38.17 11:53:54 INFO - PROCESS | 1942 | Values: 172.0 156.0 140.0 155.0 140.0 132.0 155.0 179.0 255.0 193.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:172.00 stddev:24.94 (14.5%) stddev-sans-first:25.69 11:53:54 INFO - PROCESS | 1942 | Values: 167.0 172.0 169.0 169.0 172.0 166.0 199.0 232.0 223.0 170.0 11:53:54 INFO - PROCESS | 1942 | 11:53:54 INFO - PROCESS | 1942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:79.00 stddev:10.18 (12.9%) stddev-sans-first:10.36 11:53:54 INFO - PROCESS | 1942 | Values: 68.0 67.0 82.0 89.0 86.0 76.0 66.0 68.0 68.0 92.0 11:53:54 INFO - PROCESS | 1942 | -------- Summary: end -------- 11:53:54 INFO - PROCESS | 1942 | 11:53:55 INFO - TEST-INFO | 1942: exit 0 11:53:55 INFO - TEST-OK | kraken | took 61544ms 11:53:55 INFO - SUITE-END | took 1173s 11:53:55 INFO - Completed test suite (00:19:34) 11:53:55 INFO - javascript benchmark 11:53:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2774.972250277497, 3520.7887526748395, 3540.433530635099, 3550.165711057901, 3552.626974167714, 4601.884952876179, 5790.826275211745, 5848.093545500449, 5944.108383742441, 5975.701214939252, 5755.942440575593, 5806.651600903938, 5884.558658100649, 5885.352611212763, 5885.970570147143, 5206.7656955437005, 5235.293235413209, 5241.973790131044, 5315.601329900253, 5345.812896548621, 4861.442959281659, 5378.408375078739, 5391.029614669358, 5437.728113594324, 5449.182622606601, 5169.198774190007, 5236.7905283788605, 5302.708351040691, 5317.8404647860625, 5347.197920311945, 5301.390340110859, 5322.813701520428, 5328.254044433782, 5330.493603107738, 5365.463453654643, 5156.871078223037, 5240.34495688039, 5307.2835167252315, 5312.787488500456, 5370.919436208421, 5543.002259593312, 5650.152477128422, 5690.800821971211, 5783.9710801446145, 5785.884282314372, 4842.854714358575, 5084.949150508484, 5529.557635389199, 6206.751729930797, 6259.0, 5322.0686379883755, 6261.217347831521, 6278.497720182374, 6313.905291420587, 6349.968250158766, 6013.75944962201, 6059.21230240066, 6077.392260773931, 6112.816615501453, 6121.908171377433, 5416.0, 6424.100625912376, 6472.644004579699, 6474.870502589922, 6497.577657452251, 6121.910283036266, 6182.969085154546, 6262.843428914313, 6323.399277068671, 6344.746210151635, 6258.561900666909, 6325.683715814283, 6340.4293613575, 6358.109864618957, 6366.0, 6140.013486850375, 6231.75072997075, 6267.467265282502, 6310.5898116622275, 6379.904301435482, 5514.751836167382, 6201.472874805602, 6342.587731797418, 6348.0, 6357.713902874381, 4580.427446569179, 4996.4254110777, 5004.874878128003, 5019.774110164978, 5025.246213068069, 4443.911121777546, 4487.237169681162, 4489.2592722201125, 4489.438820147481, 4501.212287849613, 5843.824685259449, 6013.729382177812, 6032.125341825411, 6053.909191362133, 6072.483838873657, 6338.049292606146, 6353.428191462791, 6366.299707032223, 6379.872402551923, 6383.36166383358, 6093.664848433379, 6095.329513753483, 6125.846853828601, 6144.569880108439, 6152.78465253714, 5395.946040539623, 5397.541208997201, 5443.346798384219, 5473.8357849264585, 5522.723863806794, 6418.903716444257, 6467.062275969958, 6475.158229430144, 6476.902846457307, 6489.999999999905, 5541.362743284574, 5657.943420565742, 5853.239078919713, 6164.89031974249, 6299.748010079546, 5191.792328306826, 6434.002729576923, 6506.121673574007, 6509.251436084722, 6568.441682457044, 6291.905621415774, 6302.810915672537, 6303.716332765129, 6370.936290637034, 6373.139626150596, 6160.876782464416, 6348.9047664286, 6356.3325850785, 6358.809235722936, 6361.395667411589, 5968.0, 6151.477124444473, 6173.104899789595, 6191.659458729813, 6207.379262073757, 6191.473724733448, 6235.594686345373, 6271.184745982993, 6284.717187726655, 6291.528135389955, 5993.190919225849, 6004.039353703386, 6091.664958427329, 6155.446009859134, 6178.567500274938, 5601.935632229864, 5968.164456976114, 6153.261608606996, 6241.375862413723, 6280.654563998841, 6187.504999600112, 6202.100695399052, 6216.316205217513, 6227.283862355887, 6228.34602366745], "value": 5757.379486908131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.2656458288609, 515.8968206358728, 544.4473859033079, 550.675101690003, 568.6247076929227, 37988.86033418999, 38749.806250968744, 40991.59008409915, 41007.58992410075, 41128.58871411285, 37039.888803335874, 39750.0, 42586.0, 42698.573014269845, 42746.93132671685, 9349.018353072948, 9625.941146473882, 9633.855492167622, 9638.228941684649, 9658.855117173249, 7582.848343033136, 9458.905410945905, 9477.34146524359, 9596.856047159263, 9601.991790861965, 9534.856977145348, 9556.569954352071, 9595.328327017112, 9640.325177237597, 9698.108868770592, 8582.755500452462, 9258.814823703487, 9576.42541447512, 9672.371295865816, 9679.70960871175, 7977.60111994398, 9499.24006079512, 9543.904560954372, 9600.90399096007, 9601.951990240073, 32316.838415808004, 39474.81575552738, 39633.60366396328, 39635.20729585392, 39829.60170398288, 2553.4637726077544, 3037.3925214956876, 3075.6770539093295, 3597.190632107781, 3942.8368631253848, 27928.720712792816, 28428.573571396446, 28938.42123157546, 29862.0, 29927.0, 2603.7396260374, 2694.568868980973, 2817.0281252967693, 2825.2795537138104, 2838.233676907244, 421952.0, 511551.0, 515831.0, 516078.0, 519061.0, 35717.64282357195, 67914.0, 68323.0, 69005.65497172483, 69144.0, 29931.551026734618, 37618.623813761515, 38079.619203807604, 38103.42844857329, 38109.80945095257, 15268.389264429521, 15645.687086258438, 15760.290786914617, 16046.598835028984, 16060.0, 13232.272225027717, 13297.401616927262, 13371.130876492996, 13377.13048651854, 13392.933035334956, 8279.917200828035, 8322.292605128632, 8377.204165604258, 8461.23848853606, 8486.575671216538, 3400.523926650271, 3428.2800611871785, 3449.120474279043, 3453.8963831085107, 3472.9652703472643, 964.7636329099415, 988.2341185581089, 1026.071405378134, 1080.0873262093519, 1128.4019469681082, 27486.80105591548, 30170.84914575413, 30492.0, 30608.477586987727, 30906.072817815053, 766.2988365645483, 1037.2169012395593, 1054.7995880782628, 1172.7537217184488, 1261.4890969157507, 12426.5650702225, 14300.0, 15247.542573722805, 15679.68640627181, 15693.0, 681854.0, 682067.0, 685817.0, 686722.0, 687794.0, 61702.382976170564, 61728.69135654293, 62332.68833655893, 62357.0, 62447.0, 1423.6440889777555, 1469.3576665604132, 1471.6762312291494, 1483.473366954737, 1483.6735918098002, 29753.85123074371, 29777.0, 29866.656000479597, 30452.84773576118, 30473.54289685701, 54512.0, 55082.72458637681, 55478.72260638832, 55699.16451253153, 55783.0, 524916.0, 546731.0, 558280.0, 558539.0, 559309.0, 27741.722582773913, 28178.577321340606, 28279.858600706866, 28485.0, 28639.856800715865, 48060.27909581429, 48112.27831582459, 48826.26760598665, 49028.50971490382, 49215.0, 39538.604613953496, 39977.80011099926, 40005.99985000398, 40287.0, 40897.0, 38682.80658596689, 38747.0, 39548.0, 40043.599564003984, 40268.1946361077, 38379.0, 38610.0, 38768.836934891995, 39326.213475730896, 39367.80316098401, 25363.36591585225, 33936.32127357488, 34679.0, 34934.30131397409, 34964.65035349614, 24513.896874640326, 24898.50202995966, 25202.865871036214, 25434.872825635754, 25715.742842572083], "value": 18858.51823195149, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.31462468742666, 404.5004419541867, 407.2486262845052, 408.0858876117498, 430.1740657936761, 20024.799752002476, 21232.787672123275, 21263.25578604749, 21508.0, 21988.780112198874, 16866.156692165372, 20831.791682083214, 21106.366808995717, 21692.0, 22023.77976220241, 5729.885402291951, 5895.675737834417, 5920.0, 5973.88052238955, 5985.820425387245, 4186.937195942048, 5525.696086715229, 5943.88112237755, 5994.790182343619, 6478.060681201223, 5435.592330575203, 5476.890462190754, 6421.7752378666755, 6481.254655714606, 6505.739770409178, 5210.817621383252, 5844.707764611752, 6404.871902561923, 6479.0, 6582.637954912478, 4678.929816052762, 5627.521660658849, 5640.0, 5759.568032397587, 5770.826875193751, 25325.0, 25770.355741106436, 25898.352541186432, 26093.825777840044, 26623.46753064928, 1826.8538516918616, 2116.1429621003517, 2191.7808219178114, 2210.9005094770773, 2250.414892128042, 15029.473968411054, 15043.172625505593, 15238.247601525856, 15417.614559635987, 15806.604834879105, 1726.464795913271, 1745.903975281359, 1757.79785324688, 1768.8142745011717, 1803.0624075480678, 119543.0, 120994.0, 123057.38471307587, 124037.75962240352, 124233.0, 9639.987801280904, 10917.617883374203, 11672.416379181008, 11726.179167458367, 11791.08716992985, 14516.419343226364, 14604.853951460562, 14799.260036998106, 14853.851461485463, 14895.03182293169, 8900.510471924106, 8976.955115224382, 9098.408603440888, 9177.174054335143, 9192.264618830477, 7821.374290056782, 9093.863592046124, 9121.817563648823, 9257.305702072372, 9272.119148680864, 6612.371824676648, 6940.687669054904, 7048.506604537633, 7072.257412971564, 7091.219965803757, 1478.9573350787668, 1592.6655402365402, 1866.2348437140706, 1928.3540014095154, 1981.8216360527333, 855.9172646602053, 919.1360121485782, 931.7204838548544, 1048.219076787798, 1090.3948308688755, 16097.758533622005, 16447.91776041136, 20500.0, 20977.95110244482, 21908.780912190992, 912.6349460215966, 974.770928831724, 1013.5033833421718, 1071.116329028539, 1086.7556647638567, 9808.0, 10876.673699789018, 11379.829302560469, 11421.828672569918, 11428.542858285742, 619305.0, 629312.0, 636323.0, 639588.0, 640438.0, 131708.3414582921, 133648.3317583406, 134853.0, 136394.0, 137759.0, 1073.6188653028219, 1074.5164675895878, 1095.7205912492263, 1097.25386737018, 1103.194667892443, 18487.89072655645, 18641.254349825856, 18875.829279633017, 18896.716549252047, 18901.43295701131, 52001.47998520118, 53500.0, 53665.0, 54435.0, 54587.90824183415, 78327.0, 78369.43261134632, 79361.60319198367, 79425.8086128697, 80840.0, 7981.2018798119725, 8321.459105158145, 8430.241278284984, 8492.108328625405, 8812.206901378906, 9674.22606191489, 10683.57265709394, 12699.936500317439, 12996.155249908727, 13262.53581124656, 10723.839142412715, 10777.892221078002, 11238.325700458, 11468.31190128595, 11490.655280341269, 10827.783444330911, 11036.779264414507, 11092.778144436905, 11310.660680179279, 11523.8271425927, 10556.15550755953, 11385.259958102697, 11417.60038398652, 11492.023178029962, 11736.06111511094, 8281.710140145065, 8341.749747507585, 8498.532580707873, 8504.829903401773, 8528.061913189667, 10604.257701960789, 11308.982191602796, 11545.422728863356, 11582.71043223926, 11600.593979210687], "value": 9913.77903058408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1595.361855257897, 1603.9358425662974, 1869.2336142181707, 1940.3111895277168, 1975.3876298347504, 7835.451518393715, 7923.3661307095435, 8385.287250583708, 8408.075111737711, 8519.3610479214, 8620.525871077089, 8654.22112009919, 8823.382363234576, 8829.823403531926, 8873.91126088739, 2459.0655550890638, 2490.4645501217233, 2495.189063554343, 2497.475530138673, 2498.8750562471805, 2444.181199298237, 2486.2292689266296, 2497.5379554782426, 2506.9373265668414, 2514.1954574536157, 2467.0748469324003, 2474.5669507836146, 2486.4032632168332, 2498.1381423408893, 2498.4253621667026, 2414.263649586875, 2428.599281118622, 2430.684011078566, 2458.9016439342404, 2467.962980555293, 2430.3195105370523, 2451.9141830035865, 2465.815063870217, 2471.505698860235, 2487.44032592667, 8642.783930401727, 8718.128187181232, 8803.77990550235, 8814.647414103429, 8825.382223244376, 5322.92015619766, 5507.421720719347, 5527.143292789624, 5529.474699903502, 5539.778408863641, 3619.2218672985173, 3624.3294990426593, 3638.4718418264392, 3690.3541880170865, 3716.535433070866, 834.5743670727911, 1050.070687441612, 1056.1550759392455, 1058.8147074261974, 1062.829947208443, 11638.709032274177, 11776.64670059891, 11782.410879456078, 11807.704807379798, 11833.822492662617, 4882.2432522959, 4910.48439913811, 5003.77483013258, 5009.5491405773655, 5041.966396888629, 10016.0, 10057.094861462503, 10058.748531286776, 10066.496675166212, 10076.899231007743, 5345.438728933406, 5374.623776335698, 5425.26758887553, 5437.401885792559, 5499.670019798745, 4485.439320084989, 4868.099401610713, 4971.801127954914, 5026.220935754964, 5041.319421878073, 4040.474738284004, 4100.856470023535, 4102.138550904284, 4129.613716752235, 4164.7917604119675, 1141.57191053355, 1375.3467103125936, 1376.078027721429, 1378.1593228130832, 1397.343248673122, 772.7527191298731, 894.6580129805292, 896.3680605173467, 924.8797656304772, 929.7768535551419, 4366.388705581221, 5843.393066906549, 5943.3462319144855, 6069.666168360694, 6121.989871671124, 959.8704174936433, 973.4159504297506, 1003.1523362758458, 1020.811149937264, 1023.1712313026472, 3939.6848252140335, 4014.337634290368, 4046.9595304046584, 4093.9765058735316, 4131.029208136086, 10392.06471417576, 10614.522346494427, 10865.185111116698, 10892.074173695166, 10908.890911090946, 10763.83854242187, 10764.892351076389, 10838.729031774112, 10941.4529273536, 10967.122630189566, 7812.882806757903, 8167.42828002046, 8307.252347288651, 8341.95829020851, 8379.120192379713, 6030.698465076816, 6053.303870055, 6128.233970753656, 6175.197224360804, 6194.845128871814, 9918.20654347636, 10191.898081019095, 10224.233182511192, 10236.948815255875, 10253.897461025294, 6859.971004349388, 8249.958750206211, 10020.398776073458, 10115.7471063224, 10201.54093065799, 6917.584944903322, 6962.443004559522, 7387.9261207387235, 7625.923740762521, 7725.266099720518, 7027.332403421667, 8506.064332923497, 8583.313334933315, 8604.397692161489, 8618.569071546272, 7498.250174982458, 7563.0, 7588.165301816906, 7665.041869766279, 7727.227277272228, 6380.947143721234, 7376.926230737624, 7485.850282994201, 7491.10106787189, 7622.085349758065, 7005.8248543784775, 7049.0, 7083.327083927019, 7147.213806481387, 7188.712451501881, 4839.080574690797, 4858.1012512685265, 5007.799688012438, 5022.573081288131, 5192.013517431676, 4802.951970480391, 4956.504349565014, 5064.34163558735, 5126.410462796677, 5299.33758280215], "value": 4663.464866306401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.8954245099118, 323.3274788440045, 330.978930000947, 336.76407584166105, 337.13188539510736, 4594.3338215958665, 5333.466653334664, 5500.779968801248, 5521.282233309669, 5546.306711661047, 4764.690295130823, 5418.83743487695, 5446.836594902149, 5461.098918678414, 5519.69641669708, 4001.3397789364794, 4160.43834082398, 4164.8125834337525, 4191.329387298033, 4204.495460544724, 3803.315403227418, 3821.7515861469055, 3998.1608460108387, 4059.7970101494807, 4135.648469880049, 3138.686131386866, 3687.760295580792, 3872.5352957645123, 3873.3028054950096, 4074.348104303312, 3391.9830400848086, 4036.8385264589383, 4068.816903239361, 4072.511298644182, 4104.968040819784, 3108.5648009278493, 3146.433641944449, 3408.642092580293, 3449.344624521333, 3567.1973805893726, 4300.903269666246, 4895.853124406273, 5038.168702164138, 5117.437081920985, 5181.922271165936, 3907.7264591478606, 3986.926798065019, 4627.606653434462, 4670.953290467086, 4688.898108944395, 4959.975200123977, 5074.13739664258, 5260.684358938438, 5677.290338707661, 5701.403606990049, 3275.4922986937063, 3294.5387645729616, 3675.1333959511626, 3890.961090389088, 3909.6767747414756, 5290.650884024588, 5294.364676238837, 5962.940370596325, 5963.389884731142, 5982.222311099573, 3579.89023402746, 3681.742278040565, 3908.511436070491, 3917.8236979335998, 3951.209758048402, 3148.449021421242, 3387.5257463955068, 3656.433252845813, 4025.611164148364, 4118.519850726132, 4323.156984388077, 4482.4172857528965, 4619.214733495314, 4662.6269898408045, 4677.204875171229, 5529.364123125812, 5738.569607279387, 5757.740901659436, 5763.204845649857, 5776.5089967352405, 1135.2904434728296, 1278.4502663854632, 1297.5718013055669, 1304.5825335892614, 1306.137948953686, 859.7979474823411, 868.8574524500262, 879.2131042716733, 892.125716797542, 895.820835832836, 4635.635825728902, 4786.133407970894, 5088.898222035538, 5107.923381149286, 5115.488451154929, 5047.268146118792, 5136.768845401966, 5528.419515950848, 5680.971595141998, 5691.516221121168, 4447.73313601185, 4506.436695413074, 4578.679492435497, 4874.926876096862, 4987.351644286292, 2563.3850674075584, 2573.6139579063292, 2593.9092131775674, 2676.5449873521547, 2925.9707402926124, 5346.34263378354, 5748.741306641211, 5825.33008703996, 5882.705864706833, 5903.970480147572, 4735.384400028043, 5388.595855310868, 5617.915731264035, 5753.5547392358085, 5769.1923130761725, 4698.929516057262, 5796.913046304308, 5856.502197313191, 5871.794487193013, 5937.851553711192, 4822.614190864792, 5086.516780905808, 5613.298337707786, 5636.689982051026, 5682.8295151143875, 4594.093451217707, 4952.331435256195, 5157.203800465453, 5337.866553336197, 5556.333240011225, 5086.669366491166, 5330.440303768049, 5830.163498497959, 5875.41245875409, 5895.64626122434, 3054.09904078293, 3419.794812311269, 3726.366517691945, 3735.5991503186306, 3742.2889650967318, 4859.635527335393, 5013.799448022184, 5088.150635644051, 5245.265662807134, 5347.144456886879, 4993.425756038102, 5628.155776633538, 5698.660814708623, 5711.914321285267, 5718.198082939413, 4908.674657842291, 5591.8881622368135, 5623.831285061455, 5689.77240910359, 5692.203091567267, 4946.703197808143, 5226.111561034557, 5529.806456774155, 5569.693666848362, 5585.106382978704, 5065.656666600026, 5657.915131272952, 5686.914696279477, 5711.572581652698, 5729.455701708331, 4627.005193883331, 5111.361079865017, 5417.51242388187, 5586.748596313257, 5598.412166722598], "value": 4019.4763614553212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.3936971683222, 742.9145648250451, 752.5071078443618, 752.7628796928964, 812.1594150054694, 14737.778933315996, 14737.852621473809, 15058.774118388219, 15118.941674082818, 15183.316750746215, 13876.502229598667, 13891.722165556683, 14054.859451405482, 14055.0, 14068.718625627507, 744.162816831065, 920.3051695969534, 927.9907200928005, 931.4923366765096, 940.0223767282052, 933.7898972731115, 951.1772316945827, 951.8191543606728, 952.200151872427, 953.0993211415215, 1007.2395341517145, 1007.6876168387787, 1011.4841430870273, 1011.514473052935, 1013.9961438176226, 959.4627008874983, 969.4280374578997, 995.2933417273745, 1004.7437903334603, 1006.66276797273, 734.709789633092, 752.1538269446872, 752.5033477904557, 754.2344520311888, 759.3279947246672, 14514.419423223058, 14656.193909334983, 14714.632134196623, 14735.263236838222, 14736.484223052248, 12686.492540298377, 12693.682657933625, 12739.0, 12820.102592818506, 13154.934225328812, 9952.203823694088, 10221.131203847608, 10276.280660353777, 10480.58077676892, 10608.522616482276, 3486.4247399179103, 3541.557305336833, 3639.5450568678916, 3669.7614655047605, 3681.5029970953847, 65923.0, 85350.57324713399, 85403.0, 87380.56309718538, 87841.56079219563, 9492.525373731423, 9558.474283914313, 9621.374610650286, 9661.32370734056, 9882.555285012191, 21756.0, 21765.45586360322, 21814.45463863416, 21867.0, 22479.775202248096, 6062.363451837582, 7414.184439711627, 7600.467967242351, 7619.276168763959, 7661.080670319486, 3932.6853851691794, 4047.838086476508, 4047.98800299925, 4052.49343832021, 4065.776382299002, 2969.584258203853, 3047.83236921967, 3512.877049303262, 3608.8195590220384, 3629.274145170976, 625.5058503781961, 635.8887194740902, 637.2735082006516, 642.958207716497, 646.4537465841356, 584.6287607369351, 586.7359688140353, 591.1959734760723, 601.4767152577199, 627.7834147219202, 8065.7176998805935, 8148.511089334659, 8178.5092894426525, 8237.588120593946, 8274.710385136492, 562.0192763627496, 570.349801226602, 598.1297212555721, 616.0451300484322, 624.950003999679, 3892.591277915835, 3930.4300876373336, 3935.5474120475938, 3970.821313040862, 4061.0246981066675, 94815.20397694303, 94820.0, 96700.06599867964, 97818.02181978231, 97959.0, 79985.20014799778, 80312.0, 82566.58716706379, 83691.0, 85223.0, 56326.43673563294, 63876.04185937122, 73534.0, 74635.88046179312, 75050.62474687591, 8126.267559888396, 8386.622601983048, 8405.747827565183, 8471.6021856393, 8540.0, 44252.77873610611, 44798.552014479435, 45190.0, 45372.092558149314, 46064.309035365164, 61922.380776193466, 62473.68763156155, 62559.6872015637, 62979.6851015742, 63374.683126584074, 10810.459477026274, 10914.890851091388, 11016.449177540931, 11073.0, 11550.653480395602, 11985.760284794082, 12016.699582510508, 12069.939650302043, 12215.69460763488, 12409.503619855466, 11088.002079812855, 11487.368194749035, 11642.185047046964, 11729.882701173221, 11823.586174483851, 11183.88816111861, 11252.324860508395, 11430.0, 11738.060955123741, 12029.879701202875, 9138.0, 11425.485853136795, 11430.657080287605, 11964.222325549159, 12145.574904878287, 9447.797675462607, 9456.952715236379, 9501.192398646193, 9652.35541440715, 9706.980767019644, 8856.202941735275, 9866.260030497884, 9898.356606820533, 9911.10800028001, 10022.699319020441], "value": 6959.840668138898, "unit": "score"}], "name": "dromaeo_css", "value": 7209.673394362683, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 149.0, 107.0, 115.0, 117.0, 115.0, 108.0, 115.0, 116.0, 101.0], "value": 120.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 114.0, 174.0, 198.0, 144.0, 134.0, 168.0, 119.0, 218.0, 151.0], "value": 158.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 221.0, 228.0, 227.0, 195.0, 224.0, 219.0, 204.0, 200.0, 199.0], "value": 211.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 75.0, 155.0, 84.0, 88.0, 86.0, 58.0, 137.0, 58.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 138.0, 143.0, 78.0, 83.0, 89.0, 126.0, 117.0, 119.0, 164.0], "value": 116.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 131.0, 131.0, 92.0, 92.0, 136.0, 122.0], "value": 104.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 95.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 83.0, 152.0, 145.0, 91.0, 88.0, 90.0, 89.0, 92.0], "value": 111.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 60.0, 61.0, 64.0, 84.0, 83.0, 81.0, 62.0, 61.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 69.0, 81.0, 68.0, 95.0, 62.0, 74.0, 101.0, 103.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 92.0, 100.0, 88.0, 85.0, 87.0, 86.0, 85.0, 89.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 156.0, 140.0, 155.0, 140.0, 132.0, 155.0, 179.0, 255.0, 193.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 169.0, 169.0, 172.0, 166.0, 199.0, 232.0, 223.0, 170.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 82.0, 89.0, 86.0, 76.0, 66.0, 68.0, 68.0, 92.0], "value": 76.2, "unit": "score"}], "name": "kraken", "value": 1680.1000000000004, "alertThreshold": 2.0}]} 11:53:55 INFO - Return code: 0 11:53:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:53:55 ERROR - # TBPL SUCCESS # 11:53:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:53:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:53:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:53:55 INFO - 2016-05-06 11:53:55.774 screenresolution[1948:22687] starting screenresolution argv=screenresolution get 11:53:55 INFO - 2016-05-06 11:53:55.776 screenresolution[1948:22687] Display 0: 1600x1200x32@60 11:53:55 INFO - 2016-05-06 11:53:55.783 screenresolution[1949:22689] starting screenresolution argv=screenresolution list 11:53:55 INFO - Available Modes on Display 0 11:53:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:53:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:53:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:53:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:53:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:53:56 INFO - Intel Iris: 11:53:56 INFO - Chipset Model: Intel Iris 11:53:56 INFO - Type: GPU 11:53:56 INFO - Bus: Built-In 11:53:56 INFO - VRAM (Dynamic, Max): 1536 MB 11:53:56 INFO - Vendor: Intel (0x8086) 11:53:56 INFO - Device ID: 0x0a2e 11:53:56 INFO - Revision ID: 0x0009 11:53:56 INFO - Displays: 11:53:56 INFO - Display: 11:53:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:53:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:53:56 INFO - Display Serial Number: 1600x1200 60 11:53:56 INFO - Main Display: Yes 11:53:56 INFO - Mirror: Off 11:53:56 INFO - Online: Yes 11:53:56 INFO - Rotation: Supported 11:53:56 INFO - Return code: 0 11:53:56 INFO - Running post-action listener: _resource_record_post_action 11:53:56 INFO - ##### 11:53:56 INFO - ##### Finished run-tests step (success) 11:53:56 INFO - ##### 11:53:56 INFO - Running post-run listener: _resource_record_post_run 11:53:57 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 774144; Write bytes: 701636096; Read time: 11; Write time: 1998 11:53:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386152960; Write bytes: 384187904; Read time: 28499; Write time: 779 11:53:57 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 774144; Write bytes: 297971712; Read time: 11; Write time: 1172 11:53:57 INFO - Running post-run listener: _upload_blobber_files 11:53:57 INFO - Blob upload gear active. 11:53:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:53:57 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 11:53:57 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'] 11:53:57 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 11:53:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:58 INFO - (blobuploader) - INFO - Done attempting. 11:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:59 INFO - (blobuploader) - INFO - Done attempting. 11:53:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:53:59 INFO - Return code: 0 11:53:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:53:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:53:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459081b0fc3d4a78b53125542769e4b2aea84be404975b2d2566f6df1b6331541b4e9b0d0bdf589e58a755d8e58bd54256e877525f787723a52bca8da33437fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319e3ba5a987aacff24bad2eb7f2dd3752cda2367cc10e998fa5fffc2779d8a6d2fa8069ec4968d7597cdff8f20a9eb2ad2b64ce64c1922468ec95377150f362"} 11:53:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:53:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:53:59 INFO - Contents: 11:53:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459081b0fc3d4a78b53125542769e4b2aea84be404975b2d2566f6df1b6331541b4e9b0d0bdf589e58a755d8e58bd54256e877525f787723a52bca8da33437fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319e3ba5a987aacff24bad2eb7f2dd3752cda2367cc10e998fa5fffc2779d8a6d2fa8069ec4968d7597cdff8f20a9eb2ad2b64ce64c1922468ec95377150f362"} 11:53:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:53:59 INFO - Copying logs to upload dir... 11:53:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:53:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.209871 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-06 11:53:59.714884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 11:53:59.721743) ========= 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.V4N3UZkqbO/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.rePFjFhP95/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/459081b0fc3d4a78b53125542769e4b2aea84be404975b2d2566f6df1b6331541b4e9b0d0bdf589e58a755d8e58bd54256e877525f787723a52bca8da33437fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319e3ba5a987aacff24bad2eb7f2dd3752cda2367cc10e998fa5fffc2779d8a6d2fa8069ec4968d7597cdff8f20a9eb2ad2b64ce64c1922468ec95377150f362"} build_url:https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011036 build_url: 'https://queue.taskcluster.net/v1/task/SpeYAu74SHSN26WX07cFWg/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/459081b0fc3d4a78b53125542769e4b2aea84be404975b2d2566f6df1b6331541b4e9b0d0bdf589e58a755d8e58bd54256e877525f787723a52bca8da33437fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/319e3ba5a987aacff24bad2eb7f2dd3752cda2367cc10e998fa5fffc2779d8a6d2fa8069ec4968d7597cdff8f20a9eb2ad2b64ce64c1922468ec95377150f362"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 11:53:59.752871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:53:59.753461) ========= 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.V4N3UZkqbO/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.rePFjFhP95/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005228 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 11:53:59.807388) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 11:53:59.807711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 11:53:59.808064) ========= ========= Total master_lag: 0.30 =========