builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1459819756.02 results: success (0) buildid: 20160404175051 builduid: a2b81269b7fe46f9acc0ba8851067937 revision: 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.023737) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.024103) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.024411) ========= 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.056289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.056574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.074180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.074466) ========= 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.129727) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.130000) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.130396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.130667) ========= 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 18:29:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.3M=0s 2016-04-04 18:29:17 (39.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106872 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.272232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.272512) ========= 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022532 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.343817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.344126) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 --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 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 --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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 18:29:17,790 truncating revision to first 12 chars 2016-04-04 18:29:17,790 Setting DEBUG logging. 2016-04-04 18:29:17,790 attempt 1/10 2016-04-04 18:29:17,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7eebd9f0738a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 18:29:18,051 unpacking tar archive at: fx-team-7eebd9f0738a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.929912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.930272) ========= echo 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7eebd9f0738af3900c95d8583ab54d6166a9b1d2'] 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 program finished with exit code 0 elapsedTime=0.004742 script_repo_revision: '7eebd9f0738af3900c95d8583ab54d6166a9b1d2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.980713) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.981018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 18:29:16.990957) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-04 18:29:16.991251) ========= /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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:18 INFO - MultiFileLogger online at 20160404 18:29:18 in /builds/slave/test 18:29:18 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 18:29:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:18 INFO - {'append_to_log': False, 18:29:18 INFO - 'base_work_dir': '/builds/slave/test', 18:29:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:29:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:18 INFO - 'branch': 'Fx-Team-Non-PGO', 18:29:18 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:18 INFO - 'config_files': ('talos/linux_config.py',), 18:29:18 INFO - 'default_actions': ('clobber', 18:29:18 INFO - 'read-buildbot-config', 18:29:18 INFO - 'download-and-extract', 18:29:18 INFO - 'populate-webroot', 18:29:18 INFO - 'create-virtualenv', 18:29:18 INFO - 'install', 18:29:18 INFO - 'run-tests'), 18:29:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:18 INFO - 'download_minidump_stackwalk': True, 18:29:18 INFO - 'download_symbols': 'ondemand', 18:29:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:18 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:18 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:18 INFO - 'installer_path': 'installer.exe', 18:29:18 INFO - 'log_level': 'info', 18:29:18 INFO - 'log_name': 'talos', 18:29:18 INFO - 'log_to_console': True, 18:29:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:18 INFO - 'opt_config_files': (), 18:29:18 INFO - 'pip_index': False, 18:29:18 INFO - 'sps_profile': False, 18:29:18 INFO - 'sps_profile_interval': 0, 18:29:18 INFO - 'suite': 'dromaeojs', 18:29:18 INFO - 'system_bits': '32', 18:29:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:18 INFO - 'title': 'talos-linux64-ix-035', 18:29:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:18 INFO - 'use_talos_json': True, 18:29:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:18 INFO - 'work_dir': 'build'} 18:29:18 INFO - ##### 18:29:18 INFO - ##### Running clobber step. 18:29:18 INFO - ##### 18:29:18 INFO - Running pre-action listener: _resource_record_pre_action 18:29:18 INFO - Running main action method: clobber 18:29:18 INFO - rmtree: /builds/slave/test/build 18:29:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:18 INFO - Running post-action listener: _resource_record_post_action 18:29:18 INFO - ##### 18:29:18 INFO - ##### Running read-buildbot-config step. 18:29:18 INFO - ##### 18:29:18 INFO - Running pre-action listener: _resource_record_pre_action 18:29:18 INFO - Running main action method: read_buildbot_config 18:29:18 INFO - Using buildbot properties: 18:29:18 INFO - { 18:29:18 INFO - "project": "", 18:29:18 INFO - "product": "firefox", 18:29:18 INFO - "script_repo_revision": "production", 18:29:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:29:18 INFO - "repository": "", 18:29:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:29:18 INFO - "buildid": "20160404175051", 18:29:18 INFO - "pgo_build": "False", 18:29:18 INFO - "basedir": "/builds/slave/test", 18:29:18 INFO - "buildnumber": 1609, 18:29:18 INFO - "slavename": "talos-linux64-ix-035", 18:29:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:29:18 INFO - "platform": "ubuntu64_hw", 18:29:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:29:18 INFO - "branch": "fx-team", 18:29:18 INFO - "repo_path": "integration/fx-team", 18:29:18 INFO - "revision": "7eebd9f0738af3900c95d8583ab54d6166a9b1d2", 18:29:18 INFO - "stage_platform": "linux64", 18:29:18 INFO - "builduid": "a2b81269b7fe46f9acc0ba8851067937", 18:29:18 INFO - "slavebuilddir": "test" 18:29:18 INFO - } 18:29:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:29:18 INFO - Running post-action listener: _resource_record_post_action 18:29:18 INFO - ##### 18:29:18 INFO - ##### Running download-and-extract step. 18:29:18 INFO - ##### 18:29:18 INFO - Running pre-action listener: _resource_record_pre_action 18:29:18 INFO - Running main action method: download_and_extract 18:29:18 INFO - mkdir: /builds/slave/test/build/tests 18:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:18 INFO - https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:21 INFO - Downloaded 1361 bytes. 18:29:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:29:21 INFO - Using the following test package requirements: 18:29:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:29:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'jsshell-linux-x86_64.zip'], 18:29:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:21 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')]} 18:29:21 INFO - https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:22 INFO - Downloaded 22125225 bytes. 18:29:22 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'] 18:29:22 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 18:29:24 INFO - Return code: 0 18:29:24 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 18:29:24 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')]} 18:29:24 INFO - https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:25 INFO - Downloaded 22125225 bytes. 18:29:25 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'] 18:29:25 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 18:29:26 INFO - Return code: 0 18:29:26 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')]} 18:29:26 INFO - https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:29:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:28 INFO - Downloaded 10847584 bytes. 18:29:28 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'] 18:29:28 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 18:29:28 INFO - Return code: 0 18:29: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')]} 18:29:28 INFO - https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSxof3gjTb-peiY_2mLbsg/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 18:29:30 INFO - Downloaded 54086932 bytes. 18:29:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:30 INFO - mkdir: /builds/slave/test/properties 18:29:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:30 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:30 INFO - Contents: 18:29:30 INFO - build_url:https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:31 INFO - Running post-action listener: _resource_record_post_action 18:29:31 INFO - Running post-action listener: set_extra_try_arguments 18:29:31 INFO - ##### 18:29:31 INFO - ##### Running populate-webroot step. 18:29:31 INFO - ##### 18:29:31 INFO - Running pre-action listener: _resource_record_pre_action 18:29:31 INFO - Running main action method: populate_webroot 18:29:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:31 INFO - '--tppagecycles', 18:29:31 INFO - '7'], 18:29:31 INFO - 'tests': ['tsvgm']}}, 18:29:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:29:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:29:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:29:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:29:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'tests': ['damp', 'tps']}, 18:29:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['damp', 'tps']}, 18:29:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:29:31 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['dromaeo_dom']}, 18:29:31 INFO - 'other': {'tests': ['a11yr', 18:29:31 INFO - 'ts_paint', 18:29:31 INFO - 'tpaint', 18:29:31 INFO - 'sessionrestore', 18:29:31 INFO - 'sessionrestore_no_auto_restore', 18:29:31 INFO - 'tabpaint']}, 18:29:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['a11yr', 18:29:31 INFO - 'ts_paint', 18:29:31 INFO - 'tpaint', 18:29:31 INFO - 'sessionrestore', 18:29:31 INFO - 'sessionrestore_no_auto_restore', 18:29:31 INFO - 'tabpaint']}, 18:29:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['a11yr', 18:29:31 INFO - 'ts_paint', 18:29:31 INFO - 'tpaint', 18:29:31 INFO - 'sessionrestore', 18:29:31 INFO - 'sessionrestore_no_auto_restore', 18:29:31 INFO - 'tabpaint']}, 18:29:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['a11yr', 18:29:31 INFO - 'ts_paint', 18:29:31 INFO - 'tpaint', 18:29:31 INFO - 'sessionrestore', 18:29:31 INFO - 'sessionrestore_no_auto_restore', 18:29:31 INFO - 'tabpaint']}, 18:29:31 INFO - 'other_l64': {'tests': ['a11yr', 18:29:31 INFO - 'ts_paint', 18:29:31 INFO - 'tpaint', 18:29:31 INFO - 'sessionrestore', 18:29:31 INFO - 'sessionrestore_no_auto_restore', 18:29:31 INFO - 'tabpaint']}, 18:29:31 INFO - 'other_nol64': {'tests': ['a11yr', 18:29:31 INFO - 'ts_paint', 18:29:31 INFO - 'tpaint', 18:29:31 INFO - 'sessionrestore', 18:29:31 INFO - 'sessionrestore_no_auto_restore', 18:29:31 INFO - 'tabpaint']}, 18:29:31 INFO - 'svgr': {'tests': ['tsvgx', 18:29:31 INFO - 'tsvgr_opacity', 18:29:31 INFO - 'tart', 18:29:31 INFO - 'tscrollx', 18:29:31 INFO - 'cart']}, 18:29:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['tsvgx', 18:29:31 INFO - 'tsvgr_opacity', 18:29:31 INFO - 'tart', 18:29:31 INFO - 'tscrollx', 18:29:31 INFO - 'cart']}, 18:29:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'tests': ['tp5o']}, 18:29:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'talos_options': ['--e10s'], 18:29:31 INFO - 'tests': ['tp5o']}, 18:29:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'talos_options': ['--xperf_path', 18:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:31 INFO - 'tests': ['tp5n']}, 18:29:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:31 INFO - 'talos_options': ['--e10s', 18:29:31 INFO - '--xperf_path', 18:29:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:31 INFO - 'tests': ['tp5n']}}, 18:29:31 INFO - 'talos.zip': {'path': '', 18:29:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:31 INFO - Running post-action listener: _resource_record_post_action 18:29:31 INFO - ##### 18:29:31 INFO - ##### Running create-virtualenv step. 18:29:31 INFO - ##### 18:29:31 INFO - Running pre-action listener: _resource_record_pre_action 18:29:31 INFO - Running main action method: create_virtualenv 18:29:31 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:31 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 18:29:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:31 INFO - Using real prefix '/usr' 18:29:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:33 INFO - Installing pip.................done. 18:29:33 INFO - Return code: 0 18:29:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:29:33 INFO - Using env: {'DISPLAY': ':0', 18:29:33 INFO - 'HOME': '/home/cltbld', 18:29:33 INFO - 'LANG': 'en_US.UTF-8', 18:29:33 INFO - 'LANGUAGE': 'en_US:en', 18:29:33 INFO - 'LOGNAME': 'cltbld', 18:29:33 INFO - 'MAIL': '/var/mail/cltbld', 18:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:33 INFO - 'MOZ_NO_REMOTE': '1', 18:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:33 INFO - 'NO_EM_RESTART': '1', 18:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:33 INFO - 'PWD': '/builds/slave/test', 18:29:33 INFO - 'SHELL': '/bin/bash', 18:29:33 INFO - 'SHLVL': '1', 18:29:33 INFO - 'TERM': 'linux', 18:29:33 INFO - 'TMOUT': '86400', 18:29:33 INFO - 'USER': 'cltbld', 18:29:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:33 INFO - '_': '/tools/buildbot/bin/python'} 18:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:34 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 18:29:34 INFO - Cleaning up... 18:29:34 INFO - Return code: 0 18:29:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:29: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')]} 18:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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')]} 18:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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', '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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29: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', 'psutil>=0.7.1'] in /builds/slave/test/build 18:29: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 psutil>=0.7.1 18:29:34 INFO - Using env: {'DISPLAY': ':0', 18:29:34 INFO - 'HOME': '/home/cltbld', 18:29:34 INFO - 'LANG': 'en_US.UTF-8', 18:29:34 INFO - 'LANGUAGE': 'en_US:en', 18:29:34 INFO - 'LOGNAME': 'cltbld', 18:29:34 INFO - 'MAIL': '/var/mail/cltbld', 18:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:34 INFO - 'MOZ_NO_REMOTE': '1', 18:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:34 INFO - 'NO_EM_RESTART': '1', 18:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:34 INFO - 'PWD': '/builds/slave/test', 18:29:34 INFO - 'SHELL': '/bin/bash', 18:29:34 INFO - 'SHLVL': '1', 18:29:34 INFO - 'TERM': 'linux', 18:29:34 INFO - 'TMOUT': '86400', 18:29:34 INFO - 'USER': 'cltbld', 18:29:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:34 INFO - '_': '/tools/buildbot/bin/python'} 18:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:34 INFO - Downloading/unpacking psutil>=0.7.1 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:36 INFO - Installing collected packages: psutil 18:29:36 INFO - Running setup.py install for psutil 18:29:36 INFO - building 'psutil._psutil_linux' extension 18:29:36 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 18:29:36 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 18:29:36 INFO - building 'psutil._psutil_posix' extension 18:29:36 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 18:29:36 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 18:29:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:36 INFO - Successfully installed psutil 18:29:36 INFO - Cleaning up... 18:29:36 INFO - Return code: 0 18:29:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:29:36 INFO - Using env: {'DISPLAY': ':0', 18:29:36 INFO - 'HOME': '/home/cltbld', 18:29:36 INFO - 'LANG': 'en_US.UTF-8', 18:29:36 INFO - 'LANGUAGE': 'en_US:en', 18:29:36 INFO - 'LOGNAME': 'cltbld', 18:29:36 INFO - 'MAIL': '/var/mail/cltbld', 18:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:36 INFO - 'MOZ_NO_REMOTE': '1', 18:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:36 INFO - 'NO_EM_RESTART': '1', 18:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:36 INFO - 'PWD': '/builds/slave/test', 18:29:36 INFO - 'SHELL': '/bin/bash', 18:29:36 INFO - 'SHLVL': '1', 18:29:36 INFO - 'TERM': 'linux', 18:29:36 INFO - 'TMOUT': '86400', 18:29:36 INFO - 'USER': 'cltbld', 18:29:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:36 INFO - '_': '/tools/buildbot/bin/python'} 18:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:29:37 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 18:29:37 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 18:29:37 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 18:29:37 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 18:29:37 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 18:29:37 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 18:29:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:29:39 INFO - Installing collected packages: mozsystemmonitor 18:29:39 INFO - Running setup.py install for mozsystemmonitor 18:29:39 INFO - Successfully installed mozsystemmonitor 18:29:39 INFO - Cleaning up... 18:29:39 INFO - Return code: 0 18:29:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:39 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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:39 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 18:29:39 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 18:29:39 INFO - Using env: {'DISPLAY': ':0', 18:29:39 INFO - 'HOME': '/home/cltbld', 18:29:39 INFO - 'LANG': 'en_US.UTF-8', 18:29:39 INFO - 'LANGUAGE': 'en_US:en', 18:29:39 INFO - 'LOGNAME': 'cltbld', 18:29:39 INFO - 'MAIL': '/var/mail/cltbld', 18:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:39 INFO - 'MOZ_NO_REMOTE': '1', 18:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:39 INFO - 'NO_EM_RESTART': '1', 18:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:39 INFO - 'PWD': '/builds/slave/test', 18:29:39 INFO - 'SHELL': '/bin/bash', 18:29:39 INFO - 'SHLVL': '1', 18:29:39 INFO - 'TERM': 'linux', 18:29:39 INFO - 'TMOUT': '86400', 18:29:39 INFO - 'USER': 'cltbld', 18:29:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:39 INFO - '_': '/tools/buildbot/bin/python'} 18:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:29:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:29:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:41 INFO - Downloading docopt-0.6.1.tar.gz 18:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:29:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:29:42 INFO - Running setup.py install for blobuploader 18:29:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:29:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:29:42 INFO - Running setup.py install for requests 18:29:42 INFO - Running setup.py install for docopt 18:29:42 INFO - Successfully installed blobuploader requests docopt 18:29:42 INFO - Cleaning up... 18:29:42 INFO - Return code: 0 18:29:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:42 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')]} 18:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:42 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')]} 18:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:42 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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:42 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 18:29:42 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 18:29:42 INFO - Using env: {'DISPLAY': ':0', 18:29:42 INFO - 'HOME': '/home/cltbld', 18:29:42 INFO - 'LANG': 'en_US.UTF-8', 18:29:42 INFO - 'LANGUAGE': 'en_US:en', 18:29:42 INFO - 'LOGNAME': 'cltbld', 18:29:42 INFO - 'MAIL': '/var/mail/cltbld', 18:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:42 INFO - 'MOZ_NO_REMOTE': '1', 18:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:42 INFO - 'NO_EM_RESTART': '1', 18:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:42 INFO - 'PWD': '/builds/slave/test', 18:29:42 INFO - 'SHELL': '/bin/bash', 18:29:42 INFO - 'SHLVL': '1', 18:29:42 INFO - 'TERM': 'linux', 18:29:42 INFO - 'TMOUT': '86400', 18:29:42 INFO - 'USER': 'cltbld', 18:29:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:42 INFO - '_': '/tools/buildbot/bin/python'} 18:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:42 INFO - Running setup.py (path:/tmp/pip-h91NAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:42 INFO - Running setup.py (path:/tmp/pip-T97nJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:43 INFO - Running setup.py (path:/tmp/pip-vcdd0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:43 INFO - Running setup.py (path:/tmp/pip-1jyU59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:43 INFO - Running setup.py (path:/tmp/pip-Esa8Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:43 INFO - Running setup.py (path:/tmp/pip-Eq9NHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:43 INFO - Running setup.py (path:/tmp/pip-R6WXsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:43 INFO - Running setup.py (path:/tmp/pip-dCVBcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:43 INFO - Running setup.py (path:/tmp/pip-OZiTer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:43 INFO - Running setup.py (path:/tmp/pip-Sme4nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:43 INFO - Running setup.py (path:/tmp/pip-e3ZSoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:43 INFO - Running setup.py (path:/tmp/pip-2R1fYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:43 INFO - Running setup.py (path:/tmp/pip-1V2oyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:43 INFO - Running setup.py (path:/tmp/pip-ogQFl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:43 INFO - Running setup.py (path:/tmp/pip-VILoHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:43 INFO - Running setup.py (path:/tmp/pip-4iDN40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:44 INFO - Running setup.py (path:/tmp/pip-eJuxlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:29:44 INFO - Running setup.py install for manifestparser 18:29:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Running setup.py install for mozcrash 18:29:44 INFO - Running setup.py install for mozdebug 18:29:44 INFO - Running setup.py install for mozdevice 18:29:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Running setup.py install for mozfile 18:29:44 INFO - Running setup.py install for mozhttpd 18:29:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Running setup.py install for mozinfo 18:29:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Running setup.py install for mozInstall 18:29:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:29:44 INFO - Running setup.py install for mozleak 18:29:44 INFO - Running setup.py install for mozlog 18:29:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Running setup.py install for moznetwork 18:29:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Running setup.py install for mozprocess 18:29:45 INFO - Running setup.py install for mozprofile 18:29:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Running setup.py install for mozrunner 18:29:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Running setup.py install for mozscreenshot 18:29:45 INFO - Running setup.py install for moztest 18:29:45 INFO - Running setup.py install for mozversion 18:29:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:29:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:29:45 INFO - Cleaning up... 18:29:45 INFO - Return code: 0 18:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:45 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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:45 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 18:29:45 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 18:29:45 INFO - Using env: {'DISPLAY': ':0', 18:29:45 INFO - 'HOME': '/home/cltbld', 18:29:45 INFO - 'LANG': 'en_US.UTF-8', 18:29:45 INFO - 'LANGUAGE': 'en_US:en', 18:29:45 INFO - 'LOGNAME': 'cltbld', 18:29:45 INFO - 'MAIL': '/var/mail/cltbld', 18:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:45 INFO - 'MOZ_NO_REMOTE': '1', 18:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:45 INFO - 'NO_EM_RESTART': '1', 18:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:45 INFO - 'PWD': '/builds/slave/test', 18:29:45 INFO - 'SHELL': '/bin/bash', 18:29:45 INFO - 'SHLVL': '1', 18:29:45 INFO - 'TERM': 'linux', 18:29:45 INFO - 'TMOUT': '86400', 18:29:45 INFO - 'USER': 'cltbld', 18:29:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:45 INFO - '_': '/tools/buildbot/bin/python'} 18:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:46 INFO - Running setup.py (path:/tmp/pip-vr5XeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:46 INFO - Running setup.py (path:/tmp/pip-Dib3AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:46 INFO - Running setup.py (path:/tmp/pip-M0800f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:46 INFO - Running setup.py (path:/tmp/pip-aqCEfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:46 INFO - Running setup.py (path:/tmp/pip-PBhJza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:46 INFO - Running setup.py (path:/tmp/pip-wJ15Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:46 INFO - Running setup.py (path:/tmp/pip-LlKxuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:46 INFO - Running setup.py (path:/tmp/pip-nIMwLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:46 INFO - Running setup.py (path:/tmp/pip-DyzGtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:46 INFO - Running setup.py (path:/tmp/pip-dd6eUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:46 INFO - Running setup.py (path:/tmp/pip-2R0EPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:46 INFO - Running setup.py (path:/tmp/pip-oQjyOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:46 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)) 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:46 INFO - Running setup.py (path:/tmp/pip-Naw4b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:47 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)) 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:47 INFO - Running setup.py (path:/tmp/pip-e3pO_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:47 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)) 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:47 INFO - Running setup.py (path:/tmp/pip-tbvG7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:47 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)) 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:47 INFO - Running setup.py (path:/tmp/pip-r0OoYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:47 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)) 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:47 INFO - Running setup.py (path:/tmp/pip-k1_ojC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:47 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)) 18:29:47 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)) 18:29:47 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)) 18:29:47 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)) 18:29:47 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)) 18:29:47 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)) 18:29:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:49 INFO - Downloading blessings-1.6.tar.gz 18:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:29:49 INFO - Installing collected packages: blessings 18:29:49 INFO - Running setup.py install for blessings 18:29:49 INFO - Successfully installed blessings 18:29:49 INFO - Cleaning up... 18:29:49 INFO - Return code: 0 18:29:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:49 INFO - Reading from file tmpfile_stdout 18:29:49 INFO - Current package versions: 18:29:49 INFO - argparse == 1.2.1 18:29:49 INFO - blessings == 1.6 18:29:49 INFO - blobuploader == 1.2.4 18:29:49 INFO - docopt == 0.6.1 18:29:49 INFO - manifestparser == 1.1 18:29:49 INFO - mozInstall == 1.12 18:29:49 INFO - mozcrash == 0.17 18:29:49 INFO - mozdebug == 0.1 18:29:49 INFO - mozdevice == 0.48 18:29:49 INFO - mozfile == 1.2 18:29:49 INFO - mozhttpd == 0.7 18:29:49 INFO - mozinfo == 0.9 18:29:49 INFO - mozleak == 0.1 18:29:49 INFO - mozlog == 3.1 18:29:49 INFO - moznetwork == 0.27 18:29:49 INFO - mozprocess == 0.22 18:29:49 INFO - mozprofile == 0.28 18:29:49 INFO - mozrunner == 6.11 18:29:49 INFO - mozscreenshot == 0.1 18:29:49 INFO - mozsystemmonitor == 0.0 18:29:49 INFO - moztest == 0.7 18:29:49 INFO - mozversion == 1.4 18:29:49 INFO - psutil == 3.1.1 18:29:49 INFO - requests == 1.2.3 18:29:49 INFO - wsgiref == 0.1.2 18:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:49 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')]} 18:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 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')]} 18:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:49 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 18:29:49 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 18:29:49 INFO - Using env: {'DISPLAY': ':0', 18:29:49 INFO - 'HOME': '/home/cltbld', 18:29:49 INFO - 'LANG': 'en_US.UTF-8', 18:29:49 INFO - 'LANGUAGE': 'en_US:en', 18:29:49 INFO - 'LOGNAME': 'cltbld', 18:29:49 INFO - 'MAIL': '/var/mail/cltbld', 18:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:49 INFO - 'MOZ_NO_REMOTE': '1', 18:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:49 INFO - 'NO_EM_RESTART': '1', 18:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:49 INFO - 'PWD': '/builds/slave/test', 18:29:49 INFO - 'SHELL': '/bin/bash', 18:29:49 INFO - 'SHLVL': '1', 18:29:49 INFO - 'TERM': 'linux', 18:29:49 INFO - 'TMOUT': '86400', 18:29:49 INFO - 'USER': 'cltbld', 18:29:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:49 INFO - '_': '/tools/buildbot/bin/python'} 18:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 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)) 18:29:49 INFO - Cleaning up... 18:29:49 INFO - Return code: 0 18:29:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:29:49 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')]} 18:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 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')]} 18:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:49 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 18:29:49 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 18:29:49 INFO - Using env: {'DISPLAY': ':0', 18:29:49 INFO - 'HOME': '/home/cltbld', 18:29:49 INFO - 'LANG': 'en_US.UTF-8', 18:29:49 INFO - 'LANGUAGE': 'en_US:en', 18:29:49 INFO - 'LOGNAME': 'cltbld', 18:29:49 INFO - 'MAIL': '/var/mail/cltbld', 18:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:49 INFO - 'MOZ_NO_REMOTE': '1', 18:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:49 INFO - 'NO_EM_RESTART': '1', 18:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:49 INFO - 'PWD': '/builds/slave/test', 18:29:49 INFO - 'SHELL': '/bin/bash', 18:29:49 INFO - 'SHLVL': '1', 18:29:49 INFO - 'TERM': 'linux', 18:29:49 INFO - 'TMOUT': '86400', 18:29:49 INFO - 'USER': 'cltbld', 18:29:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:49 INFO - '_': '/tools/buildbot/bin/python'} 18:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:50 INFO - Downloading/unpacking jsonschema 18:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:29:52 INFO - Downloading/unpacking functools32 (from jsonschema) 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:29:52 INFO - warning: no files found matching '*.txt' 18:29:52 INFO - no previously-included directories found matching 'build' 18:29:52 INFO - no previously-included directories found matching 'dist' 18:29:52 INFO - no previously-included directories found matching '.git*' 18:29:52 INFO - Installing collected packages: jsonschema, functools32 18:29:52 INFO - Running setup.py install for functools32 18:29:52 INFO - warning: no files found matching '*.txt' 18:29:52 INFO - no previously-included directories found matching 'build' 18:29:52 INFO - no previously-included directories found matching 'dist' 18:29:52 INFO - no previously-included directories found matching '.git*' 18:29:52 INFO - Successfully installed jsonschema functools32 18:29:52 INFO - Cleaning up... 18:29:52 INFO - Return code: 0 18:29:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:29:52 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')]} 18:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:52 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')]} 18:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:52 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 0x7fddc4fc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', '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 18:29:52 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 18:29:52 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 18:29:52 INFO - Using env: {'DISPLAY': ':0', 18:29:52 INFO - 'HOME': '/home/cltbld', 18:29:52 INFO - 'LANG': 'en_US.UTF-8', 18:29:52 INFO - 'LANGUAGE': 'en_US:en', 18:29:52 INFO - 'LOGNAME': 'cltbld', 18:29:52 INFO - 'MAIL': '/var/mail/cltbld', 18:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:52 INFO - 'MOZ_NO_REMOTE': '1', 18:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:52 INFO - 'NO_EM_RESTART': '1', 18:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:52 INFO - 'PWD': '/builds/slave/test', 18:29:52 INFO - 'SHELL': '/bin/bash', 18:29:52 INFO - 'SHLVL': '1', 18:29:52 INFO - 'TERM': 'linux', 18:29:52 INFO - 'TMOUT': '86400', 18:29:52 INFO - 'USER': 'cltbld', 18:29:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:52 INFO - '_': '/tools/buildbot/bin/python'} 18:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:52 INFO - Downloading/unpacking flake8 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 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 18:29:52 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 18:29:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:29:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:29:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:29:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:29:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:29:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:29:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:29:55 INFO - no previously-included directories found matching 'docs/_build' 18:29:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:29:55 INFO - Running setup.py install for pep8 18:29:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:29:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:29:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:29:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:29:55 INFO - no previously-included directories found matching 'docs/_build' 18:29:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:29:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:29:55 INFO - Cleaning up... 18:29:55 INFO - Return code: 0 18:29:55 INFO - Running post-action listener: _resource_record_post_action 18:29:55 INFO - Running post-action listener: _start_resource_monitoring 18:29:55 INFO - Starting resource monitoring. 18:29:55 INFO - ##### 18:29:55 INFO - ##### Running install step. 18:29:55 INFO - ##### 18:29:55 INFO - Running pre-action listener: _resource_record_pre_action 18:29:55 INFO - Running main action method: install 18:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:55 INFO - Reading from file tmpfile_stdout 18:29:55 INFO - Detecting whether we're running mozinstall >=1.0... 18:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:29:55 INFO - Reading from file tmpfile_stdout 18:29:55 INFO - Output received: 18:29:55 INFO - Usage: mozinstall [options] installer 18:29:55 INFO - Options: 18:29:55 INFO - -h, --help show this help message and exit 18:29:55 INFO - -d DEST, --destination=DEST 18:29:55 INFO - Directory to install application into. [default: 18:29:55 INFO - "/builds/slave/test"] 18:29:55 INFO - --app=APP Application being installed. [default: firefox] 18:29:55 INFO - mkdir: /builds/slave/test/build/application 18:29:55 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'] 18:29:55 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 18:30:11 INFO - Reading from file tmpfile_stdout 18:30:11 INFO - Output received: 18:30:11 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:11 INFO - Running post-action listener: _resource_record_post_action 18:30:11 INFO - ##### 18:30:11 INFO - ##### Running run-tests step. 18:30:11 INFO - ##### 18:30:11 INFO - Running pre-action listener: _resource_record_pre_action 18:30:11 INFO - Running main action method: run_tests 18:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:11 INFO - Python 2.7.3 18:30:11 INFO - Return code: 0 18:30:11 INFO - grabbing minidump binary from tooltool 18:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:11 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 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:11 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 18:30:11 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 18:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:11 INFO - Return code: 0 18:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:30:12 INFO - Return code: 0 18:30:12 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/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:30:12 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/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 18:30:12 INFO - Using env: {'DISPLAY': ':0', 18:30:12 INFO - 'HOME': '/home/cltbld', 18:30:12 INFO - 'LANG': 'en_US.UTF-8', 18:30:12 INFO - 'LANGUAGE': 'en_US:en', 18:30:12 INFO - 'LOGNAME': 'cltbld', 18:30:12 INFO - 'MAIL': '/var/mail/cltbld', 18:30:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:12 INFO - 'MOZ_NO_REMOTE': '1', 18:30:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:12 INFO - 'NO_EM_RESTART': '1', 18:30:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:12 INFO - 'PWD': '/builds/slave/test', 18:30:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:12 INFO - 'SHELL': '/bin/bash', 18:30:12 INFO - 'SHLVL': '1', 18:30:12 INFO - 'TERM': 'linux', 18:30:12 INFO - 'TMOUT': '86400', 18:30:12 INFO - 'USER': 'cltbld', 18:30:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161', 18:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:12 INFO - '_': '/tools/buildbot/bin/python'} 18:30:12 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/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:30:12 INFO - mozversion application_buildid: 20160404175051 18:30:12 INFO - mozversion application_changeset: 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 18:30:12 INFO - mozversion application_display_name: Nightly 18:30:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:12 INFO - mozversion application_name: Firefox 18:30:12 INFO - mozversion application_remotingname: firefox 18:30:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:30:12 INFO - mozversion application_vendor: Mozilla 18:30:12 INFO - mozversion application_version: 48.0a1 18:30:12 INFO - mozversion platform_buildid: 20160404175051 18:30:12 INFO - mozversion platform_changeset: 7eebd9f0738af3900c95d8583ab54d6166a9b1d2 18:30:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:30:12 INFO - mozversion platform_version: 48.0a1 18:30:12 INFO - using testdate: 1459819812 18:30:12 INFO - actual date: 1459819812 18:30:12 INFO - starting webserver on 'localhost:54058' 18:30:12 INFO - SUITE-START | Running 2 tests 18:30:12 INFO - TEST-START | dromaeo_css 18:30:12 INFO - operating with platform_type : linux_ 18:30:12 INFO - Initialising browser for dromaeo_css test... 18:30:12 INFO - TEST-INFO | started process 1367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgeasH/profile http://localhost:54058/getInfo.html) 18:30:17 INFO - PROCESS | 1367 | __metrics Screen width/height:1600/1200 18:30:17 INFO - PROCESS | 1367 | colorDepth:24 18:30:17 INFO - PROCESS | 1367 | Browser inner width/height: 1024/697 18:30:17 INFO - PROCESS | 1367 | __metrics 18:30:17 ERROR - PROCESS | 1367 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:30:18 INFO - TEST-INFO | 1367: exit 0 18:30:18 INFO - Browser initialized. 18:30:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:18 INFO - TEST-INFO | started process 1450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplgeasH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:30 INFO - PROCESS | 1450 | RSS: Main: 154046464 18:30:30 INFO - PROCESS | 1450 | 18:31:21 INFO - PROCESS | 1450 | 1459819881552 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] 18:33:32 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:54058/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54058/tests/dromaeo/cssquery-ext.html) 18:33:33 INFO - PROCESS | 1450 | RSS: Main: 231194624 18:33:33 INFO - PROCESS | 1450 | 18:36:35 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:54058/tests/dromaeo/cssquery-ext.html (next: http://localhost:54058/tests/dromaeo/cssquery-jquery.html) 18:36:36 INFO - PROCESS | 1450 | RSS: Main: 235954176 18:36:36 INFO - PROCESS | 1450 | 18:39:38 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:54058/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54058/tests/dromaeo/cssquery-mootools.html) 18:39:38 INFO - PROCESS | 1450 | RSS: Main: 232841216 18:39:38 INFO - PROCESS | 1450 | 18:42:40 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:54058/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54058/tests/dromaeo/cssquery-prototype.html) 18:42:41 INFO - PROCESS | 1450 | RSS: Main: 218411008 18:42:41 INFO - PROCESS | 1450 | 18:45:44 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:54058/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54058/tests/dromaeo/cssquery-yui.html) 18:45:44 INFO - PROCESS | 1450 | RSS: Main: 221503488 18:45:44 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:54058/tests/dromaeo/cssquery-yui.html (next: http://localhost:54058/tests/dromaeo/cssquery-dojo.html) 18:48:47 INFO - PROCESS | 1450 | RSS: Main: 262815744 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | __start_tp_report 18:48:47 INFO - PROCESS | 1450 | _x_x_mozilla_page_load 18:48:47 INFO - PROCESS | 1450 | _x_x_mozilla_page_load_details 18:48:47 INFO - PROCESS | 1450 | |i|pagename|runs| 18:48:47 INFO - PROCESS | 1450 | |0;dojo.html;2575.8712064396777;2650.1651979626427;2655.96016059759;2668;2688.4891870544593;4526.140033393653;4534.2518484450065;4536.546345365462;4554.453465584126;4578.221702310607;4537.387452693885;4567.566081222279;4603.976980115103;4678.064387122572;4684.976575117128;4182.581741825816;4185.183889141618;4225;4251.3622956556455;4388.802503887333;4261.275583150857;4345.674074444413;4347.826086956518;4359.280718681413;4372.672049596277;4087.2847251730827;4159.085001299709;4191.455110835572;4264.211120942605;4265.445492086009;4234.237837189305;4235.618794308527;4237.237297286487;4265.936010959838;4276.166147601219;4207.621314081717;4222.303319952204;4234.91530169398;4260.105377870651;4264.33902745075;4366.323219900889;4435.578620031092;4493.168763778679;4522.570355816192;4535.682502224846;4854.417469903598;4886.560209581155;4887.902241955177;4927.48261432548;4929.531694489054;4867.440244371907;4882.755862206911;4885.902281954376;4894.1679914414635;4968.726720030397;4496.392986946753;4497.955020449786;4578.702384345007;4616.238320677118;4620.306953956866;4998.100341938486;5000.1249781288125;5012.749362531932;5022.974885125551;5072.746362681851;4564.543545645409;4810.879728006757;4811.206150985118;4818.855434336975;4866.367372241657;4854.757262136879;4856.3201151838775;4856.368672072608;4891.217405215149;4910.140725373046;4836.322914791932;4874.122657921608;4877.341558889575;4878.829240976549;4927.704337739747;4752.42970843501;4782.880427989328;4863.221884498464;4867.440244371872;4913.263010548375;3895.7272990890365;3897.1036661567996;3916.060145565101;3930.4104384342577;3933.92132157361;3437.845296961643;3469.7224222062678;3475.7740746851373;3497.527833742463;3505.8422370993367;4105.774182419936;4183.037901282662;4197.496300443905;4224.51418086924;4282;4951.3810773653295;4963.6525443218625;4963.900721985612;4967.552920237196;5022.372203474566;4209.810558524874;4253.893652658647;4255.829766809293;4275.230458517497;4303.354496825438;4347.456567929009;4453.732776033448;4518.841840535565;4519.480259770168;4527.773611319487;4684.320773487893;4709.7174169549935;4711.505291944365;4739;4759.190937540696;4966.379202599675;4968.254761785761;4969.82605608802;4971;5030.346055012825;4548.4541854977615;4641.976790116028;4715.976420117878;4716.198246298206;4725.5983241424865;4855.8057677692495;4860.805567777391;4875.1712208923855;4875.390576177978;4923.630727695366;4932.2355034968205;4939.456659767495;4944.28307895346;4950.579200767975;4993.875153121201;4691.225947718588;4720.598749106364;4750.762461876823;4787.928181077356;4795.856124316276;4748.31149483316;4754.263089221176;4766.356541866804;4773.928391074067;4813.566778989908;4576.084783043338;4715.151272770934;4715.905681886412;4722.645801564965;4766.880827979328;4695.225287827607;4723.905521889612;4766.594839438687;4801.975990120167;4805.7597120143155;4590.2426099693175;4591.563801438858;4596.954030459653;4599.356090147315;4641.837535686234 18:48:47 INFO - PROCESS | 1450 | |1;ext.html;505.1261317919996;535.4458135829416;546.6364867363204;549.6235078970906;558.408087427327;26638.4672306554;34472.655273447286;34890.825545872234;34921.30157396851;34972.47541286883;37044.25911481769;37167;37445.62554374456;37494.43758343627;37526.24947501048;7668.846623067521;7847.254510821463;7856.842863142734;7860.449768516206;7868.645910934022;7761.844763104735;7886.487378320419;7890.921090789105;7894.6052697365185;8077.798055048612;8042.396820238476;8098.190180981914;8104.230098140697;8122.106568277485;8139.593020348959;7942.920570794276;8010.599470026505;8017.67929282828;8023.799405014921;8035.075966263896;7905.221325201841;8027.076886158108;8028;8037.638306276232;8037.799055023613;37946.62053379459;38329.42505862414;38390.23219535621;38427.8078609608;38454.23091538181;2828.3353411948174;2961.3633068890076;2969.6139501864836;3175.1744546417867;3594.4608308753636;28508.857455712798;28841.711582884112;29624.555631665542;29711.554326685116;30325;3477.826108694555;3482.039225023044;3529.188286694049;3575.6070118141392;3586.7489275750445;235320;236298.8185059081;236378;236419;237067;48005;54405.45594544004;55440.16839747407;55478;56607.43392566104;51693.74153129286;52071.479285207424;52094.47905520972;52377.476225238024;52382.476175238524;13811.723765524634;14021.439142434188;14022.265658196553;14028;14034.929825350808;8775.254103401283;10595.364278143183;10603.522841472151;10681.145508359312;10965.396903170402;18583.535411614546;18636.813631863508;18698.532536686693;18698.81301186998;18771.24915003412;6424.74301027963;6746.321142069316;6796.4562834973085;6864.828379290458;6918.238993710688;883.1565854608833;912.2519533982204;933.332667142996;947.966821161256;1052.231870734353;26533.601995970075;26567;26847.10716946032;27071.72928270692;27224.59163112555;979.4515071559807;1000.2048371544639;1018.511114664965;1034.9301397205588;1069.9728260869651;13599.932000339935;14000.509982150576;14071.2964351782;14156.36296366666;14222.217778022308;134024.32987835;135456;135660;135725;135847;47104.29343559849;47598.5240147601;47611.761941190074;47683;47707.045859082624;1077.946102694862;1222.4865556466304;1245.0910835090435;1251.8998480121568;1257.5032862019268;24984;26511.469770604093;26514.602280965417;26794.59808102841;26897.86551067232;37772.43341349827;38078.428823568225;38458.23083538258;38477.422838658;38501;204106;205356;205356;205862;206153;29131.417371652024;30262.54606180865;30605.23486912756;30660.080197594107;30673.233169170948;38471.615283846804;38602.8419147426;38637.2272554553;39019;39082.80458597689;33021.17447063843;33027.33945321032;33185.170370740925;33198.668013319555;33252.33495330128;32347.67652323541;32688.182795430304;32708.83645581852;33121.668783311856;33250.16874578155;29610.851945740997;29655;29662.406751865274;30700.232494187825;33036.834815825765;28986.13041608755;29405.264868377606;29450.558241626823;29712.40575188441;29776.85111574428;23653.408664783517;23714.762852371947;23868.93697177017;23893.522129556965;24072.87963560171 18:48:47 INFO - PROCESS | 1450 | |2;jquery.html;333.36993083073014;345.1922501346848;345.4334890779122;354.4222916645867;356.17723059732003;14673.926630366846;15404.460843870453;15962.680746385066;16039.438619648314;16102;15470.071795692267;15742.134182619951;17820.554486137855;17831.37590184344;18086;5394.595405344595;5457.345118585776;5631.239782629354;5633;5649.717514124298;5537.58468114891;5591.832245032656;5614.29821272341;5634.098544232924;5635.690037047961;5538.529225015878;5597.160425936122;5607.887842243153;5609.270794796671;5617.185508101323;5489.286392768934;5617.691026993513;5650.3219613646215;5667.518260947824;5675.148727690838;5417.51486847885;5457.645253058538;5468.56251499883;5472.2338872557875;5484.890302193974;21879.890600547056;22044.448888777748;22443;22613.095476180933;23238.65142022871;1963.7741659709031;2021.1915233906554;2029.370895022533;2040.6224848402944;2165.404513758713;13834.23911684857;13853.861461385459;14137.293135343192;14294.213818240096;14872.182029988346;1867.6451474219855;1892.6687829629898;1909.6276226135908;1929.7684277886603;1948.162290215207;48918.26622600628;51403;52973.47026529763;67730.3226967729;70450.64774676145;14518.564443066725;14659.216094830395;15201.838529176835;15297.9235103826;15374.615634609001;25398.492030159294;25596.8720156398;25741.613875791878;25783.097591584203;25798.87100564485;7211.675474603656;7885.645145968445;8221.424500284922;8387;8719.651213951498;6707;6987.161540615159;7061.611611361322;7104.893426598605;7121.608311542915;7316.487845850846;7528.33163128716;7644.388448924073;7656.73201437947;7797.961010195027;3031.5604237385455;3071.9385612288074;3117.7177986357506;3121.360121175199;3188.4579621463945;838.9286910612544;872.842888280103;895.1630225738955;924.0574613893791;925.0934084596998;15664.765028524582;15736.606584835241;15966;16088.195590220443;16102.75845862313;836.7029704454952;868.1925808997693;896.1979028769215;911.5168960450972;920.8940971788196;9008.369414141078;9033.77415564616;9185.586648600829;9264.536773161315;9420.24638028956;306594;399576;401731;402994;408164;69665;70246;71073;71703.6414817933;72948.63525682337;954.0888451528773;976.5556671714353;978.8596285327656;987.8913319534845;991.9156871665845;11679.649610511698;14451.205183714997;14823.481178158712;14859.554213373616;15056;33206.33587328192;33236.83381583077;34669;34846.47730283997;35042.649573503935;42946.35580466358;44233;44352.334714979945;44383;45466.77266613646;7398.3353745409;7482.812929676802;7498.212687667717;7658.195889431529;7667.233276672288;9575.377600455948;11636.709082273012;11787.11596630239;11811.527538898348;11828.585999489977;10211.387316760722;10354.637587684394;10395.58417663285;10521.631742888962;10528.157572424641;5825.737841797045;7371.152317483344;10355.637552685921;10377.792444150924;10405.011523905217;10339.224558158017;10508.264421490729;10517.421541815274;10686.83969740439;10763.784724305626;7521.5111017783665;7652.885206721792;7673.846523069619;7753.689852405841;7784;10175.338602990782;10330.48347582633;10484.947575262075;10604.098651614391;10637.627683031056 18:48:47 INFO - PROCESS | 1450 | |3;mootools.html;1383.827021622297;1397.050005995923;1510.9546713598588;1710.9059001754913;1763.3475614022805;6846.82882927927;6978.1975072866635;7014.193367762702;7015.684294206761;7029.894551581724;6217.751289948408;6874.48441366897;6911.965440172792;7010.719571217158;7020.648967551615;2199.626063569197;2207.249535158046;2232.4195709115584;2234.7876951689564;2235.1282999630157;1906.961860762784;2180.1824315881545;2193.7148170737782;2212;2221.6334304839684;2118.353902059871;2167.024838822528;2174.8695078295355;2176.934691959236;2178.8039076483115;2137.8075973162336;2162.3188695560925;2168.718066651333;2182.410749097751;2191.3316438486254;2110.9894450527804;2124.8193903518218;2125.1818050050842;2126.075157306577;2129.1909074551727;6965.373116419547;7112.893306600405;7125.465590080713;7144.8928266076055;7145.1068616422945;4445.644348452116;4529.343245229456;4537.137943790669;4552.863414097583;4554.567316104998;2901.9854900725572;2969.8515074246416;2999.040307101728;3045.101694999958;3051.1761824307537;970.8106919150769;974.1914211204684;983.1348413396165;1005.6379703306803;1023.1303392116715;9858.80282394348;9859.112679858847;9866;9874.111329980336;9888.604455821758;3983.9601603983588;4016.7589944602832;4119.732217405859;4146.834126634901;4157.542670306264;8526.65893364271;8572.142785721502;8580.099089595627;8580.485170889766;8594.441361311494;4542.659300552472;4556.681032327705;4564.497905230422;4584.495705472462;4588.426446694163;4138.896527586834;4158.251514727318;4173.10278290163;4179.205950869386;4180.080382315886;3358.8320583970703;3464.705500032475;3472.7569070164845;3499.055255081114;3504.3867323218847;1031.3554028732042;1059.5814653212092;1139.0261326565667;1140.971475713097;1157.739508610556;922.4004397141778;924.1867156901883;935.1350001248818;935.2284365398438;992.1318846009741;6503.739850405931;6564.606123632598;6615.503837212228;6646.302138275508;6668.266490686021;1032.6747074671605;1051.5530899367739;1059.4067322299536;1061.5010944855906;1079.7259234103676;4747.169245382044;4747.335373047776;4767.809287628525;4801.927971080437;4805.67843842939;8258.793530161674;8357.540335281617;8442.366822488339;8492.787680308042;8523.232909038215;8399.496030238206;8413.915860841436;8435.114312997048;8472.830543389098;8478.957605211934;6712.53012289135;6772.525923185428;6791.524593278522;6875.656217189221;6884.690188941509;6378.075179099097;6450.129232553733;6460.806175814733;6478.1578394808375;6484.1246431733;7554.320111190019;7624.161342252459;7736.535807851547;7739.651715672921;7758.107817601048;7594.772156835304;7791.337736292252;7883.2905038546805;7908.802279943047;7933.761987140395;6221.471174949999;6267.341929097562;6319.9052014218905;6330.3669633036325;6348.77779277723;6635.104260924713;6657.367550082734;6704.530682852153;6706.597604143767;6716.227633822173;6112.266528016667;6145.539084568586;6209.099680546386;6292.056191571301;6328.462080723006;6305.211848518935;6325.652089135142;6334.271558770616;6397.712102955285;6415.871682566416;6443.194600674916;6482.060101285193;6493.480521558169;6497.967510162419;6528.249251336157;6024.457798797954;6145.723442445012;6159.96920015415;6179.660118693515;6188.009918413032;6112.755489780359;6123.8162855114415;6225.501959843111;6246.3753624637175;6255.812325630239 18:48:47 INFO - PROCESS | 1450 | |4;prototype.html;309.6794817364028;311.3492800047901;311.7848684407758;312.9139486641174;316.60266365711027;5249.580033597313;5284.8150314739;5368.489993450626;5375.3280839895015;5381.165919282513;5201.661891977019;5335.546478549328;5363.088274993251;5364.624476286662;5373.086575282202;3922.901927451808;3974.9006274843214;4065.715399922007;4088.08018195905;4092.26339258934;4080.367543030835;4084.346504559271;4089.018635527482;4091.9181616367655;4096.815643296044;4047.0489434982755;4060.7969601519953;4066.3087275163293;4068.1456894052285;4073.7555746655294;3866.28473732359;3955.940660890089;4041.9191616167805;4046.271671099201;4072.857449989251;3503.2643144939593;3505.877294294713;3507.2985402919517;3519.436890097598;3524.9647503524893;5076.923846142311;5100.668456550312;5105.566026887719;5107.540321371057;5120.871978200575;4664.277037059262;4665.486796452387;4669.32294817253;4669.719816811003;4678.649101317381;5555.138953462179;5564.443555644443;5564.721763911788;5565.888682226333;5613.607047506676;3891.5330160380654;3903.0242439390154;3903.2974064668347;3907.33575292201;3909;5649.8587535311535;5836.562257830679;5843.8539036524;5909.084091965709;5966.075258334921;3904.8047597620007;3911.9022024449046;3937.9803100984313;3947.50656167979;3948.447217389568;3977.105151340925;3995.2409042281874;3997.700172487075;4002.239574480839;4010.7994600270454;4619.976900115478;4621.907561848811;4622.930656040162;4623.953760462419;4625.306204069417;5600.551955843523;5612.971935140298;5629.662220266797;5630.690312032795;5640.182173584807;1383.3359987205997;1410.5063227870164;1411.5835828430431;1413.9151650900978;1415.7451658701532;905.6241659711146;912.3750231091724;936.1247233836385;947.2381370650585;950.9381890177116;4837.927431088537;4849.612031037508;4871.780769865364;4910.238912968495;4948.975255123773;5780.364159942403;5783.248177736868;5785.537157027427;5793.333766616893;5793.971030144822;4882;4882.414110306786;4883.4628190898975;4892.192788189909;4893.535114164149;3070.4319700854967;3107.673694262115;3112.2686168750324;3115.252339438564;3115.9532607010915;5482.095454250084;5484.506394424441;5485.149801780731;5485.424030476823;5487.314085739283;5706.572007099484;5873.060310350324;5896.498797602166;5922.082077278029;5934.940650593525;5447.809326673627;5465.562754979592;5474.042042642522;5483.561315094703;5492.093804522209;5764.625299355528;5765.654060756368;5767.5674324425;5774;5775.729339545293;5641.548676105819;5641.8589535261945;5647.802326918538;5648.322201335866;5651.265335506358;5472.890542189054;5473.726313684379;5479.150731636602;5479.205515200353;5480.588955828249;3853.788041657736;3970.285348637273;3984.980075099606;4019.0354314964784;4027.8993025174605;5798.246227990334;5829.213056237354;5837.357890632112;5842.678652674143;5846.824595262149;5408.78364865401;5479.0685583451705;5514.503694667499;5534.308211473566;5578.665280083208;5549.805756798492;5554;5562.499375056264;5623.634463759842;5641.041023026178;5552.416996215339;5564.276644036249;5567.610267281413;5575.776968921197;5583.664980101207;5654.264945557051;5666.17840413146;5676.460736230051;5678.403767604342;5691.715414229355;5342.305500285093;5499.835004949858;5541.113421852646;5542.168674698666;5553.916691249554 18:48:47 INFO - PROCESS | 1450 | |5;yui.html;673.2627772589013;699.2624965856323;751.3388218367835;766.0156698642243;771.3559178086299;13318.533851315206;13346.26595537245;13346.7330653387;13350.866491335084;13389.330533473312;13957.023008389417;14000.929995350009;14008.929955350235;14025.088369255991;14090.36593353299;649.9870002599945;814.2305521282391;824.9835003299945;839.1692224697535;841.7306461932184;829.6059371798408;837.8282452097336;838.0655569040537;838.1618381618382;838.4675730910855;872.6116877989298;879.2043200903161;879.2306731609841;879.7800549862534;879.885614870066;667.3460009190995;868.4919322196523;874.152072489684;874.7594411536846;884.4604791077437;629.0752593687272;629.1757797285525;630.0832289019465;630.1587380846576;631.1038325577691;12970.87029129706;12984.091113622051;13000.609981700563;13001;13033.804492932613;11819.172657913949;12174.391280436032;12507.93746031273;12608;12826.35868206586;9967.90032099677;9983.700488985342;10093;10173.898261017443;10360.533775980099;3358.865645374182;3368.4778859276853;3409.6590340965954;3477.895663130085;3479.530263414432;42679.786601067106;42964;43391.349129763075;43482;43686.12627747427;9969.202463802878;10308.690739277834;10314.948425257826;10366.118879895294;10757.9462102689;17785.911070444567;17808.198631061376;17963.640727185382;17973.820261797213;17990.1004949752;6957.756478523329;6997.300269973064;7026.191987921352;7148.142222933177;7229.457790665721;3781.357169281229;3802.5817160112365;3825.9808700956874;3888.0862997195636;3895.7467764595776;2762.8396073649114;2800.1179628416985;2808.845513496777;2822.0264008916893;2823.463541927027;490.0786521339858;506.87834919619763;507.28979428799977;518.8884389856199;519.7037688517509;517.9430262671103;618.2086928731231;624.8469125064388;632.550888868899;651.0494677770414;7439.330460258495;7521.285477879593;7678.884816727754;7735.922640773632;7763.534187948741;476.7509423280333;551.1980068999596;554.6339415985431;574.2678085441096;634.1692382978313;3528.347255757693;3545.62770909056;3565.732570057256;3635.0548857296762;3690.409534474471;48008;50281.24578131331;50815.491845081815;50910;50917.74541127271;41573;41971;42008.789956050634;42069.57930420718;42228.78885605552;38270.617293827265;38345.61654383476;38469.461221550824;38709.612903871166;39026.21947561033;8362;8437.198466145706;8488.151184881463;8549.358798090043;8629.525376104375;29761.25596860096;30275.94034208792;30791.69208307978;30892.53661195039;31559.684403156592;35218.47172292469;35230;37241.81379093087;39333.40999885061;39604.60395396125;10116.544755485873;10260.17918566498;10354.430506322225;10425;10829.566817327533;10910.23628346008;11275.605353812578;11377.20359574855;11445.713857153305;11656.825147622962;10452.32059916103;10501.369917804956;10552.630657926935;10690.358578485315;11080;10529.684109476728;10811;10953.780924381626;11007.119430445386;11164.944175279072;10441.164706823587;10502.632407865687;10618.893811061791;10634.202434817265;10697.14422846155;8767.386282960131;8932.732018039469;9170.862437063315;9379.718608441757;9511.857322140035;9294.209992150743;9300.11648893354;9338.953305233703;9347.485888276211;9436.292278079034 18:48:47 INFO - PROCESS | 1450 | __end_tp_report 18:48:47 INFO - PROCESS | 1450 | __start_cc_report 18:48:47 INFO - PROCESS | 1450 | _x_x_mozilla_cycle_collect,951 18:48:47 INFO - PROCESS | 1450 | __end_cc_report 18:48:47 INFO - PROCESS | 1450 | __startTimestamp1459820927445__endTimestamp 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | ------- Summary: start ------- 18:48:47 INFO - PROCESS | 1450 | Number of tests: 6 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | [#0] dojo.html Cycles:165 Average:4526.32 Median:4678.06 stddev:479.65 (10.3%) stddev-sans-first:456.07 18:48:47 INFO - PROCESS | 1450 | Values: 2575.9 2650.2 2656.0 2668.0 2688.5 4526.1 4534.3 4536.5 4554.5 4578.2 4537.4 4567.6 4604.0 4678.1 4685.0 4182.6 4185.2 4225.0 4251.4 4388.8 4261.3 4345.7 4347.8 4359.3 4372.7 4087.3 4159.1 4191.5 4264.2 4265.4 4234.2 4235.6 4237.2 4265.9 4276.2 4207.6 4222.3 4234.9 4260.1 4264.3 4366.3 4435.6 4493.2 4522.6 4535.7 4854.4 4886.6 4887.9 4927.5 4929.5 4867.4 4882.8 4885.9 4894.2 4968.7 4496.4 4498.0 4578.7 4616.2 4620.3 4998.1 5000.1 5012.7 5023.0 5072.7 4564.5 4810.9 4811.2 4818.9 4866.4 4854.8 4856.3 4856.4 4891.2 4910.1 4836.3 4874.1 4877.3 4878.8 4927.7 4752.4 4782.9 4863.2 4867.4 4913.3 3895.7 3897.1 3916.1 3930.4 3933.9 3437.8 3469.7 3475.8 3497.5 3505.8 4105.8 4183.0 4197.5 4224.5 4282.0 4951.4 4963.7 4963.9 4967.6 5022.4 4209.8 4253.9 4255.8 4275.2 4303.4 4347.5 4453.7 4518.8 4519.5 4527.8 4684.3 4709.7 4711.5 4739.0 4759.2 4966.4 4968.3 4969.8 4971.0 5030.3 4548.5 4642.0 4716.0 4716.2 4725.6 4855.8 4860.8 4875.2 4875.4 4923.6 4932.2 4939.5 4944.3 4950.6 4993.9 4691.2 4720.6 4750.8 4787.9 4795.9 4748.3 4754.3 4766.4 4773.9 4813.6 4576.1 4715.2 4715.9 4722.6 4766.9 4695.2 4723.9 4766.6 4802.0 4805.8 4590.2 4591.6 4597.0 4599.4 4641.8 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | [#1] ext.html Cycles:180 Average:35919.34 Median:33191.92 stddev:51160.74 (154.1%) stddev-sans-first:51235.15 18:48:47 INFO - PROCESS | 1450 | Values: 505.1 535.4 546.6 549.6 558.4 26638.5 34472.7 34890.8 34921.3 34972.5 37044.3 37167.0 37445.6 37494.4 37526.2 7668.8 7847.3 7856.8 7860.4 7868.6 7761.8 7886.5 7890.9 7894.6 8077.8 8042.4 8098.2 8104.2 8122.1 8139.6 7942.9 8010.6 8017.7 8023.8 8035.1 7905.2 8027.1 8028.0 8037.6 8037.8 37946.6 38329.4 38390.2 38427.8 38454.2 2828.3 2961.4 2969.6 3175.2 3594.5 28508.9 28841.7 29624.6 29711.6 30325.0 3477.8 3482.0 3529.2 3575.6 3586.7 235320.0 236298.8 236378.0 236419.0 237067.0 48005.0 54405.5 55440.2 55478.0 56607.4 51693.7 52071.5 52094.5 52377.5 52382.5 13811.7 14021.4 14022.3 14028.0 14034.9 8775.3 10595.4 10603.5 10681.1 10965.4 18583.5 18636.8 18698.5 18698.8 18771.2 6424.7 6746.3 6796.5 6864.8 6918.2 883.2 912.3 933.3 948.0 1052.2 26533.6 26567.0 26847.1 27071.7 27224.6 979.5 1000.2 1018.5 1034.9 1070.0 13599.9 14000.5 14071.3 14156.4 14222.2 134024.3 135456.0 135660.0 135725.0 135847.0 47104.3 47598.5 47611.8 47683.0 47707.0 1077.9 1222.5 1245.1 1251.9 1257.5 24984.0 26511.5 26514.6 26794.6 26897.9 37772.4 38078.4 38458.2 38477.4 38501.0 204106.0 205356.0 205356.0 205862.0 206153.0 29131.4 30262.5 30605.2 30660.1 30673.2 38471.6 38602.8 38637.2 39019.0 39082.8 33021.2 33027.3 33185.2 33198.7 33252.3 32347.7 32688.2 32708.8 33121.7 33250.2 29610.9 29655.0 29662.4 30700.2 33036.8 28986.1 29405.3 29450.6 29712.4 29776.9 23653.4 23714.8 23868.9 23893.5 24072.9 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | [#2] jquery.html Cycles:180 Average:24122.49 Median:405579.00 stddev:63245.59 (15.6%) stddev-sans-first:63397.79 18:48:47 INFO - PROCESS | 1450 | Values: 333.4 345.2 345.4 354.4 356.2 14673.9 15404.5 15962.7 16039.4 16102.0 15470.1 15742.1 17820.6 17831.4 18086.0 5394.6 5457.3 5631.2 5633.0 5649.7 5537.6 5591.8 5614.3 5634.1 5635.7 5538.5 5597.2 5607.9 5609.3 5617.2 5489.3 5617.7 5650.3 5667.5 5675.1 5417.5 5457.6 5468.6 5472.2 5484.9 21879.9 22044.4 22443.0 22613.1 23238.7 1963.8 2021.2 2029.4 2040.6 2165.4 13834.2 13853.9 14137.3 14294.2 14872.2 1867.6 1892.7 1909.6 1929.8 1948.2 48918.3 51403.0 52973.5 67730.3 70450.6 14518.6 14659.2 15201.8 15297.9 15374.6 25398.5 25596.9 25741.6 25783.1 25798.9 7211.7 7885.6 8221.4 8387.0 8719.7 6707.0 6987.2 7061.6 7104.9 7121.6 7316.5 7528.3 7644.4 7656.7 7798.0 3031.6 3071.9 3117.7 3121.4 3188.5 838.9 872.8 895.2 924.1 925.1 15664.8 15736.6 15966.0 16088.2 16102.8 836.7 868.2 896.2 911.5 920.9 9008.4 9033.8 9185.6 9264.5 9420.2 306594.0 399576.0 401731.0 402994.0 408164.0 69665.0 70246.0 71073.0 71703.6 72948.6 954.1 976.6 978.9 987.9 991.9 11679.6 14451.2 14823.5 14859.6 15056.0 33206.3 33236.8 34669.0 34846.5 35042.6 42946.4 44233.0 44352.3 44383.0 45466.8 7398.3 7482.8 7498.2 7658.2 7667.2 9575.4 11636.7 11787.1 11811.5 11828.6 10211.4 10354.6 10395.6 10521.6 10528.2 5825.7 7371.2 10355.6 10377.8 10405.0 10339.2 10508.3 10517.4 10686.8 10763.8 7521.5 7652.9 7673.8 7753.7 7784.0 10175.3 10330.5 10484.9 10604.1 10637.6 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | [#3] mootools.html Cycles:180 Average:5026.52 Median:6251.09 stddev:2542.08 (40.7%) stddev-sans-first:2534.47 18:48:47 INFO - PROCESS | 1450 | Values: 1383.8 1397.1 1511.0 1710.9 1763.3 6846.8 6978.2 7014.2 7015.7 7029.9 6217.8 6874.5 6912.0 7010.7 7020.6 2199.6 2207.2 2232.4 2234.8 2235.1 1907.0 2180.2 2193.7 2212.0 2221.6 2118.4 2167.0 2174.9 2176.9 2178.8 2137.8 2162.3 2168.7 2182.4 2191.3 2111.0 2124.8 2125.2 2126.1 2129.2 6965.4 7112.9 7125.5 7144.9 7145.1 4445.6 4529.3 4537.1 4552.9 4554.6 2902.0 2969.9 2999.0 3045.1 3051.2 970.8 974.2 983.1 1005.6 1023.1 9858.8 9859.1 9866.0 9874.1 9888.6 3984.0 4016.8 4119.7 4146.8 4157.5 8526.7 8572.1 8580.1 8580.5 8594.4 4542.7 4556.7 4564.5 4584.5 4588.4 4138.9 4158.3 4173.1 4179.2 4180.1 3358.8 3464.7 3472.8 3499.1 3504.4 1031.4 1059.6 1139.0 1141.0 1157.7 922.4 924.2 935.1 935.2 992.1 6503.7 6564.6 6615.5 6646.3 6668.3 1032.7 1051.6 1059.4 1061.5 1079.7 4747.2 4747.3 4767.8 4801.9 4805.7 8258.8 8357.5 8442.4 8492.8 8523.2 8399.5 8413.9 8435.1 8472.8 8479.0 6712.5 6772.5 6791.5 6875.7 6884.7 6378.1 6450.1 6460.8 6478.2 6484.1 7554.3 7624.2 7736.5 7739.7 7758.1 7594.8 7791.3 7883.3 7908.8 7933.8 6221.5 6267.3 6319.9 6330.4 6348.8 6635.1 6657.4 6704.5 6706.6 6716.2 6112.3 6145.5 6209.1 6292.1 6328.5 6305.2 6325.7 6334.3 6397.7 6415.9 6443.2 6482.1 6493.5 6498.0 6528.2 6024.5 6145.7 6160.0 6179.7 6188.0 6112.8 6123.8 6225.5 6246.4 6255.8 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | [#4] prototype.html Cycles:180 Average:4618.55 Median:5363.86 stddev:1372.58 (25.6%) stddev-sans-first:1337.78 18:48:47 INFO - PROCESS | 1450 | Values: 309.7 311.3 311.8 312.9 316.6 5249.6 5284.8 5368.5 5375.3 5381.2 5201.7 5335.5 5363.1 5364.6 5373.1 3922.9 3974.9 4065.7 4088.1 4092.3 4080.4 4084.3 4089.0 4091.9 4096.8 4047.0 4060.8 4066.3 4068.1 4073.8 3866.3 3955.9 4041.9 4046.3 4072.9 3503.3 3505.9 3507.3 3519.4 3525.0 5076.9 5100.7 5105.6 5107.5 5120.9 4664.3 4665.5 4669.3 4669.7 4678.6 5555.1 5564.4 5564.7 5565.9 5613.6 3891.5 3903.0 3903.3 3907.3 3909.0 5649.9 5836.6 5843.9 5909.1 5966.1 3904.8 3911.9 3938.0 3947.5 3948.4 3977.1 3995.2 3997.7 4002.2 4010.8 4620.0 4621.9 4622.9 4624.0 4625.3 5600.6 5613.0 5629.7 5630.7 5640.2 1383.3 1410.5 1411.6 1413.9 1415.7 905.6 912.4 936.1 947.2 950.9 4837.9 4849.6 4871.8 4910.2 4949.0 5780.4 5783.2 5785.5 5793.3 5794.0 4882.0 4882.4 4883.5 4892.2 4893.5 3070.4 3107.7 3112.3 3115.3 3116.0 5482.1 5484.5 5485.1 5485.4 5487.3 5706.6 5873.1 5896.5 5922.1 5934.9 5447.8 5465.6 5474.0 5483.6 5492.1 5764.6 5765.7 5767.6 5774.0 5775.7 5641.5 5641.9 5647.8 5648.3 5651.3 5472.9 5473.7 5479.2 5479.2 5480.6 3853.8 3970.3 3985.0 4019.0 4027.9 5798.2 5829.2 5837.4 5842.7 5846.8 5408.8 5479.1 5514.5 5534.3 5578.7 5549.8 5554.0 5562.5 5623.6 5641.0 5552.4 5564.3 5567.6 5575.8 5583.7 5654.3 5666.2 5676.5 5678.4 5691.7 5342.3 5499.8 5541.1 5542.2 5553.9 18:48:47 INFO - PROCESS | 1450 | 18:48:47 INFO - PROCESS | 1450 | [#5] yui.html Cycles:180 Average:12462.22 Median:39469.01 stddev:13573.76 (34.4%) stddev-sans-first:13582.96 18:48:47 INFO - PROCESS | 1450 | Values: 673.3 699.3 751.3 766.0 771.4 13318.5 13346.3 13346.7 13350.9 13389.3 13957.0 14000.9 14008.9 14025.1 14090.4 650.0 814.2 825.0 839.2 841.7 829.6 837.8 838.1 838.2 838.5 872.6 879.2 879.2 879.8 879.9 667.3 868.5 874.2 874.8 884.5 629.1 629.2 630.1 630.2 631.1 12970.9 12984.1 13000.6 13001.0 13033.8 11819.2 12174.4 12507.9 12608.0 12826.4 9967.9 9983.7 10093.0 10173.9 10360.5 3358.9 3368.5 3409.7 3477.9 3479.5 42679.8 42964.0 43391.3 43482.0 43686.1 9969.2 10308.7 10314.9 10366.1 10757.9 17785.9 17808.2 17963.6 17973.8 17990.1 6957.8 6997.3 7026.2 7148.1 7229.5 3781.4 3802.6 3826.0 3888.1 3895.7 2762.8 2800.1 2808.8 2822.0 2823.5 490.1 506.9 507.3 518.9 519.7 517.9 618.2 624.8 632.6 651.0 7439.3 7521.3 7678.9 7735.9 7763.5 476.8 551.2 554.6 574.3 634.2 3528.3 3545.6 3565.7 3635.1 3690.4 48008.0 50281.2 50815.5 50910.0 50917.7 41573.0 41971.0 42008.8 42069.6 42228.8 38270.6 38345.6 38469.5 38709.6 39026.2 8362.0 8437.2 8488.2 8549.4 8629.5 29761.3 30275.9 30791.7 30892.5 31559.7 35218.5 35230.0 37241.8 39333.4 39604.6 10116.5 10260.2 10354.4 10425.0 10829.6 10910.2 11275.6 11377.2 11445.7 11656.8 10452.3 10501.4 10552.6 10690.4 11080.0 10529.7 10811.0 10953.8 11007.1 11164.9 10441.2 10502.6 10618.9 10634.2 10697.1 8767.4 8932.7 9170.9 9379.7 9511.9 9294.2 9300.1 9339.0 9347.5 9436.3 18:48:47 INFO - PROCESS | 1450 | -------- Summary: end -------- 18:48:47 INFO - PROCESS | 1450 | 18:48:48 INFO - TEST-INFO | 1450: exit 0 18:48:48 INFO - TEST-OK | dromaeo_css | took 1115378ms 18:48:48 INFO - TEST-START | kraken 18:48:48 INFO - operating with platform_type : linux_ 18:48:48 INFO - Initialising browser for kraken test... 18:48:48 INFO - TEST-INFO | started process 1624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3MXm6u/profile http://localhost:54058/getInfo.html) 18:48:52 INFO - PROCESS | 1624 | __metrics Screen width/height:1600/1200 18:48:52 INFO - PROCESS | 1624 | colorDepth:24 18:48:52 INFO - PROCESS | 1624 | Browser inner width/height: 1024/697 18:48:52 INFO - PROCESS | 1624 | __metrics 18:48:53 ERROR - PROCESS | 1624 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:48:53 INFO - TEST-INFO | 1624: exit 0 18:48:53 INFO - Browser initialized. 18:48:53 INFO - Running cycle 1/1 for kraken test... 18:48:53 INFO - TEST-INFO | started process 1705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3MXm6u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:05 INFO - PROCESS | 1705 | RSS: Main: 153370624 18:49:05 INFO - PROCESS | 1705 | 18:49:08 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54058/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:08 INFO - PROCESS | 1705 | RSS: Main: 194633728 18:49:08 INFO - PROCESS | 1705 | 18:49:11 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54058/tests/kraken/driver.html?testName=audio-dft) 18:49:12 INFO - PROCESS | 1705 | RSS: Main: 184655872 18:49:12 INFO - PROCESS | 1705 | 18:49:15 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54058/tests/kraken/driver.html?testName=audio-fft) 18:49:15 INFO - PROCESS | 1705 | RSS: Main: 169644032 18:49:15 INFO - PROCESS | 1705 | 18:49:18 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54058/tests/kraken/driver.html?testName=audio-oscillator) 18:49:18 INFO - PROCESS | 1705 | RSS: Main: 171413504 18:49:18 INFO - PROCESS | 1705 | 18:49:20 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54058/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:21 INFO - PROCESS | 1705 | RSS: Main: 173125632 18:49:21 INFO - PROCESS | 1705 | 18:49:24 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54058/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:25 INFO - PROCESS | 1705 | RSS: Main: 173678592 18:49:25 INFO - PROCESS | 1705 | 18:49:28 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54058/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:29 INFO - PROCESS | 1705 | RSS: Main: 174391296 18:49:29 INFO - PROCESS | 1705 | 18:49:32 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54058/tests/kraken/driver.html?testName=json-parse-financial) 18:49:32 INFO - PROCESS | 1705 | RSS: Main: 173961216 18:49:32 INFO - PROCESS | 1705 | 18:49:34 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54058/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:34 INFO - PROCESS | 1705 | RSS: Main: 183451648 18:49:34 INFO - PROCESS | 1705 | 18:49:36 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:37 INFO - PROCESS | 1705 | RSS: Main: 182300672 18:49:37 INFO - PROCESS | 1705 | 18:49:39 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:49:40 INFO - PROCESS | 1705 | RSS: Main: 190558208 18:49:40 INFO - PROCESS | 1705 | 18:49:42 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:49:43 INFO - PROCESS | 1705 | RSS: Main: 196481024 18:49:43 INFO - PROCESS | 1705 | 18:49:45 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:49:46 INFO - PROCESS | 1705 | RSS: Main: 195272704 18:49:46 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:54058/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54058/tests/kraken/driver.html?testName=ai-astar) 18:49:48 INFO - PROCESS | 1705 | RSS: Main: 257728512 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | __start_tp_report 18:49:48 INFO - PROCESS | 1705 | _x_x_mozilla_page_load 18:49:48 INFO - PROCESS | 1705 | _x_x_mozilla_page_load_details 18:49:48 INFO - PROCESS | 1705 | |i|pagename|runs| 18:49:48 INFO - PROCESS | 1705 | |0;ai-astar;112;109;112;112;112;113;118;112;111;111 18:49:48 INFO - PROCESS | 1705 | |1;audio-beat-detection;159;139;159;181;145;156;163;135;183;134 18:49:48 INFO - PROCESS | 1705 | |2;audio-dft;161;162;160;161;160;161;164;162;160;160 18:49:48 INFO - PROCESS | 1705 | |3;audio-fft;74;79;100;99;73;73;72;114;104;74 18:49:48 INFO - PROCESS | 1705 | |4;audio-oscillator;94;94;142;94;93;94;151;94;93;136 18:49:48 INFO - PROCESS | 1705 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;116 18:49:48 INFO - PROCESS | 1705 | |6;imaging-darkroom;145;146;146;146;145;146;146;145;145;147 18:49:48 INFO - PROCESS | 1705 | |7;imaging-desaturate;96;95;95;95;95;95;96;95;95;95 18:49:48 INFO - PROCESS | 1705 | |8;json-parse-financial;65;66;66;66;65;65;65;73;63;64 18:49:48 INFO - PROCESS | 1705 | |9;json-stringify-tinderbox;63;63;63;64;64;65;64;64;63;65 18:49:48 INFO - PROCESS | 1705 | |10;stanford-crypto-aes;81;92;83;90;82;84;81;82;82;91 18:49:48 INFO - PROCESS | 1705 | |11;stanford-crypto-ccm;119;118;118;126;118;134;117;118;120;117 18:49:48 INFO - PROCESS | 1705 | |12;stanford-crypto-pbkdf2;145;141;145;139;138;136;142;139;132;141 18:49:48 INFO - PROCESS | 1705 | |13;stanford-crypto-sha256-iterative;67;67;75;68;69;67;69;68;65;66 18:49:48 INFO - PROCESS | 1705 | __end_tp_report 18:49:48 INFO - PROCESS | 1705 | __start_cc_report 18:49:48 INFO - PROCESS | 1705 | _x_x_mozilla_cycle_collect,1165 18:49:48 INFO - PROCESS | 1705 | __end_cc_report 18:49:48 INFO - PROCESS | 1705 | __startTimestamp1459820988267__endTimestamp 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | ------- Summary: start ------- 18:49:48 INFO - PROCESS | 1705 | Number of tests: 14 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:2.30 (2.1%) stddev-sans-first:2.44 18:49:48 INFO - PROCESS | 1705 | Values: 112.0 109.0 112.0 112.0 112.0 113.0 118.0 112.0 111.0 111.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:159.00 stddev:17.49 (11.0%) stddev-sans-first:18.50 18:49:48 INFO - PROCESS | 1705 | Values: 159.0 139.0 159.0 181.0 145.0 156.0 163.0 135.0 183.0 134.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 18:49:48 INFO - PROCESS | 1705 | Values: 161.0 162.0 160.0 161.0 160.0 161.0 164.0 162.0 160.0 160.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#3] audio-fft Cycles:10 Average:86.20 Median:73.50 stddev:16.14 (22.0%) stddev-sans-first:16.50 18:49:48 INFO - PROCESS | 1705 | Values: 74.0 79.0 100.0 99.0 73.0 73.0 72.0 114.0 104.0 74.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:94.00 stddev:24.08 (25.6%) stddev-sans-first:24.96 18:49:48 INFO - PROCESS | 1705 | Values: 94.0 94.0 142.0 94.0 93.0 94.0 151.0 94.0 93.0 136.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:49:48 INFO - PROCESS | 1705 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 18:49:48 INFO - PROCESS | 1705 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 147.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:49:48 INFO - PROCESS | 1705 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.50 stddev:2.70 (4.1%) stddev-sans-first:2.85 18:49:48 INFO - PROCESS | 1705 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 65.0 73.0 63.0 64.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:49:48 INFO - PROCESS | 1705 | Values: 63.0 63.0 63.0 64.0 64.0 65.0 64.0 64.0 63.0 65.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.50 stddev:4.39 (5.3%) stddev-sans-first:4.44 18:49:48 INFO - PROCESS | 1705 | Values: 81.0 92.0 83.0 90.0 82.0 84.0 81.0 82.0 82.0 91.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:118.50 stddev:5.42 (4.6%) stddev-sans-first:5.72 18:49:48 INFO - PROCESS | 1705 | Values: 119.0 118.0 118.0 126.0 118.0 134.0 117.0 118.0 120.0 117.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:141.00 stddev:3.97 (2.8%) stddev-sans-first:3.73 18:49:48 INFO - PROCESS | 1705 | Values: 145.0 141.0 145.0 139.0 138.0 136.0 142.0 139.0 132.0 141.0 18:49:48 INFO - PROCESS | 1705 | 18:49:48 INFO - PROCESS | 1705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.73 (4.0%) stddev-sans-first:2.86 18:49:48 INFO - PROCESS | 1705 | Values: 67.0 67.0 75.0 68.0 69.0 67.0 69.0 68.0 65.0 66.0 18:49:48 INFO - PROCESS | 1705 | -------- Summary: end -------- 18:49:48 INFO - PROCESS | 1705 | 18:49:49 INFO - TEST-INFO | 1705: exit 0 18:49:49 INFO - TEST-OK | kraken | took 60960ms 18:49:49 INFO - SUITE-END | took 1176s 18:49:49 INFO - Completed test suite (00:19:36) 18:49:49 INFO - javascript benchmark 18:49:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2575.8712064396777, 2650.1651979626427, 2655.96016059759, 2668.0, 2688.4891870544593, 4526.140033393653, 4534.2518484450065, 4536.546345365462, 4554.453465584126, 4578.221702310607, 4537.387452693885, 4567.566081222279, 4603.976980115103, 4678.064387122572, 4684.976575117128, 4182.581741825816, 4185.183889141618, 4225.0, 4251.3622956556455, 4388.802503887333, 4261.275583150857, 4345.674074444413, 4347.826086956518, 4359.280718681413, 4372.672049596277, 4087.2847251730827, 4159.085001299709, 4191.455110835572, 4264.211120942605, 4265.445492086009, 4234.237837189305, 4235.618794308527, 4237.237297286487, 4265.936010959838, 4276.166147601219, 4207.621314081717, 4222.303319952204, 4234.91530169398, 4260.105377870651, 4264.33902745075, 4366.323219900889, 4435.578620031092, 4493.168763778679, 4522.570355816192, 4535.682502224846, 4854.417469903598, 4886.560209581155, 4887.902241955177, 4927.48261432548, 4929.531694489054, 4867.440244371907, 4882.755862206911, 4885.902281954376, 4894.1679914414635, 4968.726720030397, 4496.392986946753, 4497.955020449786, 4578.702384345007, 4616.238320677118, 4620.306953956866, 4998.100341938486, 5000.1249781288125, 5012.749362531932, 5022.974885125551, 5072.746362681851, 4564.543545645409, 4810.879728006757, 4811.206150985118, 4818.855434336975, 4866.367372241657, 4854.757262136879, 4856.3201151838775, 4856.368672072608, 4891.217405215149, 4910.140725373046, 4836.322914791932, 4874.122657921608, 4877.341558889575, 4878.829240976549, 4927.704337739747, 4752.42970843501, 4782.880427989328, 4863.221884498464, 4867.440244371872, 4913.263010548375, 3895.7272990890365, 3897.1036661567996, 3916.060145565101, 3930.4104384342577, 3933.92132157361, 3437.845296961643, 3469.7224222062678, 3475.7740746851373, 3497.527833742463, 3505.8422370993367, 4105.774182419936, 4183.037901282662, 4197.496300443905, 4224.51418086924, 4282.0, 4951.3810773653295, 4963.6525443218625, 4963.900721985612, 4967.552920237196, 5022.372203474566, 4209.810558524874, 4253.893652658647, 4255.829766809293, 4275.230458517497, 4303.354496825438, 4347.456567929009, 4453.732776033448, 4518.841840535565, 4519.480259770168, 4527.773611319487, 4684.320773487893, 4709.7174169549935, 4711.505291944365, 4739.0, 4759.190937540696, 4966.379202599675, 4968.254761785761, 4969.82605608802, 4971.0, 5030.346055012825, 4548.4541854977615, 4641.976790116028, 4715.976420117878, 4716.198246298206, 4725.5983241424865, 4855.8057677692495, 4860.805567777391, 4875.1712208923855, 4875.390576177978, 4923.630727695366, 4932.2355034968205, 4939.456659767495, 4944.28307895346, 4950.579200767975, 4993.875153121201, 4691.225947718588, 4720.598749106364, 4750.762461876823, 4787.928181077356, 4795.856124316276, 4748.31149483316, 4754.263089221176, 4766.356541866804, 4773.928391074067, 4813.566778989908, 4576.084783043338, 4715.151272770934, 4715.905681886412, 4722.645801564965, 4766.880827979328, 4695.225287827607, 4723.905521889612, 4766.594839438687, 4801.975990120167, 4805.7597120143155, 4590.2426099693175, 4591.563801438858, 4596.954030459653, 4599.356090147315, 4641.837535686234], "unit": "score", "name": "dojo.html", "value": 4496.027891475723}, {"lowerIsBetter": false, "replicates": [505.1261317919996, 535.4458135829416, 546.6364867363204, 549.6235078970906, 558.408087427327, 26638.4672306554, 34472.655273447286, 34890.825545872234, 34921.30157396851, 34972.47541286883, 37044.25911481769, 37167.0, 37445.62554374456, 37494.43758343627, 37526.24947501048, 7668.846623067521, 7847.254510821463, 7856.842863142734, 7860.449768516206, 7868.645910934022, 7761.844763104735, 7886.487378320419, 7890.921090789105, 7894.6052697365185, 8077.798055048612, 8042.396820238476, 8098.190180981914, 8104.230098140697, 8122.106568277485, 8139.593020348959, 7942.920570794276, 8010.599470026505, 8017.67929282828, 8023.799405014921, 8035.075966263896, 7905.221325201841, 8027.076886158108, 8028.0, 8037.638306276232, 8037.799055023613, 37946.62053379459, 38329.42505862414, 38390.23219535621, 38427.8078609608, 38454.23091538181, 2828.3353411948174, 2961.3633068890076, 2969.6139501864836, 3175.1744546417867, 3594.4608308753636, 28508.857455712798, 28841.711582884112, 29624.555631665542, 29711.554326685116, 30325.0, 3477.826108694555, 3482.039225023044, 3529.188286694049, 3575.6070118141392, 3586.7489275750445, 235320.0, 236298.8185059081, 236378.0, 236419.0, 237067.0, 48005.0, 54405.45594544004, 55440.16839747407, 55478.0, 56607.43392566104, 51693.74153129286, 52071.479285207424, 52094.47905520972, 52377.476225238024, 52382.476175238524, 13811.723765524634, 14021.439142434188, 14022.265658196553, 14028.0, 14034.929825350808, 8775.254103401283, 10595.364278143183, 10603.522841472151, 10681.145508359312, 10965.396903170402, 18583.535411614546, 18636.813631863508, 18698.532536686693, 18698.81301186998, 18771.24915003412, 6424.74301027963, 6746.321142069316, 6796.4562834973085, 6864.828379290458, 6918.238993710688, 883.1565854608833, 912.2519533982204, 933.332667142996, 947.966821161256, 1052.231870734353, 26533.601995970075, 26567.0, 26847.10716946032, 27071.72928270692, 27224.59163112555, 979.4515071559807, 1000.2048371544639, 1018.511114664965, 1034.9301397205588, 1069.9728260869651, 13599.932000339935, 14000.509982150576, 14071.2964351782, 14156.36296366666, 14222.217778022308, 134024.32987835, 135456.0, 135660.0, 135725.0, 135847.0, 47104.29343559849, 47598.5240147601, 47611.761941190074, 47683.0, 47707.045859082624, 1077.946102694862, 1222.4865556466304, 1245.0910835090435, 1251.8998480121568, 1257.5032862019268, 24984.0, 26511.469770604093, 26514.602280965417, 26794.59808102841, 26897.86551067232, 37772.43341349827, 38078.428823568225, 38458.23083538258, 38477.422838658, 38501.0, 204106.0, 205356.0, 205356.0, 205862.0, 206153.0, 29131.417371652024, 30262.54606180865, 30605.23486912756, 30660.080197594107, 30673.233169170948, 38471.615283846804, 38602.8419147426, 38637.2272554553, 39019.0, 39082.80458597689, 33021.17447063843, 33027.33945321032, 33185.170370740925, 33198.668013319555, 33252.33495330128, 32347.67652323541, 32688.182795430304, 32708.83645581852, 33121.668783311856, 33250.16874578155, 29610.851945740997, 29655.0, 29662.406751865274, 30700.232494187825, 33036.834815825765, 28986.13041608755, 29405.264868377606, 29450.558241626823, 29712.40575188441, 29776.85111574428, 23653.408664783517, 23714.762852371947, 23868.93697177017, 23893.522129556965, 24072.87963560171], "unit": "score", "name": "ext.html", "value": 16377.046290924505}, {"lowerIsBetter": false, "replicates": [333.36993083073014, 345.1922501346848, 345.4334890779122, 354.4222916645867, 356.17723059732003, 14673.926630366846, 15404.460843870453, 15962.680746385066, 16039.438619648314, 16102.0, 15470.071795692267, 15742.134182619951, 17820.554486137855, 17831.37590184344, 18086.0, 5394.595405344595, 5457.345118585776, 5631.239782629354, 5633.0, 5649.717514124298, 5537.58468114891, 5591.832245032656, 5614.29821272341, 5634.098544232924, 5635.690037047961, 5538.529225015878, 5597.160425936122, 5607.887842243153, 5609.270794796671, 5617.185508101323, 5489.286392768934, 5617.691026993513, 5650.3219613646215, 5667.518260947824, 5675.148727690838, 5417.51486847885, 5457.645253058538, 5468.56251499883, 5472.2338872557875, 5484.890302193974, 21879.890600547056, 22044.448888777748, 22443.0, 22613.095476180933, 23238.65142022871, 1963.7741659709031, 2021.1915233906554, 2029.370895022533, 2040.6224848402944, 2165.404513758713, 13834.23911684857, 13853.861461385459, 14137.293135343192, 14294.213818240096, 14872.182029988346, 1867.6451474219855, 1892.6687829629898, 1909.6276226135908, 1929.7684277886603, 1948.162290215207, 48918.26622600628, 51403.0, 52973.47026529763, 67730.3226967729, 70450.64774676145, 14518.564443066725, 14659.216094830395, 15201.838529176835, 15297.9235103826, 15374.615634609001, 25398.492030159294, 25596.8720156398, 25741.613875791878, 25783.097591584203, 25798.87100564485, 7211.675474603656, 7885.645145968445, 8221.424500284922, 8387.0, 8719.651213951498, 6707.0, 6987.161540615159, 7061.611611361322, 7104.893426598605, 7121.608311542915, 7316.487845850846, 7528.33163128716, 7644.388448924073, 7656.73201437947, 7797.961010195027, 3031.5604237385455, 3071.9385612288074, 3117.7177986357506, 3121.360121175199, 3188.4579621463945, 838.9286910612544, 872.842888280103, 895.1630225738955, 924.0574613893791, 925.0934084596998, 15664.765028524582, 15736.606584835241, 15966.0, 16088.195590220443, 16102.75845862313, 836.7029704454952, 868.1925808997693, 896.1979028769215, 911.5168960450972, 920.8940971788196, 9008.369414141078, 9033.77415564616, 9185.586648600829, 9264.536773161315, 9420.24638028956, 306594.0, 399576.0, 401731.0, 402994.0, 408164.0, 69665.0, 70246.0, 71073.0, 71703.6414817933, 72948.63525682337, 954.0888451528773, 976.5556671714353, 978.8596285327656, 987.8913319534845, 991.9156871665845, 11679.649610511698, 14451.205183714997, 14823.481178158712, 14859.554213373616, 15056.0, 33206.33587328192, 33236.83381583077, 34669.0, 34846.47730283997, 35042.649573503935, 42946.35580466358, 44233.0, 44352.334714979945, 44383.0, 45466.77266613646, 7398.3353745409, 7482.812929676802, 7498.212687667717, 7658.195889431529, 7667.233276672288, 9575.377600455948, 11636.709082273012, 11787.11596630239, 11811.527538898348, 11828.585999489977, 10211.387316760722, 10354.637587684394, 10395.58417663285, 10521.631742888962, 10528.157572424641, 5825.737841797045, 7371.152317483344, 10355.637552685921, 10377.792444150924, 10405.011523905217, 10339.224558158017, 10508.264421490729, 10517.421541815274, 10686.83969740439, 10763.784724305626, 7521.5111017783665, 7652.885206721792, 7673.846523069619, 7753.689852405841, 7784.0, 10175.338602990782, 10330.48347582633, 10484.947575262075, 10604.098651614391, 10637.627683031056], "unit": "score", "name": "jquery.html", "value": 8749.220917739987}, {"lowerIsBetter": false, "replicates": [1383.827021622297, 1397.050005995923, 1510.9546713598588, 1710.9059001754913, 1763.3475614022805, 6846.82882927927, 6978.1975072866635, 7014.193367762702, 7015.684294206761, 7029.894551581724, 6217.751289948408, 6874.48441366897, 6911.965440172792, 7010.719571217158, 7020.648967551615, 2199.626063569197, 2207.249535158046, 2232.4195709115584, 2234.7876951689564, 2235.1282999630157, 1906.961860762784, 2180.1824315881545, 2193.7148170737782, 2212.0, 2221.6334304839684, 2118.353902059871, 2167.024838822528, 2174.8695078295355, 2176.934691959236, 2178.8039076483115, 2137.8075973162336, 2162.3188695560925, 2168.718066651333, 2182.410749097751, 2191.3316438486254, 2110.9894450527804, 2124.8193903518218, 2125.1818050050842, 2126.075157306577, 2129.1909074551727, 6965.373116419547, 7112.893306600405, 7125.465590080713, 7144.8928266076055, 7145.1068616422945, 4445.644348452116, 4529.343245229456, 4537.137943790669, 4552.863414097583, 4554.567316104998, 2901.9854900725572, 2969.8515074246416, 2999.040307101728, 3045.101694999958, 3051.1761824307537, 970.8106919150769, 974.1914211204684, 983.1348413396165, 1005.6379703306803, 1023.1303392116715, 9858.80282394348, 9859.112679858847, 9866.0, 9874.111329980336, 9888.604455821758, 3983.9601603983588, 4016.7589944602832, 4119.732217405859, 4146.834126634901, 4157.542670306264, 8526.65893364271, 8572.142785721502, 8580.099089595627, 8580.485170889766, 8594.441361311494, 4542.659300552472, 4556.681032327705, 4564.497905230422, 4584.495705472462, 4588.426446694163, 4138.896527586834, 4158.251514727318, 4173.10278290163, 4179.205950869386, 4180.080382315886, 3358.8320583970703, 3464.705500032475, 3472.7569070164845, 3499.055255081114, 3504.3867323218847, 1031.3554028732042, 1059.5814653212092, 1139.0261326565667, 1140.971475713097, 1157.739508610556, 922.4004397141778, 924.1867156901883, 935.1350001248818, 935.2284365398438, 992.1318846009741, 6503.739850405931, 6564.606123632598, 6615.503837212228, 6646.302138275508, 6668.266490686021, 1032.6747074671605, 1051.5530899367739, 1059.4067322299536, 1061.5010944855906, 1079.7259234103676, 4747.169245382044, 4747.335373047776, 4767.809287628525, 4801.927971080437, 4805.67843842939, 8258.793530161674, 8357.540335281617, 8442.366822488339, 8492.787680308042, 8523.232909038215, 8399.496030238206, 8413.915860841436, 8435.114312997048, 8472.830543389098, 8478.957605211934, 6712.53012289135, 6772.525923185428, 6791.524593278522, 6875.656217189221, 6884.690188941509, 6378.075179099097, 6450.129232553733, 6460.806175814733, 6478.1578394808375, 6484.1246431733, 7554.320111190019, 7624.161342252459, 7736.535807851547, 7739.651715672921, 7758.107817601048, 7594.772156835304, 7791.337736292252, 7883.2905038546805, 7908.802279943047, 7933.761987140395, 6221.471174949999, 6267.341929097562, 6319.9052014218905, 6330.3669633036325, 6348.77779277723, 6635.104260924713, 6657.367550082734, 6704.530682852153, 6706.597604143767, 6716.227633822173, 6112.266528016667, 6145.539084568586, 6209.099680546386, 6292.056191571301, 6328.462080723006, 6305.211848518935, 6325.652089135142, 6334.271558770616, 6397.712102955285, 6415.871682566416, 6443.194600674916, 6482.060101285193, 6493.480521558169, 6497.967510162419, 6528.249251336157, 6024.457798797954, 6145.723442445012, 6159.96920015415, 6179.660118693515, 6188.009918413032, 6112.755489780359, 6123.8162855114415, 6225.501959843111, 6246.3753624637175, 6255.812325630239], "unit": "score", "name": "mootools.html", "value": 4165.263352144684}, {"lowerIsBetter": false, "replicates": [309.6794817364028, 311.3492800047901, 311.7848684407758, 312.9139486641174, 316.60266365711027, 5249.580033597313, 5284.8150314739, 5368.489993450626, 5375.3280839895015, 5381.165919282513, 5201.661891977019, 5335.546478549328, 5363.088274993251, 5364.624476286662, 5373.086575282202, 3922.901927451808, 3974.9006274843214, 4065.715399922007, 4088.08018195905, 4092.26339258934, 4080.367543030835, 4084.346504559271, 4089.018635527482, 4091.9181616367655, 4096.815643296044, 4047.0489434982755, 4060.7969601519953, 4066.3087275163293, 4068.1456894052285, 4073.7555746655294, 3866.28473732359, 3955.940660890089, 4041.9191616167805, 4046.271671099201, 4072.857449989251, 3503.2643144939593, 3505.877294294713, 3507.2985402919517, 3519.436890097598, 3524.9647503524893, 5076.923846142311, 5100.668456550312, 5105.566026887719, 5107.540321371057, 5120.871978200575, 4664.277037059262, 4665.486796452387, 4669.32294817253, 4669.719816811003, 4678.649101317381, 5555.138953462179, 5564.443555644443, 5564.721763911788, 5565.888682226333, 5613.607047506676, 3891.5330160380654, 3903.0242439390154, 3903.2974064668347, 3907.33575292201, 3909.0, 5649.8587535311535, 5836.562257830679, 5843.8539036524, 5909.084091965709, 5966.075258334921, 3904.8047597620007, 3911.9022024449046, 3937.9803100984313, 3947.50656167979, 3948.447217389568, 3977.105151340925, 3995.2409042281874, 3997.700172487075, 4002.239574480839, 4010.7994600270454, 4619.976900115478, 4621.907561848811, 4622.930656040162, 4623.953760462419, 4625.306204069417, 5600.551955843523, 5612.971935140298, 5629.662220266797, 5630.690312032795, 5640.182173584807, 1383.3359987205997, 1410.5063227870164, 1411.5835828430431, 1413.9151650900978, 1415.7451658701532, 905.6241659711146, 912.3750231091724, 936.1247233836385, 947.2381370650585, 950.9381890177116, 4837.927431088537, 4849.612031037508, 4871.780769865364, 4910.238912968495, 4948.975255123773, 5780.364159942403, 5783.248177736868, 5785.537157027427, 5793.333766616893, 5793.971030144822, 4882.0, 4882.414110306786, 4883.4628190898975, 4892.192788189909, 4893.535114164149, 3070.4319700854967, 3107.673694262115, 3112.2686168750324, 3115.252339438564, 3115.9532607010915, 5482.095454250084, 5484.506394424441, 5485.149801780731, 5485.424030476823, 5487.314085739283, 5706.572007099484, 5873.060310350324, 5896.498797602166, 5922.082077278029, 5934.940650593525, 5447.809326673627, 5465.562754979592, 5474.042042642522, 5483.561315094703, 5492.093804522209, 5764.625299355528, 5765.654060756368, 5767.5674324425, 5774.0, 5775.729339545293, 5641.548676105819, 5641.8589535261945, 5647.802326918538, 5648.322201335866, 5651.265335506358, 5472.890542189054, 5473.726313684379, 5479.150731636602, 5479.205515200353, 5480.588955828249, 3853.788041657736, 3970.285348637273, 3984.980075099606, 4019.0354314964784, 4027.8993025174605, 5798.246227990334, 5829.213056237354, 5837.357890632112, 5842.678652674143, 5846.824595262149, 5408.78364865401, 5479.0685583451705, 5514.503694667499, 5534.308211473566, 5578.665280083208, 5549.805756798492, 5554.0, 5562.499375056264, 5623.634463759842, 5641.041023026178, 5552.416996215339, 5564.276644036249, 5567.610267281413, 5575.776968921197, 5583.664980101207, 5654.264945557051, 5666.17840413146, 5676.460736230051, 5678.403767604342, 5691.715414229355, 5342.305500285093, 5499.835004949858, 5541.113421852646, 5542.168674698666, 5553.916691249554], "unit": "score", "name": "prototype.html", "value": 4177.461028949703}, {"lowerIsBetter": false, "replicates": [673.2627772589013, 699.2624965856323, 751.3388218367835, 766.0156698642243, 771.3559178086299, 13318.533851315206, 13346.26595537245, 13346.7330653387, 13350.866491335084, 13389.330533473312, 13957.023008389417, 14000.929995350009, 14008.929955350235, 14025.088369255991, 14090.36593353299, 649.9870002599945, 814.2305521282391, 824.9835003299945, 839.1692224697535, 841.7306461932184, 829.6059371798408, 837.8282452097336, 838.0655569040537, 838.1618381618382, 838.4675730910855, 872.6116877989298, 879.2043200903161, 879.2306731609841, 879.7800549862534, 879.885614870066, 667.3460009190995, 868.4919322196523, 874.152072489684, 874.7594411536846, 884.4604791077437, 629.0752593687272, 629.1757797285525, 630.0832289019465, 630.1587380846576, 631.1038325577691, 12970.87029129706, 12984.091113622051, 13000.609981700563, 13001.0, 13033.804492932613, 11819.172657913949, 12174.391280436032, 12507.93746031273, 12608.0, 12826.35868206586, 9967.90032099677, 9983.700488985342, 10093.0, 10173.898261017443, 10360.533775980099, 3358.865645374182, 3368.4778859276853, 3409.6590340965954, 3477.895663130085, 3479.530263414432, 42679.786601067106, 42964.0, 43391.349129763075, 43482.0, 43686.12627747427, 9969.202463802878, 10308.690739277834, 10314.948425257826, 10366.118879895294, 10757.9462102689, 17785.911070444567, 17808.198631061376, 17963.640727185382, 17973.820261797213, 17990.1004949752, 6957.756478523329, 6997.300269973064, 7026.191987921352, 7148.142222933177, 7229.457790665721, 3781.357169281229, 3802.5817160112365, 3825.9808700956874, 3888.0862997195636, 3895.7467764595776, 2762.8396073649114, 2800.1179628416985, 2808.845513496777, 2822.0264008916893, 2823.463541927027, 490.0786521339858, 506.87834919619763, 507.28979428799977, 518.8884389856199, 519.7037688517509, 517.9430262671103, 618.2086928731231, 624.8469125064388, 632.550888868899, 651.0494677770414, 7439.330460258495, 7521.285477879593, 7678.884816727754, 7735.922640773632, 7763.534187948741, 476.7509423280333, 551.1980068999596, 554.6339415985431, 574.2678085441096, 634.1692382978313, 3528.347255757693, 3545.62770909056, 3565.732570057256, 3635.0548857296762, 3690.409534474471, 48008.0, 50281.24578131331, 50815.491845081815, 50910.0, 50917.74541127271, 41573.0, 41971.0, 42008.789956050634, 42069.57930420718, 42228.78885605552, 38270.617293827265, 38345.61654383476, 38469.461221550824, 38709.612903871166, 39026.21947561033, 8362.0, 8437.198466145706, 8488.151184881463, 8549.358798090043, 8629.525376104375, 29761.25596860096, 30275.94034208792, 30791.69208307978, 30892.53661195039, 31559.684403156592, 35218.47172292469, 35230.0, 37241.81379093087, 39333.40999885061, 39604.60395396125, 10116.544755485873, 10260.17918566498, 10354.430506322225, 10425.0, 10829.566817327533, 10910.23628346008, 11275.605353812578, 11377.20359574855, 11445.713857153305, 11656.825147622962, 10452.32059916103, 10501.369917804956, 10552.630657926935, 10690.358578485315, 11080.0, 10529.684109476728, 10811.0, 10953.780924381626, 11007.119430445386, 11164.944175279072, 10441.164706823587, 10502.632407865687, 10618.893811061791, 10634.202434817265, 10697.14422846155, 8767.386282960131, 8932.732018039469, 9170.862437063315, 9379.718608441757, 9511.857322140035, 9294.209992150743, 9300.11648893354, 9338.953305233703, 9347.485888276211, 9436.292278079034], "unit": "score", "name": "yui.html", "value": 5927.4889825260725}], "name": "dromaeo_css", "value": 6364.301277265076}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 112.0, 112.0, 113.0, 118.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [159.0, 139.0, 159.0, 181.0, 145.0, 156.0, 163.0, 135.0, 183.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 155.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 161.0, 164.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [74.0, 79.0, 100.0, 99.0, 73.0, 73.0, 72.0, 114.0, 104.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 94.0, 93.0, 94.0, 151.0, 94.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 73.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 65.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [81.0, 92.0, 83.0, 90.0, 82.0, 84.0, 81.0, 82.0, 82.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 118.0, 126.0, 118.0, 134.0, 117.0, 118.0, 120.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [145.0, 141.0, 145.0, 139.0, 138.0, 136.0, 142.0, 139.0, 132.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 75.0, 68.0, 69.0, 67.0, 69.0, 68.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1523.8}]} 18:49:49 INFO - Return code: 0 18:49:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:49:49 ERROR - # TBPL SUCCESS # 18:49:49 INFO - Running post-action listener: _resource_record_post_action 18:49:49 INFO - Running post-run listener: _resource_record_post_run 18:49:50 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526618624; Read time: 4; Write time: 508808 18:49:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240119808; Read time: 0; Write time: 326296 18:49:50 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286498816; Read time: 4; Write time: 182512 18:49:50 INFO - Running post-run listener: _upload_blobber_files 18:49:50 INFO - Blob upload gear active. 18:49:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:49:50 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 18:49:50 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'] 18:49:50 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 18:49:51 INFO - (blobuploader) - INFO - Open directory for files ... 18:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:52 INFO - (blobuploader) - INFO - Done attempting. 18:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:52 INFO - (blobuploader) - INFO - Done attempting. 18:49:52 INFO - (blobuploader) - INFO - Iteration through files over. 18:49:52 INFO - Return code: 0 18:49:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:49:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:49:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5559f5d9d9883de59782d9f36b5d4d90873e178e3a0f9537e55156abb7e1b3e455f5341ac5256166c7277b3a09e2f21767461e5e2c383bd18276b91dc51fa1db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c4734edd27b58e709e47583560a9bbce5e861b2c459abf511df05d730470e152b7058af344362e07cad19f90b59262c128085577ad4c20db7701c81ddf097e9"} 18:49:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:49:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:49:52 INFO - Contents: 18:49:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5559f5d9d9883de59782d9f36b5d4d90873e178e3a0f9537e55156abb7e1b3e455f5341ac5256166c7277b3a09e2f21767461e5e2c383bd18276b91dc51fa1db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c4734edd27b58e709e47583560a9bbce5e861b2c459abf511df05d730470e152b7058af344362e07cad19f90b59262c128085577ad4c20db7701c81ddf097e9"} 18:49:52 INFO - Running post-run listener: copy_logs_to_upload_dir 18:49:52 INFO - Copying logs to upload dir... 18:49:52 INFO - mkdir: /builds/slave/test/build/upload/logs 18:49:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.485798 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-04 18:49:51.498448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 18:49:51.501663) ========= 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 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/5559f5d9d9883de59782d9f36b5d4d90873e178e3a0f9537e55156abb7e1b3e455f5341ac5256166c7277b3a09e2f21767461e5e2c383bd18276b91dc51fa1db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c4734edd27b58e709e47583560a9bbce5e861b2c459abf511df05d730470e152b7058af344362e07cad19f90b59262c128085577ad4c20db7701c81ddf097e9"} build_url:https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/MSxof3gjTb-peiY_2mLbsg/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/5559f5d9d9883de59782d9f36b5d4d90873e178e3a0f9537e55156abb7e1b3e455f5341ac5256166c7277b3a09e2f21767461e5e2c383bd18276b91dc51fa1db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c4734edd27b58e709e47583560a9bbce5e861b2c459abf511df05d730470e152b7058af344362e07cad19f90b59262c128085577ad4c20db7701c81ddf097e9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 18:49:51.531750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:49:51.532551) ========= 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=ed14279e38b05397cf4aa391000001a4-1459819212.519046-128960161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:49:51.611503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 18:49:51.611870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 18:49:51.612207) ========= ========= Total master_lag: 0.34 =========