builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1458094272.74 results: success (0) buildid: 20160315173441 builduid: c2d1fbc79f694009bb5ac8e00a618f10 revision: d49937a2e5fe27e469781ea09c42aa2a142cf77d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.738913) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.739434) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.739752) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006372 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.762225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.762528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.775698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.776003) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.825518) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.825841) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.826230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:12.826511) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 19:11:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-03-15 19:11:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.364998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.205153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.205469) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018679 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.255512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.255896) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d49937a2e5fe27e469781ea09c42aa2a142cf77d --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 d49937a2e5fe27e469781ea09c42aa2a142cf77d --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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 19:11:13,573 truncating revision to first 12 chars 2016-03-15 19:11:13,574 Setting DEBUG logging. 2016-03-15 19:11:13,574 attempt 1/10 2016-03-15 19:11:13,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d49937a2e5fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 19:11:13,834 unpacking tar archive at: fx-team-d49937a2e5fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564892 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.833566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.833920) ========= echo d49937a2e5fe27e469781ea09c42aa2a142cf77d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd49937a2e5fe27e469781ea09c42aa2a142cf77d'] 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d49937a2e5fe27e469781ea09c42aa2a142cf77d program finished with exit code 0 elapsedTime=0.004732 script_repo_revision: 'd49937a2e5fe27e469781ea09c42aa2a142cf77d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.885351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.885678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 19:11:13.895921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-03-15 19:11:13.896265) ========= /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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:14 INFO - MultiFileLogger online at 20160315 19:11:14 in /builds/slave/test 19:11:14 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 19:11:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:14 INFO - {'append_to_log': False, 19:11:14 INFO - 'base_work_dir': '/builds/slave/test', 19:11:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:11:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:14 INFO - 'branch': 'Fx-Team-Non-PGO', 19:11:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:14 INFO - 'config_files': ('talos/linux_config.py',), 19:11:14 INFO - 'default_actions': ('clobber', 19:11:14 INFO - 'read-buildbot-config', 19:11:14 INFO - 'download-and-extract', 19:11:14 INFO - 'populate-webroot', 19:11:14 INFO - 'create-virtualenv', 19:11:14 INFO - 'install', 19:11:14 INFO - 'run-tests'), 19:11:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:14 INFO - 'download_minidump_stackwalk': True, 19:11:14 INFO - 'download_symbols': 'ondemand', 19:11:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:14 INFO - 'installer_path': 'installer.exe', 19:11:14 INFO - 'log_level': 'info', 19:11:14 INFO - 'log_name': 'talos', 19:11:14 INFO - 'log_to_console': True, 19:11:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:14 INFO - 'opt_config_files': (), 19:11:14 INFO - 'pip_index': False, 19:11:14 INFO - 'sps_profile': False, 19:11:14 INFO - 'sps_profile_interval': 0, 19:11:14 INFO - 'suite': 'dromaeojs', 19:11:14 INFO - 'system_bits': '32', 19:11:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:14 INFO - 'title': 'talos-linux64-ix-011', 19:11:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:14 INFO - 'use_talos_json': True, 19:11:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:14 INFO - 'work_dir': 'build'} 19:11:14 INFO - ##### 19:11:14 INFO - ##### Running clobber step. 19:11:14 INFO - ##### 19:11:14 INFO - Running pre-action listener: _resource_record_pre_action 19:11:14 INFO - Running main action method: clobber 19:11:14 INFO - rmtree: /builds/slave/test/build 19:11:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:15 INFO - Running post-action listener: _resource_record_post_action 19:11:15 INFO - ##### 19:11:15 INFO - ##### Running read-buildbot-config step. 19:11:15 INFO - ##### 19:11:15 INFO - Running pre-action listener: _resource_record_pre_action 19:11:15 INFO - Running main action method: read_buildbot_config 19:11:15 INFO - Using buildbot properties: 19:11:15 INFO - { 19:11:15 INFO - "project": "", 19:11:15 INFO - "product": "firefox", 19:11:15 INFO - "script_repo_revision": "production", 19:11:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:11:15 INFO - "repository": "", 19:11:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:11:15 INFO - "buildid": "20160315173441", 19:11:15 INFO - "pgo_build": "False", 19:11:15 INFO - "basedir": "/builds/slave/test", 19:11:15 INFO - "buildnumber": 2642, 19:11:15 INFO - "slavename": "talos-linux64-ix-011", 19:11:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:11:15 INFO - "platform": "ubuntu64_hw", 19:11:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:11:15 INFO - "branch": "fx-team", 19:11:15 INFO - "repo_path": "integration/fx-team", 19:11:15 INFO - "revision": "d49937a2e5fe27e469781ea09c42aa2a142cf77d", 19:11:15 INFO - "stage_platform": "linux64", 19:11:15 INFO - "builduid": "c2d1fbc79f694009bb5ac8e00a618f10", 19:11:15 INFO - "slavebuilddir": "test" 19:11:15 INFO - } 19:11:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:11:15 INFO - Running post-action listener: _resource_record_post_action 19:11:15 INFO - ##### 19:11:15 INFO - ##### Running download-and-extract step. 19:11:15 INFO - ##### 19:11:15 INFO - Running pre-action listener: _resource_record_pre_action 19:11:15 INFO - Running main action method: download_and_extract 19:11:15 INFO - mkdir: /builds/slave/test/build/tests 19:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:15 INFO - https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:15 INFO - Downloaded 1361 bytes. 19:11:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:11:15 INFO - Using the following test package requirements: 19:11:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:11:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:11:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'jsshell-linux-x86_64.zip'], 19:11:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:11:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:11:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:11:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:11:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:11:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:15 INFO - https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:17 INFO - Downloaded 21992845 bytes. 19:11:17 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'] 19:11:17 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 19:11:18 INFO - Return code: 0 19:11:18 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 19:11: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')]} 19:11:18 INFO - https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:19 INFO - Downloaded 21992845 bytes. 19:11:19 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'] 19:11:19 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 19:11:20 INFO - Return code: 0 19:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:20 INFO - https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:21 INFO - Downloaded 10846462 bytes. 19:11:21 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'] 19:11:21 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 19:11:22 INFO - Return code: 0 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:22 INFO - https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GA9D2jE1T4-YDijFbfqbew/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 19:11:23 INFO - Downloaded 54097624 bytes. 19:11:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:23 INFO - mkdir: /builds/slave/test/properties 19:11:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:23 INFO - Contents: 19:11:23 INFO - build_url:https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:24 INFO - Running post-action listener: _resource_record_post_action 19:11:24 INFO - Running post-action listener: set_extra_try_arguments 19:11:24 INFO - ##### 19:11:24 INFO - ##### Running populate-webroot step. 19:11:24 INFO - ##### 19:11:24 INFO - Running pre-action listener: _resource_record_pre_action 19:11:24 INFO - Running main action method: populate_webroot 19:11:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:24 INFO - '--tppagecycles', 19:11:24 INFO - '7'], 19:11:24 INFO - 'tests': ['tsvgm']}}, 19:11:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:11:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:11:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'tests': ['damp', 'tps']}, 19:11:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['damp', 'tps']}, 19:11:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:11:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:24 INFO - 'other': {'tests': ['a11yr', 19:11:24 INFO - 'ts_paint', 19:11:24 INFO - 'tpaint', 19:11:24 INFO - 'sessionrestore', 19:11:24 INFO - 'sessionrestore_no_auto_restore', 19:11:24 INFO - 'tabpaint']}, 19:11:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['a11yr', 19:11:24 INFO - 'ts_paint', 19:11:24 INFO - 'tpaint', 19:11:24 INFO - 'sessionrestore', 19:11:24 INFO - 'sessionrestore_no_auto_restore', 19:11:24 INFO - 'tabpaint']}, 19:11:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['a11yr', 19:11:24 INFO - 'ts_paint', 19:11:24 INFO - 'tpaint', 19:11:24 INFO - 'sessionrestore', 19:11:24 INFO - 'sessionrestore_no_auto_restore', 19:11:24 INFO - 'tabpaint']}, 19:11:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['a11yr', 19:11:24 INFO - 'ts_paint', 19:11:24 INFO - 'tpaint', 19:11:24 INFO - 'sessionrestore', 19:11:24 INFO - 'sessionrestore_no_auto_restore', 19:11:24 INFO - 'tabpaint']}, 19:11:24 INFO - 'other_l64': {'tests': ['a11yr', 19:11:24 INFO - 'ts_paint', 19:11:24 INFO - 'tpaint', 19:11:24 INFO - 'sessionrestore', 19:11:24 INFO - 'sessionrestore_no_auto_restore', 19:11:24 INFO - 'tabpaint']}, 19:11:24 INFO - 'other_nol64': {'tests': ['a11yr', 19:11:24 INFO - 'ts_paint', 19:11:24 INFO - 'tpaint', 19:11:24 INFO - 'sessionrestore', 19:11:24 INFO - 'sessionrestore_no_auto_restore', 19:11:24 INFO - 'tabpaint']}, 19:11:24 INFO - 'svgr': {'tests': ['tsvgx', 19:11:24 INFO - 'tsvgr_opacity', 19:11:24 INFO - 'tart', 19:11:24 INFO - 'tscrollx', 19:11:24 INFO - 'cart']}, 19:11:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['tsvgx', 19:11:24 INFO - 'tsvgr_opacity', 19:11:24 INFO - 'tart', 19:11:24 INFO - 'tscrollx', 19:11:24 INFO - 'cart']}, 19:11:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'tests': ['tp5o']}, 19:11:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'talos_options': ['--e10s'], 19:11:24 INFO - 'tests': ['tp5o']}, 19:11:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'talos_options': ['--xperf_path', 19:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:24 INFO - 'tests': ['tp5n']}, 19:11:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:24 INFO - 'talos_options': ['--e10s', 19:11:24 INFO - '--xperf_path', 19:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:24 INFO - 'tests': ['tp5n']}}, 19:11:24 INFO - 'talos.zip': {'path': '', 19:11:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:24 INFO - Running post-action listener: _resource_record_post_action 19:11:24 INFO - ##### 19:11:24 INFO - ##### Running create-virtualenv step. 19:11:24 INFO - ##### 19:11:24 INFO - Running pre-action listener: _resource_record_pre_action 19:11:24 INFO - Running main action method: create_virtualenv 19:11:24 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:24 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 19:11:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:24 INFO - Using real prefix '/usr' 19:11:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:26 INFO - Installing pip.................done. 19:11:26 INFO - Return code: 0 19:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:26 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 19:11:26 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 19:11:26 INFO - Using env: {'DISPLAY': ':0', 19:11:26 INFO - 'HOME': '/home/cltbld', 19:11:26 INFO - 'LANG': 'en_US.UTF-8', 19:11:26 INFO - 'LANGUAGE': 'en_US:en', 19:11:26 INFO - 'LOGNAME': 'cltbld', 19:11:26 INFO - 'MAIL': '/var/mail/cltbld', 19:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:26 INFO - 'MOZ_NO_REMOTE': '1', 19:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:26 INFO - 'NO_EM_RESTART': '1', 19:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:26 INFO - 'PWD': '/builds/slave/test', 19:11:26 INFO - 'SHELL': '/bin/bash', 19:11:26 INFO - 'SHLVL': '1', 19:11:26 INFO - 'TERM': 'linux', 19:11:26 INFO - 'TMOUT': '86400', 19:11:26 INFO - 'USER': 'cltbld', 19:11:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:26 INFO - '_': '/tools/buildbot/bin/python'} 19:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:26 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 19:11:26 INFO - Cleaning up... 19:11:26 INFO - Return code: 0 19:11:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:26 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 19:11:26 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 19:11:26 INFO - Using env: {'DISPLAY': ':0', 19:11:26 INFO - 'HOME': '/home/cltbld', 19:11:26 INFO - 'LANG': 'en_US.UTF-8', 19:11:26 INFO - 'LANGUAGE': 'en_US:en', 19:11:26 INFO - 'LOGNAME': 'cltbld', 19:11:26 INFO - 'MAIL': '/var/mail/cltbld', 19:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:26 INFO - 'MOZ_NO_REMOTE': '1', 19:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:26 INFO - 'NO_EM_RESTART': '1', 19:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:26 INFO - 'PWD': '/builds/slave/test', 19:11:26 INFO - 'SHELL': '/bin/bash', 19:11:26 INFO - 'SHLVL': '1', 19:11:26 INFO - 'TERM': 'linux', 19:11:26 INFO - 'TMOUT': '86400', 19:11:26 INFO - 'USER': 'cltbld', 19:11:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:26 INFO - '_': '/tools/buildbot/bin/python'} 19:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:27 INFO - Downloading/unpacking psutil>=0.7.1 19:11:27 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 19:11:27 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 19:11:27 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 19:11:27 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 19:11:27 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 19:11:27 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 19:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:29 INFO - Installing collected packages: psutil 19:11:29 INFO - Running setup.py install for psutil 19:11:29 INFO - building 'psutil._psutil_linux' extension 19:11:29 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 19:11:29 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 19:11:29 INFO - building 'psutil._psutil_posix' extension 19:11:29 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 19:11:29 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 19:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:29 INFO - Successfully installed psutil 19:11:29 INFO - Cleaning up... 19:11:29 INFO - Return code: 0 19:11:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:11:29 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')]} 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:29 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')]} 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:29 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:29 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 19:11:29 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 19:11:29 INFO - Using env: {'DISPLAY': ':0', 19:11:29 INFO - 'HOME': '/home/cltbld', 19:11:29 INFO - 'LANG': 'en_US.UTF-8', 19:11:29 INFO - 'LANGUAGE': 'en_US:en', 19:11:29 INFO - 'LOGNAME': 'cltbld', 19:11:29 INFO - 'MAIL': '/var/mail/cltbld', 19:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:29 INFO - 'MOZ_NO_REMOTE': '1', 19:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:29 INFO - 'NO_EM_RESTART': '1', 19:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:29 INFO - 'PWD': '/builds/slave/test', 19:11:29 INFO - 'SHELL': '/bin/bash', 19:11:29 INFO - 'SHLVL': '1', 19:11:29 INFO - 'TERM': 'linux', 19:11:29 INFO - 'TMOUT': '86400', 19:11:29 INFO - 'USER': 'cltbld', 19:11:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:29 INFO - '_': '/tools/buildbot/bin/python'} 19:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:11:31 INFO - Installing collected packages: mozsystemmonitor 19:11:31 INFO - Running setup.py install for mozsystemmonitor 19:11:31 INFO - Successfully installed mozsystemmonitor 19:11:31 INFO - Cleaning up... 19:11:31 INFO - Return code: 0 19:11:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:11:31 INFO - Using env: {'DISPLAY': ':0', 19:11:31 INFO - 'HOME': '/home/cltbld', 19:11:31 INFO - 'LANG': 'en_US.UTF-8', 19:11:31 INFO - 'LANGUAGE': 'en_US:en', 19:11:31 INFO - 'LOGNAME': 'cltbld', 19:11:31 INFO - 'MAIL': '/var/mail/cltbld', 19:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:31 INFO - 'MOZ_NO_REMOTE': '1', 19:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:31 INFO - 'NO_EM_RESTART': '1', 19:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:31 INFO - 'PWD': '/builds/slave/test', 19:11:31 INFO - 'SHELL': '/bin/bash', 19:11:31 INFO - 'SHLVL': '1', 19:11:31 INFO - 'TERM': 'linux', 19:11:31 INFO - 'TMOUT': '86400', 19:11:31 INFO - 'USER': 'cltbld', 19:11:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:31 INFO - '_': '/tools/buildbot/bin/python'} 19:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:33 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:34 INFO - Downloading docopt-0.6.1.tar.gz 19:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:34 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:34 INFO - Running setup.py install for blobuploader 19:11:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:34 INFO - Running setup.py install for requests 19:11:35 INFO - Running setup.py install for docopt 19:11:35 INFO - Successfully installed blobuploader requests docopt 19:11:35 INFO - Cleaning up... 19:11:35 INFO - Return code: 0 19:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:35 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:35 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 19:11:35 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 19:11:35 INFO - Using env: {'DISPLAY': ':0', 19:11:35 INFO - 'HOME': '/home/cltbld', 19:11:35 INFO - 'LANG': 'en_US.UTF-8', 19:11:35 INFO - 'LANGUAGE': 'en_US:en', 19:11:35 INFO - 'LOGNAME': 'cltbld', 19:11:35 INFO - 'MAIL': '/var/mail/cltbld', 19:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:35 INFO - 'MOZ_NO_REMOTE': '1', 19:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:35 INFO - 'NO_EM_RESTART': '1', 19:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:35 INFO - 'PWD': '/builds/slave/test', 19:11:35 INFO - 'SHELL': '/bin/bash', 19:11:35 INFO - 'SHLVL': '1', 19:11:35 INFO - 'TERM': 'linux', 19:11:35 INFO - 'TMOUT': '86400', 19:11:35 INFO - 'USER': 'cltbld', 19:11:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:35 INFO - '_': '/tools/buildbot/bin/python'} 19:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:35 INFO - Running setup.py (path:/tmp/pip-6OLRdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:35 INFO - Running setup.py (path:/tmp/pip-QrmiyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:35 INFO - Running setup.py (path:/tmp/pip-KNQI3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:35 INFO - Running setup.py (path:/tmp/pip-mVEUN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:35 INFO - Running setup.py (path:/tmp/pip-8szik0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:35 INFO - Running setup.py (path:/tmp/pip-Tj5AP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:35 INFO - Running setup.py (path:/tmp/pip-FqekSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:36 INFO - Running setup.py (path:/tmp/pip-ZjaNIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:36 INFO - Running setup.py (path:/tmp/pip-iCuNA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:36 INFO - Running setup.py (path:/tmp/pip-0UUzlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:36 INFO - Running setup.py (path:/tmp/pip-YgvL8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:36 INFO - Running setup.py (path:/tmp/pip-BAVSpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:36 INFO - Running setup.py (path:/tmp/pip-05sj6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:36 INFO - Running setup.py (path:/tmp/pip-rjfzmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:36 INFO - Running setup.py (path:/tmp/pip-uxIuy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:36 INFO - Running setup.py (path:/tmp/pip-MEvGlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:36 INFO - Running setup.py (path:/tmp/pip-rbLvgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:36 INFO - Running setup.py install for manifestparser 19:11:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:36 INFO - Running setup.py install for mozcrash 19:11:36 INFO - Running setup.py install for mozdebug 19:11:37 INFO - Running setup.py install for mozdevice 19:11:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Running setup.py install for mozfile 19:11:37 INFO - Running setup.py install for mozhttpd 19:11:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Running setup.py install for mozinfo 19:11:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Running setup.py install for mozInstall 19:11:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Running setup.py install for mozleak 19:11:37 INFO - Running setup.py install for mozlog 19:11:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Running setup.py install for moznetwork 19:11:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:37 INFO - Running setup.py install for mozprocess 19:11:37 INFO - Running setup.py install for mozprofile 19:11:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:38 INFO - Running setup.py install for mozrunner 19:11:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:38 INFO - Running setup.py install for mozscreenshot 19:11:38 INFO - Running setup.py install for moztest 19:11:38 INFO - Running setup.py install for mozversion 19:11:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:38 INFO - Cleaning up... 19:11:38 INFO - Return code: 0 19:11:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:38 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:38 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 19:11:38 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 19:11:38 INFO - Using env: {'DISPLAY': ':0', 19:11:38 INFO - 'HOME': '/home/cltbld', 19:11:38 INFO - 'LANG': 'en_US.UTF-8', 19:11:38 INFO - 'LANGUAGE': 'en_US:en', 19:11:38 INFO - 'LOGNAME': 'cltbld', 19:11:38 INFO - 'MAIL': '/var/mail/cltbld', 19:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:38 INFO - 'MOZ_NO_REMOTE': '1', 19:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:38 INFO - 'NO_EM_RESTART': '1', 19:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:38 INFO - 'PWD': '/builds/slave/test', 19:11:38 INFO - 'SHELL': '/bin/bash', 19:11:38 INFO - 'SHLVL': '1', 19:11:38 INFO - 'TERM': 'linux', 19:11:38 INFO - 'TMOUT': '86400', 19:11:38 INFO - 'USER': 'cltbld', 19:11:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:38 INFO - '_': '/tools/buildbot/bin/python'} 19:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:38 INFO - Running setup.py (path:/tmp/pip-vZfCtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:38 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)) 19:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:38 INFO - Running setup.py (path:/tmp/pip-7Gqo8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:38 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)) 19:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:38 INFO - Running setup.py (path:/tmp/pip-Zp2d92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:38 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)) 19:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:38 INFO - Running setup.py (path:/tmp/pip-A5t9Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:39 INFO - Running setup.py (path:/tmp/pip-Qqfovw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:39 INFO - Running setup.py (path:/tmp/pip-kh0w9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:39 INFO - Running setup.py (path:/tmp/pip-WWBCVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:39 INFO - Running setup.py (path:/tmp/pip-lVcLWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:39 INFO - Running setup.py (path:/tmp/pip-rLkQw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:39 INFO - Running setup.py (path:/tmp/pip-hkRuGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:39 INFO - Running setup.py (path:/tmp/pip-XOC1YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:39 INFO - Running setup.py (path:/tmp/pip-B4mskX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:39 INFO - Running setup.py (path:/tmp/pip-yi8xB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:39 INFO - Running setup.py (path:/tmp/pip-HTPBg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:39 INFO - Running setup.py (path:/tmp/pip-m7eLUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:39 INFO - Running setup.py (path:/tmp/pip-BXngaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:39 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)) 19:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:39 INFO - Running setup.py (path:/tmp/pip-dZHaeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:39 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)) 19:11:39 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)) 19:11:39 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)) 19:11:39 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)) 19:11:39 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)) 19:11:39 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)) 19:11:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:41 INFO - Downloading blessings-1.6.tar.gz 19:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:41 INFO - Installing collected packages: blessings 19:11:41 INFO - Running setup.py install for blessings 19:11:41 INFO - Successfully installed blessings 19:11:41 INFO - Cleaning up... 19:11:42 INFO - Return code: 0 19:11:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:42 INFO - Reading from file tmpfile_stdout 19:11:42 INFO - Current package versions: 19:11:42 INFO - argparse == 1.2.1 19:11:42 INFO - blessings == 1.6 19:11:42 INFO - blobuploader == 1.2.4 19:11:42 INFO - docopt == 0.6.1 19:11:42 INFO - manifestparser == 1.1 19:11:42 INFO - mozInstall == 1.12 19:11:42 INFO - mozcrash == 0.17 19:11:42 INFO - mozdebug == 0.1 19:11:42 INFO - mozdevice == 0.48 19:11:42 INFO - mozfile == 1.2 19:11:42 INFO - mozhttpd == 0.7 19:11:42 INFO - mozinfo == 0.9 19:11:42 INFO - mozleak == 0.1 19:11:42 INFO - mozlog == 3.1 19:11:42 INFO - moznetwork == 0.27 19:11:42 INFO - mozprocess == 0.22 19:11:42 INFO - mozprofile == 0.28 19:11:42 INFO - mozrunner == 6.11 19:11:42 INFO - mozscreenshot == 0.1 19:11:42 INFO - mozsystemmonitor == 0.0 19:11:42 INFO - moztest == 0.7 19:11:42 INFO - mozversion == 1.4 19:11:42 INFO - psutil == 3.1.1 19:11:42 INFO - requests == 1.2.3 19:11:42 INFO - wsgiref == 0.1.2 19:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:42 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:42 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 19:11:42 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 19:11:42 INFO - Using env: {'DISPLAY': ':0', 19:11:42 INFO - 'HOME': '/home/cltbld', 19:11:42 INFO - 'LANG': 'en_US.UTF-8', 19:11:42 INFO - 'LANGUAGE': 'en_US:en', 19:11:42 INFO - 'LOGNAME': 'cltbld', 19:11:42 INFO - 'MAIL': '/var/mail/cltbld', 19:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:42 INFO - 'MOZ_NO_REMOTE': '1', 19:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:42 INFO - 'NO_EM_RESTART': '1', 19:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:42 INFO - 'PWD': '/builds/slave/test', 19:11:42 INFO - 'SHELL': '/bin/bash', 19:11:42 INFO - 'SHLVL': '1', 19:11:42 INFO - 'TERM': 'linux', 19:11:42 INFO - 'TMOUT': '86400', 19:11:42 INFO - 'USER': 'cltbld', 19:11:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:42 INFO - '_': '/tools/buildbot/bin/python'} 19:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 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)) 19:11:42 INFO - Cleaning up... 19:11:42 INFO - Return code: 0 19:11:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:42 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:42 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 19:11:42 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 19:11:42 INFO - Using env: {'DISPLAY': ':0', 19:11:42 INFO - 'HOME': '/home/cltbld', 19:11:42 INFO - 'LANG': 'en_US.UTF-8', 19:11:42 INFO - 'LANGUAGE': 'en_US:en', 19:11:42 INFO - 'LOGNAME': 'cltbld', 19:11:42 INFO - 'MAIL': '/var/mail/cltbld', 19:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:42 INFO - 'MOZ_NO_REMOTE': '1', 19:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:42 INFO - 'NO_EM_RESTART': '1', 19:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:42 INFO - 'PWD': '/builds/slave/test', 19:11:42 INFO - 'SHELL': '/bin/bash', 19:11:42 INFO - 'SHLVL': '1', 19:11:42 INFO - 'TERM': 'linux', 19:11:42 INFO - 'TMOUT': '86400', 19:11:42 INFO - 'USER': 'cltbld', 19:11:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:42 INFO - '_': '/tools/buildbot/bin/python'} 19:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:42 INFO - Downloading/unpacking jsonschema 19:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:44 INFO - Downloading/unpacking functools32 (from jsonschema) 19:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:44 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:44 INFO - warning: no files found matching '*.txt' 19:11:44 INFO - no previously-included directories found matching 'build' 19:11:44 INFO - no previously-included directories found matching 'dist' 19:11:44 INFO - no previously-included directories found matching '.git*' 19:11:44 INFO - Installing collected packages: jsonschema, functools32 19:11:44 INFO - Running setup.py install for functools32 19:11:44 INFO - warning: no files found matching '*.txt' 19:11:44 INFO - no previously-included directories found matching 'build' 19:11:44 INFO - no previously-included directories found matching 'dist' 19:11:44 INFO - no previously-included directories found matching '.git*' 19:11:44 INFO - Successfully installed jsonschema functools32 19:11:44 INFO - Cleaning up... 19:11:45 INFO - Return code: 0 19:11:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 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 0x7fb5b379bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26da410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', '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 19:11:45 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 19:11:45 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 19:11:45 INFO - Using env: {'DISPLAY': ':0', 19:11:45 INFO - 'HOME': '/home/cltbld', 19:11:45 INFO - 'LANG': 'en_US.UTF-8', 19:11:45 INFO - 'LANGUAGE': 'en_US:en', 19:11:45 INFO - 'LOGNAME': 'cltbld', 19:11:45 INFO - 'MAIL': '/var/mail/cltbld', 19:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:45 INFO - 'MOZ_NO_REMOTE': '1', 19:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:45 INFO - 'NO_EM_RESTART': '1', 19:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:45 INFO - 'PWD': '/builds/slave/test', 19:11:45 INFO - 'SHELL': '/bin/bash', 19:11:45 INFO - 'SHLVL': '1', 19:11:45 INFO - 'TERM': 'linux', 19:11:45 INFO - 'TMOUT': '86400', 19:11:45 INFO - 'USER': 'cltbld', 19:11:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:45 INFO - '_': '/tools/buildbot/bin/python'} 19:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:45 INFO - Downloading/unpacking flake8 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:47 INFO - no previously-included directories found matching 'docs/_build' 19:11:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:11:47 INFO - Running setup.py install for pep8 19:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:47 INFO - no previously-included directories found matching 'docs/_build' 19:11:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:11:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:11:48 INFO - Cleaning up... 19:11:48 INFO - Return code: 0 19:11:48 INFO - Running post-action listener: _resource_record_post_action 19:11:48 INFO - Running post-action listener: _start_resource_monitoring 19:11:48 INFO - Starting resource monitoring. 19:11:48 INFO - ##### 19:11:48 INFO - ##### Running install step. 19:11:48 INFO - ##### 19:11:48 INFO - Running pre-action listener: _resource_record_pre_action 19:11:48 INFO - Running main action method: install 19:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:48 INFO - Reading from file tmpfile_stdout 19:11:48 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:48 INFO - Reading from file tmpfile_stdout 19:11:48 INFO - Output received: 19:11:48 INFO - Usage: mozinstall [options] installer 19:11:48 INFO - Options: 19:11:48 INFO - -h, --help show this help message and exit 19:11:48 INFO - -d DEST, --destination=DEST 19:11:48 INFO - Directory to install application into. [default: 19:11:48 INFO - "/builds/slave/test"] 19:11:48 INFO - --app=APP Application being installed. [default: firefox] 19:11:48 INFO - mkdir: /builds/slave/test/build/application 19:11:48 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'] 19:11:48 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 19:12:03 INFO - Reading from file tmpfile_stdout 19:12:03 INFO - Output received: 19:12:03 INFO - /builds/slave/test/build/application/firefox/firefox 19:12:03 INFO - Running post-action listener: _resource_record_post_action 19:12:03 INFO - ##### 19:12:03 INFO - ##### Running run-tests step. 19:12:03 INFO - ##### 19:12:03 INFO - Running pre-action listener: _resource_record_pre_action 19:12:03 INFO - Running main action method: run_tests 19:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:03 INFO - Python 2.7.3 19:12:03 INFO - Return code: 0 19:12:03 INFO - grabbing minidump binary from tooltool 19:12:03 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')]} 19:12:03 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 0x2769160>, '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 0x276a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:03 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 19:12:03 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 19:12:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:04 INFO - Return code: 0 19:12:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:12:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:12:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:12:05 INFO - Return code: 0 19:12:05 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/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 19:12:05 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/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 19:12:05 INFO - Using env: {'DISPLAY': ':0', 19:12:05 INFO - 'HOME': '/home/cltbld', 19:12:05 INFO - 'LANG': 'en_US.UTF-8', 19:12:05 INFO - 'LANGUAGE': 'en_US:en', 19:12:05 INFO - 'LOGNAME': 'cltbld', 19:12:05 INFO - 'MAIL': '/var/mail/cltbld', 19:12:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:05 INFO - 'MOZ_NO_REMOTE': '1', 19:12:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:05 INFO - 'NO_EM_RESTART': '1', 19:12:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:05 INFO - 'PWD': '/builds/slave/test', 19:12:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:05 INFO - 'SHELL': '/bin/bash', 19:12:05 INFO - 'SHLVL': '1', 19:12:05 INFO - 'TERM': 'linux', 19:12:05 INFO - 'TMOUT': '86400', 19:12:05 INFO - 'USER': 'cltbld', 19:12:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191', 19:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:05 INFO - '_': '/tools/buildbot/bin/python'} 19:12:05 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/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 19:12:05 INFO - mozversion application_buildid: 20160315173441 19:12:05 INFO - mozversion application_changeset: d49937a2e5fe27e469781ea09c42aa2a142cf77d 19:12:05 INFO - mozversion application_display_name: Nightly 19:12:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:05 INFO - mozversion application_name: Firefox 19:12:05 INFO - mozversion application_remotingname: firefox 19:12:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:12:05 INFO - mozversion application_vendor: Mozilla 19:12:05 INFO - mozversion application_version: 48.0a1 19:12:05 INFO - mozversion platform_buildid: 20160315173441 19:12:05 INFO - mozversion platform_changeset: d49937a2e5fe27e469781ea09c42aa2a142cf77d 19:12:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:12:05 INFO - mozversion platform_version: 48.0a1 19:12:05 INFO - using testdate: 1458094325 19:12:05 INFO - actual date: 1458094325 19:12:05 INFO - starting webserver on 'localhost:57966' 19:12:05 INFO - SUITE-START | Running 2 tests 19:12:05 INFO - TEST-START | dromaeo_css 19:12:05 INFO - operating with platform_type : linux_ 19:12:05 INFO - Initialising browser for dromaeo_css test... 19:12:05 INFO - TEST-INFO | started process 4840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCjh0G/profile http://localhost:57966/getInfo.html) 19:12:10 INFO - PROCESS | 4840 | __metrics Screen width/height:1600/1200 19:12:10 INFO - PROCESS | 4840 | colorDepth:24 19:12:10 INFO - PROCESS | 4840 | Browser inner width/height: 1024/697 19:12:10 INFO - PROCESS | 4840 | __metrics 19:12:11 ERROR - PROCESS | 4840 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:12:12 INFO - TEST-INFO | 4840: exit 0 19:12:12 INFO - Browser initialized. 19:12:12 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:12 INFO - TEST-INFO | started process 4932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUCjh0G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:24 INFO - PROCESS | 4932 | RSS: Main: 153833472 19:12:24 INFO - PROCESS | 4932 | 19:13:15 INFO - PROCESS | 4932 | 1458094395404 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] 19:15:27 INFO - PROCESS | 4932 | Cycle 1(1): loaded http://localhost:57966/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57966/tests/dromaeo/cssquery-ext.html) 19:15:27 INFO - PROCESS | 4932 | RSS: Main: 244977664 19:15:27 INFO - PROCESS | 4932 | 19:18:30 INFO - PROCESS | 4932 | Cycle 1(1): loaded http://localhost:57966/tests/dromaeo/cssquery-ext.html (next: http://localhost:57966/tests/dromaeo/cssquery-jquery.html) 19:18:30 INFO - PROCESS | 4932 | RSS: Main: 234508288 19:18:30 INFO - PROCESS | 4932 | 19:21:32 INFO - PROCESS | 4932 | Cycle 1(1): loaded http://localhost:57966/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57966/tests/dromaeo/cssquery-mootools.html) 19:21:33 INFO - PROCESS | 4932 | RSS: Main: 234778624 19:21:33 INFO - PROCESS | 4932 | 19:24:35 INFO - PROCESS | 4932 | Cycle 1(1): loaded http://localhost:57966/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57966/tests/dromaeo/cssquery-prototype.html) 19:24:35 INFO - PROCESS | 4932 | RSS: Main: 210624512 19:24:35 INFO - PROCESS | 4932 | 19:27:38 INFO - PROCESS | 4932 | Cycle 1(1): loaded http://localhost:57966/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57966/tests/dromaeo/cssquery-yui.html) 19:27:39 INFO - PROCESS | 4932 | RSS: Main: 203849728 19:27:39 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | Cycle 1(1): loaded http://localhost:57966/tests/dromaeo/cssquery-yui.html (next: http://localhost:57966/tests/dromaeo/cssquery-dojo.html) 19:30:41 INFO - PROCESS | 4932 | RSS: Main: 265396224 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | __start_tp_report 19:30:41 INFO - PROCESS | 4932 | _x_x_mozilla_page_load 19:30:41 INFO - PROCESS | 4932 | _x_x_mozilla_page_load_details 19:30:41 INFO - PROCESS | 4932 | |i|pagename|runs| 19:30:41 INFO - PROCESS | 4932 | |0;dojo.html;2596.052440859087;2655.4556315955233;2660.76053155216;2679.0221569127275;2694.6227528146055;4615.053913947641;4622.260438329864;4647.976760116199;4661.510541393156;4742.857714268569;4660.836870709526;4668.25307950728;4678.345031695565;4690.0385420988705;4716.575508204261;4240.448741663579;4310.6982511224305;4350.8912277193;4399.560043995607;4401.471823381199;4232.15356928614;4313.719608225455;4375.912481750363;4385.342198670209;4389.582989615981;4255.234057869582;4279.144171165779;4298.742075475481;4311.051568654891;4344.608985191317;4287.764172970486;4304.59106384896;4307.353896915456;4342;4342.261815491374;4175.958240417587;4290.313549832012;4291.4850217973735;4291.914161716748;4346.15250026245;4575.4051973243595;4613.7001094929055;4637.466691330506;4665.020345727401;4667.649926255544;5001.374828146481;5002.9499705002845;5010.223415370623;5010.248462730583;5051.924221136685;4939.308496810413;5009.323741294915;5017.899642007176;5027.346444962168;5028.346314979066;4682.74244916526;4717.787699553528;4742.834000809989;4761.547652972962;4763;5118.769655365518;5139.897202055938;5147.073526765218;5147.897042059213;5194.454582268883;4863.513648635179;4924.63065270099;4935.407751069823;4946.134426475424;5021.020900924358;5039.244113383022;5062.898742025212;5067.037262920107;5067.949320506821;5087.847364579068;5005.349304590452;5010.49895010496;5011.273365362002;5012.699238045729;5041.092603331435;4884.853454396374;4918;4969.751512424365;4988.6009119270375;5000.14997450427;4265.53079161292;4273.7008409411665;4287.571242875688;4303.096349766584;4322.978385108055;3762.3039737648623;3766;3777.58446570877;3784.4701741756176;3796.6393192646656;4167.166566686675;4247.6389506892265;4269.039466120098;4332.718373305725;4337.240982827992;5013.573846223112;5040.49595040493;5042.042012017705;5053.620978426559;5076.949230507722;4268.317069268902;4284.507281662649;4293.3989241506215;4293.527711951683;4327.156204540147;4445.2887537993765;4528.47922488918;4563.657725670588;4567;4594.839180628662;4675.345451636774;4681.485036646034;4690.788914498788;4695.788689508912;4750.667453278237;4913.77887995034;4992.126377883928;4993.051320249141;5000.524950129732;5044.419891712353;4664.743439110882;4692.296155576691;4699.201135806853;4724.905501889874;4755;4885.3649025627865;4892.8532144035735;4925.975370123127;4932.087563800708;4973.9253911190635;4838.661293709407;4999.800007999785;5004.624653150955;5022.748862556785;5050.267711181931;4870.878228044186;4885.926711099265;4888.657793954531;4896.436909755424;4952.628552858622;4886.193778026728;4886.975565122294;4888.975555122344;4892.951070489249;4924.236743304794;4757.643176761688;4782.0435912818275;4804.2073057946445;4843.854684359475;4863.95136048635;4878.463369029333;4879.731614761222;4891.021795640957;4894.094592500399;4948.430930443045;4727.054589082129;4756.191447453872;4772.856814295576;4774.928376074431;4819.518048195152 19:30:41 INFO - PROCESS | 4932 | |1;ext.html;499.6003197442048;535.389655792397;541.2773946781048;560.6523955147809;571.9875819798956;27140.45719085617;27853.303667408323;27858.582121268173;34884.825575872084;35587.82206088966;40079;40753.59246407535;40781.59218407815;40911.38632920501;41008.79495602518;7808.921910780905;7979.241972012649;8000.8799868002025;8004.359651227917;8005.439619226657;7815.140334563193;7933.841323173562;7942.444028917978;7944.165862584432;7946.284834364906;7899.170587088359;7990.400719945998;7991.680332786682;7992.080910695287;7993.480423772466;7913.446058775888;7964.2433968772875;7964.960175199116;7982.760517184435;7987.96006019972;7928.762137135837;8058;8059.992500937383;8060.113387527367;8060.5566693831815;38499;38965.415518767244;38981;38990.80504597487;39066.41400378996;3086.182161727144;3170.1282147409647;3558.2349794793986;3825.7704537727827;3885.1258466845015;28174.436511269865;28479.430411391655;29142.562861557093;31016.224594385094;31977.200569985936;3379.4761811919193;3389.1018879996823;3417.3165366926714;3445.9655403445895;3493.5633045869267;233532;237865;239146;239211;239902;42789;59644.105338419955;59795;60307.69846150829;60424.39575604276;44208.91597466332;44528.3320750189;44546.77726611411;44588.777056114515;44626;12217.389130543437;12243.57147499851;12285.57000504978;12285.815712764315;12307.4461649226;9393;9398.765030874283;9435.764105897408;9461;9474.24206063527;14757;14770.92614536942;14779.704405912036;15328.080315181125;15454.845451545341;6162.845928851814;6291.622502649856;6331;6359.141515895388;6362.586431881913;891.9509426981449;959.1511512311655;992.8212921674168;1009.8687170667766;1013.8143396526713;27430.314242143708;27733.722662773114;28138.155855324374;28213.576796348072;28302.433951320858;805.5046146619903;916.5783739479781;937.6249500199838;956.5695437053354;967.5936106835146;13190;13363.732725345439;13520.25638589887;13603.387847546885;13665.863341366658;275857;427855;435127;435189;436804;50300;50982.235266471034;51292;51312.230316544534;51334.48665513372;1082.9025387715144;1167.3579531257774;1228.4778968938165;1238.3684320996356;1255.6798016505732;25950.61074083928;28063.43873122567;28165.43669126565;29531.114066578037;30348.393032139677;36830;37443.81278093592;37898.810505947295;38090;38119.42820857634;219409;219737;220115;220329;220570;24323.75676243215;32010;33011.33977320392;33324.50013249851;33717.325653487285;38111.42832857565;38382;38915.80542097385;39250.21499569935;39301.2139757209;32300.35399292048;33234;33491.4976275361;33875.322493550484;34016.14959626029;33055.66944330526;33321.50017749687;33454.33091338208;33516.49725254074;33592.49611255882;32790.180245494055;33207.667923320456;33648;33767.4934875982;33782.83108584442;28968.855155724086;29670.406591868472;30089.849550752107;30196.5470517938;30269.848650756605;23030.309090726634;23884.64173037371;23957.760422395553;26238.86880565585;26454.338641534116 19:30:41 INFO - PROCESS | 4932 | |2;jquery.html;350.6686181558428;356.8269389346167;358.44441116269786;359.42850867121274;366.17245026240704;10790.190735694825;11120.165987550925;11130.05394541463;15403.152826594547;15895.52313430596;16478.835211647878;16998.915005424988;17015.91492042541;17023.914880425582;17359.13204339781;5493.752781124839;5517.393086760453;5646.040173170551;5680.147977803342;5703.17303990921;5733.369329373765;5766.673665057039;5799.391063938289;5803.303603567578;5805.361410244891;5698.6580805151825;5700.914486282709;5725.541956643479;5749.971250143743;5774.422557744213;5560.944390556103;5737.627054241461;5749.913751293734;5762.88474230513;5789.189513468097;5516.420775818521;5574.219609254707;5576.163575463673;5580.665160090408;5583.664980101166;21625.567488650297;21752.238671646417;22504.212352567745;22505.54988900213;22543;2063.9071241794154;2070.8550401471903;2091.895405229732;2474.183519438599;2511.8116141289474;13880.097793643381;14150.080244784056;14220.644483887985;14308.856911430961;14582.781258281135;1870.0556219109262;1927.807219278075;1941.7184508246226;1953.9218431262732;1989.3435166395054;50691;59854.40145598575;62090.68954655243;66187;69297.30702692959;15656.92171539135;16612.086335251435;16825.831741682425;16890.155492225338;16900.915495422443;21386.679199812017;24718.629220561706;25664.871675641876;25796;25835.61246581303;8623.180797824196;8681.913180868236;8785.901762279715;8808.383413161017;8864.601092950832;7076.540024898365;7171.820704482429;7180;7270.890936635955;7309.561426314438;8176.795580110426;8262.380321475914;8326.791830204173;8362.707305244408;8391.454555453876;3124.453220686371;3165.2245199925705;3168.4296826570976;3236.4174448599006;3288.786228895114;841.1420351241821;843.4391129898548;881.7707396077066;905.42053086025;930.6230976454547;15728.449504267295;15788.763168552481;16040.518784436486;16310.673786524441;16390.92112162615;863.4775960543906;904.6697955246419;931.3108299858056;939.201678573221;963.1331801378675;9078.81842363149;9481.336306458481;9524.571394287274;9576.281778866613;9672.70981870545;309383;310762;311810;311864;313459;72661.63669181621;74951.62524187453;75164.62417687876;75604;76965.61517192378;933.8926023507383;944.4522177137382;972.3193764364972;975.1321324021485;977.2994988719435;14921;14934.477293294682;15128.167950762814;15283.159426231665;15508.147051912254;22859.885700572057;27928.860355698904;31809.204769880937;34059.14852128716;34854;39696.40455393229;42757.57242427536;43806.56193438152;43917.12165756603;44448;7403.222661620668;7483.363914067365;7633.236676332544;7683.270089341504;7699.692012319444;9135.725928222164;11337.943310283727;11372.772544549229;11558.94220528892;11874.525018999144;9862.55618497155;9997;10128.898711013091;10155.949220253851;10351.585936562453;9880.703578892357;9979.550920208463;10077.19382449417;10277.126444252322;10289.176865850564;10102.595896164072;10210.234232432449;10258.692239232834;10672.146228301563;10692.19808514349;7266.781996540112;7561.7731468056045;7700.152983171734;7715.691372345043;7723.7682869514;7929.881051784343;9555.61777528891;10164.644237451654;10314.742131446774;10621.628243011457 19:30:41 INFO - PROCESS | 4932 | |3;mootools.html;1306.5949555637758;1391.2834890031631;1397.3153154954073;1535.5470136309787;1769.6018395860924;7237.059182306306;7345.449091318146;7400.592967386791;7405.370543503808;7410.666520006606;7324.377427918634;7500.96249518753;7514.849703005951;7515.098188217422;7520.586367749772;1925.210663627913;2222.299975507718;2254.391314345122;2277.624192008325;2283.703118594589;2222.1111555377815;2230.7546169921375;2233.3411643565187;2233.6091184042807;2235;2174.7607763146043;2225.3657707553352;2233.4416395901026;2234.726206062545;2235.485838257202;2112.6936594193835;2122.479992401864;2167.2306331252335;2240.9887950560305;2244.05749585173;2188.9452763681034;2189.179057853305;2205.3494219205213;2205.8566193197553;2250.2124256510256;7592.8610708393635;7650.08199016116;7656.578888161149;7658.770236892902;7661.961690191513;4464.196444639963;4603.05637344347;4609.377734005933;4610.815567377301;4621.029583787408;2960.5411161270035;2964.5997790298247;3020.592220050287;3022.5466180072945;3060.066679662702;907.7276816954953;931.1991687149047;964.2575217082807;969.5007071358256;995;9782.853257201077;9803.068708472683;9804.90195098047;9830.705078847575;9848.409095454295;4131.710780245354;4158.542560318362;4255.255330317182;4263.488381394252;4282.036541778138;8451.66193352259;8455.534945577929;8466.40735148546;8480.872786908078;8489.108643592457;4081.1837632473625;4323.567643235651;4384.802683879233;4386.583274588909;4387.341898715218;4127.855525056609;4190.916181676349;4203.201391735561;4212.178625168062;4239.872803815891;3498.3353162898966;3574.749767516301;3586.246888153517;3611.476335931328;3622.0763705255517;1213.2417239225483;1222.730999180179;1223.1376879300071;1225.3138242584182;1234.456838990841;923.2106548900593;939.8590211468335;943.7451887990204;982.6609819612222;1242.6458459339226;7160.248173941765;7211.711531538785;7220.711171553079;7233.638318084075;7238.3485486305435;470.2945581627559;472.33165071424236;473.2404490792229;476.5258567725136;476.8974670445871;5479.671219726829;5480.835574932758;5483.424240454695;5490.917636235459;5528.170774383874;8923.15230053144;9089.136532029446;9142.314326425412;9240.399374040666;9282.350235483585;8962.68630597939;8991.955040224757;8999.730008099768;9019.77450563728;9067.727968160965;6769.255381907986;6888.552244104118;6893.724251029903;6937.895931561031;6947.548409353376;6690.096836926952;6700.329967003261;6760.08738820253;6766.357196066366;6768.830779230361;7557.924420755942;7592.468527203043;7621.542707437571;7656.14640298719;7730.729424470116;7940.007499062617;7971.402144839044;7980.201979801974;8020.197980201933;8039.718609848627;6554.442872355712;6609.438197753245;6637.800865974028;6638.5684930479365;6719.26088130315;7029.859402812018;7077.079979602619;7095.467839911924;7108.573485590881;7111.6799744010605;6251.437370636664;6346.841328966812;6350.1109844622715;6388.68056597159;6408.775692850728;6581.6709164542535;6615.338466153538;6650.401463868275;6655.367740064686;6681.398674119158;6853.931460685529;6863.828404289733;6903.792886213421;6905.136857892763;6916.481263905127;6174.135621012972;6201.751929922752;6271.560990730605;6298.622082675054;6312.6528040956355;6284.465820405317;6308.936910630835;6311.305756366888;6325.430711236011;6354.332795056453 19:30:41 INFO - PROCESS | 4932 | |4;prototype.html;305.5966124715376;307.3208209856218;311.1753852291429;315.1805306203869;320.2665895100221;5391.514763671269;5478.096114141167;5521.779128834842;5568.303962004749;5568.387477377485;5410.1073322901775;5453.263809385731;5475.5072043516075;5482.780688772445;5504.724763761806;3916.4321173429835;4001.5798341174195;4084.6732261419015;4151.107511884944;4159.355299928516;4130.772807495587;4146.523149837762;4152.522459917118;4152.8961775955695;4152.958470415302;4082.4896887889013;4083.9994201420545;4091.856785012525;4099.303118469852;4104.774237416941;3880.611938806125;3946.3291240488898;3949.3681011038384;3964.207158568269;4093.2427500912277;3490.4240800267926;3527.2769082338314;3531.0642679689645;3533.452314891196;3533.5406397168463;5207.1668533034535;5211.218317252443;5224.8693782655355;5228.8692782680355;5238.973805130988;4742.9525704742855;4743.478217396084;4749.1926372516755;4749.453812811536;4751.002289519205;5739.598228124033;5744;5752.050911599581;5755.079187330049;5756.165356023395;3885.844566217348;3888.727789054767;3890.319194141014;3897.7856217908;3914.628110329543;5868.09044598088;5935.614185077956;6004.159417681528;6008.7896923607905;6103.786367477162;3962.167944731581;3971.3248747712382;3992.181602771425;3998.8800335989968;3999;3983.6016398359934;4013.0569316210667;4024.879253622396;4025.5571887092397;4031.3751368537924;4700.764961751967;4711.505291944297;4711.78796954131;4714.5992590630185;4714.764261786897;5733.684647344436;5734.283214598176;5736.71316434185;5737.282839645044;5740.483356497935;1381.8134551835574;1410.2384712255268;1410.5697762182429;1413.5194034028275;1413.9575812725634;901.8061116859775;926.3885835348638;934.3366209990846;935.1957316707626;937.9718608441758;4866.9513304867205;4935.235038569028;4985.8005679772405;4998.750062496861;4999.325091112653;5951.821445356646;5974.492168165668;5975.073863551156;5977.940220597825;5996.190514280516;5048.671836330626;5049.116404629175;5052.090623687772;5052.898942021139;5057.190849464068;3185.1718553176343;3214.51782232667;3217.7747557670737;3218.1311046017913;3219.066470723511;5615.241942337732;5618.69097199658;5619.129034999582;5622.128570071645;5622.7750889963945;5947.6431414115295;6169.691515424211;6170.10533472644;6176.227971503562;6177.227846519185;5583.720813959286;5598;5605.243292155588;5608.355039170466;5611.607187496836;6011.458968692838;6022.8795424090395;6025.126356678345;6026;6029.51763858899;5855.882882342244;5860.882782344414;5861;5861.062230043172;5862.091375836752;5427.267318912054;5594.384617692132;5599.720013999202;5605.103183490622;5605.355384130877;3946.329124048861;3954.2289253595272;3957.050307926135;3969.364901615728;3973.4039894016128;5946.851328716643;5985.6408615483215;5986.191864098465;5992.760289588367;5994.6403215807195;5794.159846822272;5795.159701843125;5795.768169273182;5799.82600521985;5799.884002320015;5781.8554536136935;5782.971085144547;5783.045797443375;5786.9131963019745;5791.0734282514595;5464.071107911744;5619.072852979376;5620.622947377755;5622.7469763861545;5654.491095801398;5796.956547821433;5821.417858214145;5829.242198514166;5833.066709326487;5834.445727655866;5598;5614.578906581941;5625.549956003591;5625.943740562542;5631.099024156116 19:30:41 INFO - PROCESS | 4932 | |5;yui.html;676.1818199978027;758.3440324119631;770.2182284980746;775.097011981042;785.3677789379551;11847.170698051139;11944.163908526407;11965.880341196586;11991.460384282707;11998.94000529996;11514.366709830976;13587.864121358783;13757.380917858696;13778.104423212484;13823.861761382383;659.350539718377;800.219785708935;809.7125520440247;813.3371302388534;813.8331642013403;814.0556953933439;825.1006403020706;825.6037102190921;827.4414770030236;827.6234313387395;841.1000229754135;841.6423020216414;842.2083241752763;842.8482873082843;845.8815765792793;676.1548064918851;686.0189928402383;832.98334033319;833.4332653795417;837.0917554453425;613.6900865063114;621.9906701399437;622.2004723929774;623.23031056645;623.3517142172135;12445.439955202037;12496.375181240901;12528.997680185563;12578.68553286166;12592.370381480889;11621.244619099816;11971.102167337485;12070.456829442695;12144.878551214462;12370.072244581692;9668.903310966942;9681.273904457123;9682.661106861226;9689.467079310705;10207.183425325957;3383.6785505377197;3425.469052296898;3450.8102054387;3504.912377190565;3512.5960514540643;44518.33222501665;44728.55271447309;45060;45181.54818451806;45319.32021019687;9932.519599086914;10232.693019209435;10299.17606591471;10462.110720588835;10556.841647375142;18260.543486412946;18281.908590457228;18303.176357063963;18306;18312.450626481226;6635;6635.701393437307;6777.085093512412;6864.759733409406;6871.175458944858;3722.9441558376648;3809.9047523811573;3826.1773718650625;3853.8843834685003;3864.729468937204;2866.584345269924;2944.617199764017;2945.3520225550346;2950.144458107125;2959.8668059937354;503.1747933389245;510.2270060857803;512.8769095417073;514.9073166830007;515.1191462598923;589.4370875813673;594.4026253615176;628.3653509954978;632.6109442692803;655.4035827397046;7705.229477052362;7853.960730196427;7864.174261702439;7871.173526779606;8095.676172953134;511.8541215753492;583.375787906944;592;607.8571535689109;627.3945642455053;3400.863965441404;3681.9079523011605;3795.4686343911876;3822.57951625321;3917.3928041153667;51361.229581556305;51843.22235166476;51964.48035519672;52021.7398913003;52099;45733;45737.085258294646;46832.53167468282;47325.76337118361;47464.28803567949;41242;42201.788991055466;42502;42615;42816.357754633704;7584.848303033798;7614.076410235778;7702.768916932501;7822.022247219098;7901.525908445512;33608.831955841044;35354.46968295529;36368;36577.085572860895;36819.447708283864;45566.31650525311;46054.53945460502;46201.76899115483;46521.82360765875;51986.740066299426;10916.181286403393;11418;11653.30080195191;11673.883261167279;12397.93801030989;11758.647240582795;11779.116566257737;11900.76198476043;12296;12322.815157772462;8124.634391452517;10199.541020654236;11308.208425410143;11320.490577924178;11356.545738170711;10411.583536658449;11462.885371146516;11503.597374091867;11513.769724605294;11618.6514404568;11095.5561777528;11162.441877906234;11268.492917818554;11275.830862536905;11480.311181329147;9091.499967501586;9333.533323333942;9442.38624489406;9780.80438391214;9841.901580984098;8119.766304806334;8127.715529956423;8184.631691573774;8241.79395515117;8306.792330191553 19:30:41 INFO - PROCESS | 4932 | __end_tp_report 19:30:41 INFO - PROCESS | 4932 | __start_cc_report 19:30:41 INFO - PROCESS | 4932 | _x_x_mozilla_cycle_collect,849 19:30:41 INFO - PROCESS | 4932 | __end_cc_report 19:30:41 INFO - PROCESS | 4932 | __startTimestamp1458095441904__endTimestamp 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | ------- Summary: start ------- 19:30:41 INFO - PROCESS | 4932 | Number of tests: 6 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | [#0] dojo.html Cycles:165 Average:4632.39 Median:4750.67 stddev:475.94 (10.0%) stddev-sans-first:449.80 19:30:41 INFO - PROCESS | 4932 | Values: 2596.1 2655.5 2660.8 2679.0 2694.6 4615.1 4622.3 4648.0 4661.5 4742.9 4660.8 4668.3 4678.3 4690.0 4716.6 4240.4 4310.7 4350.9 4399.6 4401.5 4232.2 4313.7 4375.9 4385.3 4389.6 4255.2 4279.1 4298.7 4311.1 4344.6 4287.8 4304.6 4307.4 4342.0 4342.3 4176.0 4290.3 4291.5 4291.9 4346.2 4575.4 4613.7 4637.5 4665.0 4667.6 5001.4 5002.9 5010.2 5010.2 5051.9 4939.3 5009.3 5017.9 5027.3 5028.3 4682.7 4717.8 4742.8 4761.5 4763.0 5118.8 5139.9 5147.1 5147.9 5194.5 4863.5 4924.6 4935.4 4946.1 5021.0 5039.2 5062.9 5067.0 5067.9 5087.8 5005.3 5010.5 5011.3 5012.7 5041.1 4884.9 4918.0 4969.8 4988.6 5000.1 4265.5 4273.7 4287.6 4303.1 4323.0 3762.3 3766.0 3777.6 3784.5 3796.6 4167.2 4247.6 4269.0 4332.7 4337.2 5013.6 5040.5 5042.0 5053.6 5076.9 4268.3 4284.5 4293.4 4293.5 4327.2 4445.3 4528.5 4563.7 4567.0 4594.8 4675.3 4681.5 4690.8 4695.8 4750.7 4913.8 4992.1 4993.1 5000.5 5044.4 4664.7 4692.3 4699.2 4724.9 4755.0 4885.4 4892.9 4926.0 4932.1 4973.9 4838.7 4999.8 5004.6 5022.7 5050.3 4870.9 4885.9 4888.7 4896.4 4952.6 4886.2 4887.0 4889.0 4893.0 4924.2 4757.6 4782.0 4804.2 4843.9 4864.0 4878.5 4879.7 4891.0 4894.1 4948.4 4727.1 4756.2 4772.9 4774.9 4819.5 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | [#1] ext.html Cycles:180 Average:43835.32 Median:36208.91 stddev:79423.55 (219.3%) stddev-sans-first:79579.71 19:30:41 INFO - PROCESS | 4932 | Values: 499.6 535.4 541.3 560.7 572.0 27140.5 27853.3 27858.6 34884.8 35587.8 40079.0 40753.6 40781.6 40911.4 41008.8 7808.9 7979.2 8000.9 8004.4 8005.4 7815.1 7933.8 7942.4 7944.2 7946.3 7899.2 7990.4 7991.7 7992.1 7993.5 7913.4 7964.2 7965.0 7982.8 7988.0 7928.8 8058.0 8060.0 8060.1 8060.6 38499.0 38965.4 38981.0 38990.8 39066.4 3086.2 3170.1 3558.2 3825.8 3885.1 28174.4 28479.4 29142.6 31016.2 31977.2 3379.5 3389.1 3417.3 3446.0 3493.6 233532.0 237865.0 239146.0 239211.0 239902.0 42789.0 59644.1 59795.0 60307.7 60424.4 44208.9 44528.3 44546.8 44588.8 44626.0 12217.4 12243.6 12285.6 12285.8 12307.4 9393.0 9398.8 9435.8 9461.0 9474.2 14757.0 14770.9 14779.7 15328.1 15454.8 6162.8 6291.6 6331.0 6359.1 6362.6 892.0 959.2 992.8 1009.9 1013.8 27430.3 27733.7 28138.2 28213.6 28302.4 805.5 916.6 937.6 956.6 967.6 13190.0 13363.7 13520.3 13603.4 13665.9 275857.0 427855.0 435127.0 435189.0 436804.0 50300.0 50982.2 51292.0 51312.2 51334.5 1082.9 1167.4 1228.5 1238.4 1255.7 25950.6 28063.4 28165.4 29531.1 30348.4 36830.0 37443.8 37898.8 38090.0 38119.4 219409.0 219737.0 220115.0 220329.0 220570.0 24323.8 32010.0 33011.3 33324.5 33717.3 38111.4 38382.0 38915.8 39250.2 39301.2 32300.4 33234.0 33491.5 33875.3 34016.1 33055.7 33321.5 33454.3 33516.5 33592.5 32790.2 33207.7 33648.0 33767.5 33782.8 28968.9 29670.4 30089.8 30196.5 30269.8 23030.3 23884.6 23957.8 26238.9 26454.3 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | [#2] jquery.html Cycles:180 Average:22201.67 Median:43861.84 stddev:51558.02 (117.5%) stddev-sans-first:51676.56 19:30:41 INFO - PROCESS | 4932 | Values: 350.7 356.8 358.4 359.4 366.2 10790.2 11120.2 11130.1 15403.2 15895.5 16478.8 16998.9 17015.9 17023.9 17359.1 5493.8 5517.4 5646.0 5680.1 5703.2 5733.4 5766.7 5799.4 5803.3 5805.4 5698.7 5700.9 5725.5 5750.0 5774.4 5560.9 5737.6 5749.9 5762.9 5789.2 5516.4 5574.2 5576.2 5580.7 5583.7 21625.6 21752.2 22504.2 22505.5 22543.0 2063.9 2070.9 2091.9 2474.2 2511.8 13880.1 14150.1 14220.6 14308.9 14582.8 1870.1 1927.8 1941.7 1953.9 1989.3 50691.0 59854.4 62090.7 66187.0 69297.3 15656.9 16612.1 16825.8 16890.2 16900.9 21386.7 24718.6 25664.9 25796.0 25835.6 8623.2 8681.9 8785.9 8808.4 8864.6 7076.5 7171.8 7180.0 7270.9 7309.6 8176.8 8262.4 8326.8 8362.7 8391.5 3124.5 3165.2 3168.4 3236.4 3288.8 841.1 843.4 881.8 905.4 930.6 15728.4 15788.8 16040.5 16310.7 16390.9 863.5 904.7 931.3 939.2 963.1 9078.8 9481.3 9524.6 9576.3 9672.7 309383.0 310762.0 311810.0 311864.0 313459.0 72661.6 74951.6 75164.6 75604.0 76965.6 933.9 944.5 972.3 975.1 977.3 14921.0 14934.5 15128.2 15283.2 15508.1 22859.9 27928.9 31809.2 34059.1 34854.0 39696.4 42757.6 43806.6 43917.1 44448.0 7403.2 7483.4 7633.2 7683.3 7699.7 9135.7 11337.9 11372.8 11558.9 11874.5 9862.6 9997.0 10128.9 10155.9 10351.6 9880.7 9979.6 10077.2 10277.1 10289.2 10102.6 10210.2 10258.7 10672.1 10692.2 7266.8 7561.8 7700.2 7715.7 7723.8 7929.9 9555.6 10164.6 10314.7 10621.6 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | [#3] mootools.html Cycles:180 Average:5196.57 Median:6481.61 stddev:2685.44 (41.4%) stddev-sans-first:2677.05 19:30:41 INFO - PROCESS | 4932 | Values: 1306.6 1391.3 1397.3 1535.5 1769.6 7237.1 7345.4 7400.6 7405.4 7410.7 7324.4 7501.0 7514.8 7515.1 7520.6 1925.2 2222.3 2254.4 2277.6 2283.7 2222.1 2230.8 2233.3 2233.6 2235.0 2174.8 2225.4 2233.4 2234.7 2235.5 2112.7 2122.5 2167.2 2241.0 2244.1 2188.9 2189.2 2205.3 2205.9 2250.2 7592.9 7650.1 7656.6 7658.8 7662.0 4464.2 4603.1 4609.4 4610.8 4621.0 2960.5 2964.6 3020.6 3022.5 3060.1 907.7 931.2 964.3 969.5 995.0 9782.9 9803.1 9804.9 9830.7 9848.4 4131.7 4158.5 4255.3 4263.5 4282.0 8451.7 8455.5 8466.4 8480.9 8489.1 4081.2 4323.6 4384.8 4386.6 4387.3 4127.9 4190.9 4203.2 4212.2 4239.9 3498.3 3574.7 3586.2 3611.5 3622.1 1213.2 1222.7 1223.1 1225.3 1234.5 923.2 939.9 943.7 982.7 1242.6 7160.2 7211.7 7220.7 7233.6 7238.3 470.3 472.3 473.2 476.5 476.9 5479.7 5480.8 5483.4 5490.9 5528.2 8923.2 9089.1 9142.3 9240.4 9282.4 8962.7 8992.0 8999.7 9019.8 9067.7 6769.3 6888.6 6893.7 6937.9 6947.5 6690.1 6700.3 6760.1 6766.4 6768.8 7557.9 7592.5 7621.5 7656.1 7730.7 7940.0 7971.4 7980.2 8020.2 8039.7 6554.4 6609.4 6637.8 6638.6 6719.3 7029.9 7077.1 7095.5 7108.6 7111.7 6251.4 6346.8 6350.1 6388.7 6408.8 6581.7 6615.3 6650.4 6655.4 6681.4 6853.9 6863.8 6903.8 6905.1 6916.5 6174.1 6201.8 6271.6 6298.6 6312.7 6284.5 6308.9 6311.3 6325.4 6354.3 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | [#4] prototype.html Cycles:180 Average:4722.49 Median:5476.80 stddev:1431.80 (26.1%) stddev-sans-first:1396.91 19:30:41 INFO - PROCESS | 4932 | Values: 305.6 307.3 311.2 315.2 320.3 5391.5 5478.1 5521.8 5568.3 5568.4 5410.1 5453.3 5475.5 5482.8 5504.7 3916.4 4001.6 4084.7 4151.1 4159.4 4130.8 4146.5 4152.5 4152.9 4153.0 4082.5 4084.0 4091.9 4099.3 4104.8 3880.6 3946.3 3949.4 3964.2 4093.2 3490.4 3527.3 3531.1 3533.5 3533.5 5207.2 5211.2 5224.9 5228.9 5239.0 4743.0 4743.5 4749.2 4749.5 4751.0 5739.6 5744.0 5752.1 5755.1 5756.2 3885.8 3888.7 3890.3 3897.8 3914.6 5868.1 5935.6 6004.2 6008.8 6103.8 3962.2 3971.3 3992.2 3998.9 3999.0 3983.6 4013.1 4024.9 4025.6 4031.4 4700.8 4711.5 4711.8 4714.6 4714.8 5733.7 5734.3 5736.7 5737.3 5740.5 1381.8 1410.2 1410.6 1413.5 1414.0 901.8 926.4 934.3 935.2 938.0 4867.0 4935.2 4985.8 4998.8 4999.3 5951.8 5974.5 5975.1 5977.9 5996.2 5048.7 5049.1 5052.1 5052.9 5057.2 3185.2 3214.5 3217.8 3218.1 3219.1 5615.2 5618.7 5619.1 5622.1 5622.8 5947.6 6169.7 6170.1 6176.2 6177.2 5583.7 5598.0 5605.2 5608.4 5611.6 6011.5 6022.9 6025.1 6026.0 6029.5 5855.9 5860.9 5861.0 5861.1 5862.1 5427.3 5594.4 5599.7 5605.1 5605.4 3946.3 3954.2 3957.1 3969.4 3973.4 5946.9 5985.6 5986.2 5992.8 5994.6 5794.2 5795.2 5795.8 5799.8 5799.9 5781.9 5783.0 5783.0 5786.9 5791.1 5464.1 5619.1 5620.6 5622.7 5654.5 5797.0 5821.4 5829.2 5833.1 5834.4 5598.0 5614.6 5625.5 5625.9 5631.1 19:30:41 INFO - PROCESS | 4932 | 19:30:41 INFO - PROCESS | 4932 | [#5] yui.html Cycles:180 Average:13162.25 Median:45735.04 stddev:15075.78 (33.0%) stddev-sans-first:15088.91 19:30:41 INFO - PROCESS | 4932 | Values: 676.2 758.3 770.2 775.1 785.4 11847.2 11944.2 11965.9 11991.5 11998.9 11514.4 13587.9 13757.4 13778.1 13823.9 659.4 800.2 809.7 813.3 813.8 814.1 825.1 825.6 827.4 827.6 841.1 841.6 842.2 842.8 845.9 676.2 686.0 833.0 833.4 837.1 613.7 622.0 622.2 623.2 623.4 12445.4 12496.4 12529.0 12578.7 12592.4 11621.2 11971.1 12070.5 12144.9 12370.1 9668.9 9681.3 9682.7 9689.5 10207.2 3383.7 3425.5 3450.8 3504.9 3512.6 44518.3 44728.6 45060.0 45181.5 45319.3 9932.5 10232.7 10299.2 10462.1 10556.8 18260.5 18281.9 18303.2 18306.0 18312.5 6635.0 6635.7 6777.1 6864.8 6871.2 3722.9 3809.9 3826.2 3853.9 3864.7 2866.6 2944.6 2945.4 2950.1 2959.9 503.2 510.2 512.9 514.9 515.1 589.4 594.4 628.4 632.6 655.4 7705.2 7854.0 7864.2 7871.2 8095.7 511.9 583.4 592.0 607.9 627.4 3400.9 3681.9 3795.5 3822.6 3917.4 51361.2 51843.2 51964.5 52021.7 52099.0 45733.0 45737.1 46832.5 47325.8 47464.3 41242.0 42201.8 42502.0 42615.0 42816.4 7584.8 7614.1 7702.8 7822.0 7901.5 33608.8 35354.5 36368.0 36577.1 36819.4 45566.3 46054.5 46201.8 46521.8 51986.7 10916.2 11418.0 11653.3 11673.9 12397.9 11758.6 11779.1 11900.8 12296.0 12322.8 8124.6 10199.5 11308.2 11320.5 11356.5 10411.6 11462.9 11503.6 11513.8 11618.7 11095.6 11162.4 11268.5 11275.8 11480.3 9091.5 9333.5 9442.4 9780.8 9841.9 8119.8 8127.7 8184.6 8241.8 8306.8 19:30:41 INFO - PROCESS | 4932 | -------- Summary: end -------- 19:30:41 INFO - PROCESS | 4932 | 19:30:42 INFO - TEST-INFO | 4932: exit 0 19:30:42 INFO - TEST-OK | dromaeo_css | took 1117594ms 19:30:42 INFO - TEST-START | kraken 19:30:42 INFO - operating with platform_type : linux_ 19:30:42 INFO - Initialising browser for kraken test... 19:30:42 INFO - TEST-INFO | started process 5116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc0vKZE/profile http://localhost:57966/getInfo.html) 19:30:47 INFO - PROCESS | 5116 | __metrics Screen width/height:1600/1200 19:30:47 INFO - PROCESS | 5116 | colorDepth:24 19:30:47 INFO - PROCESS | 5116 | Browser inner width/height: 1024/697 19:30:47 INFO - PROCESS | 5116 | __metrics 19:30:48 ERROR - PROCESS | 5116 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:30:49 INFO - PROCESS | 5116 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:30:49 INFO - TEST-INFO | 5116: exit 0 19:30:49 INFO - Browser initialized. 19:30:49 INFO - Running cycle 1/1 for kraken test... 19:30:49 INFO - TEST-INFO | started process 5198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc0vKZE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:01 INFO - PROCESS | 5198 | RSS: Main: 153616384 19:31:01 INFO - PROCESS | 5198 | 19:31:04 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57966/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:05 INFO - PROCESS | 5198 | RSS: Main: 195796992 19:31:05 INFO - PROCESS | 5198 | 19:31:07 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57966/tests/kraken/driver.html?testName=audio-dft) 19:31:08 INFO - PROCESS | 5198 | RSS: Main: 185401344 19:31:08 INFO - PROCESS | 5198 | 19:31:11 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57966/tests/kraken/driver.html?testName=audio-fft) 19:31:11 INFO - PROCESS | 5198 | RSS: Main: 171802624 19:31:11 INFO - PROCESS | 5198 | 19:31:14 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57966/tests/kraken/driver.html?testName=audio-oscillator) 19:31:14 INFO - PROCESS | 5198 | RSS: Main: 173137920 19:31:14 INFO - PROCESS | 5198 | 19:31:16 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57966/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:17 INFO - PROCESS | 5198 | RSS: Main: 174223360 19:31:17 INFO - PROCESS | 5198 | 19:31:20 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57966/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:21 INFO - PROCESS | 5198 | RSS: Main: 175403008 19:31:21 INFO - PROCESS | 5198 | 19:31:24 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57966/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:25 INFO - PROCESS | 5198 | RSS: Main: 176787456 19:31:25 INFO - PROCESS | 5198 | 19:31:27 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57966/tests/kraken/driver.html?testName=json-parse-financial) 19:31:28 INFO - PROCESS | 5198 | RSS: Main: 175116288 19:31:28 INFO - PROCESS | 5198 | 19:31:30 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57966/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:30 INFO - PROCESS | 5198 | RSS: Main: 185384960 19:31:30 INFO - PROCESS | 5198 | 19:31:32 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:33 INFO - PROCESS | 5198 | RSS: Main: 182013952 19:31:33 INFO - PROCESS | 5198 | 19:31:35 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:35 INFO - PROCESS | 5198 | RSS: Main: 188391424 19:31:35 INFO - PROCESS | 5198 | 19:31:38 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:39 INFO - PROCESS | 5198 | RSS: Main: 197787648 19:31:39 INFO - PROCESS | 5198 | 19:31:41 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:42 INFO - PROCESS | 5198 | RSS: Main: 196833280 19:31:42 INFO - PROCESS | 5198 | 19:31:43 INFO - PROCESS | 5198 | Cycle 1(1): loaded http://localhost:57966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57966/tests/kraken/driver.html?testName=ai-astar) 19:31:44 INFO - PROCESS | 5198 | RSS: Main: 258138112 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | __start_tp_report 19:31:44 INFO - PROCESS | 5198 | _x_x_mozilla_page_load 19:31:44 INFO - PROCESS | 5198 | _x_x_mozilla_page_load_details 19:31:44 INFO - PROCESS | 5198 | |i|pagename|runs| 19:31:44 INFO - PROCESS | 5198 | |0;ai-astar;111;113;107;112;113;113;101;111;112;112 19:31:44 INFO - PROCESS | 5198 | |1;audio-beat-detection;151;130;157;183;129;158;157;135;175;131 19:31:44 INFO - PROCESS | 5198 | |2;audio-dft;161;161;161;161;162;161;163;163;163;161 19:31:44 INFO - PROCESS | 5198 | |3;audio-fft;73;73;97;95;72;73;73;111;96;72 19:31:44 INFO - PROCESS | 5198 | |4;audio-oscillator;93;93;136;93;94;94;139;94;93;138 19:31:44 INFO - PROCESS | 5198 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 19:31:44 INFO - PROCESS | 5198 | |6;imaging-darkroom;147;146;146;145;147;146;146;145;146;146 19:31:44 INFO - PROCESS | 5198 | |7;imaging-desaturate;96;95;96;95;95;95;96;95;95;95 19:31:44 INFO - PROCESS | 5198 | |8;json-parse-financial;67;64;66;65;66;70;67;74;64;63 19:31:44 INFO - PROCESS | 5198 | |9;json-stringify-tinderbox;64;64;65;63;64;65;65;64;64;64 19:31:44 INFO - PROCESS | 5198 | |10;stanford-crypto-aes;81;82;83;81;81;80;82;80;80;81 19:31:44 INFO - PROCESS | 5198 | |11;stanford-crypto-ccm;119;117;117;124;115;115;129;114;119;123 19:31:44 INFO - PROCESS | 5198 | |12;stanford-crypto-pbkdf2;131;131;131;141;140;129;131;140;153;139 19:31:44 INFO - PROCESS | 5198 | |13;stanford-crypto-sha256-iterative;67;69;69;68;68;67;66;66;65;66 19:31:44 INFO - PROCESS | 5198 | __end_tp_report 19:31:44 INFO - PROCESS | 5198 | __start_cc_report 19:31:44 INFO - PROCESS | 5198 | _x_x_mozilla_cycle_collect,1105 19:31:44 INFO - PROCESS | 5198 | __end_cc_report 19:31:44 INFO - PROCESS | 5198 | __startTimestamp1458095504103__endTimestamp 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | ------- Summary: start ------- 19:31:44 INFO - PROCESS | 5198 | Number of tests: 14 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 19:31:44 INFO - PROCESS | 5198 | Values: 111.0 113.0 107.0 112.0 113.0 113.0 101.0 111.0 112.0 112.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:157.00 stddev:19.15 (12.2%) stddev-sans-first:20.31 19:31:44 INFO - PROCESS | 5198 | Values: 151.0 130.0 157.0 183.0 129.0 158.0 157.0 135.0 175.0 131.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 19:31:44 INFO - PROCESS | 5198 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 163.0 163.0 163.0 161.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#3] audio-fft Cycles:10 Average:83.50 Median:73.00 stddev:14.65 (20.1%) stddev-sans-first:15.04 19:31:44 INFO - PROCESS | 5198 | Values: 73.0 73.0 97.0 95.0 72.0 73.0 73.0 111.0 96.0 72.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:21.39 (23.0%) stddev-sans-first:22.10 19:31:44 INFO - PROCESS | 5198 | Values: 93.0 93.0 136.0 93.0 94.0 94.0 139.0 94.0 93.0 138.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:31:44 INFO - PROCESS | 5198 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 19:31:44 INFO - PROCESS | 5198 | Values: 147.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 146.0 146.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:31:44 INFO - PROCESS | 5198 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.50 stddev:3.27 (4.9%) stddev-sans-first:3.47 19:31:44 INFO - PROCESS | 5198 | Values: 67.0 64.0 66.0 65.0 66.0 70.0 67.0 74.0 64.0 63.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 19:31:44 INFO - PROCESS | 5198 | Values: 64.0 64.0 65.0 63.0 64.0 65.0 65.0 64.0 64.0 64.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 19:31:44 INFO - PROCESS | 5198 | Values: 81.0 82.0 83.0 81.0 81.0 80.0 82.0 80.0 80.0 81.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:119.00 stddev:4.78 (4.0%) stddev-sans-first:5.07 19:31:44 INFO - PROCESS | 5198 | Values: 119.0 117.0 117.0 124.0 115.0 115.0 129.0 114.0 119.0 123.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:139.50 stddev:7.46 (5.3%) stddev-sans-first:7.63 19:31:44 INFO - PROCESS | 5198 | Values: 131.0 131.0 131.0 141.0 140.0 129.0 131.0 140.0 153.0 139.0 19:31:44 INFO - PROCESS | 5198 | 19:31:44 INFO - PROCESS | 5198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.37 (2.0%) stddev-sans-first:1.45 19:31:44 INFO - PROCESS | 5198 | Values: 67.0 69.0 69.0 68.0 68.0 67.0 66.0 66.0 65.0 66.0 19:31:44 INFO - PROCESS | 5198 | -------- Summary: end -------- 19:31:44 INFO - PROCESS | 5198 | 19:31:45 INFO - TEST-INFO | 5198: exit 0 19:31:45 INFO - TEST-OK | kraken | took 62384ms 19:31:45 INFO - SUITE-END | took 1179s 19:31:45 INFO - Completed test suite (00:19:40) 19:31:45 INFO - javascript benchmark 19:31:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2596.052440859087, 2655.4556315955233, 2660.76053155216, 2679.0221569127275, 2694.6227528146055, 4615.053913947641, 4622.260438329864, 4647.976760116199, 4661.510541393156, 4742.857714268569, 4660.836870709526, 4668.25307950728, 4678.345031695565, 4690.0385420988705, 4716.575508204261, 4240.448741663579, 4310.6982511224305, 4350.8912277193, 4399.560043995607, 4401.471823381199, 4232.15356928614, 4313.719608225455, 4375.912481750363, 4385.342198670209, 4389.582989615981, 4255.234057869582, 4279.144171165779, 4298.742075475481, 4311.051568654891, 4344.608985191317, 4287.764172970486, 4304.59106384896, 4307.353896915456, 4342.0, 4342.261815491374, 4175.958240417587, 4290.313549832012, 4291.4850217973735, 4291.914161716748, 4346.15250026245, 4575.4051973243595, 4613.7001094929055, 4637.466691330506, 4665.020345727401, 4667.649926255544, 5001.374828146481, 5002.9499705002845, 5010.223415370623, 5010.248462730583, 5051.924221136685, 4939.308496810413, 5009.323741294915, 5017.899642007176, 5027.346444962168, 5028.346314979066, 4682.74244916526, 4717.787699553528, 4742.834000809989, 4761.547652972962, 4763.0, 5118.769655365518, 5139.897202055938, 5147.073526765218, 5147.897042059213, 5194.454582268883, 4863.513648635179, 4924.63065270099, 4935.407751069823, 4946.134426475424, 5021.020900924358, 5039.244113383022, 5062.898742025212, 5067.037262920107, 5067.949320506821, 5087.847364579068, 5005.349304590452, 5010.49895010496, 5011.273365362002, 5012.699238045729, 5041.092603331435, 4884.853454396374, 4918.0, 4969.751512424365, 4988.6009119270375, 5000.14997450427, 4265.53079161292, 4273.7008409411665, 4287.571242875688, 4303.096349766584, 4322.978385108055, 3762.3039737648623, 3766.0, 3777.58446570877, 3784.4701741756176, 3796.6393192646656, 4167.166566686675, 4247.6389506892265, 4269.039466120098, 4332.718373305725, 4337.240982827992, 5013.573846223112, 5040.49595040493, 5042.042012017705, 5053.620978426559, 5076.949230507722, 4268.317069268902, 4284.507281662649, 4293.3989241506215, 4293.527711951683, 4327.156204540147, 4445.2887537993765, 4528.47922488918, 4563.657725670588, 4567.0, 4594.839180628662, 4675.345451636774, 4681.485036646034, 4690.788914498788, 4695.788689508912, 4750.667453278237, 4913.77887995034, 4992.126377883928, 4993.051320249141, 5000.524950129732, 5044.419891712353, 4664.743439110882, 4692.296155576691, 4699.201135806853, 4724.905501889874, 4755.0, 4885.3649025627865, 4892.8532144035735, 4925.975370123127, 4932.087563800708, 4973.9253911190635, 4838.661293709407, 4999.800007999785, 5004.624653150955, 5022.748862556785, 5050.267711181931, 4870.878228044186, 4885.926711099265, 4888.657793954531, 4896.436909755424, 4952.628552858622, 4886.193778026728, 4886.975565122294, 4888.975555122344, 4892.951070489249, 4924.236743304794, 4757.643176761688, 4782.0435912818275, 4804.2073057946445, 4843.854684359475, 4863.95136048635, 4878.463369029333, 4879.731614761222, 4891.021795640957, 4894.094592500399, 4948.430930443045, 4727.054589082129, 4756.191447453872, 4772.856814295576, 4774.928376074431, 4819.518048195152], "unit": "score", "name": "dojo.html", "value": 4602.761970920634}, {"lowerIsBetter": false, "replicates": [499.6003197442048, 535.389655792397, 541.2773946781048, 560.6523955147809, 571.9875819798956, 27140.45719085617, 27853.303667408323, 27858.582121268173, 34884.825575872084, 35587.82206088966, 40079.0, 40753.59246407535, 40781.59218407815, 40911.38632920501, 41008.79495602518, 7808.921910780905, 7979.241972012649, 8000.8799868002025, 8004.359651227917, 8005.439619226657, 7815.140334563193, 7933.841323173562, 7942.444028917978, 7944.165862584432, 7946.284834364906, 7899.170587088359, 7990.400719945998, 7991.680332786682, 7992.080910695287, 7993.480423772466, 7913.446058775888, 7964.2433968772875, 7964.960175199116, 7982.760517184435, 7987.96006019972, 7928.762137135837, 8058.0, 8059.992500937383, 8060.113387527367, 8060.5566693831815, 38499.0, 38965.415518767244, 38981.0, 38990.80504597487, 39066.41400378996, 3086.182161727144, 3170.1282147409647, 3558.2349794793986, 3825.7704537727827, 3885.1258466845015, 28174.436511269865, 28479.430411391655, 29142.562861557093, 31016.224594385094, 31977.200569985936, 3379.4761811919193, 3389.1018879996823, 3417.3165366926714, 3445.9655403445895, 3493.5633045869267, 233532.0, 237865.0, 239146.0, 239211.0, 239902.0, 42789.0, 59644.105338419955, 59795.0, 60307.69846150829, 60424.39575604276, 44208.91597466332, 44528.3320750189, 44546.77726611411, 44588.777056114515, 44626.0, 12217.389130543437, 12243.57147499851, 12285.57000504978, 12285.815712764315, 12307.4461649226, 9393.0, 9398.765030874283, 9435.764105897408, 9461.0, 9474.24206063527, 14757.0, 14770.92614536942, 14779.704405912036, 15328.080315181125, 15454.845451545341, 6162.845928851814, 6291.622502649856, 6331.0, 6359.141515895388, 6362.586431881913, 891.9509426981449, 959.1511512311655, 992.8212921674168, 1009.8687170667766, 1013.8143396526713, 27430.314242143708, 27733.722662773114, 28138.155855324374, 28213.576796348072, 28302.433951320858, 805.5046146619903, 916.5783739479781, 937.6249500199838, 956.5695437053354, 967.5936106835146, 13190.0, 13363.732725345439, 13520.25638589887, 13603.387847546885, 13665.863341366658, 275857.0, 427855.0, 435127.0, 435189.0, 436804.0, 50300.0, 50982.235266471034, 51292.0, 51312.230316544534, 51334.48665513372, 1082.9025387715144, 1167.3579531257774, 1228.4778968938165, 1238.3684320996356, 1255.6798016505732, 25950.61074083928, 28063.43873122567, 28165.43669126565, 29531.114066578037, 30348.393032139677, 36830.0, 37443.81278093592, 37898.810505947295, 38090.0, 38119.42820857634, 219409.0, 219737.0, 220115.0, 220329.0, 220570.0, 24323.75676243215, 32010.0, 33011.33977320392, 33324.50013249851, 33717.325653487285, 38111.42832857565, 38382.0, 38915.80542097385, 39250.21499569935, 39301.2139757209, 32300.35399292048, 33234.0, 33491.4976275361, 33875.322493550484, 34016.14959626029, 33055.66944330526, 33321.50017749687, 33454.33091338208, 33516.49725254074, 33592.49611255882, 32790.180245494055, 33207.667923320456, 33648.0, 33767.4934875982, 33782.83108584442, 28968.855155724086, 29670.406591868472, 30089.849550752107, 30196.5470517938, 30269.848650756605, 23030.309090726634, 23884.64173037371, 23957.760422395553, 26238.86880565585, 26454.338641534116], "unit": "score", "name": "ext.html", "value": 16799.243987733873}, {"lowerIsBetter": false, "replicates": [350.6686181558428, 356.8269389346167, 358.44441116269786, 359.42850867121274, 366.17245026240704, 10790.190735694825, 11120.165987550925, 11130.05394541463, 15403.152826594547, 15895.52313430596, 16478.835211647878, 16998.915005424988, 17015.91492042541, 17023.914880425582, 17359.13204339781, 5493.752781124839, 5517.393086760453, 5646.040173170551, 5680.147977803342, 5703.17303990921, 5733.369329373765, 5766.673665057039, 5799.391063938289, 5803.303603567578, 5805.361410244891, 5698.6580805151825, 5700.914486282709, 5725.541956643479, 5749.971250143743, 5774.422557744213, 5560.944390556103, 5737.627054241461, 5749.913751293734, 5762.88474230513, 5789.189513468097, 5516.420775818521, 5574.219609254707, 5576.163575463673, 5580.665160090408, 5583.664980101166, 21625.567488650297, 21752.238671646417, 22504.212352567745, 22505.54988900213, 22543.0, 2063.9071241794154, 2070.8550401471903, 2091.895405229732, 2474.183519438599, 2511.8116141289474, 13880.097793643381, 14150.080244784056, 14220.644483887985, 14308.856911430961, 14582.781258281135, 1870.0556219109262, 1927.807219278075, 1941.7184508246226, 1953.9218431262732, 1989.3435166395054, 50691.0, 59854.40145598575, 62090.68954655243, 66187.0, 69297.30702692959, 15656.92171539135, 16612.086335251435, 16825.831741682425, 16890.155492225338, 16900.915495422443, 21386.679199812017, 24718.629220561706, 25664.871675641876, 25796.0, 25835.61246581303, 8623.180797824196, 8681.913180868236, 8785.901762279715, 8808.383413161017, 8864.601092950832, 7076.540024898365, 7171.820704482429, 7180.0, 7270.890936635955, 7309.561426314438, 8176.795580110426, 8262.380321475914, 8326.791830204173, 8362.707305244408, 8391.454555453876, 3124.453220686371, 3165.2245199925705, 3168.4296826570976, 3236.4174448599006, 3288.786228895114, 841.1420351241821, 843.4391129898548, 881.7707396077066, 905.42053086025, 930.6230976454547, 15728.449504267295, 15788.763168552481, 16040.518784436486, 16310.673786524441, 16390.92112162615, 863.4775960543906, 904.6697955246419, 931.3108299858056, 939.201678573221, 963.1331801378675, 9078.81842363149, 9481.336306458481, 9524.571394287274, 9576.281778866613, 9672.70981870545, 309383.0, 310762.0, 311810.0, 311864.0, 313459.0, 72661.63669181621, 74951.62524187453, 75164.62417687876, 75604.0, 76965.61517192378, 933.8926023507383, 944.4522177137382, 972.3193764364972, 975.1321324021485, 977.2994988719435, 14921.0, 14934.477293294682, 15128.167950762814, 15283.159426231665, 15508.147051912254, 22859.885700572057, 27928.860355698904, 31809.204769880937, 34059.14852128716, 34854.0, 39696.40455393229, 42757.57242427536, 43806.56193438152, 43917.12165756603, 44448.0, 7403.222661620668, 7483.363914067365, 7633.236676332544, 7683.270089341504, 7699.692012319444, 9135.725928222164, 11337.943310283727, 11372.772544549229, 11558.94220528892, 11874.525018999144, 9862.55618497155, 9997.0, 10128.898711013091, 10155.949220253851, 10351.585936562453, 9880.703578892357, 9979.550920208463, 10077.19382449417, 10277.126444252322, 10289.176865850564, 10102.595896164072, 10210.234232432449, 10258.692239232834, 10672.146228301563, 10692.19808514349, 7266.781996540112, 7561.7731468056045, 7700.152983171734, 7715.691372345043, 7723.7682869514, 7929.881051784343, 9555.61777528891, 10164.644237451654, 10314.742131446774, 10621.628243011457], "unit": "score", "name": "jquery.html", "value": 8789.83502085193}, {"lowerIsBetter": false, "replicates": [1306.5949555637758, 1391.2834890031631, 1397.3153154954073, 1535.5470136309787, 1769.6018395860924, 7237.059182306306, 7345.449091318146, 7400.592967386791, 7405.370543503808, 7410.666520006606, 7324.377427918634, 7500.96249518753, 7514.849703005951, 7515.098188217422, 7520.586367749772, 1925.210663627913, 2222.299975507718, 2254.391314345122, 2277.624192008325, 2283.703118594589, 2222.1111555377815, 2230.7546169921375, 2233.3411643565187, 2233.6091184042807, 2235.0, 2174.7607763146043, 2225.3657707553352, 2233.4416395901026, 2234.726206062545, 2235.485838257202, 2112.6936594193835, 2122.479992401864, 2167.2306331252335, 2240.9887950560305, 2244.05749585173, 2188.9452763681034, 2189.179057853305, 2205.3494219205213, 2205.8566193197553, 2250.2124256510256, 7592.8610708393635, 7650.08199016116, 7656.578888161149, 7658.770236892902, 7661.961690191513, 4464.196444639963, 4603.05637344347, 4609.377734005933, 4610.815567377301, 4621.029583787408, 2960.5411161270035, 2964.5997790298247, 3020.592220050287, 3022.5466180072945, 3060.066679662702, 907.7276816954953, 931.1991687149047, 964.2575217082807, 969.5007071358256, 995.0, 9782.853257201077, 9803.068708472683, 9804.90195098047, 9830.705078847575, 9848.409095454295, 4131.710780245354, 4158.542560318362, 4255.255330317182, 4263.488381394252, 4282.036541778138, 8451.66193352259, 8455.534945577929, 8466.40735148546, 8480.872786908078, 8489.108643592457, 4081.1837632473625, 4323.567643235651, 4384.802683879233, 4386.583274588909, 4387.341898715218, 4127.855525056609, 4190.916181676349, 4203.201391735561, 4212.178625168062, 4239.872803815891, 3498.3353162898966, 3574.749767516301, 3586.246888153517, 3611.476335931328, 3622.0763705255517, 1213.2417239225483, 1222.730999180179, 1223.1376879300071, 1225.3138242584182, 1234.456838990841, 923.2106548900593, 939.8590211468335, 943.7451887990204, 982.6609819612222, 1242.6458459339226, 7160.248173941765, 7211.711531538785, 7220.711171553079, 7233.638318084075, 7238.3485486305435, 470.2945581627559, 472.33165071424236, 473.2404490792229, 476.5258567725136, 476.8974670445871, 5479.671219726829, 5480.835574932758, 5483.424240454695, 5490.917636235459, 5528.170774383874, 8923.15230053144, 9089.136532029446, 9142.314326425412, 9240.399374040666, 9282.350235483585, 8962.68630597939, 8991.955040224757, 8999.730008099768, 9019.77450563728, 9067.727968160965, 6769.255381907986, 6888.552244104118, 6893.724251029903, 6937.895931561031, 6947.548409353376, 6690.096836926952, 6700.329967003261, 6760.08738820253, 6766.357196066366, 6768.830779230361, 7557.924420755942, 7592.468527203043, 7621.542707437571, 7656.14640298719, 7730.729424470116, 7940.007499062617, 7971.402144839044, 7980.201979801974, 8020.197980201933, 8039.718609848627, 6554.442872355712, 6609.438197753245, 6637.800865974028, 6638.5684930479365, 6719.26088130315, 7029.859402812018, 7077.079979602619, 7095.467839911924, 7108.573485590881, 7111.6799744010605, 6251.437370636664, 6346.841328966812, 6350.1109844622715, 6388.68056597159, 6408.775692850728, 6581.6709164542535, 6615.338466153538, 6650.401463868275, 6655.367740064686, 6681.398674119158, 6853.931460685529, 6863.828404289733, 6903.792886213421, 6905.136857892763, 6916.481263905127, 6174.135621012972, 6201.751929922752, 6271.560990730605, 6298.622082675054, 6312.6528040956355, 6284.465820405317, 6308.936910630835, 6311.305756366888, 6325.430711236011, 6354.332795056453], "unit": "score", "name": "mootools.html", "value": 4203.562788606023}, {"lowerIsBetter": false, "replicates": [305.5966124715376, 307.3208209856218, 311.1753852291429, 315.1805306203869, 320.2665895100221, 5391.514763671269, 5478.096114141167, 5521.779128834842, 5568.303962004749, 5568.387477377485, 5410.1073322901775, 5453.263809385731, 5475.5072043516075, 5482.780688772445, 5504.724763761806, 3916.4321173429835, 4001.5798341174195, 4084.6732261419015, 4151.107511884944, 4159.355299928516, 4130.772807495587, 4146.523149837762, 4152.522459917118, 4152.8961775955695, 4152.958470415302, 4082.4896887889013, 4083.9994201420545, 4091.856785012525, 4099.303118469852, 4104.774237416941, 3880.611938806125, 3946.3291240488898, 3949.3681011038384, 3964.207158568269, 4093.2427500912277, 3490.4240800267926, 3527.2769082338314, 3531.0642679689645, 3533.452314891196, 3533.5406397168463, 5207.1668533034535, 5211.218317252443, 5224.8693782655355, 5228.8692782680355, 5238.973805130988, 4742.9525704742855, 4743.478217396084, 4749.1926372516755, 4749.453812811536, 4751.002289519205, 5739.598228124033, 5744.0, 5752.050911599581, 5755.079187330049, 5756.165356023395, 3885.844566217348, 3888.727789054767, 3890.319194141014, 3897.7856217908, 3914.628110329543, 5868.09044598088, 5935.614185077956, 6004.159417681528, 6008.7896923607905, 6103.786367477162, 3962.167944731581, 3971.3248747712382, 3992.181602771425, 3998.8800335989968, 3999.0, 3983.6016398359934, 4013.0569316210667, 4024.879253622396, 4025.5571887092397, 4031.3751368537924, 4700.764961751967, 4711.505291944297, 4711.78796954131, 4714.5992590630185, 4714.764261786897, 5733.684647344436, 5734.283214598176, 5736.71316434185, 5737.282839645044, 5740.483356497935, 1381.8134551835574, 1410.2384712255268, 1410.5697762182429, 1413.5194034028275, 1413.9575812725634, 901.8061116859775, 926.3885835348638, 934.3366209990846, 935.1957316707626, 937.9718608441758, 4866.9513304867205, 4935.235038569028, 4985.8005679772405, 4998.750062496861, 4999.325091112653, 5951.821445356646, 5974.492168165668, 5975.073863551156, 5977.940220597825, 5996.190514280516, 5048.671836330626, 5049.116404629175, 5052.090623687772, 5052.898942021139, 5057.190849464068, 3185.1718553176343, 3214.51782232667, 3217.7747557670737, 3218.1311046017913, 3219.066470723511, 5615.241942337732, 5618.69097199658, 5619.129034999582, 5622.128570071645, 5622.7750889963945, 5947.6431414115295, 6169.691515424211, 6170.10533472644, 6176.227971503562, 6177.227846519185, 5583.720813959286, 5598.0, 5605.243292155588, 5608.355039170466, 5611.607187496836, 6011.458968692838, 6022.8795424090395, 6025.126356678345, 6026.0, 6029.51763858899, 5855.882882342244, 5860.882782344414, 5861.0, 5861.062230043172, 5862.091375836752, 5427.267318912054, 5594.384617692132, 5599.720013999202, 5605.103183490622, 5605.355384130877, 3946.329124048861, 3954.2289253595272, 3957.050307926135, 3969.364901615728, 3973.4039894016128, 5946.851328716643, 5985.6408615483215, 5986.191864098465, 5992.760289588367, 5994.6403215807195, 5794.159846822272, 5795.159701843125, 5795.768169273182, 5799.82600521985, 5799.884002320015, 5781.8554536136935, 5782.971085144547, 5783.045797443375, 5786.9131963019745, 5791.0734282514595, 5464.071107911744, 5619.072852979376, 5620.622947377755, 5622.7469763861545, 5654.491095801398, 5796.956547821433, 5821.417858214145, 5829.242198514166, 5833.066709326487, 5834.445727655866, 5598.0, 5614.578906581941, 5625.549956003591, 5625.943740562542, 5631.099024156116], "unit": "score", "name": "prototype.html", "value": 4258.51219760252}, {"lowerIsBetter": false, "replicates": [676.1818199978027, 758.3440324119631, 770.2182284980746, 775.097011981042, 785.3677789379551, 11847.170698051139, 11944.163908526407, 11965.880341196586, 11991.460384282707, 11998.94000529996, 11514.366709830976, 13587.864121358783, 13757.380917858696, 13778.104423212484, 13823.861761382383, 659.350539718377, 800.219785708935, 809.7125520440247, 813.3371302388534, 813.8331642013403, 814.0556953933439, 825.1006403020706, 825.6037102190921, 827.4414770030236, 827.6234313387395, 841.1000229754135, 841.6423020216414, 842.2083241752763, 842.8482873082843, 845.8815765792793, 676.1548064918851, 686.0189928402383, 832.98334033319, 833.4332653795417, 837.0917554453425, 613.6900865063114, 621.9906701399437, 622.2004723929774, 623.23031056645, 623.3517142172135, 12445.439955202037, 12496.375181240901, 12528.997680185563, 12578.68553286166, 12592.370381480889, 11621.244619099816, 11971.102167337485, 12070.456829442695, 12144.878551214462, 12370.072244581692, 9668.903310966942, 9681.273904457123, 9682.661106861226, 9689.467079310705, 10207.183425325957, 3383.6785505377197, 3425.469052296898, 3450.8102054387, 3504.912377190565, 3512.5960514540643, 44518.33222501665, 44728.55271447309, 45060.0, 45181.54818451806, 45319.32021019687, 9932.519599086914, 10232.693019209435, 10299.17606591471, 10462.110720588835, 10556.841647375142, 18260.543486412946, 18281.908590457228, 18303.176357063963, 18306.0, 18312.450626481226, 6635.0, 6635.701393437307, 6777.085093512412, 6864.759733409406, 6871.175458944858, 3722.9441558376648, 3809.9047523811573, 3826.1773718650625, 3853.8843834685003, 3864.729468937204, 2866.584345269924, 2944.617199764017, 2945.3520225550346, 2950.144458107125, 2959.8668059937354, 503.1747933389245, 510.2270060857803, 512.8769095417073, 514.9073166830007, 515.1191462598923, 589.4370875813673, 594.4026253615176, 628.3653509954978, 632.6109442692803, 655.4035827397046, 7705.229477052362, 7853.960730196427, 7864.174261702439, 7871.173526779606, 8095.676172953134, 511.8541215753492, 583.375787906944, 592.0, 607.8571535689109, 627.3945642455053, 3400.863965441404, 3681.9079523011605, 3795.4686343911876, 3822.57951625321, 3917.3928041153667, 51361.229581556305, 51843.22235166476, 51964.48035519672, 52021.7398913003, 52099.0, 45733.0, 45737.085258294646, 46832.53167468282, 47325.76337118361, 47464.28803567949, 41242.0, 42201.788991055466, 42502.0, 42615.0, 42816.357754633704, 7584.848303033798, 7614.076410235778, 7702.768916932501, 7822.022247219098, 7901.525908445512, 33608.831955841044, 35354.46968295529, 36368.0, 36577.085572860895, 36819.447708283864, 45566.31650525311, 46054.53945460502, 46201.76899115483, 46521.82360765875, 51986.740066299426, 10916.181286403393, 11418.0, 11653.30080195191, 11673.883261167279, 12397.93801030989, 11758.647240582795, 11779.116566257737, 11900.76198476043, 12296.0, 12322.815157772462, 8124.634391452517, 10199.541020654236, 11308.208425410143, 11320.490577924178, 11356.545738170711, 10411.583536658449, 11462.885371146516, 11503.597374091867, 11513.769724605294, 11618.6514404568, 11095.5561777528, 11162.441877906234, 11268.492917818554, 11275.830862536905, 11480.311181329147, 9091.499967501586, 9333.533323333942, 9442.38624489406, 9780.80438391214, 9841.901580984098, 8119.766304806334, 8127.715529956423, 8184.631691573774, 8241.79395515117, 8306.792330191553], "unit": "score", "name": "yui.html", "value": 6006.729171544589}], "name": "dromaeo_css", "value": 6466.080582484654}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 113.0, 113.0, 101.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 157.0, 183.0, 129.0, 158.0, 157.0, 135.0, 175.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 163.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 97.0, 95.0, 72.0, 73.0, 73.0, 111.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 93.0, 94.0, 94.0, 139.0, 94.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 66.0, 65.0, 66.0, 70.0, 67.0, 74.0, 64.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 81.0, 81.0, 80.0, 82.0, 80.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.1}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 117.0, 124.0, 115.0, 115.0, 129.0, 114.0, 119.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [131.0, 131.0, 131.0, 141.0, 140.0, 129.0, 131.0, 140.0, 153.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 68.0, 68.0, 67.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1505.9999999999998}]} 19:31:45 INFO - Return code: 0 19:31:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:31:45 ERROR - # TBPL SUCCESS # 19:31:45 INFO - Running post-action listener: _resource_record_post_action 19:31:45 INFO - Running post-run listener: _resource_record_post_run 19:31:46 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 518201344; Read time: 0; Write time: 804044 19:31:46 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 232067072; Read time: 0; Write time: 429696 19:31:46 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 285536256; Read time: 0; Write time: 373764 19:31:46 INFO - Running post-run listener: _upload_blobber_files 19:31:46 INFO - Blob upload gear active. 19:31:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:47 INFO - (blobuploader) - INFO - Done attempting. 19:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:48 INFO - (blobuploader) - INFO - Done attempting. 19:31:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:48 INFO - Return code: 0 19:31:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57b9e0f61531d71174bdd8bd0b8a089ac4a4fa55460c18e689842f2eb2b9815107142952f54eba03c82953a08fb7970955cd78bb6285307ccbbb19110e275e0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f1fcbd530e7e7fa476fb60d6c0e7f8368a3a355b68daa1724d869b085d968083e4f244e92f1d0a87bf6ddd9596f27a1b75c3279437c83f578766e9b67df531a"} 19:31:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:48 INFO - Contents: 19:31:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57b9e0f61531d71174bdd8bd0b8a089ac4a4fa55460c18e689842f2eb2b9815107142952f54eba03c82953a08fb7970955cd78bb6285307ccbbb19110e275e0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f1fcbd530e7e7fa476fb60d6c0e7f8368a3a355b68daa1724d869b085d968083e4f244e92f1d0a87bf6ddd9596f27a1b75c3279437c83f578766e9b67df531a"} 19:31:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:48 INFO - Copying logs to upload dir... 19:31:48 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.356820 ========= master_lag: 155.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-03-15 19:34:23.793101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-15 19:34:23.797053) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 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/57b9e0f61531d71174bdd8bd0b8a089ac4a4fa55460c18e689842f2eb2b9815107142952f54eba03c82953a08fb7970955cd78bb6285307ccbbb19110e275e0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f1fcbd530e7e7fa476fb60d6c0e7f8368a3a355b68daa1724d869b085d968083e4f244e92f1d0a87bf6ddd9596f27a1b75c3279437c83f578766e9b67df531a"} build_url:https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/GA9D2jE1T4-YDijFbfqbew/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/57b9e0f61531d71174bdd8bd0b8a089ac4a4fa55460c18e689842f2eb2b9815107142952f54eba03c82953a08fb7970955cd78bb6285307ccbbb19110e275e0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f1fcbd530e7e7fa476fb60d6c0e7f8368a3a355b68daa1724d869b085d968083e4f244e92f1d0a87bf6ddd9596f27a1b75c3279437c83f578766e9b67df531a"}' ========= master_lag: 4.69 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-15 19:34:28.498975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:34:28.499377) ========= 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=5cf47e208febbcd81da23b2e0000026f-1458094272.260940-1327934191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 19:34:28.770265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 19:34:28.770580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 19:34:28.771324) ========= ========= Total master_lag: 160.66 =========