builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1459834093.57 results: success (0) buildid: 20160404210116 builduid: 5842b6487d794412a51197051bfc2587 revision: ffd37011577923985b68a6e7b5c2699771dc2cdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.568788) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.569990) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.570852) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006328 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.602377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.603148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.618531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.619258) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.673434) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.674112) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.675049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.675818) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 22:28:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 46.8M=0s 2016-04-04 22:28:14 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.803363) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.804154) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017719 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:13.858065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:28:13.858953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ffd37011577923985b68a6e7b5c2699771dc2cdd --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 ffd37011577923985b68a6e7b5c2699771dc2cdd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 22:28:14,830 truncating revision to first 12 chars 2016-04-04 22:28:14,831 Setting DEBUG logging. 2016-04-04 22:28:14,831 attempt 1/10 2016-04-04 22:28:14,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ffd370115779?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 22:28:16,093 unpacking tar archive at: fx-team-ffd370115779/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 22:28:15.430683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:15.431616) ========= echo ffd37011577923985b68a6e7b5c2699771dc2cdd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ffd37011577923985b68a6e7b5c2699771dc2cdd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ffd37011577923985b68a6e7b5c2699771dc2cdd program finished with exit code 0 elapsedTime=0.004764 script_repo_revision: 'ffd37011577923985b68a6e7b5c2699771dc2cdd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:15.486402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:15.486763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:28:15.497147) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-04 22:28:15.497488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:28:16 INFO - MultiFileLogger online at 20160404 22:28:16 in /builds/slave/test 22:28:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:28:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:28:16 INFO - {'append_to_log': False, 22:28:16 INFO - 'base_work_dir': '/builds/slave/test', 22:28:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:28:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:28:16 INFO - 'branch': 'Fx-Team-Non-PGO', 22:28:16 INFO - 'buildbot_json_path': 'buildprops.json', 22:28:16 INFO - 'config_files': ('talos/linux_config.py',), 22:28:16 INFO - 'default_actions': ('clobber', 22:28:16 INFO - 'read-buildbot-config', 22:28:16 INFO - 'download-and-extract', 22:28:16 INFO - 'populate-webroot', 22:28:16 INFO - 'create-virtualenv', 22:28:16 INFO - 'install', 22:28:16 INFO - 'run-tests'), 22:28:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:28:16 INFO - 'download_minidump_stackwalk': True, 22:28:16 INFO - 'download_symbols': 'ondemand', 22:28:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:28:16 INFO - 'tooltool.py': '/tools/tooltool.py', 22:28:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:28:16 INFO - '/tools/misc-python/virtualenv.py')}, 22:28:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:28:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:28:16 INFO - 'installer_path': 'installer.exe', 22:28:16 INFO - 'log_level': 'info', 22:28:16 INFO - 'log_name': 'talos', 22:28:16 INFO - 'log_to_console': True, 22:28:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:28:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:28:16 INFO - 'opt_config_files': (), 22:28:16 INFO - 'pip_index': False, 22:28:16 INFO - 'sps_profile': False, 22:28:16 INFO - 'sps_profile_interval': 0, 22:28:16 INFO - 'suite': 'dromaeojs', 22:28:16 INFO - 'system_bits': '32', 22:28:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:28:16 INFO - 'title': 'talos-linux64-ix-013', 22:28:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:28:16 INFO - 'use_talos_json': True, 22:28:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:28:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:28:16 INFO - 'work_dir': 'build'} 22:28:16 INFO - ##### 22:28:16 INFO - ##### Running clobber step. 22:28:16 INFO - ##### 22:28:16 INFO - Running pre-action listener: _resource_record_pre_action 22:28:16 INFO - Running main action method: clobber 22:28:16 INFO - rmtree: /builds/slave/test/build 22:28:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:28:17 INFO - Running post-action listener: _resource_record_post_action 22:28:17 INFO - ##### 22:28:17 INFO - ##### Running read-buildbot-config step. 22:28:17 INFO - ##### 22:28:17 INFO - Running pre-action listener: _resource_record_pre_action 22:28:17 INFO - Running main action method: read_buildbot_config 22:28:17 INFO - Using buildbot properties: 22:28:17 INFO - { 22:28:17 INFO - "project": "", 22:28:17 INFO - "product": "firefox", 22:28:17 INFO - "script_repo_revision": "production", 22:28:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:28:17 INFO - "repository": "", 22:28:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:28:17 INFO - "buildid": "20160404210116", 22:28:17 INFO - "pgo_build": "False", 22:28:17 INFO - "basedir": "/builds/slave/test", 22:28:17 INFO - "buildnumber": 1610, 22:28:17 INFO - "slavename": "talos-linux64-ix-013", 22:28:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:28:17 INFO - "platform": "ubuntu64_hw", 22:28:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:28:17 INFO - "branch": "fx-team", 22:28:17 INFO - "repo_path": "integration/fx-team", 22:28:17 INFO - "revision": "ffd37011577923985b68a6e7b5c2699771dc2cdd", 22:28:17 INFO - "stage_platform": "linux64", 22:28:17 INFO - "builduid": "5842b6487d794412a51197051bfc2587", 22:28:17 INFO - "slavebuilddir": "test" 22:28:17 INFO - } 22:28:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:28:17 INFO - Running post-action listener: _resource_record_post_action 22:28:17 INFO - ##### 22:28:17 INFO - ##### Running download-and-extract step. 22:28:17 INFO - ##### 22:28:17 INFO - Running pre-action listener: _resource_record_pre_action 22:28:17 INFO - Running main action method: download_and_extract 22:28:17 INFO - mkdir: /builds/slave/test/build/tests 22:28:17 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')]} 22:28:17 INFO - https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:28:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:28:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:28:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:28:17 INFO - Downloaded 1361 bytes. 22:28:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:28:17 INFO - Using the following test package requirements: 22:28:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:28:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:28:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'jsshell-linux-x86_64.zip'], 22:28:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:28:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:28:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:28:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:28:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:28:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:28:17 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')]} 22:28:17 INFO - https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:28:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:28:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:28:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:28:18 INFO - Downloaded 22125516 bytes. 22:28:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:28:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:28:20 INFO - Return code: 0 22:28:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:28: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')]} 22:28:20 INFO - https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:28:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:28:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:28:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:28:21 INFO - Downloaded 22125516 bytes. 22:28:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:28:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:28:22 INFO - Return code: 0 22:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:22 INFO - https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:28:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:28:23 INFO - Downloaded 10847584 bytes. 22:28:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:28:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:28:23 INFO - Return code: 0 22:28: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')]} 22:28:23 INFO - https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:28:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:28:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:28:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:28:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:28:25 INFO - Downloaded 54082798 bytes. 22:28:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:28:25 INFO - mkdir: /builds/slave/test/properties 22:28:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:28:25 INFO - Writing to file /builds/slave/test/properties/build_url 22:28:25 INFO - Contents: 22:28:25 INFO - build_url:https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:28:26 INFO - Running post-action listener: _resource_record_post_action 22:28:26 INFO - Running post-action listener: set_extra_try_arguments 22:28:26 INFO - ##### 22:28:26 INFO - ##### Running populate-webroot step. 22:28:26 INFO - ##### 22:28:26 INFO - Running pre-action listener: _resource_record_pre_action 22:28:26 INFO - Running main action method: populate_webroot 22:28:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:28:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:28:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:28:26 INFO - '--tppagecycles', 22:28:26 INFO - '7'], 22:28:26 INFO - 'tests': ['tsvgm']}}, 22:28:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:28:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:28:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:28:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:28:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'tests': ['damp', 'tps']}, 22:28:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['damp', 'tps']}, 22:28:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:28:26 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['dromaeo_dom']}, 22:28:26 INFO - 'other': {'tests': ['a11yr', 22:28:26 INFO - 'ts_paint', 22:28:26 INFO - 'tpaint', 22:28:26 INFO - 'sessionrestore', 22:28:26 INFO - 'sessionrestore_no_auto_restore', 22:28:26 INFO - 'tabpaint']}, 22:28:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['a11yr', 22:28:26 INFO - 'ts_paint', 22:28:26 INFO - 'tpaint', 22:28:26 INFO - 'sessionrestore', 22:28:26 INFO - 'sessionrestore_no_auto_restore', 22:28:26 INFO - 'tabpaint']}, 22:28:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['a11yr', 22:28:26 INFO - 'ts_paint', 22:28:26 INFO - 'tpaint', 22:28:26 INFO - 'sessionrestore', 22:28:26 INFO - 'sessionrestore_no_auto_restore', 22:28:26 INFO - 'tabpaint']}, 22:28:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['a11yr', 22:28:26 INFO - 'ts_paint', 22:28:26 INFO - 'tpaint', 22:28:26 INFO - 'sessionrestore', 22:28:26 INFO - 'sessionrestore_no_auto_restore', 22:28:26 INFO - 'tabpaint']}, 22:28:26 INFO - 'other_l64': {'tests': ['a11yr', 22:28:26 INFO - 'ts_paint', 22:28:26 INFO - 'tpaint', 22:28:26 INFO - 'sessionrestore', 22:28:26 INFO - 'sessionrestore_no_auto_restore', 22:28:26 INFO - 'tabpaint']}, 22:28:26 INFO - 'other_nol64': {'tests': ['a11yr', 22:28:26 INFO - 'ts_paint', 22:28:26 INFO - 'tpaint', 22:28:26 INFO - 'sessionrestore', 22:28:26 INFO - 'sessionrestore_no_auto_restore', 22:28:26 INFO - 'tabpaint']}, 22:28:26 INFO - 'svgr': {'tests': ['tsvgx', 22:28:26 INFO - 'tsvgr_opacity', 22:28:26 INFO - 'tart', 22:28:26 INFO - 'tscrollx', 22:28:26 INFO - 'cart']}, 22:28:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['tsvgx', 22:28:26 INFO - 'tsvgr_opacity', 22:28:26 INFO - 'tart', 22:28:26 INFO - 'tscrollx', 22:28:26 INFO - 'cart']}, 22:28:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'tests': ['tp5o']}, 22:28:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'talos_options': ['--e10s'], 22:28:26 INFO - 'tests': ['tp5o']}, 22:28:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'talos_options': ['--xperf_path', 22:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:26 INFO - 'tests': ['tp5n']}, 22:28:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:26 INFO - 'talos_options': ['--e10s', 22:28:26 INFO - '--xperf_path', 22:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:26 INFO - 'tests': ['tp5n']}}, 22:28:26 INFO - 'talos.zip': {'path': '', 22:28:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:28:26 INFO - Running post-action listener: _resource_record_post_action 22:28:26 INFO - ##### 22:28:26 INFO - ##### Running create-virtualenv step. 22:28:26 INFO - ##### 22:28:26 INFO - Running pre-action listener: _resource_record_pre_action 22:28:26 INFO - Running main action method: create_virtualenv 22:28:26 INFO - Creating virtualenv /builds/slave/test/build/venv 22:28:26 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 22:28:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:28:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:28:26 INFO - Using real prefix '/usr' 22:28:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:28:26 INFO - Installing distribute.............................................................................................................................................................................................done. 22:28:28 INFO - Installing pip.................done. 22:28:28 INFO - Return code: 0 22:28:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:28: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')]} 22:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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')]} 22:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:28 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:28 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 22:28:28 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 22:28:28 INFO - Using env: {'DISPLAY': ':0', 22:28:28 INFO - 'HOME': '/home/cltbld', 22:28:28 INFO - 'LANG': 'en_US.UTF-8', 22:28:28 INFO - 'LANGUAGE': 'en_US:en', 22:28:28 INFO - 'LOGNAME': 'cltbld', 22:28:28 INFO - 'MAIL': '/var/mail/cltbld', 22:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:28 INFO - 'MOZ_NO_REMOTE': '1', 22:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:28 INFO - 'NO_EM_RESTART': '1', 22:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:28 INFO - 'PWD': '/builds/slave/test', 22:28:28 INFO - 'SHELL': '/bin/bash', 22:28:28 INFO - 'SHLVL': '1', 22:28:28 INFO - 'TERM': 'linux', 22:28:28 INFO - 'TMOUT': '86400', 22:28:28 INFO - 'USER': 'cltbld', 22:28:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:28 INFO - '_': '/tools/buildbot/bin/python'} 22:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:28 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 22:28:28 INFO - Cleaning up... 22:28:28 INFO - Return code: 0 22:28:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:28: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')]} 22:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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')]} 22:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:28 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:28 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 22:28:28 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 22:28:28 INFO - Using env: {'DISPLAY': ':0', 22:28:28 INFO - 'HOME': '/home/cltbld', 22:28:28 INFO - 'LANG': 'en_US.UTF-8', 22:28:28 INFO - 'LANGUAGE': 'en_US:en', 22:28:28 INFO - 'LOGNAME': 'cltbld', 22:28:28 INFO - 'MAIL': '/var/mail/cltbld', 22:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:28 INFO - 'MOZ_NO_REMOTE': '1', 22:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:28 INFO - 'NO_EM_RESTART': '1', 22:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:28 INFO - 'PWD': '/builds/slave/test', 22:28:28 INFO - 'SHELL': '/bin/bash', 22:28:28 INFO - 'SHLVL': '1', 22:28:28 INFO - 'TERM': 'linux', 22:28:28 INFO - 'TMOUT': '86400', 22:28:28 INFO - 'USER': 'cltbld', 22:28:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:28 INFO - '_': '/tools/buildbot/bin/python'} 22:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:29 INFO - Downloading/unpacking psutil>=0.7.1 22:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:31 INFO - Installing collected packages: psutil 22:28:31 INFO - Running setup.py install for psutil 22:28:31 INFO - building 'psutil._psutil_linux' extension 22:28:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:28:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:28:31 INFO - building 'psutil._psutil_posix' extension 22:28:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:28:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:31 INFO - Successfully installed psutil 22:28:31 INFO - Cleaning up... 22:28:31 INFO - Return code: 0 22:28:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:28:31 INFO - Using env: {'DISPLAY': ':0', 22:28:31 INFO - 'HOME': '/home/cltbld', 22:28:31 INFO - 'LANG': 'en_US.UTF-8', 22:28:31 INFO - 'LANGUAGE': 'en_US:en', 22:28:31 INFO - 'LOGNAME': 'cltbld', 22:28:31 INFO - 'MAIL': '/var/mail/cltbld', 22:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:31 INFO - 'MOZ_NO_REMOTE': '1', 22:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:31 INFO - 'NO_EM_RESTART': '1', 22:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:31 INFO - 'PWD': '/builds/slave/test', 22:28:31 INFO - 'SHELL': '/bin/bash', 22:28:31 INFO - 'SHLVL': '1', 22:28:31 INFO - 'TERM': 'linux', 22:28:31 INFO - 'TMOUT': '86400', 22:28:31 INFO - 'USER': 'cltbld', 22:28:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:31 INFO - '_': '/tools/buildbot/bin/python'} 22:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:28:33 INFO - Installing collected packages: mozsystemmonitor 22:28:33 INFO - Running setup.py install for mozsystemmonitor 22:28:33 INFO - Successfully installed mozsystemmonitor 22:28:33 INFO - Cleaning up... 22:28:34 INFO - Return code: 0 22:28:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:28:34 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')]} 22:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:34 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')]} 22:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:34 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:34 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 22:28:34 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 22:28:34 INFO - Using env: {'DISPLAY': ':0', 22:28:34 INFO - 'HOME': '/home/cltbld', 22:28:34 INFO - 'LANG': 'en_US.UTF-8', 22:28:34 INFO - 'LANGUAGE': 'en_US:en', 22:28:34 INFO - 'LOGNAME': 'cltbld', 22:28:34 INFO - 'MAIL': '/var/mail/cltbld', 22:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:34 INFO - 'MOZ_NO_REMOTE': '1', 22:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:34 INFO - 'NO_EM_RESTART': '1', 22:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:34 INFO - 'PWD': '/builds/slave/test', 22:28:34 INFO - 'SHELL': '/bin/bash', 22:28:34 INFO - 'SHLVL': '1', 22:28:34 INFO - 'TERM': 'linux', 22:28:34 INFO - 'TMOUT': '86400', 22:28:34 INFO - 'USER': 'cltbld', 22:28:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:34 INFO - '_': '/tools/buildbot/bin/python'} 22:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:34 INFO - Downloading/unpacking blobuploader==1.2.4 22:28:34 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 22:28:34 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 22:28:34 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 22:28:34 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 22:28:34 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 22:28:34 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 22:28:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:28:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:28:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:36 INFO - Downloading docopt-0.6.1.tar.gz 22:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 22:28:36 INFO - Running setup.py install for blobuploader 22:28:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:28:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:28:36 INFO - Running setup.py install for requests 22:28:37 INFO - Running setup.py install for docopt 22:28:37 INFO - Successfully installed blobuploader requests docopt 22:28:37 INFO - Cleaning up... 22:28:37 INFO - Return code: 0 22:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:37 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')]} 22:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:37 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')]} 22:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:37 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:37 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 22:28:37 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 22:28:37 INFO - Using env: {'DISPLAY': ':0', 22:28:37 INFO - 'HOME': '/home/cltbld', 22:28:37 INFO - 'LANG': 'en_US.UTF-8', 22:28:37 INFO - 'LANGUAGE': 'en_US:en', 22:28:37 INFO - 'LOGNAME': 'cltbld', 22:28:37 INFO - 'MAIL': '/var/mail/cltbld', 22:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:37 INFO - 'MOZ_NO_REMOTE': '1', 22:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:37 INFO - 'NO_EM_RESTART': '1', 22:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:37 INFO - 'PWD': '/builds/slave/test', 22:28:37 INFO - 'SHELL': '/bin/bash', 22:28:37 INFO - 'SHLVL': '1', 22:28:37 INFO - 'TERM': 'linux', 22:28:37 INFO - 'TMOUT': '86400', 22:28:37 INFO - 'USER': 'cltbld', 22:28:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:37 INFO - '_': '/tools/buildbot/bin/python'} 22:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:37 INFO - Running setup.py (path:/tmp/pip-WuplCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:37 INFO - Running setup.py (path:/tmp/pip-sLcdhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:37 INFO - Running setup.py (path:/tmp/pip-j0QOsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:37 INFO - Running setup.py (path:/tmp/pip-krIrGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:37 INFO - Running setup.py (path:/tmp/pip-7LJoTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:38 INFO - Running setup.py (path:/tmp/pip-Wi8nBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:38 INFO - Running setup.py (path:/tmp/pip-a3pYx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:38 INFO - Running setup.py (path:/tmp/pip-vQlz7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:38 INFO - Running setup.py (path:/tmp/pip-desZc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:38 INFO - Running setup.py (path:/tmp/pip-3j8Ijo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:38 INFO - Running setup.py (path:/tmp/pip-yZ3Zrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:38 INFO - Running setup.py (path:/tmp/pip-gGvM0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:38 INFO - Running setup.py (path:/tmp/pip-MxbNVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:38 INFO - Running setup.py (path:/tmp/pip-uAQCeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:38 INFO - Running setup.py (path:/tmp/pip-A4ovKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:38 INFO - Running setup.py (path:/tmp/pip-t0Isqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:38 INFO - Running setup.py (path:/tmp/pip-sxv6WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:28:38 INFO - Running setup.py install for manifestparser 22:28:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for mozcrash 22:28:39 INFO - Running setup.py install for mozdebug 22:28:39 INFO - Running setup.py install for mozdevice 22:28:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for mozfile 22:28:39 INFO - Running setup.py install for mozhttpd 22:28:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for mozinfo 22:28:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for mozInstall 22:28:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for mozleak 22:28:39 INFO - Running setup.py install for mozlog 22:28:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for moznetwork 22:28:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Running setup.py install for mozprocess 22:28:40 INFO - Running setup.py install for mozprofile 22:28:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Running setup.py install for mozrunner 22:28:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Running setup.py install for mozscreenshot 22:28:40 INFO - Running setup.py install for moztest 22:28:40 INFO - Running setup.py install for mozversion 22:28:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:28:40 INFO - Cleaning up... 22:28:40 INFO - Return code: 0 22:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:40 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')]} 22:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:40 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')]} 22:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:40 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:40 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 22:28:40 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 22:28:40 INFO - Using env: {'DISPLAY': ':0', 22:28:40 INFO - 'HOME': '/home/cltbld', 22:28:40 INFO - 'LANG': 'en_US.UTF-8', 22:28:40 INFO - 'LANGUAGE': 'en_US:en', 22:28:40 INFO - 'LOGNAME': 'cltbld', 22:28:40 INFO - 'MAIL': '/var/mail/cltbld', 22:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:40 INFO - 'MOZ_NO_REMOTE': '1', 22:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:40 INFO - 'NO_EM_RESTART': '1', 22:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:40 INFO - 'PWD': '/builds/slave/test', 22:28:40 INFO - 'SHELL': '/bin/bash', 22:28:40 INFO - 'SHLVL': '1', 22:28:40 INFO - 'TERM': 'linux', 22:28:40 INFO - 'TMOUT': '86400', 22:28:40 INFO - 'USER': 'cltbld', 22:28:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:40 INFO - '_': '/tools/buildbot/bin/python'} 22:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:40 INFO - Running setup.py (path:/tmp/pip-ZqGr0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:40 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)) 22:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:40 INFO - Running setup.py (path:/tmp/pip-IVi1Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:41 INFO - Running setup.py (path:/tmp/pip-4kd7Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:41 INFO - Running setup.py (path:/tmp/pip-Z3pkyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:41 INFO - Running setup.py (path:/tmp/pip-2lbaAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:41 INFO - Running setup.py (path:/tmp/pip-Hhz8XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:41 INFO - Running setup.py (path:/tmp/pip-4qFYz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:41 INFO - Running setup.py (path:/tmp/pip-HqtBU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:41 INFO - Running setup.py (path:/tmp/pip-9f5DhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:41 INFO - Running setup.py (path:/tmp/pip-pE3QAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:41 INFO - Running setup.py (path:/tmp/pip-QN4dQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:41 INFO - Running setup.py (path:/tmp/pip-n3XkTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:41 INFO - Running setup.py (path:/tmp/pip-paz8HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:41 INFO - Running setup.py (path:/tmp/pip-cmoBaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:41 INFO - Running setup.py (path:/tmp/pip-rltams-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:41 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)) 22:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:42 INFO - Running setup.py (path:/tmp/pip-ZNLObO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:42 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)) 22:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:42 INFO - Running setup.py (path:/tmp/pip-2zB75E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:42 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)) 22:28:42 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)) 22:28:42 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)) 22:28:42 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)) 22:28:42 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)) 22:28:42 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)) 22:28:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:28: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 22:28: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 22:28: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 22:28: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 22:28: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 22:28: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 22:28:44 INFO - Downloading blessings-1.6.tar.gz 22:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:28:44 INFO - Installing collected packages: blessings 22:28:44 INFO - Running setup.py install for blessings 22:28:44 INFO - Successfully installed blessings 22:28:44 INFO - Cleaning up... 22:28:44 INFO - Return code: 0 22:28:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:44 INFO - Reading from file tmpfile_stdout 22:28:44 INFO - Current package versions: 22:28:44 INFO - argparse == 1.2.1 22:28:44 INFO - blessings == 1.6 22:28:44 INFO - blobuploader == 1.2.4 22:28:44 INFO - docopt == 0.6.1 22:28:44 INFO - manifestparser == 1.1 22:28:44 INFO - mozInstall == 1.12 22:28:44 INFO - mozcrash == 0.17 22:28:44 INFO - mozdebug == 0.1 22:28:44 INFO - mozdevice == 0.48 22:28:44 INFO - mozfile == 1.2 22:28:44 INFO - mozhttpd == 0.7 22:28:44 INFO - mozinfo == 0.9 22:28:44 INFO - mozleak == 0.1 22:28:44 INFO - mozlog == 3.1 22:28:44 INFO - moznetwork == 0.27 22:28:44 INFO - mozprocess == 0.22 22:28:44 INFO - mozprofile == 0.28 22:28:44 INFO - mozrunner == 6.11 22:28:44 INFO - mozscreenshot == 0.1 22:28:44 INFO - mozsystemmonitor == 0.0 22:28:44 INFO - moztest == 0.7 22:28:44 INFO - mozversion == 1.4 22:28:44 INFO - psutil == 3.1.1 22:28:44 INFO - requests == 1.2.3 22:28:44 INFO - wsgiref == 0.1.2 22:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:44 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:44 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 22:28:44 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 22:28:44 INFO - Using env: {'DISPLAY': ':0', 22:28:44 INFO - 'HOME': '/home/cltbld', 22:28:44 INFO - 'LANG': 'en_US.UTF-8', 22:28:44 INFO - 'LANGUAGE': 'en_US:en', 22:28:44 INFO - 'LOGNAME': 'cltbld', 22:28:44 INFO - 'MAIL': '/var/mail/cltbld', 22:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:44 INFO - 'MOZ_NO_REMOTE': '1', 22:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:44 INFO - 'NO_EM_RESTART': '1', 22:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:44 INFO - 'PWD': '/builds/slave/test', 22:28:44 INFO - 'SHELL': '/bin/bash', 22:28:44 INFO - 'SHLVL': '1', 22:28:44 INFO - 'TERM': 'linux', 22:28:44 INFO - 'TMOUT': '86400', 22:28:44 INFO - 'USER': 'cltbld', 22:28:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:44 INFO - '_': '/tools/buildbot/bin/python'} 22:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 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)) 22:28:44 INFO - Cleaning up... 22:28:44 INFO - Return code: 0 22:28:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:44 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:44 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 22:28:44 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 22:28:44 INFO - Using env: {'DISPLAY': ':0', 22:28:44 INFO - 'HOME': '/home/cltbld', 22:28:44 INFO - 'LANG': 'en_US.UTF-8', 22:28:44 INFO - 'LANGUAGE': 'en_US:en', 22:28:44 INFO - 'LOGNAME': 'cltbld', 22:28:44 INFO - 'MAIL': '/var/mail/cltbld', 22:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:44 INFO - 'MOZ_NO_REMOTE': '1', 22:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:44 INFO - 'NO_EM_RESTART': '1', 22:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:44 INFO - 'PWD': '/builds/slave/test', 22:28:44 INFO - 'SHELL': '/bin/bash', 22:28:44 INFO - 'SHLVL': '1', 22:28:44 INFO - 'TERM': 'linux', 22:28:44 INFO - 'TMOUT': '86400', 22:28:44 INFO - 'USER': 'cltbld', 22:28:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:44 INFO - '_': '/tools/buildbot/bin/python'} 22:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:44 INFO - Downloading/unpacking jsonschema 22:28: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 22:28: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 22:28: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 22:28: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 22:28: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 22:28: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 22:28:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:28:46 INFO - Downloading/unpacking functools32 (from jsonschema) 22:28:46 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 22:28:46 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 22:28:46 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 22:28:46 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 22:28:46 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 22:28:46 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 22:28:46 INFO - Downloading functools32-3.2.3-2.tar.gz 22:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:28:47 INFO - warning: no files found matching '*.txt' 22:28:47 INFO - no previously-included directories found matching 'build' 22:28:47 INFO - no previously-included directories found matching 'dist' 22:28:47 INFO - no previously-included directories found matching '.git*' 22:28:47 INFO - Installing collected packages: jsonschema, functools32 22:28:47 INFO - Running setup.py install for functools32 22:28:47 INFO - warning: no files found matching '*.txt' 22:28:47 INFO - no previously-included directories found matching 'build' 22:28:47 INFO - no previously-included directories found matching 'dist' 22:28:47 INFO - no previously-included directories found matching '.git*' 22:28:47 INFO - Successfully installed jsonschema functools32 22:28:47 INFO - Cleaning up... 22:28:47 INFO - Return code: 0 22:28:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:47 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 0x7f681eab6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:47 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 22:28:47 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 22:28:47 INFO - Using env: {'DISPLAY': ':0', 22:28:47 INFO - 'HOME': '/home/cltbld', 22:28:47 INFO - 'LANG': 'en_US.UTF-8', 22:28:47 INFO - 'LANGUAGE': 'en_US:en', 22:28:47 INFO - 'LOGNAME': 'cltbld', 22:28:47 INFO - 'MAIL': '/var/mail/cltbld', 22:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:47 INFO - 'MOZ_NO_REMOTE': '1', 22:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:47 INFO - 'NO_EM_RESTART': '1', 22:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:47 INFO - 'PWD': '/builds/slave/test', 22:28:47 INFO - 'SHELL': '/bin/bash', 22:28:47 INFO - 'SHLVL': '1', 22:28:47 INFO - 'TERM': 'linux', 22:28:47 INFO - 'TMOUT': '86400', 22:28:47 INFO - 'USER': 'cltbld', 22:28:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:47 INFO - '_': '/tools/buildbot/bin/python'} 22:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:47 INFO - Downloading/unpacking flake8 22:28:47 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 22:28:47 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 22:28:47 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 22:28:47 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 22:28:47 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 22:28:47 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 22:28:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:28:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:28:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 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 22:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:28:50 INFO - no previously-included directories found matching 'docs/_build' 22:28:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:28:50 INFO - Running setup.py install for pep8 22:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:28:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:28:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:28:50 INFO - no previously-included directories found matching 'docs/_build' 22:28:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:28:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:28:50 INFO - Cleaning up... 22:28:50 INFO - Return code: 0 22:28:50 INFO - Running post-action listener: _resource_record_post_action 22:28:50 INFO - Running post-action listener: _start_resource_monitoring 22:28:50 INFO - Starting resource monitoring. 22:28:50 INFO - ##### 22:28:50 INFO - ##### Running install step. 22:28:50 INFO - ##### 22:28:50 INFO - Running pre-action listener: _resource_record_pre_action 22:28:50 INFO - Running main action method: install 22:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:50 INFO - Reading from file tmpfile_stdout 22:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:28:50 INFO - Reading from file tmpfile_stdout 22:28:50 INFO - Output received: 22:28:50 INFO - Usage: mozinstall [options] installer 22:28:50 INFO - Options: 22:28:50 INFO - -h, --help show this help message and exit 22:28:50 INFO - -d DEST, --destination=DEST 22:28:50 INFO - Directory to install application into. [default: 22:28:50 INFO - "/builds/slave/test"] 22:28:50 INFO - --app=APP Application being installed. [default: firefox] 22:28:50 INFO - mkdir: /builds/slave/test/build/application 22:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:29:06 INFO - Reading from file tmpfile_stdout 22:29:06 INFO - Output received: 22:29:06 INFO - /builds/slave/test/build/application/firefox/firefox 22:29:06 INFO - Running post-action listener: _resource_record_post_action 22:29:06 INFO - ##### 22:29:06 INFO - ##### Running run-tests step. 22:29:06 INFO - ##### 22:29:06 INFO - Running pre-action listener: _resource_record_pre_action 22:29:06 INFO - Running main action method: run_tests 22:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:29:06 INFO - Python 2.7.3 22:29:06 INFO - Return code: 0 22:29:06 INFO - grabbing minidump binary from tooltool 22:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:06 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375410>, '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 0x1376310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13767a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:29:06 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:29:06 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/linux64/releng.manifest -o -c /builds/tooltool_cache 22:29:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:29:06 INFO - Return code: 0 22:29:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:29:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:29:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:29:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:29:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:29:07 INFO - Return code: 0 22:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:29:07 INFO - Using env: {'DISPLAY': ':0', 22:29:07 INFO - 'HOME': '/home/cltbld', 22:29:07 INFO - 'LANG': 'en_US.UTF-8', 22:29:07 INFO - 'LANGUAGE': 'en_US:en', 22:29:07 INFO - 'LOGNAME': 'cltbld', 22:29:07 INFO - 'MAIL': '/var/mail/cltbld', 22:29:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:29:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:07 INFO - 'MOZ_NO_REMOTE': '1', 22:29:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:07 INFO - 'NO_EM_RESTART': '1', 22:29:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:07 INFO - 'PWD': '/builds/slave/test', 22:29:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:29:07 INFO - 'SHELL': '/bin/bash', 22:29:07 INFO - 'SHLVL': '1', 22:29:07 INFO - 'TERM': 'linux', 22:29:07 INFO - 'TMOUT': '86400', 22:29:07 INFO - 'USER': 'cltbld', 22:29:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963', 22:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:07 INFO - '_': '/tools/buildbot/bin/python'} 22:29:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:29:07 INFO - mozversion application_buildid: 20160404210116 22:29:07 INFO - mozversion application_changeset: ffd37011577923985b68a6e7b5c2699771dc2cdd 22:29:07 INFO - mozversion application_display_name: Nightly 22:29:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:29:07 INFO - mozversion application_name: Firefox 22:29:07 INFO - mozversion application_remotingname: firefox 22:29:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:29:07 INFO - mozversion application_vendor: Mozilla 22:29:07 INFO - mozversion application_version: 48.0a1 22:29:07 INFO - mozversion platform_buildid: 20160404210116 22:29:07 INFO - mozversion platform_changeset: ffd37011577923985b68a6e7b5c2699771dc2cdd 22:29:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:29:07 INFO - mozversion platform_version: 48.0a1 22:29:07 INFO - using testdate: 1459834147 22:29:07 INFO - actual date: 1459834147 22:29:07 INFO - starting webserver on 'localhost:33919' 22:29:07 INFO - SUITE-START | Running 2 tests 22:29:07 INFO - TEST-START | dromaeo_css 22:29:07 INFO - operating with platform_type : linux_ 22:29:07 INFO - Initialising browser for dromaeo_css test... 22:29:07 INFO - TEST-INFO | started process 28159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphxGPGH/profile http://localhost:33919/getInfo.html) 22:29:11 INFO - PROCESS | 28159 | __metrics Screen width/height:1600/1200 22:29:11 INFO - PROCESS | 28159 | colorDepth:24 22:29:11 INFO - PROCESS | 28159 | Browser inner width/height: 1024/697 22:29:11 INFO - PROCESS | 28159 | __metrics 22:29:13 ERROR - PROCESS | 28159 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:29:13 INFO - TEST-INFO | 28159: exit 0 22:29:13 INFO - Browser initialized. 22:29:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:29:13 INFO - TEST-INFO | started process 28240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphxGPGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:25 INFO - PROCESS | 28240 | RSS: Main: 154378240 22:29:25 INFO - PROCESS | 28240 | 22:30:16 INFO - PROCESS | 28240 | 1459834216766 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] 22:32:27 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:33919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33919/tests/dromaeo/cssquery-ext.html) 22:32:28 INFO - PROCESS | 28240 | RSS: Main: 228646912 22:32:28 INFO - PROCESS | 28240 | 22:35:31 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:33919/tests/dromaeo/cssquery-ext.html (next: http://localhost:33919/tests/dromaeo/cssquery-jquery.html) 22:35:31 INFO - PROCESS | 28240 | RSS: Main: 235950080 22:35:31 INFO - PROCESS | 28240 | 22:38:33 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:33919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33919/tests/dromaeo/cssquery-mootools.html) 22:38:34 INFO - PROCESS | 28240 | RSS: Main: 222838784 22:38:34 INFO - PROCESS | 28240 | 22:41:36 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:33919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33919/tests/dromaeo/cssquery-prototype.html) 22:41:36 INFO - PROCESS | 28240 | RSS: Main: 218374144 22:41:36 INFO - PROCESS | 28240 | 22:44:39 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:33919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33919/tests/dromaeo/cssquery-yui.html) 22:44:40 INFO - PROCESS | 28240 | RSS: Main: 199761920 22:44:40 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:33919/tests/dromaeo/cssquery-yui.html (next: http://localhost:33919/tests/dromaeo/cssquery-dojo.html) 22:47:42 INFO - PROCESS | 28240 | RSS: Main: 273559552 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | __start_tp_report 22:47:42 INFO - PROCESS | 28240 | _x_x_mozilla_page_load 22:47:42 INFO - PROCESS | 28240 | _x_x_mozilla_page_load_details 22:47:42 INFO - PROCESS | 28240 | |i|pagename|runs| 22:47:42 INFO - PROCESS | 28240 | |0;dojo.html;2589.106758168432;2651.2974061873597;2653.204038788363;2670.4525572257676;2688.9327766805823;4430.534793846648;4531.6601254905845;4535.977320113395;4549.931751023733;4579.290210017449;4522.208613492642;4527.320901864722;4554.635629149669;4574.473935497411;4666.113438446701;4160.958390416087;4172.019575399779;4188.4555007849085;4193.496780386358;4362.105768317503;4306.784660766964;4325;4334.241507736149;4361.302191649337;4379.08039311745;4121.690873184523;4165.375193720935;4202.705810593229;4248.129133527619;4257.9999999999845;4222.577742225783;4243.0241044559925;4267.743935363857;4268.06102657418;4287.056847493546;4216.430781844442;4219.2405367033925;4221.598948099926;4240.745555266694;4261.893452663678;4338.240807858644;4451.732896026217;4527.071950250191;4530.8867278317975;4534.501204867462;4875.073735990186;4892.168331383673;4893;4894.902101957977;4917.532834380728;4910.312556242129;4913.778879950411;4916.58209052231;4917.188663870457;4959.429665588467;4484.461864576239;4520.593146616755;4594.287885377772;4595.310703394518;4628.1669299526075;4951.950480495149;4959.404871415453;4974.000447839118;4976.900461990812;5034.974825125851;4766.809327626856;4774.976125119421;4778.04439112179;4781.904361912742;4823.734694591761;4781.187198176319;4840.75796210188;4889.364382630235;4925.556699896955;4934.1611925972675;4841.419029716457;4846.248831431134;4866.586340161055;4868.440129385166;4908.558229759267;4695.600873925686;4846.127697014501;4856;4857.878553036202;4904.068227036852;4086.9386959195635;4110.856120035784;4114.156597897484;4152.854650087233;4153.958460415418;3567.94648080279;3587.8744243951337;3617.7467577269863;3627.7641953273483;3634.055145662147;4150.730202536825;4231.597998190167;4249.660027197817;4256.170046840898;4262.23279809631;4776.068666610047;4871.098846713298;4879.975600121977;4918.926216106761;4925.827596034122;4237.78811059452;4248.87253382399;4261.126469073894;4284.700070995063;4306.289462238696;4268.509121451073;4306.763128027926;4341.196878577473;4353.608175264241;4391.67062470316;4629.259318509023;4649;4651.627869770478;4671.696339737906;4705.247160454311;4882.023595280887;4882.365292512093;4884.291777692144;4889.119958407378;4924.532169443897;4538.750368729751;4647.837325693585;4654.511276316073;4692.1084993851055;4723.6929599575915;4797.688150270221;4820.204666230173;4825.034993001484;4844.031193761191;4863.440704318907;4880.341153944172;4882.218844984785;4891.95108048915;4894.681845680019;4941.308216849572;4639.907201856012;4723.409573803275;4748.358971538798;4816.109019831342;4821.059893320909;4743.739094349844;4744.240921452551;4753.453352864465;4759.500252473579;4810.975945120252;4691.695039822537;4696.953030469788;4703.412073490814;4707.411573553306;4750.5249475052215;4631.328457373729;4733;4785.306130611111;4800.975995120142;4833.03339332142;4676.859694209179;4679.3916790816975;4700.670953033255;4702.388689470347;4747.596454301285 22:47:42 INFO - PROCESS | 28240 | |1;ext.html;516.5144763921913;526.9367675878892;529.1692043491719;542.3979382884997;543.6140340358345;27586.586201207;28013.299667508298;28021.439571208564;28029.719702802966;35259.29481410376;38589.80705096471;39159.41260881089;39183.41224881622;39201.803990980006;39209.803950980204;7636.465447418683;7829.765107046797;7839.451238413313;7839.568823714693;7839.804004899866;7677.2706592873865;7805.921940780577;7806.492577982442;7808;7809.297163255306;7793.454458187929;8051.396145289097;8069.677212911476;8070.515769053875;8074.354051675852;7642.503237289586;7855.175206603339;7874;7876.881846772303;7916.52500849948;9880.11079002886;9931.404115753077;10158.59365625374;10172.643957461527;10230.6419275325;35081.824590877135;35488;35564.46653300203;35575.110622234395;35611.82194089039;3288.917777055569;3335.849886755102;3522.1370764162943;3688.908958282685;3974.7813870237123;29599.85200073986;30102.84948575243;30324.54513182304;30359.24101897448;31106.53340199899;3535;3543.450765131409;3619.8914032579064;3637.805029109377;3639.999000274919;252974;255242;255640;255750;256967;59655;59971;60212.279833415756;60250.69874650687;60303;53976.65058373572;55075.724621376634;64012.67993660095;64159;64855.67572162109;15209.695806083817;15335.309911053806;15439.073655580702;15446.304916278794;15471.92264038695;11537.307761534166;11756.177067605357;11759.294442333487;11762.470688819023;11773.17587768848;17985.55036124081;18017.18922648484;18036;18069.457916262534;18100;7146.749863754743;7151.249118842551;7213.963930180315;7227.819304517324;7443.255674432514;916.5692124701379;939.3778237250053;953.3993584042009;993.7018894331671;1017.8829434614966;27407.588886166723;27911.58132628012;28540.857295713802;28543.57184642232;28660.713392866222;990.069334825262;1038.0864838941684;1049.7690508088208;1098.8406681031365;1119.1941801902617;14184.361703723358;14583.197924114276;14755.40978360875;14922;15029.549113526611;288222;291028;291474;291745;292595;47765.761171193924;48860.267095993586;48873.26690099651;48896.26655600169;48905.26642100371;1083.3229231730168;1227.34337129637;1265.0385706862667;1271.7965125579863;1326.257295914291;26401.603975939994;27510.449791004467;27768.166954991382;28167.859160704065;28227.43545129127;38752.80623596864;39353;39353.80323098366;39388.212235755695;39456.40815387714;208103;209242;210436;210474;210561;29467.557986630647;30892.227694306923;31100.844495777375;31348.686513134577;31388;39523;39647.80176099101;39754;40516.594834051284;40536.3919541213;32656.510152348208;33508.66491335153;33586.32827343488;33658.831705841316;33734.662653373154;32945.34109317848;33216.1695957603;33260;33315.33369332551;33499.83250083832;29890;29993.250168745955;30287.848560757055;33425.66574334226;33946.66053339435;28471.857640711663;29719.108426746367;29965.33230614237;29979.70020299769;30171.849140754155;23761.52476950417;24389.63415548804;24593.631095533223;24675.506489870462;24797.752022479544 22:47:42 INFO - PROCESS | 28240 | |2;jquery.html;346.53737260756907;356.2589813188568;356.36744778019005;358.24381361425435;359.6709011254702;15545.145017024059;16092.195390230485;16343.59141021475;16942.23759930803;16946.491605251864;10674.09270212031;10911.83632245517;13523.661908452294;16570.83429165708;16604.501864944043;4535.750533720644;4798.47216806151;4799.400074990626;4808.278758186265;4820.3733514643045;3383.0696558446502;3441.965580344202;5955.910661340084;6065.332813390545;6065.909011364811;6002.249718785152;6011.609245399035;6021.217241758565;6035.849103772397;6037.818865434044;5755.913661295084;5909.261342332208;5922.022866227067;5999.070144127667;6006.90989635158;5198.454162312941;5207.505286997729;5212.218167274939;5221.373435187764;5223.791048358061;18650.62698746031;18998;19697.507562310915;19731.40805775829;19764.50588735279;2025.0178663348265;2058.8970551472516;2064.380685794271;2138.272987184365;2386.1648423051965;8640.13598640131;8858.202761751409;8908.688195913177;9080.409773364776;9300.581473833627;1741.9912900435543;1750.0374793863452;1755.3417468449331;1774.8136445673147;1787.499500139963;61613.6919315405;61675;61962.690186549684;62066.37933620651;62606;9783.461909594898;9786.608535658494;9824.263180261509;9831.705048848546;9933.701988940344;13308.134971226838;13437.529686461123;13453.798193027113;13467;13480.797788033187;7115.89326160108;7156.032091174864;7253.927460725431;7261.8547629047125;7434.962825185839;7059.470539709542;7231;7265.346118849329;7330.96334518324;7339.522931009467;4257.467816522934;4270.829166833354;4271.722338048017;4297.355396690459;4299.763513006752;1731.67526841966;1750.2561411400359;1754.850837678786;1826.1325870211542;1841.3187120765404;935.2377812083131;938.4228699349987;952.6522819170953;966.6665000574791;978.0708327089294;16046.352351862046;16123.758143627854;16222.432214872422;16380.344786208418;16427.342906283615;889.8220355928711;918.9494577798151;928.4011812381111;935.1817159985013;936.6534382278601;9296.772435659313;9338.906610933804;9367.297452691075;9389.812203755886;9459.24326053914;386873;392887;393256;393266;395516;50837;61911;62506;67948.32051679419;70615.64692176506;916.3036092569695;924.9075092490832;940.182041623778;948.9003654616304;952.4475804033644;11831.40842957866;14023.50917717875;14270.357833897708;14527.636809079857;14732.337044833223;32093.67906320907;32805.83597081999;33123;33363.83318083394;33830.15424614404;38935;40660.18679626332;41759.373609395276;42187.15625687531;42569.36145957875;7314.817129571803;7373.483856130019;7532.887006695014;7545.584992825447;7778.338841198335;9240.306976976619;10246.487675616338;11727.941360293144;12027.579034733742;12412.069094817743;10475.842862356918;10477.895221047693;10538.8419173714;10562.735931601464;10700.30448020876;10323.32898361604;10427.791444170922;10470.633527826794;10551.525181366704;10567.735806604589;5422.674639521641;9492.86085669724;10328.380297182193;10652;10853.589598643126;7095.787126386217;7691.653875575725;7700.807479813049;7727.265909738566;7807.258310460497;9641.42151470914;10310.742231444274;10390.220733445172;10484.108850747467;10524.421156836448 22:47:42 INFO - PROCESS | 28240 | |3;mootools.html;1400.5238219005537;1409.4080486195796;1517.286875168671;1706.5733566608349;1732.3850033238193;6940.965295173523;7115.501914865961;7128.96435517823;7143.821404464885;7173.175084865242;6199.4110559496885;6355.078513615523;6363.777267795628;6866.073080134181;7026.2973702629715;2144.174492820264;2167.0898222746405;2172.8153106985924;2175.8912054397215;2175.9564808703817;2147.967780483294;2178.106976139783;2199.3621849663577;2204.1073365287;2213.0373287619855;1859.860510461714;2049.3646969439446;2099.422658768843;2146.216630929715;2157.30966090851;2083.9895800520976;2098.8530802843807;2102.6740855167322;2103.2638576498257;2104.137303705481;2039.5512987142804;2064.3290930447665;2072.2229164063474;2073.6060148571723;2078.781727918577;7085.7165713371405;7206.1352637683285;7221;7227.168875579323;7227.819304517377;4307.504636966758;4416.712913660634;4423.469183697945;4425.712328698624;4427.9557204427865;2771.584262360642;2846.3453405716596;2980.910572682823;2998.1155559110116;2998.190488568096;875.7985663297413;901.4816480523725;929.8884133903907;931.050328664765;932.2495391210073;9393.154616084517;9484.810303793885;9533.427994320293;9559.426434413957;9569.234461243084;3922.7450215735885;4028.738132021409;4090.0388408723925;4103.97948010264;4129.504459464823;8204.753857384288;8263.214994575506;8284.8343033139;8299.336053115736;8307.958460207781;4451.9554804451545;4467.865964021084;4485.573870482299;4488.079943611552;4493.618042466362;3397.3375191837354;3921.8039098044983;4028.959710402917;4061.8375264989068;4073.490813648294;3417.1457135716073;3460.1349662584353;3479.2693534357563;3517.56030496188;3525.25969546393;1108.179946839333;1116.2744216259496;1118.2060736876747;1120.9495572699248;1130.0902773267599;969.8448248280241;1065.1265961911313;1163.3892206591438;1170.9238899471677;1181.1082632612322;6462.870742585122;6508.544401891917;6508.674566271668;6522.412982831473;6537.346265373425;1095.4905968724422;1111.90548803351;1120.523777394604;1141.3266172957995;1154.2728081308721;5225.921611175835;5262.368515778131;5280.709560974184;5309.548688361455;5313.787448502094;8026.43814932949;8068.314193293636;8252.628631711468;8358.038825535019;8368.456050356828;8178.918210817816;8188.918110818935;8224;8241.587920603946;8243.05204901432;6478.935210647834;6584.341565843473;6619.437347825488;6648.16897887764;6697.966510167418;6634.237062737847;6655.101561289164;6676.332366763285;6695.966520167368;6708.094407255153;7626.199249078767;7648.847023059619;7788.026496687914;7846.764597062097;7987.281144697005;7882.684692612232;8070.2333278338465;8081;8132.349412046904;8231.382646301432;5537.169424586345;5595.244641973281;5701;6208.689565521796;6283.3088360281245;6763.222229443677;6838.863222735418;6841.213260475109;6842.315768423118;6846.520743547904;5933.228680271537;6091.177691011834;6094.75620975156;6153.661548614869;6350.460210881942;6047.304559975483;6057.545684073624;6066.423689749467;6176.907346389898;6320.209973753281;6222.688865556795;6225.346338634378;6282.717277722605;6290.402411770874;6297.559170857996;5831.329397119216;5857.824265272048;5859.091840764689;5864;5864.9413505866105;5756;5866.530677545701;6000.519958403404;6023.909641355295;6032.306284777307 22:47:42 INFO - PROCESS | 28240 | |4;prototype.html;301.58682604831387;303.9665636779955;313.60642393795786;315.0485533688261;319.7953309881676;5201.7919283228675;5263.526282634562;5287.762050707718;5369.355677318727;5389.919151212725;5243.318368612085;5249.842504724855;5256.684598924067;5263.394709608397;5276.261323414725;3924.3917192835015;4044.413560033793;4097.303458412077;4131.938020929689;4155.085881106152;4129.587041295861;4144.41978123063;4151.73013754105;4152.730072545275;4163.437935878648;4116.156187981456;4123.237201117788;4123.773192474413;4132.690048246379;4138.1103062841485;3909.882703518899;4008.819603117867;4098.52866920305;4115.794210289474;4128.256913755523;3637.527121474218;3644.398674218751;3647.051766540692;3650.580183278904;3654.086478380405;5041.546260836506;5044.293798868125;5044.924326135111;5064.265681476202;5068.898622027576;4751.643626727975;4753.928691069636;4756.381670382828;4768.998510312838;4772.665913386064;5551.195076713854;5558.916616250759;5566.4990150886615;5566.582506312043;5572.275604171432;3968.9007774805573;3971.4241434991764;3993.121513267077;4002.939221106409;4004.939925901114;5538.196961440609;5709.4290570942985;5721.6853073080965;5724.914126288068;5734.197212390227;3887.9222415552094;3978.4430179774854;3979.5423526294267;3979.5821438749094;3987;4042.757434553936;4044.4944381952255;4045.130296986162;4046.9392959105635;4053.310937140693;4643.233866412072;4645.837395691135;4648.953510464919;4656.67403281767;4659.487456379796;5554.750036248379;5571.9442805572235;5572.4706152915405;5578.9163162552595;5581.246531718247;1400.3628349101134;1412.7951447040123;1420.3537390487304;1421.4030107354936;1423.7721964485634;892.1123482135188;909.4452384045727;920.2683866326287;946.186279799372;948.4498990585444;4847.079054979543;4882.5605695487575;4886.291487734258;4901.313816065754;4920.384951881015;5718.971405143031;5719.370869204384;5728.112142617901;5731.312242530923;5731.484166425042;4886.413630364308;4905.435874874363;4906.06784710911;4908.410990681141;4918.286848407032;3049.603551538286;3076.661567227603;3077.8922737704074;3083.938321233563;3088.8918887838818;5422.078246698071;5425.02349577072;5436.592255580847;5437.102878025161;5439.700816455133;5698.2592263005545;5831.183634291203;5875.383084776123;5881;5883.588148829626;5394.3796463406425;5412.052890744104;5420.051490989061;5423;5424.891502169856;5698.6580805151825;5709.51469125129;5712.11462223356;5715.514181294637;5722.2561067061015;5583.692896890548;5603.915941260802;5604.103343465026;5607.8878422432135;5608.6073974821375;5410;5414.485623865884;5416.21464887597;5416.539594134542;5423.18652202157;3785.6592906638534;3869.6130386961077;3872.5352957644136;3873.1091848874353;3987.4417581539187;5638.605297629127;5644.322681278273;5648.63283886546;5653.632513886749;5655.717214139194;5497.752601133038;5534.1145416733125;5543.307086614173;5558.416366281483;5559.63862348946;5540.335159780852;5550.2507161534295;5554.472325129106;5556.333100069882;5565.7217139143695;5453.536449401687;5458.836234912959;5472.370677371994;5473;5477.096279114061;5421.83734487966;5586.832395028156;5597.63615365;5604;5608.355039170548;5427.918581221206;5451.972740136274;5454.809081682122;5462.262594549685;5468.043092458884 22:47:42 INFO - PROCESS | 28240 | |5;yui.html;659.9340065993401;674.3728332650636;679.6329981809823;736.7605528203334;780.4419839814532;11262.54949802008;11387.373694446802;11412.657620271395;11417.942910285446;12448.62654120378;12501.43743531541;12536.435860386282;12557.874421255785;12569.937150314236;12648.620541383772;640.9743610255607;804.7384600004992;811.5739236900615;824.3075816314295;829.7469271872077;816.5508970066439;824.686619084747;825.9132791056943;826.5454000299841;828.159418190537;853.4111463090479;854.9829003419959;855.3755758296447;856.5545916123612;856.7815207122206;656.7340227207989;827.0819390476566;847.2586486824028;847.4279861093768;849.9362547808939;619.1734035063151;620.4044117647064;620.5749061892618;621.5959626242978;621.6270237857294;10448;10479;10482.79034419315;10500.527476263587;10515.316504427188;11411.828822567668;12111.091668124838;12349.93825030869;12383.318917459535;12490.582497323421;9906.752331191707;9987.335081823381;10062.748431289203;10165;10240.89759102407;3306.189983454045;3350.4136776064333;3356.613989391227;3419.281950790337;3464.6015708193377;44028.55971440308;44524.332135018;44829;44951.10097798058;45076.77461612704;9203.125703058198;9244.768880778034;9325.90674093264;9456.90543094574;9646.228301735844;16480;16491.257893394824;16513.752293715603;16529.35530315144;16736;6644.169478815148;6682.532222744361;6686.431653309523;6760.7295708172105;6885.208201056842;3643;3779.981100094537;3830.5211848518934;3832.9041773955873;3877.1470276539117;2714.6199532065525;2716.348076461635;2726.05950946923;2729.972700272972;2735.726427357248;494.16979474482497;516.0247132918787;516.3236160629588;549.4670169935157;564.7599770097692;611.0955785437577;621.3351713666334;622.1445512420422;624.8469125064297;657.3689258312074;7600.9619951900995;7743.690252389842;7779.611019449005;7899.842003159904;8050.355971522265;465.9370984917061;519.7453247908574;605.8636806718541;613.9017757158833;619.6746707978348;3587.874424395186;3614.8373323200517;3678.4850120983083;3685.7972811495624;3733.4773131761576;49943.25085123726;50710.746446267534;51103.23345149826;51178.74410627923;51198.488015120114;41155.7942210287;41460.8539146083;41801.58198417977;42127.57872421236;42756.572434275884;37989.62010379916;38575.42136867949;38602.80698596545;38743;38988.80505597454;8143.633536490754;8233.46482478637;8289.502629842229;8305.211004954519;8383.95808020956;31481.685183147874;31868.84065579657;32254.516182256815;32266.35467290594;32763.836180818944;37608;39535.60464395319;40474.39288410617;40614.796926016366;40658.390124148755;10210.336328138646;10251.436171010666;10526.736831579272;10569.260151789302;10672.199585031309;10972.914708154905;11011.779764404508;11130.499127539442;11371.772564548497;11406.258593191416;10470.790584188426;10546.947265263625;10686.25196236287;10731.248812583044;10901.34591924487;10250.333728307636;10408.583656653953;10503.684889453329;10511.842322365324;10635.627753028606;10109;10240.897591024292;10574.312669676447;10705.9464702676;10706.143508519144;9262.073792620684;9367.672131475365;9501.57242924084;9514.143727064597;9721.416714997124;8874.511901845202;9356.4386136832;9360.672376466791;9379.906200937903;9478 22:47:42 INFO - PROCESS | 28240 | __end_tp_report 22:47:42 INFO - PROCESS | 28240 | __start_cc_report 22:47:42 INFO - PROCESS | 28240 | _x_x_mozilla_cycle_collect,981 22:47:42 INFO - PROCESS | 28240 | __end_cc_report 22:47:42 INFO - PROCESS | 28240 | __startTimestamp1459835262883__endTimestamp 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | ------- Summary: start ------- 22:47:42 INFO - PROCESS | 28240 | Number of tests: 6 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | [#0] dojo.html Cycles:165 Average:4522.29 Median:4666.11 stddev:455.93 (9.8%) stddev-sans-first:431.37 22:47:42 INFO - PROCESS | 28240 | Values: 2589.1 2651.3 2653.2 2670.5 2688.9 4430.5 4531.7 4536.0 4549.9 4579.3 4522.2 4527.3 4554.6 4574.5 4666.1 4161.0 4172.0 4188.5 4193.5 4362.1 4306.8 4325.0 4334.2 4361.3 4379.1 4121.7 4165.4 4202.7 4248.1 4258.0 4222.6 4243.0 4267.7 4268.1 4287.1 4216.4 4219.2 4221.6 4240.7 4261.9 4338.2 4451.7 4527.1 4530.9 4534.5 4875.1 4892.2 4893.0 4894.9 4917.5 4910.3 4913.8 4916.6 4917.2 4959.4 4484.5 4520.6 4594.3 4595.3 4628.2 4952.0 4959.4 4974.0 4976.9 5035.0 4766.8 4775.0 4778.0 4781.9 4823.7 4781.2 4840.8 4889.4 4925.6 4934.2 4841.4 4846.2 4866.6 4868.4 4908.6 4695.6 4846.1 4856.0 4857.9 4904.1 4086.9 4110.9 4114.2 4152.9 4154.0 3567.9 3587.9 3617.7 3627.8 3634.1 4150.7 4231.6 4249.7 4256.2 4262.2 4776.1 4871.1 4880.0 4918.9 4925.8 4237.8 4248.9 4261.1 4284.7 4306.3 4268.5 4306.8 4341.2 4353.6 4391.7 4629.3 4649.0 4651.6 4671.7 4705.2 4882.0 4882.4 4884.3 4889.1 4924.5 4538.8 4647.8 4654.5 4692.1 4723.7 4797.7 4820.2 4825.0 4844.0 4863.4 4880.3 4882.2 4892.0 4894.7 4941.3 4639.9 4723.4 4748.4 4816.1 4821.1 4743.7 4744.2 4753.5 4759.5 4811.0 4691.7 4697.0 4703.4 4707.4 4750.5 4631.3 4733.0 4785.3 4801.0 4833.0 4676.9 4679.4 4700.7 4702.4 4747.6 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | [#1] ext.html Cycles:180 Average:41588.59 Median:18325.59 stddev:66335.34 (362.0%) stddev-sans-first:66449.74 22:47:42 INFO - PROCESS | 28240 | Values: 516.5 526.9 529.2 542.4 543.6 27586.6 28013.3 28021.4 28029.7 35259.3 38589.8 39159.4 39183.4 39201.8 39209.8 7636.5 7829.8 7839.5 7839.6 7839.8 7677.3 7805.9 7806.5 7808.0 7809.3 7793.5 8051.4 8069.7 8070.5 8074.4 7642.5 7855.2 7874.0 7876.9 7916.5 9880.1 9931.4 10158.6 10172.6 10230.6 35081.8 35488.0 35564.5 35575.1 35611.8 3288.9 3335.8 3522.1 3688.9 3974.8 29599.9 30102.8 30324.5 30359.2 31106.5 3535.0 3543.5 3619.9 3637.8 3640.0 252974.0 255242.0 255640.0 255750.0 256967.0 59655.0 59971.0 60212.3 60250.7 60303.0 53976.7 55075.7 64012.7 64159.0 64855.7 15209.7 15335.3 15439.1 15446.3 15471.9 11537.3 11756.2 11759.3 11762.5 11773.2 17985.6 18017.2 18036.0 18069.5 18100.0 7146.7 7151.2 7214.0 7227.8 7443.3 916.6 939.4 953.4 993.7 1017.9 27407.6 27911.6 28540.9 28543.6 28660.7 990.1 1038.1 1049.8 1098.8 1119.2 14184.4 14583.2 14755.4 14922.0 15029.5 288222.0 291028.0 291474.0 291745.0 292595.0 47765.8 48860.3 48873.3 48896.3 48905.3 1083.3 1227.3 1265.0 1271.8 1326.3 26401.6 27510.4 27768.2 28167.9 28227.4 38752.8 39353.0 39353.8 39388.2 39456.4 208103.0 209242.0 210436.0 210474.0 210561.0 29467.6 30892.2 31100.8 31348.7 31388.0 39523.0 39647.8 39754.0 40516.6 40536.4 32656.5 33508.7 33586.3 33658.8 33734.7 32945.3 33216.2 33260.0 33315.3 33499.8 29890.0 29993.3 30287.8 33425.7 33946.7 28471.9 29719.1 29965.3 29979.7 30171.8 23761.5 24389.6 24593.6 24675.5 24797.8 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | [#2] jquery.html Cycles:180 Average:23162.93 Median:4284.54 stddev:64284.26 (1500.4%) stddev-sans-first:64441.77 22:47:42 INFO - PROCESS | 28240 | Values: 346.5 356.3 356.4 358.2 359.7 15545.1 16092.2 16343.6 16942.2 16946.5 10674.1 10911.8 13523.7 16570.8 16604.5 4535.8 4798.5 4799.4 4808.3 4820.4 3383.1 3442.0 5955.9 6065.3 6065.9 6002.2 6011.6 6021.2 6035.8 6037.8 5755.9 5909.3 5922.0 5999.1 6006.9 5198.5 5207.5 5212.2 5221.4 5223.8 18650.6 18998.0 19697.5 19731.4 19764.5 2025.0 2058.9 2064.4 2138.3 2386.2 8640.1 8858.2 8908.7 9080.4 9300.6 1742.0 1750.0 1755.3 1774.8 1787.5 61613.7 61675.0 61962.7 62066.4 62606.0 9783.5 9786.6 9824.3 9831.7 9933.7 13308.1 13437.5 13453.8 13467.0 13480.8 7115.9 7156.0 7253.9 7261.9 7435.0 7059.5 7231.0 7265.3 7331.0 7339.5 4257.5 4270.8 4271.7 4297.4 4299.8 1731.7 1750.3 1754.9 1826.1 1841.3 935.2 938.4 952.7 966.7 978.1 16046.4 16123.8 16222.4 16380.3 16427.3 889.8 918.9 928.4 935.2 936.7 9296.8 9338.9 9367.3 9389.8 9459.2 386873.0 392887.0 393256.0 393266.0 395516.0 50837.0 61911.0 62506.0 67948.3 70615.6 916.3 924.9 940.2 948.9 952.4 11831.4 14023.5 14270.4 14527.6 14732.3 32093.7 32805.8 33123.0 33363.8 33830.2 38935.0 40660.2 41759.4 42187.2 42569.4 7314.8 7373.5 7532.9 7545.6 7778.3 9240.3 10246.5 11727.9 12027.6 12412.1 10475.8 10477.9 10538.8 10562.7 10700.3 10323.3 10427.8 10470.6 10551.5 10567.7 5422.7 9492.9 10328.4 10652.0 10853.6 7095.8 7691.7 7700.8 7727.3 7807.3 9641.4 10310.7 10390.2 10484.1 10524.4 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | [#3] mootools.html Cycles:180 Average:4961.88 Median:6012.21 stddev:2497.47 (41.5%) stddev-sans-first:2490.13 22:47:42 INFO - PROCESS | 28240 | Values: 1400.5 1409.4 1517.3 1706.6 1732.4 6941.0 7115.5 7129.0 7143.8 7173.2 6199.4 6355.1 6363.8 6866.1 7026.3 2144.2 2167.1 2172.8 2175.9 2176.0 2148.0 2178.1 2199.4 2204.1 2213.0 1859.9 2049.4 2099.4 2146.2 2157.3 2084.0 2098.9 2102.7 2103.3 2104.1 2039.6 2064.3 2072.2 2073.6 2078.8 7085.7 7206.1 7221.0 7227.2 7227.8 4307.5 4416.7 4423.5 4425.7 4428.0 2771.6 2846.3 2980.9 2998.1 2998.2 875.8 901.5 929.9 931.1 932.2 9393.2 9484.8 9533.4 9559.4 9569.2 3922.7 4028.7 4090.0 4104.0 4129.5 8204.8 8263.2 8284.8 8299.3 8308.0 4452.0 4467.9 4485.6 4488.1 4493.6 3397.3 3921.8 4029.0 4061.8 4073.5 3417.1 3460.1 3479.3 3517.6 3525.3 1108.2 1116.3 1118.2 1120.9 1130.1 969.8 1065.1 1163.4 1170.9 1181.1 6462.9 6508.5 6508.7 6522.4 6537.3 1095.5 1111.9 1120.5 1141.3 1154.3 5225.9 5262.4 5280.7 5309.5 5313.8 8026.4 8068.3 8252.6 8358.0 8368.5 8178.9 8188.9 8224.0 8241.6 8243.1 6478.9 6584.3 6619.4 6648.2 6698.0 6634.2 6655.1 6676.3 6696.0 6708.1 7626.2 7648.8 7788.0 7846.8 7987.3 7882.7 8070.2 8081.0 8132.3 8231.4 5537.2 5595.2 5701.0 6208.7 6283.3 6763.2 6838.9 6841.2 6842.3 6846.5 5933.2 6091.2 6094.8 6153.7 6350.5 6047.3 6057.5 6066.4 6176.9 6320.2 6222.7 6225.3 6282.7 6290.4 6297.6 5831.3 5857.8 5859.1 5864.0 5864.9 5756.0 5866.5 6000.5 6023.9 6032.3 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | [#4] prototype.html Cycles:180 Average:4601.19 Median:5269.89 stddev:1344.16 (25.5%) stddev-sans-first:1308.62 22:47:42 INFO - PROCESS | 28240 | Values: 301.6 304.0 313.6 315.0 319.8 5201.8 5263.5 5287.8 5369.4 5389.9 5243.3 5249.8 5256.7 5263.4 5276.3 3924.4 4044.4 4097.3 4131.9 4155.1 4129.6 4144.4 4151.7 4152.7 4163.4 4116.2 4123.2 4123.8 4132.7 4138.1 3909.9 4008.8 4098.5 4115.8 4128.3 3637.5 3644.4 3647.1 3650.6 3654.1 5041.5 5044.3 5044.9 5064.3 5068.9 4751.6 4753.9 4756.4 4769.0 4772.7 5551.2 5558.9 5566.5 5566.6 5572.3 3968.9 3971.4 3993.1 4002.9 4004.9 5538.2 5709.4 5721.7 5724.9 5734.2 3887.9 3978.4 3979.5 3979.6 3987.0 4042.8 4044.5 4045.1 4046.9 4053.3 4643.2 4645.8 4649.0 4656.7 4659.5 5554.8 5571.9 5572.5 5578.9 5581.2 1400.4 1412.8 1420.4 1421.4 1423.8 892.1 909.4 920.3 946.2 948.4 4847.1 4882.6 4886.3 4901.3 4920.4 5719.0 5719.4 5728.1 5731.3 5731.5 4886.4 4905.4 4906.1 4908.4 4918.3 3049.6 3076.7 3077.9 3083.9 3088.9 5422.1 5425.0 5436.6 5437.1 5439.7 5698.3 5831.2 5875.4 5881.0 5883.6 5394.4 5412.1 5420.1 5423.0 5424.9 5698.7 5709.5 5712.1 5715.5 5722.3 5583.7 5603.9 5604.1 5607.9 5608.6 5410.0 5414.5 5416.2 5416.5 5423.2 3785.7 3869.6 3872.5 3873.1 3987.4 5638.6 5644.3 5648.6 5653.6 5655.7 5497.8 5534.1 5543.3 5558.4 5559.6 5540.3 5550.3 5554.5 5556.3 5565.7 5453.5 5458.8 5472.4 5473.0 5477.1 5421.8 5586.8 5597.6 5604.0 5608.4 5427.9 5452.0 5454.8 5462.3 5468.0 22:47:42 INFO - PROCESS | 28240 | 22:47:42 INFO - PROCESS | 28240 | [#5] yui.html Cycles:180 Average:12369.72 Median:41964.58 stddev:13894.49 (33.1%) stddev-sans-first:13905.64 22:47:42 INFO - PROCESS | 28240 | Values: 659.9 674.4 679.6 736.8 780.4 11262.5 11387.4 11412.7 11417.9 12448.6 12501.4 12536.4 12557.9 12569.9 12648.6 641.0 804.7 811.6 824.3 829.7 816.6 824.7 825.9 826.5 828.2 853.4 855.0 855.4 856.6 856.8 656.7 827.1 847.3 847.4 849.9 619.2 620.4 620.6 621.6 621.6 10448.0 10479.0 10482.8 10500.5 10515.3 11411.8 12111.1 12349.9 12383.3 12490.6 9906.8 9987.3 10062.7 10165.0 10240.9 3306.2 3350.4 3356.6 3419.3 3464.6 44028.6 44524.3 44829.0 44951.1 45076.8 9203.1 9244.8 9325.9 9456.9 9646.2 16480.0 16491.3 16513.8 16529.4 16736.0 6644.2 6682.5 6686.4 6760.7 6885.2 3643.0 3780.0 3830.5 3832.9 3877.1 2714.6 2716.3 2726.1 2730.0 2735.7 494.2 516.0 516.3 549.5 564.8 611.1 621.3 622.1 624.8 657.4 7601.0 7743.7 7779.6 7899.8 8050.4 465.9 519.7 605.9 613.9 619.7 3587.9 3614.8 3678.5 3685.8 3733.5 49943.3 50710.7 51103.2 51178.7 51198.5 41155.8 41460.9 41801.6 42127.6 42756.6 37989.6 38575.4 38602.8 38743.0 38988.8 8143.6 8233.5 8289.5 8305.2 8384.0 31481.7 31868.8 32254.5 32266.4 32763.8 37608.0 39535.6 40474.4 40614.8 40658.4 10210.3 10251.4 10526.7 10569.3 10672.2 10972.9 11011.8 11130.5 11371.8 11406.3 10470.8 10546.9 10686.3 10731.2 10901.3 10250.3 10408.6 10503.7 10511.8 10635.6 10109.0 10240.9 10574.3 10705.9 10706.1 9262.1 9367.7 9501.6 9514.1 9721.4 8874.5 9356.4 9360.7 9379.9 9478.0 22:47:42 INFO - PROCESS | 28240 | -------- Summary: end -------- 22:47:42 INFO - PROCESS | 28240 | 22:47:43 INFO - TEST-INFO | 28240: exit 0 22:47:43 INFO - TEST-OK | dromaeo_css | took 1115899ms 22:47:43 INFO - TEST-START | kraken 22:47:43 INFO - operating with platform_type : linux_ 22:47:43 INFO - Initialising browser for kraken test... 22:47:43 INFO - TEST-INFO | started process 28415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNQnxxE/profile http://localhost:33919/getInfo.html) 22:47:47 INFO - PROCESS | 28415 | __metrics Screen width/height:1600/1200 22:47:47 INFO - PROCESS | 28415 | colorDepth:24 22:47:47 INFO - PROCESS | 28415 | Browser inner width/height: 1024/697 22:47:47 INFO - PROCESS | 28415 | __metrics 22:47:48 ERROR - PROCESS | 28415 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:47:49 INFO - TEST-INFO | 28415: exit 0 22:47:49 INFO - Browser initialized. 22:47:49 INFO - Running cycle 1/1 for kraken test... 22:47:49 INFO - TEST-INFO | started process 28492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNQnxxE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:01 INFO - PROCESS | 28492 | RSS: Main: 154095616 22:48:01 INFO - PROCESS | 28492 | 22:48:04 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33919/tests/kraken/driver.html?testName=audio-beat-detection) 22:48:04 INFO - PROCESS | 28492 | RSS: Main: 195026944 22:48:04 INFO - PROCESS | 28492 | 22:48:07 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33919/tests/kraken/driver.html?testName=audio-dft) 22:48:08 INFO - PROCESS | 28492 | RSS: Main: 184991744 22:48:08 INFO - PROCESS | 28492 | 22:48:11 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33919/tests/kraken/driver.html?testName=audio-fft) 22:48:11 INFO - PROCESS | 28492 | RSS: Main: 170971136 22:48:11 INFO - PROCESS | 28492 | 22:48:13 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33919/tests/kraken/driver.html?testName=audio-oscillator) 22:48:14 INFO - PROCESS | 28492 | RSS: Main: 172511232 22:48:14 INFO - PROCESS | 28492 | 22:48:16 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:48:17 INFO - PROCESS | 28492 | RSS: Main: 174043136 22:48:17 INFO - PROCESS | 28492 | 22:48:20 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33919/tests/kraken/driver.html?testName=imaging-darkroom) 22:48:20 INFO - PROCESS | 28492 | RSS: Main: 173641728 22:48:20 INFO - PROCESS | 28492 | 22:48:24 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33919/tests/kraken/driver.html?testName=imaging-desaturate) 22:48:24 INFO - PROCESS | 28492 | RSS: Main: 174780416 22:48:24 INFO - PROCESS | 28492 | 22:48:27 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33919/tests/kraken/driver.html?testName=json-parse-financial) 22:48:28 INFO - PROCESS | 28492 | RSS: Main: 175865856 22:48:28 INFO - PROCESS | 28492 | 22:48:29 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:48:30 INFO - PROCESS | 28492 | RSS: Main: 183939072 22:48:30 INFO - PROCESS | 28492 | 22:48:32 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:48:32 INFO - PROCESS | 28492 | RSS: Main: 182722560 22:48:32 INFO - PROCESS | 28492 | 22:48:35 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:48:35 INFO - PROCESS | 28492 | RSS: Main: 194797568 22:48:35 INFO - PROCESS | 28492 | 22:48:38 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:48:38 INFO - PROCESS | 28492 | RSS: Main: 200708096 22:48:38 INFO - PROCESS | 28492 | 22:48:41 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:48:41 INFO - PROCESS | 28492 | RSS: Main: 200085504 22:48:41 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | Cycle 1(1): loaded http://localhost:33919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33919/tests/kraken/driver.html?testName=ai-astar) 22:48:43 INFO - PROCESS | 28492 | RSS: Main: 261971968 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | __start_tp_report 22:48:43 INFO - PROCESS | 28492 | _x_x_mozilla_page_load 22:48:43 INFO - PROCESS | 28492 | _x_x_mozilla_page_load_details 22:48:43 INFO - PROCESS | 28492 | |i|pagename|runs| 22:48:43 INFO - PROCESS | 28492 | |0;ai-astar;111;115;108;115;113;113;102;113;112;113 22:48:43 INFO - PROCESS | 28492 | |1;audio-beat-detection;159;130;153;186;133;173;164;133;176;133 22:48:43 INFO - PROCESS | 28492 | |2;audio-dft;162;161;160;162;163;160;163;162;160;161 22:48:43 INFO - PROCESS | 28492 | |3;audio-fft;76;73;103;103;74;74;73;123;113;78 22:48:43 INFO - PROCESS | 28492 | |4;audio-oscillator;94;94;140;93;93;93;145;93;94;137 22:48:43 INFO - PROCESS | 28492 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;116;117;117 22:48:43 INFO - PROCESS | 28492 | |6;imaging-darkroom;148;149;149;149;149;149;149;149;149;147 22:48:43 INFO - PROCESS | 28492 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 22:48:43 INFO - PROCESS | 28492 | |8;json-parse-financial;64;64;66;66;65;64;66;73;62;73 22:48:43 INFO - PROCESS | 28492 | |9;json-stringify-tinderbox;64;63;63;64;64;63;64;64;69;64 22:48:43 INFO - PROCESS | 28492 | |10;stanford-crypto-aes;82;84;82;83;83;80;83;82;83;83 22:48:43 INFO - PROCESS | 28492 | |11;stanford-crypto-ccm;118;121;119;119;123;127;115;116;115;121 22:48:43 INFO - PROCESS | 28492 | |12;stanford-crypto-pbkdf2;141;134;140;139;135;127;130;139;142;139 22:48:43 INFO - PROCESS | 28492 | |13;stanford-crypto-sha256-iterative;70;69;69;69;67;66;66;66;69;67 22:48:43 INFO - PROCESS | 28492 | __end_tp_report 22:48:43 INFO - PROCESS | 28492 | __start_cc_report 22:48:43 INFO - PROCESS | 28492 | _x_x_mozilla_cycle_collect,1162 22:48:43 INFO - PROCESS | 28492 | __end_cc_report 22:48:43 INFO - PROCESS | 28492 | __startTimestamp1459835323853__endTimestamp 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | ------- Summary: start ------- 22:48:43 INFO - PROCESS | 28492 | Number of tests: 14 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.89 (3.4%) stddev-sans-first:4.13 22:48:43 INFO - PROCESS | 28492 | Values: 111.0 115.0 108.0 115.0 113.0 113.0 102.0 113.0 112.0 113.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:161.50 stddev:20.80 (12.9%) stddev-sans-first:21.98 22:48:43 INFO - PROCESS | 28492 | Values: 159.0 130.0 153.0 186.0 133.0 173.0 164.0 133.0 176.0 133.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 22:48:43 INFO - PROCESS | 28492 | Values: 162.0 161.0 160.0 162.0 163.0 160.0 163.0 162.0 160.0 161.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#3] audio-fft Cycles:10 Average:89.00 Median:73.50 stddev:19.37 (26.4%) stddev-sans-first:19.96 22:48:43 INFO - PROCESS | 28492 | Values: 76.0 73.0 103.0 103.0 74.0 74.0 73.0 123.0 113.0 78.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:22.90 (24.6%) stddev-sans-first:23.76 22:48:43 INFO - PROCESS | 28492 | Values: 94.0 94.0 140.0 93.0 93.0 93.0 145.0 93.0 94.0 137.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:48:43 INFO - PROCESS | 28492 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 22:48:43 INFO - PROCESS | 28492 | Values: 148.0 149.0 149.0 149.0 149.0 149.0 149.0 149.0 149.0 147.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 22:48:43 INFO - PROCESS | 28492 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:3.74 (5.7%) stddev-sans-first:3.88 22:48:43 INFO - PROCESS | 28492 | Values: 64.0 64.0 66.0 66.0 65.0 64.0 66.0 73.0 62.0 73.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.75 (2.7%) stddev-sans-first:1.86 22:48:43 INFO - PROCESS | 28492 | Values: 64.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 69.0 64.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 22:48:43 INFO - PROCESS | 28492 | Values: 82.0 84.0 82.0 83.0 83.0 80.0 83.0 82.0 83.0 83.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.00 stddev:3.78 (3.1%) stddev-sans-first:3.97 22:48:43 INFO - PROCESS | 28492 | Values: 118.0 121.0 119.0 119.0 123.0 127.0 115.0 116.0 115.0 121.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:139.00 stddev:4.97 (3.6%) stddev-sans-first:5.01 22:48:43 INFO - PROCESS | 28492 | Values: 141.0 134.0 140.0 139.0 135.0 127.0 130.0 139.0 142.0 139.0 22:48:43 INFO - PROCESS | 28492 | 22:48:43 INFO - PROCESS | 28492 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:69.00 stddev:1.55 (2.2%) stddev-sans-first:1.42 22:48:43 INFO - PROCESS | 28492 | Values: 70.0 69.0 69.0 69.0 67.0 66.0 66.0 66.0 69.0 67.0 22:48:43 INFO - PROCESS | 28492 | -------- Summary: end -------- 22:48:43 INFO - PROCESS | 28492 | 22:48:44 INFO - TEST-INFO | 28492: exit 0 22:48:44 INFO - TEST-OK | kraken | took 61076ms 22:48:44 INFO - SUITE-END | took 1176s 22:48:45 INFO - Completed test suite (00:19:37) 22:48:45 INFO - javascript benchmark 22:48:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2589.106758168432, 2651.2974061873597, 2653.204038788363, 2670.4525572257676, 2688.9327766805823, 4430.534793846648, 4531.6601254905845, 4535.977320113395, 4549.931751023733, 4579.290210017449, 4522.208613492642, 4527.320901864722, 4554.635629149669, 4574.473935497411, 4666.113438446701, 4160.958390416087, 4172.019575399779, 4188.4555007849085, 4193.496780386358, 4362.105768317503, 4306.784660766964, 4325.0, 4334.241507736149, 4361.302191649337, 4379.08039311745, 4121.690873184523, 4165.375193720935, 4202.705810593229, 4248.129133527619, 4257.9999999999845, 4222.577742225783, 4243.0241044559925, 4267.743935363857, 4268.06102657418, 4287.056847493546, 4216.430781844442, 4219.2405367033925, 4221.598948099926, 4240.745555266694, 4261.893452663678, 4338.240807858644, 4451.732896026217, 4527.071950250191, 4530.8867278317975, 4534.501204867462, 4875.073735990186, 4892.168331383673, 4893.0, 4894.902101957977, 4917.532834380728, 4910.312556242129, 4913.778879950411, 4916.58209052231, 4917.188663870457, 4959.429665588467, 4484.461864576239, 4520.593146616755, 4594.287885377772, 4595.310703394518, 4628.1669299526075, 4951.950480495149, 4959.404871415453, 4974.000447839118, 4976.900461990812, 5034.974825125851, 4766.809327626856, 4774.976125119421, 4778.04439112179, 4781.904361912742, 4823.734694591761, 4781.187198176319, 4840.75796210188, 4889.364382630235, 4925.556699896955, 4934.1611925972675, 4841.419029716457, 4846.248831431134, 4866.586340161055, 4868.440129385166, 4908.558229759267, 4695.600873925686, 4846.127697014501, 4856.0, 4857.878553036202, 4904.068227036852, 4086.9386959195635, 4110.856120035784, 4114.156597897484, 4152.854650087233, 4153.958460415418, 3567.94648080279, 3587.8744243951337, 3617.7467577269863, 3627.7641953273483, 3634.055145662147, 4150.730202536825, 4231.597998190167, 4249.660027197817, 4256.170046840898, 4262.23279809631, 4776.068666610047, 4871.098846713298, 4879.975600121977, 4918.926216106761, 4925.827596034122, 4237.78811059452, 4248.87253382399, 4261.126469073894, 4284.700070995063, 4306.289462238696, 4268.509121451073, 4306.763128027926, 4341.196878577473, 4353.608175264241, 4391.67062470316, 4629.259318509023, 4649.0, 4651.627869770478, 4671.696339737906, 4705.247160454311, 4882.023595280887, 4882.365292512093, 4884.291777692144, 4889.119958407378, 4924.532169443897, 4538.750368729751, 4647.837325693585, 4654.511276316073, 4692.1084993851055, 4723.6929599575915, 4797.688150270221, 4820.204666230173, 4825.034993001484, 4844.031193761191, 4863.440704318907, 4880.341153944172, 4882.218844984785, 4891.95108048915, 4894.681845680019, 4941.308216849572, 4639.907201856012, 4723.409573803275, 4748.358971538798, 4816.109019831342, 4821.059893320909, 4743.739094349844, 4744.240921452551, 4753.453352864465, 4759.500252473579, 4810.975945120252, 4691.695039822537, 4696.953030469788, 4703.412073490814, 4707.411573553306, 4750.5249475052215, 4631.328457373729, 4733.0, 4785.306130611111, 4800.975995120142, 4833.03339332142, 4676.859694209179, 4679.3916790816975, 4700.670953033255, 4702.388689470347, 4747.596454301285], "unit": "score", "name": "dojo.html", "value": 4494.690794675484}, {"lowerIsBetter": false, "replicates": [516.5144763921913, 526.9367675878892, 529.1692043491719, 542.3979382884997, 543.6140340358345, 27586.586201207, 28013.299667508298, 28021.439571208564, 28029.719702802966, 35259.29481410376, 38589.80705096471, 39159.41260881089, 39183.41224881622, 39201.803990980006, 39209.803950980204, 7636.465447418683, 7829.765107046797, 7839.451238413313, 7839.568823714693, 7839.804004899866, 7677.2706592873865, 7805.921940780577, 7806.492577982442, 7808.0, 7809.297163255306, 7793.454458187929, 8051.396145289097, 8069.677212911476, 8070.515769053875, 8074.354051675852, 7642.503237289586, 7855.175206603339, 7874.0, 7876.881846772303, 7916.52500849948, 9880.11079002886, 9931.404115753077, 10158.59365625374, 10172.643957461527, 10230.6419275325, 35081.824590877135, 35488.0, 35564.46653300203, 35575.110622234395, 35611.82194089039, 3288.917777055569, 3335.849886755102, 3522.1370764162943, 3688.908958282685, 3974.7813870237123, 29599.85200073986, 30102.84948575243, 30324.54513182304, 30359.24101897448, 31106.53340199899, 3535.0, 3543.450765131409, 3619.8914032579064, 3637.805029109377, 3639.999000274919, 252974.0, 255242.0, 255640.0, 255750.0, 256967.0, 59655.0, 59971.0, 60212.279833415756, 60250.69874650687, 60303.0, 53976.65058373572, 55075.724621376634, 64012.67993660095, 64159.0, 64855.67572162109, 15209.695806083817, 15335.309911053806, 15439.073655580702, 15446.304916278794, 15471.92264038695, 11537.307761534166, 11756.177067605357, 11759.294442333487, 11762.470688819023, 11773.17587768848, 17985.55036124081, 18017.18922648484, 18036.0, 18069.457916262534, 18100.0, 7146.749863754743, 7151.249118842551, 7213.963930180315, 7227.819304517324, 7443.255674432514, 916.5692124701379, 939.3778237250053, 953.3993584042009, 993.7018894331671, 1017.8829434614966, 27407.588886166723, 27911.58132628012, 28540.857295713802, 28543.57184642232, 28660.713392866222, 990.069334825262, 1038.0864838941684, 1049.7690508088208, 1098.8406681031365, 1119.1941801902617, 14184.361703723358, 14583.197924114276, 14755.40978360875, 14922.0, 15029.549113526611, 288222.0, 291028.0, 291474.0, 291745.0, 292595.0, 47765.761171193924, 48860.267095993586, 48873.26690099651, 48896.26655600169, 48905.26642100371, 1083.3229231730168, 1227.34337129637, 1265.0385706862667, 1271.7965125579863, 1326.257295914291, 26401.603975939994, 27510.449791004467, 27768.166954991382, 28167.859160704065, 28227.43545129127, 38752.80623596864, 39353.0, 39353.80323098366, 39388.212235755695, 39456.40815387714, 208103.0, 209242.0, 210436.0, 210474.0, 210561.0, 29467.557986630647, 30892.227694306923, 31100.844495777375, 31348.686513134577, 31388.0, 39523.0, 39647.80176099101, 39754.0, 40516.594834051284, 40536.3919541213, 32656.510152348208, 33508.66491335153, 33586.32827343488, 33658.831705841316, 33734.662653373154, 32945.34109317848, 33216.1695957603, 33260.0, 33315.33369332551, 33499.83250083832, 29890.0, 29993.250168745955, 30287.848560757055, 33425.66574334226, 33946.66053339435, 28471.857640711663, 29719.108426746367, 29965.33230614237, 29979.70020299769, 30171.849140754155, 23761.52476950417, 24389.63415548804, 24593.631095533223, 24675.506489870462, 24797.752022479544], "unit": "score", "name": "ext.html", "value": 17301.225295711363}, {"lowerIsBetter": false, "replicates": [346.53737260756907, 356.2589813188568, 356.36744778019005, 358.24381361425435, 359.6709011254702, 15545.145017024059, 16092.195390230485, 16343.59141021475, 16942.23759930803, 16946.491605251864, 10674.09270212031, 10911.83632245517, 13523.661908452294, 16570.83429165708, 16604.501864944043, 4535.750533720644, 4798.47216806151, 4799.400074990626, 4808.278758186265, 4820.3733514643045, 3383.0696558446502, 3441.965580344202, 5955.910661340084, 6065.332813390545, 6065.909011364811, 6002.249718785152, 6011.609245399035, 6021.217241758565, 6035.849103772397, 6037.818865434044, 5755.913661295084, 5909.261342332208, 5922.022866227067, 5999.070144127667, 6006.90989635158, 5198.454162312941, 5207.505286997729, 5212.218167274939, 5221.373435187764, 5223.791048358061, 18650.62698746031, 18998.0, 19697.507562310915, 19731.40805775829, 19764.50588735279, 2025.0178663348265, 2058.8970551472516, 2064.380685794271, 2138.272987184365, 2386.1648423051965, 8640.13598640131, 8858.202761751409, 8908.688195913177, 9080.409773364776, 9300.581473833627, 1741.9912900435543, 1750.0374793863452, 1755.3417468449331, 1774.8136445673147, 1787.499500139963, 61613.6919315405, 61675.0, 61962.690186549684, 62066.37933620651, 62606.0, 9783.461909594898, 9786.608535658494, 9824.263180261509, 9831.705048848546, 9933.701988940344, 13308.134971226838, 13437.529686461123, 13453.798193027113, 13467.0, 13480.797788033187, 7115.89326160108, 7156.032091174864, 7253.927460725431, 7261.8547629047125, 7434.962825185839, 7059.470539709542, 7231.0, 7265.346118849329, 7330.96334518324, 7339.522931009467, 4257.467816522934, 4270.829166833354, 4271.722338048017, 4297.355396690459, 4299.763513006752, 1731.67526841966, 1750.2561411400359, 1754.850837678786, 1826.1325870211542, 1841.3187120765404, 935.2377812083131, 938.4228699349987, 952.6522819170953, 966.6665000574791, 978.0708327089294, 16046.352351862046, 16123.758143627854, 16222.432214872422, 16380.344786208418, 16427.342906283615, 889.8220355928711, 918.9494577798151, 928.4011812381111, 935.1817159985013, 936.6534382278601, 9296.772435659313, 9338.906610933804, 9367.297452691075, 9389.812203755886, 9459.24326053914, 386873.0, 392887.0, 393256.0, 393266.0, 395516.0, 50837.0, 61911.0, 62506.0, 67948.32051679419, 70615.64692176506, 916.3036092569695, 924.9075092490832, 940.182041623778, 948.9003654616304, 952.4475804033644, 11831.40842957866, 14023.50917717875, 14270.357833897708, 14527.636809079857, 14732.337044833223, 32093.67906320907, 32805.83597081999, 33123.0, 33363.83318083394, 33830.15424614404, 38935.0, 40660.18679626332, 41759.373609395276, 42187.15625687531, 42569.36145957875, 7314.817129571803, 7373.483856130019, 7532.887006695014, 7545.584992825447, 7778.338841198335, 9240.306976976619, 10246.487675616338, 11727.941360293144, 12027.579034733742, 12412.069094817743, 10475.842862356918, 10477.895221047693, 10538.8419173714, 10562.735931601464, 10700.30448020876, 10323.32898361604, 10427.791444170922, 10470.633527826794, 10551.525181366704, 10567.735806604589, 5422.674639521641, 9492.86085669724, 10328.380297182193, 10652.0, 10853.589598643126, 7095.787126386217, 7691.653875575725, 7700.807479813049, 7727.265909738566, 7807.258310460497, 9641.42151470914, 10310.742231444274, 10390.220733445172, 10484.108850747467, 10524.421156836448], "unit": "score", "name": "jquery.html", "value": 7979.283568586299}, {"lowerIsBetter": false, "replicates": [1400.5238219005537, 1409.4080486195796, 1517.286875168671, 1706.5733566608349, 1732.3850033238193, 6940.965295173523, 7115.501914865961, 7128.96435517823, 7143.821404464885, 7173.175084865242, 6199.4110559496885, 6355.078513615523, 6363.777267795628, 6866.073080134181, 7026.2973702629715, 2144.174492820264, 2167.0898222746405, 2172.8153106985924, 2175.8912054397215, 2175.9564808703817, 2147.967780483294, 2178.106976139783, 2199.3621849663577, 2204.1073365287, 2213.0373287619855, 1859.860510461714, 2049.3646969439446, 2099.422658768843, 2146.216630929715, 2157.30966090851, 2083.9895800520976, 2098.8530802843807, 2102.6740855167322, 2103.2638576498257, 2104.137303705481, 2039.5512987142804, 2064.3290930447665, 2072.2229164063474, 2073.6060148571723, 2078.781727918577, 7085.7165713371405, 7206.1352637683285, 7221.0, 7227.168875579323, 7227.819304517377, 4307.504636966758, 4416.712913660634, 4423.469183697945, 4425.712328698624, 4427.9557204427865, 2771.584262360642, 2846.3453405716596, 2980.910572682823, 2998.1155559110116, 2998.190488568096, 875.7985663297413, 901.4816480523725, 929.8884133903907, 931.050328664765, 932.2495391210073, 9393.154616084517, 9484.810303793885, 9533.427994320293, 9559.426434413957, 9569.234461243084, 3922.7450215735885, 4028.738132021409, 4090.0388408723925, 4103.97948010264, 4129.504459464823, 8204.753857384288, 8263.214994575506, 8284.8343033139, 8299.336053115736, 8307.958460207781, 4451.9554804451545, 4467.865964021084, 4485.573870482299, 4488.079943611552, 4493.618042466362, 3397.3375191837354, 3921.8039098044983, 4028.959710402917, 4061.8375264989068, 4073.490813648294, 3417.1457135716073, 3460.1349662584353, 3479.2693534357563, 3517.56030496188, 3525.25969546393, 1108.179946839333, 1116.2744216259496, 1118.2060736876747, 1120.9495572699248, 1130.0902773267599, 969.8448248280241, 1065.1265961911313, 1163.3892206591438, 1170.9238899471677, 1181.1082632612322, 6462.870742585122, 6508.544401891917, 6508.674566271668, 6522.412982831473, 6537.346265373425, 1095.4905968724422, 1111.90548803351, 1120.523777394604, 1141.3266172957995, 1154.2728081308721, 5225.921611175835, 5262.368515778131, 5280.709560974184, 5309.548688361455, 5313.787448502094, 8026.43814932949, 8068.314193293636, 8252.628631711468, 8358.038825535019, 8368.456050356828, 8178.918210817816, 8188.918110818935, 8224.0, 8241.587920603946, 8243.05204901432, 6478.935210647834, 6584.341565843473, 6619.437347825488, 6648.16897887764, 6697.966510167418, 6634.237062737847, 6655.101561289164, 6676.332366763285, 6695.966520167368, 6708.094407255153, 7626.199249078767, 7648.847023059619, 7788.026496687914, 7846.764597062097, 7987.281144697005, 7882.684692612232, 8070.2333278338465, 8081.0, 8132.349412046904, 8231.382646301432, 5537.169424586345, 5595.244641973281, 5701.0, 6208.689565521796, 6283.3088360281245, 6763.222229443677, 6838.863222735418, 6841.213260475109, 6842.315768423118, 6846.520743547904, 5933.228680271537, 6091.177691011834, 6094.75620975156, 6153.661548614869, 6350.460210881942, 6047.304559975483, 6057.545684073624, 6066.423689749467, 6176.907346389898, 6320.209973753281, 6222.688865556795, 6225.346338634378, 6282.717277722605, 6290.402411770874, 6297.559170857996, 5831.329397119216, 5857.824265272048, 5859.091840764689, 5864.0, 5864.9413505866105, 5756.0, 5866.530677545701, 6000.519958403404, 6023.909641355295, 6032.306284777307], "unit": "score", "name": "mootools.html", "value": 4128.843983873058}, {"lowerIsBetter": false, "replicates": [301.58682604831387, 303.9665636779955, 313.60642393795786, 315.0485533688261, 319.7953309881676, 5201.7919283228675, 5263.526282634562, 5287.762050707718, 5369.355677318727, 5389.919151212725, 5243.318368612085, 5249.842504724855, 5256.684598924067, 5263.394709608397, 5276.261323414725, 3924.3917192835015, 4044.413560033793, 4097.303458412077, 4131.938020929689, 4155.085881106152, 4129.587041295861, 4144.41978123063, 4151.73013754105, 4152.730072545275, 4163.437935878648, 4116.156187981456, 4123.237201117788, 4123.773192474413, 4132.690048246379, 4138.1103062841485, 3909.882703518899, 4008.819603117867, 4098.52866920305, 4115.794210289474, 4128.256913755523, 3637.527121474218, 3644.398674218751, 3647.051766540692, 3650.580183278904, 3654.086478380405, 5041.546260836506, 5044.293798868125, 5044.924326135111, 5064.265681476202, 5068.898622027576, 4751.643626727975, 4753.928691069636, 4756.381670382828, 4768.998510312838, 4772.665913386064, 5551.195076713854, 5558.916616250759, 5566.4990150886615, 5566.582506312043, 5572.275604171432, 3968.9007774805573, 3971.4241434991764, 3993.121513267077, 4002.939221106409, 4004.939925901114, 5538.196961440609, 5709.4290570942985, 5721.6853073080965, 5724.914126288068, 5734.197212390227, 3887.9222415552094, 3978.4430179774854, 3979.5423526294267, 3979.5821438749094, 3987.0, 4042.757434553936, 4044.4944381952255, 4045.130296986162, 4046.9392959105635, 4053.310937140693, 4643.233866412072, 4645.837395691135, 4648.953510464919, 4656.67403281767, 4659.487456379796, 5554.750036248379, 5571.9442805572235, 5572.4706152915405, 5578.9163162552595, 5581.246531718247, 1400.3628349101134, 1412.7951447040123, 1420.3537390487304, 1421.4030107354936, 1423.7721964485634, 892.1123482135188, 909.4452384045727, 920.2683866326287, 946.186279799372, 948.4498990585444, 4847.079054979543, 4882.5605695487575, 4886.291487734258, 4901.313816065754, 4920.384951881015, 5718.971405143031, 5719.370869204384, 5728.112142617901, 5731.312242530923, 5731.484166425042, 4886.413630364308, 4905.435874874363, 4906.06784710911, 4908.410990681141, 4918.286848407032, 3049.603551538286, 3076.661567227603, 3077.8922737704074, 3083.938321233563, 3088.8918887838818, 5422.078246698071, 5425.02349577072, 5436.592255580847, 5437.102878025161, 5439.700816455133, 5698.2592263005545, 5831.183634291203, 5875.383084776123, 5881.0, 5883.588148829626, 5394.3796463406425, 5412.052890744104, 5420.051490989061, 5423.0, 5424.891502169856, 5698.6580805151825, 5709.51469125129, 5712.11462223356, 5715.514181294637, 5722.2561067061015, 5583.692896890548, 5603.915941260802, 5604.103343465026, 5607.8878422432135, 5608.6073974821375, 5410.0, 5414.485623865884, 5416.21464887597, 5416.539594134542, 5423.18652202157, 3785.6592906638534, 3869.6130386961077, 3872.5352957644136, 3873.1091848874353, 3987.4417581539187, 5638.605297629127, 5644.322681278273, 5648.63283886546, 5653.632513886749, 5655.717214139194, 5497.752601133038, 5534.1145416733125, 5543.307086614173, 5558.416366281483, 5559.63862348946, 5540.335159780852, 5550.2507161534295, 5554.472325129106, 5556.333100069882, 5565.7217139143695, 5453.536449401687, 5458.836234912959, 5472.370677371994, 5473.0, 5477.096279114061, 5421.83734487966, 5586.832395028156, 5597.63615365, 5604.0, 5608.355039170548, 5427.918581221206, 5451.972740136274, 5454.809081682122, 5462.262594549685, 5468.043092458884], "unit": "score", "name": "prototype.html", "value": 4167.586998295739}, {"lowerIsBetter": false, "replicates": [659.9340065993401, 674.3728332650636, 679.6329981809823, 736.7605528203334, 780.4419839814532, 11262.54949802008, 11387.373694446802, 11412.657620271395, 11417.942910285446, 12448.62654120378, 12501.43743531541, 12536.435860386282, 12557.874421255785, 12569.937150314236, 12648.620541383772, 640.9743610255607, 804.7384600004992, 811.5739236900615, 824.3075816314295, 829.7469271872077, 816.5508970066439, 824.686619084747, 825.9132791056943, 826.5454000299841, 828.159418190537, 853.4111463090479, 854.9829003419959, 855.3755758296447, 856.5545916123612, 856.7815207122206, 656.7340227207989, 827.0819390476566, 847.2586486824028, 847.4279861093768, 849.9362547808939, 619.1734035063151, 620.4044117647064, 620.5749061892618, 621.5959626242978, 621.6270237857294, 10448.0, 10479.0, 10482.79034419315, 10500.527476263587, 10515.316504427188, 11411.828822567668, 12111.091668124838, 12349.93825030869, 12383.318917459535, 12490.582497323421, 9906.752331191707, 9987.335081823381, 10062.748431289203, 10165.0, 10240.89759102407, 3306.189983454045, 3350.4136776064333, 3356.613989391227, 3419.281950790337, 3464.6015708193377, 44028.55971440308, 44524.332135018, 44829.0, 44951.10097798058, 45076.77461612704, 9203.125703058198, 9244.768880778034, 9325.90674093264, 9456.90543094574, 9646.228301735844, 16480.0, 16491.257893394824, 16513.752293715603, 16529.35530315144, 16736.0, 6644.169478815148, 6682.532222744361, 6686.431653309523, 6760.7295708172105, 6885.208201056842, 3643.0, 3779.981100094537, 3830.5211848518934, 3832.9041773955873, 3877.1470276539117, 2714.6199532065525, 2716.348076461635, 2726.05950946923, 2729.972700272972, 2735.726427357248, 494.16979474482497, 516.0247132918787, 516.3236160629588, 549.4670169935157, 564.7599770097692, 611.0955785437577, 621.3351713666334, 622.1445512420422, 624.8469125064297, 657.3689258312074, 7600.9619951900995, 7743.690252389842, 7779.611019449005, 7899.842003159904, 8050.355971522265, 465.9370984917061, 519.7453247908574, 605.8636806718541, 613.9017757158833, 619.6746707978348, 3587.874424395186, 3614.8373323200517, 3678.4850120983083, 3685.7972811495624, 3733.4773131761576, 49943.25085123726, 50710.746446267534, 51103.23345149826, 51178.74410627923, 51198.488015120114, 41155.7942210287, 41460.8539146083, 41801.58198417977, 42127.57872421236, 42756.572434275884, 37989.62010379916, 38575.42136867949, 38602.80698596545, 38743.0, 38988.80505597454, 8143.633536490754, 8233.46482478637, 8289.502629842229, 8305.211004954519, 8383.95808020956, 31481.685183147874, 31868.84065579657, 32254.516182256815, 32266.35467290594, 32763.836180818944, 37608.0, 39535.60464395319, 40474.39288410617, 40614.796926016366, 40658.390124148755, 10210.336328138646, 10251.436171010666, 10526.736831579272, 10569.260151789302, 10672.199585031309, 10972.914708154905, 11011.779764404508, 11130.499127539442, 11371.772564548497, 11406.258593191416, 10470.790584188426, 10546.947265263625, 10686.25196236287, 10731.248812583044, 10901.34591924487, 10250.333728307636, 10408.583656653953, 10503.684889453329, 10511.842322365324, 10635.627753028606, 10109.0, 10240.897591024292, 10574.312669676447, 10705.9464702676, 10706.143508519144, 9262.073792620684, 9367.672131475365, 9501.57242924084, 9514.143727064597, 9721.416714997124, 8874.511901845202, 9356.4386136832, 9360.672376466791, 9379.906200937903, 9478.0], "unit": "score", "name": "yui.html", "value": 5815.027597474126}], "name": "dromaeo_css", "value": 6292.771173265476}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 108.0, 115.0, 113.0, 113.0, 102.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 153.0, 186.0, 133.0, 173.0, 164.0, 133.0, 176.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 162.0, 163.0, 160.0, 163.0, 162.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 103.0, 103.0, 74.0, 74.0, 73.0, 123.0, 113.0, 78.0], "unit": "score", "name": "audio-fft", "value": 89.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 140.0, 93.0, 93.0, 93.0, 145.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 66.0, 65.0, 64.0, 66.0, 73.0, 62.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 69.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 83.0, 83.0, 80.0, 83.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 119.0, 119.0, 123.0, 127.0, 115.0, 116.0, 115.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [141.0, 134.0, 140.0, 139.0, 135.0, 127.0, 130.0, 139.0, 142.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 67.0, 66.0, 66.0, 66.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1520.7}]} 22:48:45 INFO - Return code: 0 22:48:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:48:45 ERROR - # TBPL SUCCESS # 22:48:45 INFO - Running post-action listener: _resource_record_post_action 22:48:45 INFO - Running post-run listener: _resource_record_post_run 22:48:46 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 525307904; Read time: 0; Write time: 488832 22:48:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244588544; Read time: 0; Write time: 265080 22:48:46 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 280719360; Read time: 0; Write time: 223752 22:48:46 INFO - Running post-run listener: _upload_blobber_files 22:48:46 INFO - Blob upload gear active. 22:48:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:48:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:48:46 INFO - (blobuploader) - INFO - Open directory for files ... 22:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:48:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:48:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:48:47 INFO - (blobuploader) - INFO - Done attempting. 22:48:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:48:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:48:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:48:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:48:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:48:48 INFO - (blobuploader) - INFO - Done attempting. 22:48:48 INFO - (blobuploader) - INFO - Iteration through files over. 22:48:48 INFO - Return code: 0 22:48:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:48:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:48:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb3d9e514d4aa38c19b21a349cd252fcfe0f20ebeea3fcca39bf85e6fa48931272343357b7f24763798363b6353a5ab819f25cf14a6e8242eb7ad78c9a75fc69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac609e4e4267471704aad91de5d7b4a1e56cd033e0c83b01c614e78bc9502d949d071a6fde669a5bda364d2b066b9d978dce63e5c5f829e569416811dd052464"} 22:48:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:48:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:48:48 INFO - Contents: 22:48:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb3d9e514d4aa38c19b21a349cd252fcfe0f20ebeea3fcca39bf85e6fa48931272343357b7f24763798363b6353a5ab819f25cf14a6e8242eb7ad78c9a75fc69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac609e4e4267471704aad91de5d7b4a1e56cd033e0c83b01c614e78bc9502d949d071a6fde669a5bda364d2b066b9d978dce63e5c5f829e569416811dd052464"} 22:48:48 INFO - Running post-run listener: copy_logs_to_upload_dir 22:48:48 INFO - Copying logs to upload dir... 22:48:48 INFO - mkdir: /builds/slave/test/build/upload/logs 22:48:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.043709 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-04 22:48:47.599581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 22:48:47.602586) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb3d9e514d4aa38c19b21a349cd252fcfe0f20ebeea3fcca39bf85e6fa48931272343357b7f24763798363b6353a5ab819f25cf14a6e8242eb7ad78c9a75fc69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac609e4e4267471704aad91de5d7b4a1e56cd033e0c83b01c614e78bc9502d949d071a6fde669a5bda364d2b066b9d978dce63e5c5f829e569416811dd052464"} build_url:https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/O24mDLGCTRaAwv8b6Xxfbg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb3d9e514d4aa38c19b21a349cd252fcfe0f20ebeea3fcca39bf85e6fa48931272343357b7f24763798363b6353a5ab819f25cf14a6e8242eb7ad78c9a75fc69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac609e4e4267471704aad91de5d7b4a1e56cd033e0c83b01c614e78bc9502d949d071a6fde669a5bda364d2b066b9d978dce63e5c5f829e569416811dd052464"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 22:48:47.657511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:48:47.657811) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1459834092.604558-1212849963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:48:47.733029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:48:47.733353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:48:47.733625) ========= ========= Total master_lag: 0.37 =========