builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1458173297.36 results: success (0) buildid: 20160316162107 builduid: 985daf6eae2e4da590be172e68d08f2c revision: a4c6d6add2fcbc4bf847270cf27ff23334e2f170 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.359220) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.359693) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.360018) ========= 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006273 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.382894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.383213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.396524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.396893) ========= 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.445790) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.446103) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.446449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.446719) ========= 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 17:08:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-03-16 17:08:17 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087646 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.546774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.547108) ========= 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.596830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:17.597192) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a4c6d6add2fcbc4bf847270cf27ff23334e2f170 --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 a4c6d6add2fcbc4bf847270cf27ff23334e2f170 --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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 17:08:18,000 truncating revision to first 12 chars 2016-03-16 17:08:18,000 Setting DEBUG logging. 2016-03-16 17:08:18,000 attempt 1/10 2016-03-16 17:08:18,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a4c6d6add2fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 17:08:18,239 unpacking tar archive at: fx-team-a4c6d6add2fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:18.144338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:18.144761) ========= echo a4c6d6add2fcbc4bf847270cf27ff23334e2f170 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4c6d6add2fcbc4bf847270cf27ff23334e2f170'] 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a4c6d6add2fcbc4bf847270cf27ff23334e2f170 program finished with exit code 0 elapsedTime=0.003924 script_repo_revision: 'a4c6d6add2fcbc4bf847270cf27ff23334e2f170' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:18.193718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:18.194034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:18.203634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-16 17:08:18.203935) ========= /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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:18 INFO - MultiFileLogger online at 20160316 17:08:18 in /builds/slave/test 17:08:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:08:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:18 INFO - {'append_to_log': False, 17:08:18 INFO - 'base_work_dir': '/builds/slave/test', 17:08:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:08:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:18 INFO - 'branch': 'Fx-Team-Non-PGO', 17:08:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:18 INFO - 'config_files': ('talos/linux_config.py',), 17:08:18 INFO - 'default_actions': ('clobber', 17:08:18 INFO - 'read-buildbot-config', 17:08:18 INFO - 'download-and-extract', 17:08:18 INFO - 'populate-webroot', 17:08:18 INFO - 'create-virtualenv', 17:08:18 INFO - 'install', 17:08:18 INFO - 'run-tests'), 17:08:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:18 INFO - 'download_minidump_stackwalk': True, 17:08:18 INFO - 'download_symbols': 'ondemand', 17:08:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:18 INFO - 'installer_path': 'installer.exe', 17:08:18 INFO - 'log_level': 'info', 17:08:18 INFO - 'log_name': 'talos', 17:08:18 INFO - 'log_to_console': True, 17:08:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:18 INFO - 'opt_config_files': (), 17:08:18 INFO - 'pip_index': False, 17:08:18 INFO - 'sps_profile': False, 17:08:18 INFO - 'sps_profile_interval': 0, 17:08:18 INFO - 'suite': 'dromaeojs', 17:08:18 INFO - 'system_bits': '32', 17:08:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:18 INFO - 'title': 'talos-linux64-ix-031', 17:08:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:18 INFO - 'use_talos_json': True, 17:08:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:18 INFO - 'work_dir': 'build'} 17:08:18 INFO - ##### 17:08:18 INFO - ##### Running clobber step. 17:08:18 INFO - ##### 17:08:18 INFO - Running pre-action listener: _resource_record_pre_action 17:08:18 INFO - Running main action method: clobber 17:08:18 INFO - rmtree: /builds/slave/test/build 17:08:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:19 INFO - Running post-action listener: _resource_record_post_action 17:08:19 INFO - ##### 17:08:19 INFO - ##### Running read-buildbot-config step. 17:08:19 INFO - ##### 17:08:19 INFO - Running pre-action listener: _resource_record_pre_action 17:08:19 INFO - Running main action method: read_buildbot_config 17:08:19 INFO - Using buildbot properties: 17:08:19 INFO - { 17:08:19 INFO - "project": "", 17:08:19 INFO - "product": "firefox", 17:08:19 INFO - "script_repo_revision": "production", 17:08:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:08:19 INFO - "repository": "", 17:08:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:08:19 INFO - "buildid": "20160316162107", 17:08:19 INFO - "pgo_build": "False", 17:08:19 INFO - "basedir": "/builds/slave/test", 17:08:19 INFO - "buildnumber": 1456, 17:08:19 INFO - "slavename": "talos-linux64-ix-031", 17:08:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:08:19 INFO - "platform": "ubuntu64_hw", 17:08:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:08:19 INFO - "branch": "fx-team", 17:08:19 INFO - "repo_path": "integration/fx-team", 17:08:19 INFO - "revision": "a4c6d6add2fcbc4bf847270cf27ff23334e2f170", 17:08:19 INFO - "stage_platform": "linux64", 17:08:19 INFO - "builduid": "985daf6eae2e4da590be172e68d08f2c", 17:08:19 INFO - "slavebuilddir": "test" 17:08:19 INFO - } 17:08:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:08:19 INFO - Running post-action listener: _resource_record_post_action 17:08:19 INFO - ##### 17:08:19 INFO - ##### Running download-and-extract step. 17:08:19 INFO - ##### 17:08:19 INFO - Running pre-action listener: _resource_record_pre_action 17:08:19 INFO - Running main action method: download_and_extract 17:08:19 INFO - mkdir: /builds/slave/test/build/tests 17:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:19 INFO - https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:19 INFO - Downloaded 1361 bytes. 17:08:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:08:19 INFO - Using the following test package requirements: 17:08:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:08:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'jsshell-linux-x86_64.zip'], 17:08:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:19 INFO - https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:20 INFO - Downloaded 21992926 bytes. 17:08:20 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'] 17:08:20 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 17:08:22 INFO - Return code: 0 17:08:22 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 17:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:22 INFO - https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:23 INFO - Downloaded 21992926 bytes. 17:08:23 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'] 17:08:23 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 17:08:24 INFO - Return code: 0 17:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:24 INFO - https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:26 INFO - Downloaded 10846462 bytes. 17:08:26 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'] 17:08:26 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 17:08:26 INFO - Return code: 0 17:08: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')]} 17:08:26 INFO - https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WRJoPkjVQK2U3HFXMret3Q/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 17:08:28 INFO - Downloaded 54151425 bytes. 17:08:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:28 INFO - mkdir: /builds/slave/test/properties 17:08:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:28 INFO - Contents: 17:08:28 INFO - build_url:https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:08:28 INFO - Running post-action listener: _resource_record_post_action 17:08:28 INFO - Running post-action listener: set_extra_try_arguments 17:08:28 INFO - ##### 17:08:28 INFO - ##### Running populate-webroot step. 17:08:28 INFO - ##### 17:08:28 INFO - Running pre-action listener: _resource_record_pre_action 17:08:28 INFO - Running main action method: populate_webroot 17:08:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:28 INFO - '--tppagecycles', 17:08:28 INFO - '7'], 17:08:28 INFO - 'tests': ['tsvgm']}}, 17:08:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:08:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:08:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'tests': ['damp', 'tps']}, 17:08:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['damp', 'tps']}, 17:08:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:08:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:28 INFO - 'other': {'tests': ['a11yr', 17:08:28 INFO - 'ts_paint', 17:08:28 INFO - 'tpaint', 17:08:28 INFO - 'sessionrestore', 17:08:28 INFO - 'sessionrestore_no_auto_restore', 17:08:28 INFO - 'tabpaint']}, 17:08:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['a11yr', 17:08:28 INFO - 'ts_paint', 17:08:28 INFO - 'tpaint', 17:08:28 INFO - 'sessionrestore', 17:08:28 INFO - 'sessionrestore_no_auto_restore', 17:08:28 INFO - 'tabpaint']}, 17:08:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['a11yr', 17:08:28 INFO - 'ts_paint', 17:08:28 INFO - 'tpaint', 17:08:28 INFO - 'sessionrestore', 17:08:28 INFO - 'sessionrestore_no_auto_restore', 17:08:28 INFO - 'tabpaint']}, 17:08:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['a11yr', 17:08:28 INFO - 'ts_paint', 17:08:28 INFO - 'tpaint', 17:08:28 INFO - 'sessionrestore', 17:08:28 INFO - 'sessionrestore_no_auto_restore', 17:08:28 INFO - 'tabpaint']}, 17:08:28 INFO - 'other_l64': {'tests': ['a11yr', 17:08:28 INFO - 'ts_paint', 17:08:28 INFO - 'tpaint', 17:08:28 INFO - 'sessionrestore', 17:08:28 INFO - 'sessionrestore_no_auto_restore', 17:08:28 INFO - 'tabpaint']}, 17:08:28 INFO - 'other_nol64': {'tests': ['a11yr', 17:08:28 INFO - 'ts_paint', 17:08:28 INFO - 'tpaint', 17:08:28 INFO - 'sessionrestore', 17:08:28 INFO - 'sessionrestore_no_auto_restore', 17:08:28 INFO - 'tabpaint']}, 17:08:28 INFO - 'svgr': {'tests': ['tsvgx', 17:08:28 INFO - 'tsvgr_opacity', 17:08:28 INFO - 'tart', 17:08:28 INFO - 'tscrollx', 17:08:28 INFO - 'cart']}, 17:08:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['tsvgx', 17:08:28 INFO - 'tsvgr_opacity', 17:08:28 INFO - 'tart', 17:08:28 INFO - 'tscrollx', 17:08:28 INFO - 'cart']}, 17:08:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'tests': ['tp5o']}, 17:08:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'talos_options': ['--e10s'], 17:08:28 INFO - 'tests': ['tp5o']}, 17:08:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'talos_options': ['--xperf_path', 17:08:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:28 INFO - 'tests': ['tp5n']}, 17:08:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:28 INFO - 'talos_options': ['--e10s', 17:08:28 INFO - '--xperf_path', 17:08:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:28 INFO - 'tests': ['tp5n']}}, 17:08:28 INFO - 'talos.zip': {'path': '', 17:08:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:28 INFO - Running post-action listener: _resource_record_post_action 17:08:28 INFO - ##### 17:08:28 INFO - ##### Running create-virtualenv step. 17:08:28 INFO - ##### 17:08:28 INFO - Running pre-action listener: _resource_record_pre_action 17:08:28 INFO - Running main action method: create_virtualenv 17:08:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:08:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:28 INFO - Using real prefix '/usr' 17:08:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:31 INFO - Installing pip.................done. 17:08:31 INFO - Return code: 0 17:08:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08: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', 'pip>=1.5'] in /builds/slave/test/build 17:08: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 pip>=1.5 17:08:31 INFO - Using env: {'DISPLAY': ':0', 17:08:31 INFO - 'HOME': '/home/cltbld', 17:08:31 INFO - 'LANG': 'en_US.UTF-8', 17:08:31 INFO - 'LANGUAGE': 'en_US:en', 17:08:31 INFO - 'LOGNAME': 'cltbld', 17:08:31 INFO - 'MAIL': '/var/mail/cltbld', 17:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:31 INFO - 'MOZ_NO_REMOTE': '1', 17:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:31 INFO - 'NO_EM_RESTART': '1', 17:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:31 INFO - 'PWD': '/builds/slave/test', 17:08:31 INFO - 'SHELL': '/bin/bash', 17:08:31 INFO - 'SHLVL': '1', 17:08:31 INFO - 'TERM': 'linux', 17:08:31 INFO - 'TMOUT': '86400', 17:08:31 INFO - 'USER': 'cltbld', 17:08:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:31 INFO - '_': '/tools/buildbot/bin/python'} 17:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:08:31 INFO - Cleaning up... 17:08:31 INFO - Return code: 0 17:08:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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', '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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:08: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 psutil>=0.7.1 17:08:31 INFO - Using env: {'DISPLAY': ':0', 17:08:31 INFO - 'HOME': '/home/cltbld', 17:08:31 INFO - 'LANG': 'en_US.UTF-8', 17:08:31 INFO - 'LANGUAGE': 'en_US:en', 17:08:31 INFO - 'LOGNAME': 'cltbld', 17:08:31 INFO - 'MAIL': '/var/mail/cltbld', 17:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:31 INFO - 'MOZ_NO_REMOTE': '1', 17:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:31 INFO - 'NO_EM_RESTART': '1', 17:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:31 INFO - 'PWD': '/builds/slave/test', 17:08:31 INFO - 'SHELL': '/bin/bash', 17:08:31 INFO - 'SHLVL': '1', 17:08:31 INFO - 'TERM': 'linux', 17:08:31 INFO - 'TMOUT': '86400', 17:08:31 INFO - 'USER': 'cltbld', 17:08:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:31 INFO - '_': '/tools/buildbot/bin/python'} 17:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:31 INFO - Downloading/unpacking psutil>=0.7.1 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:33 INFO - Installing collected packages: psutil 17:08:33 INFO - Running setup.py install for psutil 17:08:33 INFO - building 'psutil._psutil_linux' extension 17:08:33 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 17:08:34 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 17:08:34 INFO - building 'psutil._psutil_posix' extension 17:08:34 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 17:08:34 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 17:08:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:34 INFO - Successfully installed psutil 17:08:34 INFO - Cleaning up... 17:08:34 INFO - Return code: 0 17:08:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:08:34 INFO - Using env: {'DISPLAY': ':0', 17:08:34 INFO - 'HOME': '/home/cltbld', 17:08:34 INFO - 'LANG': 'en_US.UTF-8', 17:08:34 INFO - 'LANGUAGE': 'en_US:en', 17:08:34 INFO - 'LOGNAME': 'cltbld', 17:08:34 INFO - 'MAIL': '/var/mail/cltbld', 17:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:34 INFO - 'MOZ_NO_REMOTE': '1', 17:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:34 INFO - 'NO_EM_RESTART': '1', 17:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:34 INFO - 'PWD': '/builds/slave/test', 17:08:34 INFO - 'SHELL': '/bin/bash', 17:08:34 INFO - 'SHLVL': '1', 17:08:34 INFO - 'TERM': 'linux', 17:08:34 INFO - 'TMOUT': '86400', 17:08:34 INFO - 'USER': 'cltbld', 17:08:34 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:34 INFO - '_': '/tools/buildbot/bin/python'} 17:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:36 INFO - Installing collected packages: mozsystemmonitor 17:08:36 INFO - Running setup.py install for mozsystemmonitor 17:08:36 INFO - Successfully installed mozsystemmonitor 17:08:36 INFO - Cleaning up... 17:08:36 INFO - Return code: 0 17:08:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:08:36 INFO - Using env: {'DISPLAY': ':0', 17:08:36 INFO - 'HOME': '/home/cltbld', 17:08:36 INFO - 'LANG': 'en_US.UTF-8', 17:08:36 INFO - 'LANGUAGE': 'en_US:en', 17:08:36 INFO - 'LOGNAME': 'cltbld', 17:08:36 INFO - 'MAIL': '/var/mail/cltbld', 17:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:36 INFO - 'MOZ_NO_REMOTE': '1', 17:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:36 INFO - 'NO_EM_RESTART': '1', 17:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:36 INFO - 'PWD': '/builds/slave/test', 17:08:36 INFO - 'SHELL': '/bin/bash', 17:08:36 INFO - 'SHLVL': '1', 17:08:36 INFO - 'TERM': 'linux', 17:08:36 INFO - 'TMOUT': '86400', 17:08:36 INFO - 'USER': 'cltbld', 17:08:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:36 INFO - '_': '/tools/buildbot/bin/python'} 17:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:39 INFO - Downloading docopt-0.6.1.tar.gz 17:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:39 INFO - Running setup.py install for blobuploader 17:08:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:39 INFO - Running setup.py install for requests 17:08:40 INFO - Running setup.py install for docopt 17:08:40 INFO - Successfully installed blobuploader requests docopt 17:08:40 INFO - Cleaning up... 17:08:40 INFO - Return code: 0 17:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:40 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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:08:40 INFO - Using env: {'DISPLAY': ':0', 17:08:40 INFO - 'HOME': '/home/cltbld', 17:08:40 INFO - 'LANG': 'en_US.UTF-8', 17:08:40 INFO - 'LANGUAGE': 'en_US:en', 17:08:40 INFO - 'LOGNAME': 'cltbld', 17:08:40 INFO - 'MAIL': '/var/mail/cltbld', 17:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:40 INFO - 'MOZ_NO_REMOTE': '1', 17:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:40 INFO - 'NO_EM_RESTART': '1', 17:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:40 INFO - 'PWD': '/builds/slave/test', 17:08:40 INFO - 'SHELL': '/bin/bash', 17:08:40 INFO - 'SHLVL': '1', 17:08:40 INFO - 'TERM': 'linux', 17:08:40 INFO - 'TMOUT': '86400', 17:08:40 INFO - 'USER': 'cltbld', 17:08:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:40 INFO - '_': '/tools/buildbot/bin/python'} 17:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:40 INFO - Running setup.py (path:/tmp/pip-gjz2DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:40 INFO - Running setup.py (path:/tmp/pip-NlYh_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:40 INFO - Running setup.py (path:/tmp/pip-p0Glei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:40 INFO - Running setup.py (path:/tmp/pip-plrIPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:40 INFO - Running setup.py (path:/tmp/pip-abTWvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:40 INFO - Running setup.py (path:/tmp/pip-4vG3ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:41 INFO - Running setup.py (path:/tmp/pip-AU8t1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:41 INFO - Running setup.py (path:/tmp/pip-fPidLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:41 INFO - Running setup.py (path:/tmp/pip-JDmTJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:41 INFO - Running setup.py (path:/tmp/pip-HJQSdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:41 INFO - Running setup.py (path:/tmp/pip-B97Ohv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:41 INFO - Running setup.py (path:/tmp/pip-YzD4BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:41 INFO - Running setup.py (path:/tmp/pip-V2y7LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:41 INFO - Running setup.py (path:/tmp/pip-Xn7Zzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:41 INFO - Running setup.py (path:/tmp/pip-IbJOaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:41 INFO - Running setup.py (path:/tmp/pip-hh80LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:41 INFO - Running setup.py (path:/tmp/pip-g0k2q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:41 INFO - Running setup.py install for manifestparser 17:08:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:41 INFO - Running setup.py install for mozcrash 17:08:42 INFO - Running setup.py install for mozdebug 17:08:42 INFO - Running setup.py install for mozdevice 17:08:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Running setup.py install for mozfile 17:08:42 INFO - Running setup.py install for mozhttpd 17:08:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Running setup.py install for mozinfo 17:08:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Running setup.py install for mozInstall 17:08:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Running setup.py install for mozleak 17:08:42 INFO - Running setup.py install for mozlog 17:08:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Running setup.py install for moznetwork 17:08:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:42 INFO - Running setup.py install for mozprocess 17:08:43 INFO - Running setup.py install for mozprofile 17:08:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:43 INFO - Running setup.py install for mozrunner 17:08:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:43 INFO - Running setup.py install for mozscreenshot 17:08:43 INFO - Running setup.py install for moztest 17:08:43 INFO - Running setup.py install for mozversion 17:08:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:43 INFO - Cleaning up... 17:08:43 INFO - Return code: 0 17:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:43 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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:08:43 INFO - Using env: {'DISPLAY': ':0', 17:08:43 INFO - 'HOME': '/home/cltbld', 17:08:43 INFO - 'LANG': 'en_US.UTF-8', 17:08:43 INFO - 'LANGUAGE': 'en_US:en', 17:08:43 INFO - 'LOGNAME': 'cltbld', 17:08:43 INFO - 'MAIL': '/var/mail/cltbld', 17:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:43 INFO - 'MOZ_NO_REMOTE': '1', 17:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:43 INFO - 'NO_EM_RESTART': '1', 17:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:43 INFO - 'PWD': '/builds/slave/test', 17:08:43 INFO - 'SHELL': '/bin/bash', 17:08:43 INFO - 'SHLVL': '1', 17:08:43 INFO - 'TERM': 'linux', 17:08:43 INFO - 'TMOUT': '86400', 17:08:43 INFO - 'USER': 'cltbld', 17:08:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:43 INFO - '_': '/tools/buildbot/bin/python'} 17:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:43 INFO - Running setup.py (path:/tmp/pip-x3aH8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:43 INFO - Running setup.py (path:/tmp/pip-8XaH2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:43 INFO - Running setup.py (path:/tmp/pip-4o66xT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:44 INFO - Running setup.py (path:/tmp/pip-lWpiCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:44 INFO - Running setup.py (path:/tmp/pip-S16Yli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:44 INFO - Running setup.py (path:/tmp/pip-Gwiu_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:44 INFO - Running setup.py (path:/tmp/pip-LnIgqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:44 INFO - Running setup.py (path:/tmp/pip-wKHtXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:44 INFO - Running setup.py (path:/tmp/pip-j0mK0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:44 INFO - Running setup.py (path:/tmp/pip-ktp5_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:44 INFO - Running setup.py (path:/tmp/pip-oVr8l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:44 INFO - Running setup.py (path:/tmp/pip-Y5xgpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:44 INFO - Running setup.py (path:/tmp/pip-J39euC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:44 INFO - Running setup.py (path:/tmp/pip-oTC74M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:44 INFO - Running setup.py (path:/tmp/pip-bNg1ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:44 INFO - Running setup.py (path:/tmp/pip-BVV6BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:44 INFO - Running setup.py (path:/tmp/pip-NTfIe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:08:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:46 INFO - Downloading blessings-1.6.tar.gz 17:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:46 INFO - Installing collected packages: blessings 17:08:46 INFO - Running setup.py install for blessings 17:08:47 INFO - Successfully installed blessings 17:08:47 INFO - Cleaning up... 17:08:47 INFO - Return code: 0 17:08:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:47 INFO - Reading from file tmpfile_stdout 17:08:47 INFO - Current package versions: 17:08:47 INFO - argparse == 1.2.1 17:08:47 INFO - blessings == 1.6 17:08:47 INFO - blobuploader == 1.2.4 17:08:47 INFO - docopt == 0.6.1 17:08:47 INFO - manifestparser == 1.1 17:08:47 INFO - mozInstall == 1.12 17:08:47 INFO - mozcrash == 0.17 17:08:47 INFO - mozdebug == 0.1 17:08:47 INFO - mozdevice == 0.48 17:08:47 INFO - mozfile == 1.2 17:08:47 INFO - mozhttpd == 0.7 17:08:47 INFO - mozinfo == 0.9 17:08:47 INFO - mozleak == 0.1 17:08:47 INFO - mozlog == 3.1 17:08:47 INFO - moznetwork == 0.27 17:08:47 INFO - mozprocess == 0.22 17:08:47 INFO - mozprofile == 0.28 17:08:47 INFO - mozrunner == 6.11 17:08:47 INFO - mozscreenshot == 0.1 17:08:47 INFO - mozsystemmonitor == 0.0 17:08:47 INFO - moztest == 0.7 17:08:47 INFO - mozversion == 1.4 17:08:47 INFO - psutil == 3.1.1 17:08:47 INFO - requests == 1.2.3 17:08:47 INFO - wsgiref == 0.1.2 17:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:47 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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:08:47 INFO - Using env: {'DISPLAY': ':0', 17:08:47 INFO - 'HOME': '/home/cltbld', 17:08:47 INFO - 'LANG': 'en_US.UTF-8', 17:08:47 INFO - 'LANGUAGE': 'en_US:en', 17:08:47 INFO - 'LOGNAME': 'cltbld', 17:08:47 INFO - 'MAIL': '/var/mail/cltbld', 17:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:47 INFO - 'MOZ_NO_REMOTE': '1', 17:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:47 INFO - 'NO_EM_RESTART': '1', 17:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:47 INFO - 'PWD': '/builds/slave/test', 17:08:47 INFO - 'SHELL': '/bin/bash', 17:08:47 INFO - 'SHLVL': '1', 17:08:47 INFO - 'TERM': 'linux', 17:08:47 INFO - 'TMOUT': '86400', 17:08:47 INFO - 'USER': 'cltbld', 17:08:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:47 INFO - '_': '/tools/buildbot/bin/python'} 17:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:08:47 INFO - Cleaning up... 17:08:47 INFO - Return code: 0 17:08:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:08:47 INFO - Using env: {'DISPLAY': ':0', 17:08:47 INFO - 'HOME': '/home/cltbld', 17:08:47 INFO - 'LANG': 'en_US.UTF-8', 17:08:47 INFO - 'LANGUAGE': 'en_US:en', 17:08:47 INFO - 'LOGNAME': 'cltbld', 17:08:47 INFO - 'MAIL': '/var/mail/cltbld', 17:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:47 INFO - 'MOZ_NO_REMOTE': '1', 17:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:47 INFO - 'NO_EM_RESTART': '1', 17:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:47 INFO - 'PWD': '/builds/slave/test', 17:08:47 INFO - 'SHELL': '/bin/bash', 17:08:47 INFO - 'SHLVL': '1', 17:08:47 INFO - 'TERM': 'linux', 17:08:47 INFO - 'TMOUT': '86400', 17:08:47 INFO - 'USER': 'cltbld', 17:08:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:47 INFO - '_': '/tools/buildbot/bin/python'} 17:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:47 INFO - Downloading/unpacking jsonschema 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:49 INFO - Downloading/unpacking functools32 (from jsonschema) 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:49 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:49 INFO - warning: no files found matching '*.txt' 17:08:49 INFO - no previously-included directories found matching 'build' 17:08:49 INFO - no previously-included directories found matching 'dist' 17:08:49 INFO - no previously-included directories found matching '.git*' 17:08:49 INFO - Installing collected packages: jsonschema, functools32 17:08:49 INFO - Running setup.py install for functools32 17:08:50 INFO - warning: no files found matching '*.txt' 17:08:50 INFO - no previously-included directories found matching 'build' 17:08:50 INFO - no previously-included directories found matching 'dist' 17:08:50 INFO - no previously-included directories found matching '.git*' 17:08:50 INFO - Successfully installed jsonschema functools32 17:08:50 INFO - Cleaning up... 17:08:50 INFO - Return code: 0 17:08:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:50 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 0x7f994fb0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1409410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, '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': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', '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 17:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:08:50 INFO - Using env: {'DISPLAY': ':0', 17:08:50 INFO - 'HOME': '/home/cltbld', 17:08:50 INFO - 'LANG': 'en_US.UTF-8', 17:08:50 INFO - 'LANGUAGE': 'en_US:en', 17:08:50 INFO - 'LOGNAME': 'cltbld', 17:08:50 INFO - 'MAIL': '/var/mail/cltbld', 17:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:50 INFO - 'MOZ_NO_REMOTE': '1', 17:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:50 INFO - 'NO_EM_RESTART': '1', 17:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:50 INFO - 'PWD': '/builds/slave/test', 17:08:50 INFO - 'SHELL': '/bin/bash', 17:08:50 INFO - 'SHLVL': '1', 17:08:50 INFO - 'TERM': 'linux', 17:08:50 INFO - 'TMOUT': '86400', 17:08:50 INFO - 'USER': 'cltbld', 17:08:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:50 INFO - '_': '/tools/buildbot/bin/python'} 17:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:50 INFO - Downloading/unpacking flake8 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:52 INFO - no previously-included directories found matching 'docs/_build' 17:08:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:52 INFO - Running setup.py install for pep8 17:08:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:53 INFO - no previously-included directories found matching 'docs/_build' 17:08:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:08:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:53 INFO - Cleaning up... 17:08:53 INFO - Return code: 0 17:08:53 INFO - Running post-action listener: _resource_record_post_action 17:08:53 INFO - Running post-action listener: _start_resource_monitoring 17:08:53 INFO - Starting resource monitoring. 17:08:53 INFO - ##### 17:08:53 INFO - ##### Running install step. 17:08:53 INFO - ##### 17:08:53 INFO - Running pre-action listener: _resource_record_pre_action 17:08:53 INFO - Running main action method: install 17:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:53 INFO - Reading from file tmpfile_stdout 17:08:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:53 INFO - Reading from file tmpfile_stdout 17:08:53 INFO - Output received: 17:08:53 INFO - Usage: mozinstall [options] installer 17:08:53 INFO - Options: 17:08:53 INFO - -h, --help show this help message and exit 17:08:53 INFO - -d DEST, --destination=DEST 17:08:53 INFO - Directory to install application into. [default: 17:08:53 INFO - "/builds/slave/test"] 17:08:53 INFO - --app=APP Application being installed. [default: firefox] 17:08:53 INFO - mkdir: /builds/slave/test/build/application 17:08:53 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'] 17:08:53 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 17:09:09 INFO - Reading from file tmpfile_stdout 17:09:09 INFO - Output received: 17:09:09 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:09 INFO - Running post-action listener: _resource_record_post_action 17:09:09 INFO - ##### 17:09:09 INFO - ##### Running run-tests step. 17:09:09 INFO - ##### 17:09:09 INFO - Running pre-action listener: _resource_record_pre_action 17:09:09 INFO - Running main action method: run_tests 17:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:09 INFO - Python 2.7.3 17:09:09 INFO - Return code: 0 17:09:09 INFO - grabbing minidump binary from tooltool 17:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:09 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 0x1498160>, '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 0x1499060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14994f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:09 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 17:09:09 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 17:09:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:09 INFO - Return code: 0 17:09:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:10 INFO - Return code: 0 17:09:10 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/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 17:09:10 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/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 17:09:10 INFO - Using env: {'DISPLAY': ':0', 17:09:10 INFO - 'HOME': '/home/cltbld', 17:09:10 INFO - 'LANG': 'en_US.UTF-8', 17:09:10 INFO - 'LANGUAGE': 'en_US:en', 17:09:10 INFO - 'LOGNAME': 'cltbld', 17:09:10 INFO - 'MAIL': '/var/mail/cltbld', 17:09:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:10 INFO - 'MOZ_NO_REMOTE': '1', 17:09:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:10 INFO - 'NO_EM_RESTART': '1', 17:09:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:10 INFO - 'PWD': '/builds/slave/test', 17:09:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:10 INFO - 'SHELL': '/bin/bash', 17:09:10 INFO - 'SHLVL': '1', 17:09:10 INFO - 'TERM': 'linux', 17:09:10 INFO - 'TMOUT': '86400', 17:09:10 INFO - 'USER': 'cltbld', 17:09:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805', 17:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:10 INFO - '_': '/tools/buildbot/bin/python'} 17:09:10 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/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 17:09:10 INFO - mozversion application_buildid: 20160316162107 17:09:10 INFO - mozversion application_changeset: a4c6d6add2fcbc4bf847270cf27ff23334e2f170 17:09:10 INFO - mozversion application_display_name: Nightly 17:09:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:10 INFO - mozversion application_name: Firefox 17:09:10 INFO - mozversion application_remotingname: firefox 17:09:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:10 INFO - mozversion application_vendor: Mozilla 17:09:10 INFO - mozversion application_version: 48.0a1 17:09:10 INFO - mozversion platform_buildid: 20160316162107 17:09:10 INFO - mozversion platform_changeset: a4c6d6add2fcbc4bf847270cf27ff23334e2f170 17:09:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:10 INFO - mozversion platform_version: 48.0a1 17:09:10 INFO - using testdate: 1458173350 17:09:10 INFO - actual date: 1458173350 17:09:10 INFO - starting webserver on 'localhost:55991' 17:09:10 INFO - SUITE-START | Running 2 tests 17:09:10 INFO - TEST-START | dromaeo_css 17:09:10 INFO - operating with platform_type : linux_ 17:09:10 INFO - Initialising browser for dromaeo_css test... 17:09:10 INFO - TEST-INFO | started process 11707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8r8MvT/profile http://localhost:55991/getInfo.html) 17:09:15 INFO - PROCESS | 11707 | __metrics Screen width/height:1600/1200 17:09:15 INFO - PROCESS | 11707 | colorDepth:24 17:09:15 INFO - PROCESS | 11707 | Browser inner width/height: 1024/697 17:09:15 INFO - PROCESS | 11707 | __metrics 17:09:16 ERROR - PROCESS | 11707 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:09:16 INFO - PROCESS | 11707 | 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. 17:09:17 INFO - TEST-INFO | 11707: exit 0 17:09:17 INFO - Browser initialized. 17:09:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:17 INFO - TEST-INFO | started process 11800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8r8MvT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:29 INFO - PROCESS | 11800 | RSS: Main: 153747456 17:09:29 INFO - PROCESS | 11800 | 17:10:20 INFO - PROCESS | 11800 | 1458173420277 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:12:31 INFO - PROCESS | 11800 | Cycle 1(1): loaded http://localhost:55991/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55991/tests/dromaeo/cssquery-ext.html) 17:12:32 INFO - PROCESS | 11800 | RSS: Main: 254341120 17:12:32 INFO - PROCESS | 11800 | 17:15:35 INFO - PROCESS | 11800 | Cycle 1(1): loaded http://localhost:55991/tests/dromaeo/cssquery-ext.html (next: http://localhost:55991/tests/dromaeo/cssquery-jquery.html) 17:15:35 INFO - PROCESS | 11800 | RSS: Main: 241123328 17:15:35 INFO - PROCESS | 11800 | 17:18:37 INFO - PROCESS | 11800 | Cycle 1(1): loaded http://localhost:55991/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55991/tests/dromaeo/cssquery-mootools.html) 17:18:38 INFO - PROCESS | 11800 | RSS: Main: 227061760 17:18:38 INFO - PROCESS | 11800 | 17:21:40 INFO - PROCESS | 11800 | Cycle 1(1): loaded http://localhost:55991/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55991/tests/dromaeo/cssquery-prototype.html) 17:21:41 INFO - PROCESS | 11800 | RSS: Main: 206606336 17:21:41 INFO - PROCESS | 11800 | 17:24:43 INFO - PROCESS | 11800 | Cycle 1(1): loaded http://localhost:55991/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55991/tests/dromaeo/cssquery-yui.html) 17:24:44 INFO - PROCESS | 11800 | RSS: Main: 201183232 17:24:44 INFO - PROCESS | 11800 | 17:27:46 INFO - PROCESS | 11800 | Cycle 1(1): loaded http://localhost:55991/tests/dromaeo/cssquery-yui.html (next: http://localhost:55991/tests/dromaeo/cssquery-dojo.html) 17:27:47 INFO - PROCESS | 11800 | RSS: Main: 262197248 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | __start_tp_report 17:27:47 INFO - PROCESS | 11800 | _x_x_mozilla_page_load 17:27:47 INFO - PROCESS | 11800 | _x_x_mozilla_page_load_details 17:27:47 INFO - PROCESS | 11800 | |i|pagename|runs| 17:27:47 INFO - PROCESS | 11800 | |0;dojo.html;2616.110522422376;2697.5009623219707;2705.3371923878653;2714.145044311042;2741;4585.88535286618;4670.089332580148;4679;4694.272387779895;4721.291806229063;4696.694714843533;4699.976500117495;4713.905721885569;4718.5281471852795;4719.362886010396;4251.5535868733805;4362.062156636339;4364.738115713051;4424.247877860756;4495.842645507408;4223.894402639928;4372.2130016597;4404.801783919731;4467.5755803198645;4472.060867217872;4333.891652708676;4337.84817531388;4347.478302603692;4377.233984052778;4405.00887300358;4331.328644060176;4349.826006959718;4357.193919124972;4363.323684828857;4396;4229.957700423018;4301.5698430157045;4329.567043295677;4398.428204333416;4400.405945197422;4630.791614377361;4635.76821158944;4642.512536183686;4655.860324190246;4712.693674911154;5008.173651347523;5009.749512524396;5012.398512178562;5069.69581825088;5121.436641969418;4934.481879402647;5006.499350064964;5105.821296254613;5108.233764935252;5148.330717006766;4722.693024953436;4735.692180008288;4746.264329029006;4756.167670657655;4788.23388257884;5032.169692000852;5157;5172.250023746536;5177.792888284502;5181.740912954413;4910.042541704333;4933.975330123327;4959.652824302264;4993.700377977333;5001.574866136347;5058;5062.949370506248;5079.593632509391;5080.46655101209;5118.59051275897;4883.487233840467;5013.623978201649;5021.874453138627;5022.949770502249;5029.698218106925;5016.54851063406;5018.623603229772;5042.142835717937;5048.7728052237735;5084.288199652052;4341.044970106572;4345.152695224464;4347.260965635849;4384.934225986613;4385.451818522684;3705.184859330943;3751.437284407306;3792.829322680486;3808.6953043756434;3817.61823817616;4260.041490664637;4267.4025636410925;4273.55127711592;4316.568343165658;4317.892052698708;4964.230544265644;4981.950180498221;4984.327115839388;4996.675216110941;5026.321446604735;4185.162967406531;4239.130978149472;4259.169461954951;4314.8489802857375;4325.697201195886;4575.839845605387;4580.679352445363;4593.081383723202;4595.0809838031855;4647.767611619405;4750.762461876892;4767.880802979953;4772.217034549881;4781.497942715965;4816.349792778;4916.532929371704;5022.974885125551;5069.340985671839;5108.591312694901;5121.769520371667;4727.172744769583;4728.38530990969;4752.477227504903;4759.286107083965;4803.015381846643;4773.76131193432;4941.876453088702;4947.233178857283;4958.42978057528;5011.323471331323;5003.474635163401;5025.195968644999;5053.924191137063;5078.136716758234;5082.440931497458;4877.219644856806;4879.4876537963;4887.853364399074;4893.437254715611;4932.556069953722;4757.262624293102;4875.634327425386;4917.28699338601;4918.655694101379;4965.553100220997;4819.855404337875;4865.367502224688;4883.3651625288485;4889.095517329305;4934;4940.505949405031;4971.527704868032;4972.105021096238;4976.129177394014;5020.598352131748;4739.810407583658;4797.760111994457;4845.466998630219;4896.755162241945;4918.213085906238 17:27:47 INFO - PROCESS | 11800 | |1;ext.html;531.1846315905084;553.5682167909031;554.2406902543516;561.0854307478809;574.1817909478992;27039.864800675994;33926.15184620386;34609.48085778715;34622.8268858656;34679.30641387174;37351;37355.62644373556;37640.24719505615;37878.621213787854;37973;7661;7851.214878512132;7853.450258481908;7858.921410785876;7860.724874629389;7659.578723170223;7778.4166187535875;7778.961105194466;7781.3774898008305;7942.602869856513;7916.604169791516;7943.801404964894;7970.322522585587;7980.720674776384;8010;7849.332806711408;7913.366930645535;7913.643886025143;7923.0888447828665;7923.683052677857;7757.7672669819995;7879.054513458364;7885.723999659985;7887.723929662434;7895.407844411692;36905;37661.81169094164;37678;37692;37840.62159378399;3017.7736669749856;3145.087924501892;3209.1816586770456;3273.5744353234163;3766.7928263945473;28545.857270713514;28736.568951465746;28952;29453.852730736424;29808.403831923457;3386.187315044396;3540.8937731868086;3578.3916734155255;3581.892872652148;3637.5453068366455;239249;240443;240720;241066;241428;52961.47038529642;53263.733681331345;53576.73211633995;53652.46347536553;53692.73153634207;57921.42078579245;58469.70765146147;58537.41462585405;58611.12083318754;63959.36040639534;14364.425422983173;14431.639209019859;14513.854861451462;14538;14547.418103275962;10076.546555405024;10082.344647597884;10083.495825208856;10083.59665613382;10096.848547271797;19368.225270989285;19431.765346985278;19434.12546435414;19549.142831430992;19574.608507829762;7359.448041396917;7697.923020769721;7706.730264440717;7815.843683126305;7944.205579442009;853.9444936079135;883.5891310540629;920.6455514626917;924.2144177449114;1059.7350662334416;26973.460530789274;27792.444151116866;28309.858450707616;28346.43307133887;28359;953.0802775321848;953.1516949914582;987.2250283527396;994.9751256218652;1039.8752149741929;14114.033518220256;14403.92798036024;14546.345414456375;14572.489962851248;14673.92663036678;287475;289162;291360;291725;292223;47175.292370614465;47522.762386187846;47622.28566571504;47674.5232547677;47681;1074.5970261152067;1245.7446223524155;1263.829383033297;1267.8098285257286;1365.2559355151268;26495.470090597693;27342.179734607995;27965.580516291866;28075.71924280813;28321.291967700974;37421.4386784193;37681.43477847889;38078.80960595179;38081.61918380781;38106.0473488165;256687;260278;261420;262596;264916;27042.188734338;30777;31185;31286.217844554067;31494.52758208583;37136.81431592825;38050.038433882204;38418.42372364361;38535.6146438532;38824;34600.55921709526;35336.64663353334;35629.46555801717;35747.28505429929;36072.81963590165;34858.47712284267;34961;35407.82296088503;35476;35633.64366356407;34710.826445867606;35118.82440587781;35298.64701352954;35534;35762;31057.22356941004;31799.841000795772;32094.51858222082;32167;32448.67551324551;24103.879480602485;24760.13339533108;24801.379965501008;24839.751602484466;25168.24495265145 17:27:47 INFO - PROCESS | 11800 | |2;jquery.html;351.7309258417311;356.8447725239521;359.5990470625253;361.4523996145838;361.8733443294847;15218;15761.369545218191;16111.516654500354;16719.331226750914;16892.915535422304;11208.66374008779;11214.495347709353;11217.158713096509;14108.717825643482;16322.347106115742;4657.2082745933185;4767.404074490689;4791.688540244873;4795.544423279783;4797.160496913044;3399.5750531183603;4213.136307057046;5996.860596486654;6001.849953751147;6012.18835457212;5770.365259821417;5884.352721200665;5892.852678683024;5896.528277737771;5936.287645482548;3414.351273258073;5022.4224214215465;5177.844664660066;5212.296339994109;5865.35481097079;4923.212286034217;5057.69653820772;5099.056674515226;5106.872328191825;5107.923381149286;11725.4137293135;11927.821082683766;11928.343941083236;16983.74524382135;19639.410817675493;1864.086597567196;1901.4485799118238;1907.3705677126516;2001.7998200180011;2478.925632231018;8985.37102402832;9464.384814987005;9771.316007879452;11110.888891111066;13129.803052954214;1751.816059313779;1778.6175972165918;1805.602767391172;1811.25738447236;1859.5072305838964;56476;58312.70843645797;59065.7046714768;61173;62753.058704119474;9274.721758347261;9508.239340852853;9594.42433453981;9880.061394167542;10052.246081543914;12589.874101259053;12591.874081259253;12592;12625.116241862981;12645.367731613567;6585.308542603054;6964.547304425298;6973.884178531411;7073.762091633944;7085.078939737904;6732.360425759643;6754.560953538103;6814.863702725917;6835.658217089126;6838.350356716203;4040.8181631826637;4049.797510124482;4051.230266249462;4066.552679205285;4124.505059392832;1796.119901248379;1825.6713791517388;1829.1951541321775;1840.503064172666;1844.1701234444286;828.5194587139445;841.4446465332974;882.7395918204145;895.4537731983485;916.9862452063225;15576.688466230611;15946.441874534336;16156.515304540882;16351.91824040896;16485.258163382678;868.084171199378;884.0187391994881;895.6417433026842;899.4513346858411;918.9954050229707;8617.138286171332;9117.908820911838;9312.255019598417;9369.297302702325;9417.105374989365;405966;418574;419233;427007;431248;69941.65029174821;71707.28292717111;71805;71928.2807171932;76015.61992190115;913.2648218184426;930.6463543853292;943.712167788831;944.5088553952044;946.1059298962415;14454;14475.131492110086;14615.488457903923;14638.414463421344;14667.266636667911;32960.67039329672;33428.33143337071;34620.65379346275;34944.0409483296;35083.47374789431;46832.53167468418;47198;47640.52359476361;47665;47713.28430073482;7630.2751238632245;7682.923170768221;7702.268284512962;7708.113566939649;7756.961215193888;10611.2041596879;11352.091832653203;11559.190856639954;11645.126615503701;11728.530858765555;9688.692026576604;10217.897821021992;10322.793544128925;10329.070383665507;10382;7199.428362989434;10163.23775716839;10228.335158214692;10353.74115647115;10419.531121099417;8953.418027828171;9376.718698439057;9986.550605222637;10025.849612255675;10128.949355253177;7413.8146546336775;7475.177730449537;7495.063117110361;7594.810129746579;7612.885806713015;9630.711078667651;10003.799924001625;10058.899411005796;10063.597456101674;10100.797984040131 17:27:47 INFO - PROCESS | 11800 | |3;mootools.html;1207.3238986167742;1358.6399604104913;1359.2252416122808;1470.9190994495298;1713.340363959875;7185.389241914437;7337.046183996073;7356.521826081301;7365.042544469218;7366.96316518418;7204.819879503015;7348.742794002211;7352.595607241613;7352.669129889155;7355.227701091389;1925.3261358524544;2175.195177784222;2208.02846747431;2227.5433536125056;2236.7427745809196;2208.249195273607;2214.3135627955303;2215.8559693619864;2217.1463986365206;2218.6117429449864;2162.243214874789;2218.4564781628524;2220.4781876259067;2222.055626358799;2225.1544413122992;2173.1416090644184;2194.8353873459555;2202.944926376845;2216.1135545781653;2219.1567204462362;2189.2665956904457;2205.746339171;2213.900374483152;2216.0581752755015;2218.0240694094546;7499.325060744504;7563.130240022413;7564.546127232384;7573.394128469709;7578.052743407075;4478.037221997253;4532.773361331921;4556.111558246143;4573.63410927125;4583;3032.469317869364;3043.1479185827784;3069.2480342316276;3089.582906307642;3174.984125079383;962.6823148361094;971.7473456901186;989.1196834817018;995.4425521707794;1069.9572017119306;10257.743556411075;10270.075693187575;10272.845907311395;10286.228532860065;10289.22830787694;4039.1719697462536;4181.059261666162;4225.9577404226175;4233.872983810491;4258.1696569169335;8680.78298042554;8723.389362744674;8759.605817738217;8783.253423459077;8788.42875213109;3969.64273215412;4582.541745825458;4587.243104887656;4595.540445955445;4608.723476591415;4006.258842114218;4029.879103626896;4034.677225821927;4043.8989025274013;4065.918681626351;3549.7692649978185;3595.94606080909;3615.421532554831;3644.5444319460066;3648.1609229877276;1107.7618312062946;1131.1742428027585;1131.3777422417638;1141.960031398897;1146.0487795130023;1143.3368646185193;1152.7291086594644;1154.6593754842343;1162.9941850290695;1183.8401815754935;6635.86728265432;6729.629870357079;6730.394264516217;6744.7976560703255;6770.984352347187;470.02000828273435;476.1714616567148;479.7984846364535;480.5170803342688;481.0547274605417;5128.3333166688835;5156.561692256125;5187.118189907725;5187.533122019036;5191.896162076813;8643.783905402415;8754.912450875538;8871.334649901155;9208.769780755534;9228.769280768034;8638.82722345562;8683.782905427415;8692.348073894356;8709.172628600272;8747.693830715894;6969.2682268362105;7004.824879377954;7063.011178435023;7111.395531379891;7164.283571642898;6811.352921472452;6824.727010919508;6833.760818371333;6855;6889.689963951534;8096.230858068474;8168.1015088339045;8235.423520353517;8267;8388.203120703523;8498.107698691549;8541.871871921801;8605.35459840502;8630.352723545633;8765.868511972452;5572.721363931706;5660.773569057192;6164.845878853064;6315.810525684236;6398.360163983564;6994.33553812387;7073.328033836778;7074.186468556182;7078.504504684623;7079.504434689522;6249.125122482947;6453.741850326122;6464.41820236181;6465.77369792055;6554.442872355712;6363.077353783768;6424.100625912282;6436.903446448214;6472.061551075162;6552.770653027312;6782.287859774653;6785.830354240986;6819.215790184192;6820.454363650797;6825.2151002633345;5797;5824.475797178105;5850.736716847837;5854.531637469077;5883.823485295448;5965.552583556164;5977.133315669291;5992.520598352208;6004.279486461653;6031.4270144336215 17:27:47 INFO - PROCESS | 11800 | |4;prototype.html;321.872860220213;322.4743667821451;325.719880902424;327.8803236818561;331.9054069590166;5345.599080069001;5357.705326207057;5366.838994830161;5376.354837419511;5380.892382152355;5225.86935326617;5277.788888444457;5338.62629615927;5341.023821186157;5342.038433082043;4015.6547556568585;4062.431259623655;4117.300058989964;4148.43996060531;4216.89457763556;4131.2357213915375;4153;4197.643200327976;4198.635443480881;4220.683448741342;4154.875353739378;4155.480564929384;4155.916881662365;4158.022864626825;4165.250254954107;3937.803109844511;4072.36878283865;4139.648129908961;4140.834366625331;4150.958490415087;3672.9632703672887;3676.9888280723017;3677.8161091945294;3678.0437086357474;3684.797336146511;5147.845564633067;5180.456052114511;5187.014467251211;5188.610854185951;5191.247269145991;4839.153148199051;4839.467658557556;4854.538818812207;4856.805727770885;4858.489858564835;5641.125625528009;5661.886762264731;5662.631928924607;5664.830055098354;5665.12190610456;4092.1201941582403;4100.323446631302;4104.15864747726;4106;4110.23960567296;5704.914426283568;5917.467427931464;5955.761769529214;5967.313758917693;5969.134475501071;4026.0941288210506;4078.0824314529586;4080.367543030835;4081.5306239782212;4086.2644723949975;4108.856190033334;4125.133721918371;4135.60711732385;4136.048708796993;4136.172765446922;4720.645951553647;4733.786979585927;4739.4075740532435;4745.95254047462;4748.525147485224;5642.689652069093;5652.0391533439415;5662.065759149777;5665.093585026376;5666.320041594952;1428;1454.7308747881464;1457.118443341784;1457.118443341784;1459.737247295497;920.5949382271779;953.1040821627648;960.2318145483586;989.366805244644;990.1039559198937;4817.325574419584;4825.276208568673;4827.903441931142;4837.105135549935;4839.032193561302;5688.488036076773;5740.052891272977;5740.942590574125;5742.971285143548;5748.338941021836;4894.1679914414635;4894.926576101361;4901.044296362246;4902.583280421204;4907.901841963141;3092.3969825884187;3127.9843600782306;3129.6087989001376;3129.749620030392;3139.0269016604925;5422.267993820863;5440.156775699773;5446.700431476228;5449.1826226066405;5449.3188351456065;5771.451712087345;6026.5178785697035;6028.638281703112;6038.486728628028;6040.275166979991;5401.864953376118;5423.945760542502;5425.403205647375;5433.6196466247775;5434.0490414176575;5792.797252096325;5822.73797679097;5823.621464604787;5824;5825.3883342248455;5695.0603150481365;5706.914396284142;5707.258056452634;5716.628419152742;5719.828405147852;5398.217258497574;5416.295881535375;5424.511793938565;5428.70142142186;5447.428020057995;3910.7458015228917;3981;4018.2566225248424;4022.8994275143355;4023.818928148182;5776.9133462998925;5787.971060144672;5796.594238403271;5801.709914504174;5804.332501762183;5574.16387541872;5595.524380427709;5596.1605759136455;5598.244237027949;5599.188117722826;5585.3297604287745;5586.050371436784;5588.86027849307;5593.860153496195;5594.9720251398485;5493.313335833021;5500;5505.394406615189;5508.834734957958;5512.751926163252;5543.916841247304;5762.394948530512;5763.913541296968;5769.394213607511;5775.33583637887;5572.693501857437;5603.075492543848;5609.831705048855;5617.522510586482;5617.719114044363 17:27:47 INFO - PROCESS | 11800 | |5;yui.html;762.6834863531639;762.8245503534187;776.8679324514831;777.8444311137774;780.1574299756263;11087.889121108787;11283.830742538868;11315.207935444512;11320.660380188598;11335.546578136864;10909.290896091748;10920.836187457195;10933.070688991425;10976.835347469794;10990.17573681973;644.7485480662546;781.8201813582865;787.8542469643106;809.4900212865887;810.6190090657382;797.1191833024511;802.7752229375784;804.9315808156314;807.6850028488865;808.2685169921201;840.5461051032435;843.7890527368158;845.9873101903477;849.902261239956;849.961751721174;668.8762578922915;680.581442412915;849.3120572336366;850.7320194138857;869.8869147010848;621.3972446726668;622.0762168180248;622.327885883245;622.4242575617536;622.4802290087737;10916.126709863192;10968.835467467994;10997.670069897917;10997.725056873642;10998.230123891331;10875.510602022929;11723;11844.644660660195;11966.64100076999;12033.338166400845;9256.39833410833;9344.766380840465;9375.10936461035;9546.474943878084;9576;3228.4027454920915;3251.3172233830924;3259.820709860957;3267.493538501536;3294.7199488043543;43457.56542434599;43637.56362436367;44412;45172.3224151638;45455.772721136185;9336.253099752004;9337.626494940263;9418.952905235567;9437.811243775086;9529.761755956157;17225.65548689019;17307.134643267786;17307.653846922993;17308.221130049176;17319.307227711004;6747.122874026345;6838.247792742794;6891.104156459728;6943.375096241362;6969.1985421676145;3722.553293604785;3784.129650180419;3819.694424446038;3825.827837747308;3851.8651847185215;2799.202227365191;2868.0248715436433;2868.498012847743;2870.7990440668955;2874.2957975296185;465.25326850405287;508.9923651145236;520.6433592988815;523.3432042786355;529.0239508107535;511.4425276448689;516.4654582507087;520.456123351099;528.801699362739;533.3839415475132;7435.40516758658;7479.663415146331;7543.585102819397;7658.157602663702;7690.653920573588;472.62190247802306;537.5914305128131;537.7983256278895;563.2452513631753;571.4000299685314;3342.7325813934826;3414.3000684859544;3459.2043829919257;3470.5661792275964;3691.206390626028;53611.73194134004;54714.45285547173;54807;54829.1775623366;54857.45142548603;46580.53419465762;46728.76635616868;47370.289445658345;47730.761346193045;47940.7602961983;42489.78755106266;42680.93297667521;43002.78498607487;43028.78485607615;43189.999999999374;7582.128055273714;7617.428692847948;7861.449698521049;7878.409119315959;7987.361011119213;32852.342953141284;33076.66923330832;33757.83121084477;33956;34191;42410.787946060074;42538.361924570534;43543.782281088395;43770;44050.33924491071;10077.496125193858;10161.390316581028;10194.694159175237;10320.12278956297;10457.895421045996;10677.519511622151;10733.355998640107;10768.3538987661;10783.6225732099;11100.333979961228;8102.270795628422;9251.76870578214;10125.696229113139;10697.411642359744;11354.716132096764;9776.804463910825;10432.321899076536;10454.163666906477;10703.571857125939;10888.836667449836;10163.23775716839;10519.474026298807;10550.155987521133;10650.201234907257;10708.89291107079;8683.08827573121;8705.26005289532;8778;8881.822363552821;9016.459012459274;8904.19862212404;8918.86621700688;9252.352335336462;9363.85954210701;9422.104900034486 17:27:47 INFO - PROCESS | 11800 | __end_tp_report 17:27:47 INFO - PROCESS | 11800 | __start_cc_report 17:27:47 INFO - PROCESS | 11800 | _x_x_mozilla_cycle_collect,917 17:27:47 INFO - PROCESS | 11800 | __end_cc_report 17:27:47 INFO - PROCESS | 11800 | __startTimestamp1458174467056__endTimestamp 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | ------- Summary: start ------- 17:27:47 INFO - PROCESS | 11800 | Number of tests: 6 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | [#0] dojo.html Cycles:165 Average:4664.60 Median:4772.22 stddev:475.47 (10.0%) stddev-sans-first:448.95 17:27:47 INFO - PROCESS | 11800 | Values: 2616.1 2697.5 2705.3 2714.1 2741.0 4585.9 4670.1 4679.0 4694.3 4721.3 4696.7 4700.0 4713.9 4718.5 4719.4 4251.6 4362.1 4364.7 4424.2 4495.8 4223.9 4372.2 4404.8 4467.6 4472.1 4333.9 4337.8 4347.5 4377.2 4405.0 4331.3 4349.8 4357.2 4363.3 4396.0 4230.0 4301.6 4329.6 4398.4 4400.4 4630.8 4635.8 4642.5 4655.9 4712.7 5008.2 5009.7 5012.4 5069.7 5121.4 4934.5 5006.5 5105.8 5108.2 5148.3 4722.7 4735.7 4746.3 4756.2 4788.2 5032.2 5157.0 5172.3 5177.8 5181.7 4910.0 4934.0 4959.7 4993.7 5001.6 5058.0 5062.9 5079.6 5080.5 5118.6 4883.5 5013.6 5021.9 5022.9 5029.7 5016.5 5018.6 5042.1 5048.8 5084.3 4341.0 4345.2 4347.3 4384.9 4385.5 3705.2 3751.4 3792.8 3808.7 3817.6 4260.0 4267.4 4273.6 4316.6 4317.9 4964.2 4982.0 4984.3 4996.7 5026.3 4185.2 4239.1 4259.2 4314.8 4325.7 4575.8 4580.7 4593.1 4595.1 4647.8 4750.8 4767.9 4772.2 4781.5 4816.3 4916.5 5023.0 5069.3 5108.6 5121.8 4727.2 4728.4 4752.5 4759.3 4803.0 4773.8 4941.9 4947.2 4958.4 5011.3 5003.5 5025.2 5053.9 5078.1 5082.4 4877.2 4879.5 4887.9 4893.4 4932.6 4757.3 4875.6 4917.3 4918.7 4965.6 4819.9 4865.4 4883.4 4889.1 4934.0 4940.5 4971.5 4972.1 4976.1 5020.6 4739.8 4797.8 4845.5 4896.8 4918.2 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | [#1] ext.html Cycles:180 Average:42518.31 Median:35441.91 stddev:69075.81 (194.9%) stddev-sans-first:69197.64 17:27:47 INFO - PROCESS | 11800 | Values: 531.2 553.6 554.2 561.1 574.2 27039.9 33926.2 34609.5 34622.8 34679.3 37351.0 37355.6 37640.2 37878.6 37973.0 7661.0 7851.2 7853.5 7858.9 7860.7 7659.6 7778.4 7779.0 7781.4 7942.6 7916.6 7943.8 7970.3 7980.7 8010.0 7849.3 7913.4 7913.6 7923.1 7923.7 7757.8 7879.1 7885.7 7887.7 7895.4 36905.0 37661.8 37678.0 37692.0 37840.6 3017.8 3145.1 3209.2 3273.6 3766.8 28545.9 28736.6 28952.0 29453.9 29808.4 3386.2 3540.9 3578.4 3581.9 3637.5 239249.0 240443.0 240720.0 241066.0 241428.0 52961.5 53263.7 53576.7 53652.5 53692.7 57921.4 58469.7 58537.4 58611.1 63959.4 14364.4 14431.6 14513.9 14538.0 14547.4 10076.5 10082.3 10083.5 10083.6 10096.8 19368.2 19431.8 19434.1 19549.1 19574.6 7359.4 7697.9 7706.7 7815.8 7944.2 853.9 883.6 920.6 924.2 1059.7 26973.5 27792.4 28309.9 28346.4 28359.0 953.1 953.2 987.2 995.0 1039.9 14114.0 14403.9 14546.3 14572.5 14673.9 287475.0 289162.0 291360.0 291725.0 292223.0 47175.3 47522.8 47622.3 47674.5 47681.0 1074.6 1245.7 1263.8 1267.8 1365.3 26495.5 27342.2 27965.6 28075.7 28321.3 37421.4 37681.4 38078.8 38081.6 38106.0 256687.0 260278.0 261420.0 262596.0 264916.0 27042.2 30777.0 31185.0 31286.2 31494.5 37136.8 38050.0 38418.4 38535.6 38824.0 34600.6 35336.6 35629.5 35747.3 36072.8 34858.5 34961.0 35407.8 35476.0 35633.6 34710.8 35118.8 35298.6 35534.0 35762.0 31057.2 31799.8 32094.5 32167.0 32448.7 24103.9 24760.1 24801.4 24839.8 25168.2 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | [#2] jquery.html Cycles:180 Average:24118.22 Median:25744.87 stddev:69019.58 (268.1%) stddev-sans-first:69190.13 17:27:47 INFO - PROCESS | 11800 | Values: 351.7 356.8 359.6 361.5 361.9 15218.0 15761.4 16111.5 16719.3 16892.9 11208.7 11214.5 11217.2 14108.7 16322.3 4657.2 4767.4 4791.7 4795.5 4797.2 3399.6 4213.1 5996.9 6001.8 6012.2 5770.4 5884.4 5892.9 5896.5 5936.3 3414.4 5022.4 5177.8 5212.3 5865.4 4923.2 5057.7 5099.1 5106.9 5107.9 11725.4 11927.8 11928.3 16983.7 19639.4 1864.1 1901.4 1907.4 2001.8 2478.9 8985.4 9464.4 9771.3 11110.9 13129.8 1751.8 1778.6 1805.6 1811.3 1859.5 56476.0 58312.7 59065.7 61173.0 62753.1 9274.7 9508.2 9594.4 9880.1 10052.2 12589.9 12591.9 12592.0 12625.1 12645.4 6585.3 6964.5 6973.9 7073.8 7085.1 6732.4 6754.6 6814.9 6835.7 6838.4 4040.8 4049.8 4051.2 4066.6 4124.5 1796.1 1825.7 1829.2 1840.5 1844.2 828.5 841.4 882.7 895.5 917.0 15576.7 15946.4 16156.5 16351.9 16485.3 868.1 884.0 895.6 899.5 919.0 8617.1 9117.9 9312.3 9369.3 9417.1 405966.0 418574.0 419233.0 427007.0 431248.0 69941.7 71707.3 71805.0 71928.3 76015.6 913.3 930.6 943.7 944.5 946.1 14454.0 14475.1 14615.5 14638.4 14667.3 32960.7 33428.3 34620.7 34944.0 35083.5 46832.5 47198.0 47640.5 47665.0 47713.3 7630.3 7682.9 7702.3 7708.1 7757.0 10611.2 11352.1 11559.2 11645.1 11728.5 9688.7 10217.9 10322.8 10329.1 10382.0 7199.4 10163.2 10228.3 10353.7 10419.5 8953.4 9376.7 9986.6 10025.8 10128.9 7413.8 7475.2 7495.1 7594.8 7612.9 9630.7 10003.8 10058.9 10063.6 10100.8 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | [#3] mootools.html Cycles:180 Average:5172.67 Median:5852.63 stddev:2705.82 (46.2%) stddev-sans-first:2696.99 17:27:47 INFO - PROCESS | 11800 | Values: 1207.3 1358.6 1359.2 1470.9 1713.3 7185.4 7337.0 7356.5 7365.0 7367.0 7204.8 7348.7 7352.6 7352.7 7355.2 1925.3 2175.2 2208.0 2227.5 2236.7 2208.2 2214.3 2215.9 2217.1 2218.6 2162.2 2218.5 2220.5 2222.1 2225.2 2173.1 2194.8 2202.9 2216.1 2219.2 2189.3 2205.7 2213.9 2216.1 2218.0 7499.3 7563.1 7564.5 7573.4 7578.1 4478.0 4532.8 4556.1 4573.6 4583.0 3032.5 3043.1 3069.2 3089.6 3175.0 962.7 971.7 989.1 995.4 1070.0 10257.7 10270.1 10272.8 10286.2 10289.2 4039.2 4181.1 4226.0 4233.9 4258.2 8680.8 8723.4 8759.6 8783.3 8788.4 3969.6 4582.5 4587.2 4595.5 4608.7 4006.3 4029.9 4034.7 4043.9 4065.9 3549.8 3595.9 3615.4 3644.5 3648.2 1107.8 1131.2 1131.4 1142.0 1146.0 1143.3 1152.7 1154.7 1163.0 1183.8 6635.9 6729.6 6730.4 6744.8 6771.0 470.0 476.2 479.8 480.5 481.1 5128.3 5156.6 5187.1 5187.5 5191.9 8643.8 8754.9 8871.3 9208.8 9228.8 8638.8 8683.8 8692.3 8709.2 8747.7 6969.3 7004.8 7063.0 7111.4 7164.3 6811.4 6824.7 6833.8 6855.0 6889.7 8096.2 8168.1 8235.4 8267.0 8388.2 8498.1 8541.9 8605.4 8630.4 8765.9 5572.7 5660.8 6164.8 6315.8 6398.4 6994.3 7073.3 7074.2 7078.5 7079.5 6249.1 6453.7 6464.4 6465.8 6554.4 6363.1 6424.1 6436.9 6472.1 6552.8 6782.3 6785.8 6819.2 6820.5 6825.2 5797.0 5824.5 5850.7 5854.5 5883.8 5965.6 5977.1 5992.5 6004.3 6031.4 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | [#4] prototype.html Cycles:180 Average:4669.30 Median:5351.65 stddev:1361.20 (25.4%) stddev-sans-first:1325.33 17:27:47 INFO - PROCESS | 11800 | Values: 321.9 322.5 325.7 327.9 331.9 5345.6 5357.7 5366.8 5376.4 5380.9 5225.9 5277.8 5338.6 5341.0 5342.0 4015.7 4062.4 4117.3 4148.4 4216.9 4131.2 4153.0 4197.6 4198.6 4220.7 4154.9 4155.5 4155.9 4158.0 4165.3 3937.8 4072.4 4139.6 4140.8 4151.0 3673.0 3677.0 3677.8 3678.0 3684.8 5147.8 5180.5 5187.0 5188.6 5191.2 4839.2 4839.5 4854.5 4856.8 4858.5 5641.1 5661.9 5662.6 5664.8 5665.1 4092.1 4100.3 4104.2 4106.0 4110.2 5704.9 5917.5 5955.8 5967.3 5969.1 4026.1 4078.1 4080.4 4081.5 4086.3 4108.9 4125.1 4135.6 4136.0 4136.2 4720.6 4733.8 4739.4 4746.0 4748.5 5642.7 5652.0 5662.1 5665.1 5666.3 1428.0 1454.7 1457.1 1457.1 1459.7 920.6 953.1 960.2 989.4 990.1 4817.3 4825.3 4827.9 4837.1 4839.0 5688.5 5740.1 5740.9 5743.0 5748.3 4894.2 4894.9 4901.0 4902.6 4907.9 3092.4 3128.0 3129.6 3129.7 3139.0 5422.3 5440.2 5446.7 5449.2 5449.3 5771.5 6026.5 6028.6 6038.5 6040.3 5401.9 5423.9 5425.4 5433.6 5434.0 5792.8 5822.7 5823.6 5824.0 5825.4 5695.1 5706.9 5707.3 5716.6 5719.8 5398.2 5416.3 5424.5 5428.7 5447.4 3910.7 3981.0 4018.3 4022.9 4023.8 5776.9 5788.0 5796.6 5801.7 5804.3 5574.2 5595.5 5596.2 5598.2 5599.2 5585.3 5586.1 5588.9 5593.9 5595.0 5493.3 5500.0 5505.4 5508.8 5512.8 5543.9 5762.4 5763.9 5769.4 5775.3 5572.7 5603.1 5609.8 5617.5 5617.7 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - PROCESS | 11800 | [#5] yui.html Cycles:180 Average:12740.85 Median:23921.46 stddev:15022.33 (62.8%) stddev-sans-first:15037.54 17:27:47 INFO - PROCESS | 11800 | Values: 762.7 762.8 776.9 777.8 780.2 11087.9 11283.8 11315.2 11320.7 11335.5 10909.3 10920.8 10933.1 10976.8 10990.2 644.7 781.8 787.9 809.5 810.6 797.1 802.8 804.9 807.7 808.3 840.5 843.8 846.0 849.9 850.0 668.9 680.6 849.3 850.7 869.9 621.4 622.1 622.3 622.4 622.5 10916.1 10968.8 10997.7 10997.7 10998.2 10875.5 11723.0 11844.6 11966.6 12033.3 9256.4 9344.8 9375.1 9546.5 9576.0 3228.4 3251.3 3259.8 3267.5 3294.7 43457.6 43637.6 44412.0 45172.3 45455.8 9336.3 9337.6 9419.0 9437.8 9529.8 17225.7 17307.1 17307.7 17308.2 17319.3 6747.1 6838.2 6891.1 6943.4 6969.2 3722.6 3784.1 3819.7 3825.8 3851.9 2799.2 2868.0 2868.5 2870.8 2874.3 465.3 509.0 520.6 523.3 529.0 511.4 516.5 520.5 528.8 533.4 7435.4 7479.7 7543.6 7658.2 7690.7 472.6 537.6 537.8 563.2 571.4 3342.7 3414.3 3459.2 3470.6 3691.2 53611.7 54714.5 54807.0 54829.2 54857.5 46580.5 46728.8 47370.3 47730.8 47940.8 42489.8 42680.9 43002.8 43028.8 43190.0 7582.1 7617.4 7861.4 7878.4 7987.4 32852.3 33076.7 33757.8 33956.0 34191.0 42410.8 42538.4 43543.8 43770.0 44050.3 10077.5 10161.4 10194.7 10320.1 10457.9 10677.5 10733.4 10768.4 10783.6 11100.3 8102.3 9251.8 10125.7 10697.4 11354.7 9776.8 10432.3 10454.2 10703.6 10888.8 10163.2 10519.5 10550.2 10650.2 10708.9 8683.1 8705.3 8778.0 8881.8 9016.5 8904.2 8918.9 9252.4 9363.9 9422.1 17:27:47 INFO - PROCESS | 11800 | -------- Summary: end -------- 17:27:47 INFO - PROCESS | 11800 | 17:27:47 INFO - TEST-INFO | 11800: exit 0 17:27:47 INFO - TEST-OK | dromaeo_css | took 1116872ms 17:27:47 INFO - TEST-START | kraken 17:27:47 INFO - operating with platform_type : linux_ 17:27:47 INFO - Initialising browser for kraken test... 17:27:47 INFO - TEST-INFO | started process 11982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrcRQH/profile http://localhost:55991/getInfo.html) 17:27:52 INFO - PROCESS | 11982 | __metrics Screen width/height:1600/1200 17:27:52 INFO - PROCESS | 11982 | colorDepth:24 17:27:52 INFO - PROCESS | 11982 | Browser inner width/height: 1024/697 17:27:52 INFO - PROCESS | 11982 | __metrics 17:27:52 ERROR - PROCESS | 11982 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:27:53 INFO - TEST-INFO | 11982: exit 0 17:27:53 INFO - Browser initialized. 17:27:53 INFO - Running cycle 1/1 for kraken test... 17:27:53 INFO - TEST-INFO | started process 12063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrcRQH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:05 INFO - PROCESS | 12063 | RSS: Main: 154152960 17:28:05 INFO - PROCESS | 12063 | 17:28:08 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55991/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:09 INFO - PROCESS | 12063 | RSS: Main: 194932736 17:28:09 INFO - PROCESS | 12063 | 17:28:11 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55991/tests/kraken/driver.html?testName=audio-dft) 17:28:12 INFO - PROCESS | 12063 | RSS: Main: 184676352 17:28:12 INFO - PROCESS | 12063 | 17:28:15 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55991/tests/kraken/driver.html?testName=audio-fft) 17:28:16 INFO - PROCESS | 12063 | RSS: Main: 171909120 17:28:16 INFO - PROCESS | 12063 | 17:28:18 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55991/tests/kraken/driver.html?testName=audio-oscillator) 17:28:18 INFO - PROCESS | 12063 | RSS: Main: 172072960 17:28:18 INFO - PROCESS | 12063 | 17:28:20 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55991/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:21 INFO - PROCESS | 12063 | RSS: Main: 174981120 17:28:21 INFO - PROCESS | 12063 | 17:28:24 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55991/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:25 INFO - PROCESS | 12063 | RSS: Main: 174604288 17:28:25 INFO - PROCESS | 12063 | 17:28:28 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55991/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:29 INFO - PROCESS | 12063 | RSS: Main: 173674496 17:28:29 INFO - PROCESS | 12063 | 17:28:32 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55991/tests/kraken/driver.html?testName=json-parse-financial) 17:28:32 INFO - PROCESS | 12063 | RSS: Main: 174215168 17:28:32 INFO - PROCESS | 12063 | 17:28:34 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55991/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:35 INFO - PROCESS | 12063 | RSS: Main: 186720256 17:28:35 INFO - PROCESS | 12063 | 17:28:36 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:37 INFO - PROCESS | 12063 | RSS: Main: 184524800 17:28:37 INFO - PROCESS | 12063 | 17:28:39 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:40 INFO - PROCESS | 12063 | RSS: Main: 193433600 17:28:40 INFO - PROCESS | 12063 | 17:28:42 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:43 INFO - PROCESS | 12063 | RSS: Main: 200085504 17:28:43 INFO - PROCESS | 12063 | 17:28:45 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:46 INFO - PROCESS | 12063 | RSS: Main: 199548928 17:28:46 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:55991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55991/tests/kraken/driver.html?testName=ai-astar) 17:28:48 INFO - PROCESS | 12063 | RSS: Main: 259190784 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | __start_tp_report 17:28:48 INFO - PROCESS | 12063 | _x_x_mozilla_page_load 17:28:48 INFO - PROCESS | 12063 | _x_x_mozilla_page_load_details 17:28:48 INFO - PROCESS | 12063 | |i|pagename|runs| 17:28:48 INFO - PROCESS | 12063 | |0;ai-astar;110;112;108;113;113;112;102;115;113;111 17:28:48 INFO - PROCESS | 12063 | |1;audio-beat-detection;157;134;156;174;138;162;160;145;175;130 17:28:48 INFO - PROCESS | 12063 | |2;audio-dft;162;160;163;161;160;158;161;160;161;164 17:28:48 INFO - PROCESS | 12063 | |3;audio-fft;76;74;104;95;73;73;72;113;98;73 17:28:48 INFO - PROCESS | 12063 | |4;audio-oscillator;93;93;145;92;93;93;145;93;94;138 17:28:48 INFO - PROCESS | 12063 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 17:28:48 INFO - PROCESS | 12063 | |6;imaging-darkroom;147;145;145;145;146;146;146;146;146;145 17:28:48 INFO - PROCESS | 12063 | |7;imaging-desaturate;95;95;98;96;95;95;95;96;95;96 17:28:48 INFO - PROCESS | 12063 | |8;json-parse-financial;67;65;65;66;65;66;66;77;63;64 17:28:48 INFO - PROCESS | 12063 | |9;json-stringify-tinderbox;64;64;64;64;64;63;63;64;64;65 17:28:48 INFO - PROCESS | 12063 | |10;stanford-crypto-aes;81;80;82;80;83;82;80;83;82;80 17:28:48 INFO - PROCESS | 12063 | |11;stanford-crypto-ccm;114;122;113;112;123;123;124;133;131;116 17:28:48 INFO - PROCESS | 12063 | |12;stanford-crypto-pbkdf2;140;129;141;139;141;129;141;139;139;147 17:28:48 INFO - PROCESS | 12063 | |13;stanford-crypto-sha256-iterative;66;66;68;66;68;67;69;67;66;66 17:28:48 INFO - PROCESS | 12063 | __end_tp_report 17:28:48 INFO - PROCESS | 12063 | __start_cc_report 17:28:48 INFO - PROCESS | 12063 | _x_x_mozilla_cycle_collect,1161 17:28:48 INFO - PROCESS | 12063 | __end_cc_report 17:28:48 INFO - PROCESS | 12063 | __startTimestamp1458174528416__endTimestamp 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | ------- Summary: start ------- 17:28:48 INFO - PROCESS | 12063 | Number of tests: 14 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.67 (3.3%) stddev-sans-first:3.87 17:28:48 INFO - PROCESS | 12063 | Values: 110.0 112.0 108.0 113.0 113.0 112.0 102.0 115.0 113.0 111.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:158.50 stddev:15.84 (10.0%) stddev-sans-first:16.74 17:28:48 INFO - PROCESS | 12063 | Values: 157.0 134.0 156.0 174.0 138.0 162.0 160.0 145.0 175.0 130.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.70 (1.1%) stddev-sans-first:1.76 17:28:48 INFO - PROCESS | 12063 | Values: 162.0 160.0 163.0 161.0 160.0 158.0 161.0 160.0 161.0 164.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#3] audio-fft Cycles:10 Average:85.10 Median:73.50 stddev:15.69 (21.4%) stddev-sans-first:16.30 17:28:48 INFO - PROCESS | 12063 | Values: 76.0 74.0 104.0 95.0 73.0 73.0 72.0 113.0 98.0 73.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:24.07 (25.9%) stddev-sans-first:24.92 17:28:48 INFO - PROCESS | 12063 | Values: 93.0 93.0 145.0 92.0 93.0 93.0 145.0 93.0 94.0 138.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:28:48 INFO - PROCESS | 12063 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 17:28:48 INFO - PROCESS | 12063 | Values: 147.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 17:28:48 INFO - PROCESS | 12063 | Values: 95.0 95.0 98.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.00 stddev:3.89 (5.9%) stddev-sans-first:4.12 17:28:48 INFO - PROCESS | 12063 | Values: 67.0 65.0 65.0 66.0 65.0 66.0 66.0 77.0 63.0 64.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:28:48 INFO - PROCESS | 12063 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 64.0 65.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 17:28:48 INFO - PROCESS | 12063 | Values: 81.0 80.0 82.0 80.0 83.0 82.0 80.0 83.0 82.0 80.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.00 stddev:7.31 (5.9%) stddev-sans-first:7.29 17:28:48 INFO - PROCESS | 12063 | Values: 114.0 122.0 113.0 112.0 123.0 123.0 124.0 133.0 131.0 116.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:140.50 stddev:5.52 (3.9%) stddev-sans-first:5.83 17:28:48 INFO - PROCESS | 12063 | Values: 140.0 129.0 141.0 139.0 141.0 129.0 141.0 139.0 139.0 147.0 17:28:48 INFO - PROCESS | 12063 | 17:28:48 INFO - PROCESS | 12063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 17:28:48 INFO - PROCESS | 12063 | Values: 66.0 66.0 68.0 66.0 68.0 67.0 69.0 67.0 66.0 66.0 17:28:48 INFO - PROCESS | 12063 | -------- Summary: end -------- 17:28:48 INFO - PROCESS | 12063 | 17:28:49 INFO - TEST-INFO | 12063: exit 0 17:28:49 INFO - TEST-OK | kraken | took 61726ms 17:28:49 INFO - SUITE-END | took 1178s 17:28:49 INFO - Completed test suite (00:19:38) 17:28:49 INFO - javascript benchmark 17:28:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.110522422376, 2697.5009623219707, 2705.3371923878653, 2714.145044311042, 2741.0, 4585.88535286618, 4670.089332580148, 4679.0, 4694.272387779895, 4721.291806229063, 4696.694714843533, 4699.976500117495, 4713.905721885569, 4718.5281471852795, 4719.362886010396, 4251.5535868733805, 4362.062156636339, 4364.738115713051, 4424.247877860756, 4495.842645507408, 4223.894402639928, 4372.2130016597, 4404.801783919731, 4467.5755803198645, 4472.060867217872, 4333.891652708676, 4337.84817531388, 4347.478302603692, 4377.233984052778, 4405.00887300358, 4331.328644060176, 4349.826006959718, 4357.193919124972, 4363.323684828857, 4396.0, 4229.957700423018, 4301.5698430157045, 4329.567043295677, 4398.428204333416, 4400.405945197422, 4630.791614377361, 4635.76821158944, 4642.512536183686, 4655.860324190246, 4712.693674911154, 5008.173651347523, 5009.749512524396, 5012.398512178562, 5069.69581825088, 5121.436641969418, 4934.481879402647, 5006.499350064964, 5105.821296254613, 5108.233764935252, 5148.330717006766, 4722.693024953436, 4735.692180008288, 4746.264329029006, 4756.167670657655, 4788.23388257884, 5032.169692000852, 5157.0, 5172.250023746536, 5177.792888284502, 5181.740912954413, 4910.042541704333, 4933.975330123327, 4959.652824302264, 4993.700377977333, 5001.574866136347, 5058.0, 5062.949370506248, 5079.593632509391, 5080.46655101209, 5118.59051275897, 4883.487233840467, 5013.623978201649, 5021.874453138627, 5022.949770502249, 5029.698218106925, 5016.54851063406, 5018.623603229772, 5042.142835717937, 5048.7728052237735, 5084.288199652052, 4341.044970106572, 4345.152695224464, 4347.260965635849, 4384.934225986613, 4385.451818522684, 3705.184859330943, 3751.437284407306, 3792.829322680486, 3808.6953043756434, 3817.61823817616, 4260.041490664637, 4267.4025636410925, 4273.55127711592, 4316.568343165658, 4317.892052698708, 4964.230544265644, 4981.950180498221, 4984.327115839388, 4996.675216110941, 5026.321446604735, 4185.162967406531, 4239.130978149472, 4259.169461954951, 4314.8489802857375, 4325.697201195886, 4575.839845605387, 4580.679352445363, 4593.081383723202, 4595.0809838031855, 4647.767611619405, 4750.762461876892, 4767.880802979953, 4772.217034549881, 4781.497942715965, 4816.349792778, 4916.532929371704, 5022.974885125551, 5069.340985671839, 5108.591312694901, 5121.769520371667, 4727.172744769583, 4728.38530990969, 4752.477227504903, 4759.286107083965, 4803.015381846643, 4773.76131193432, 4941.876453088702, 4947.233178857283, 4958.42978057528, 5011.323471331323, 5003.474635163401, 5025.195968644999, 5053.924191137063, 5078.136716758234, 5082.440931497458, 4877.219644856806, 4879.4876537963, 4887.853364399074, 4893.437254715611, 4932.556069953722, 4757.262624293102, 4875.634327425386, 4917.28699338601, 4918.655694101379, 4965.553100220997, 4819.855404337875, 4865.367502224688, 4883.3651625288485, 4889.095517329305, 4934.0, 4940.505949405031, 4971.527704868032, 4972.105021096238, 4976.129177394014, 5020.598352131748, 4739.810407583658, 4797.760111994457, 4845.466998630219, 4896.755162241945, 4918.213085906238], "unit": "score", "name": "dojo.html", "value": 4635.355483047985}, {"lowerIsBetter": false, "replicates": [531.1846315905084, 553.5682167909031, 554.2406902543516, 561.0854307478809, 574.1817909478992, 27039.864800675994, 33926.15184620386, 34609.48085778715, 34622.8268858656, 34679.30641387174, 37351.0, 37355.62644373556, 37640.24719505615, 37878.621213787854, 37973.0, 7661.0, 7851.214878512132, 7853.450258481908, 7858.921410785876, 7860.724874629389, 7659.578723170223, 7778.4166187535875, 7778.961105194466, 7781.3774898008305, 7942.602869856513, 7916.604169791516, 7943.801404964894, 7970.322522585587, 7980.720674776384, 8010.0, 7849.332806711408, 7913.366930645535, 7913.643886025143, 7923.0888447828665, 7923.683052677857, 7757.7672669819995, 7879.054513458364, 7885.723999659985, 7887.723929662434, 7895.407844411692, 36905.0, 37661.81169094164, 37678.0, 37692.0, 37840.62159378399, 3017.7736669749856, 3145.087924501892, 3209.1816586770456, 3273.5744353234163, 3766.7928263945473, 28545.857270713514, 28736.568951465746, 28952.0, 29453.852730736424, 29808.403831923457, 3386.187315044396, 3540.8937731868086, 3578.3916734155255, 3581.892872652148, 3637.5453068366455, 239249.0, 240443.0, 240720.0, 241066.0, 241428.0, 52961.47038529642, 53263.733681331345, 53576.73211633995, 53652.46347536553, 53692.73153634207, 57921.42078579245, 58469.70765146147, 58537.41462585405, 58611.12083318754, 63959.36040639534, 14364.425422983173, 14431.639209019859, 14513.854861451462, 14538.0, 14547.418103275962, 10076.546555405024, 10082.344647597884, 10083.495825208856, 10083.59665613382, 10096.848547271797, 19368.225270989285, 19431.765346985278, 19434.12546435414, 19549.142831430992, 19574.608507829762, 7359.448041396917, 7697.923020769721, 7706.730264440717, 7815.843683126305, 7944.205579442009, 853.9444936079135, 883.5891310540629, 920.6455514626917, 924.2144177449114, 1059.7350662334416, 26973.460530789274, 27792.444151116866, 28309.858450707616, 28346.43307133887, 28359.0, 953.0802775321848, 953.1516949914582, 987.2250283527396, 994.9751256218652, 1039.8752149741929, 14114.033518220256, 14403.92798036024, 14546.345414456375, 14572.489962851248, 14673.92663036678, 287475.0, 289162.0, 291360.0, 291725.0, 292223.0, 47175.292370614465, 47522.762386187846, 47622.28566571504, 47674.5232547677, 47681.0, 1074.5970261152067, 1245.7446223524155, 1263.829383033297, 1267.8098285257286, 1365.2559355151268, 26495.470090597693, 27342.179734607995, 27965.580516291866, 28075.71924280813, 28321.291967700974, 37421.4386784193, 37681.43477847889, 38078.80960595179, 38081.61918380781, 38106.0473488165, 256687.0, 260278.0, 261420.0, 262596.0, 264916.0, 27042.188734338, 30777.0, 31185.0, 31286.217844554067, 31494.52758208583, 37136.81431592825, 38050.038433882204, 38418.42372364361, 38535.6146438532, 38824.0, 34600.55921709526, 35336.64663353334, 35629.46555801717, 35747.28505429929, 36072.81963590165, 34858.47712284267, 34961.0, 35407.82296088503, 35476.0, 35633.64366356407, 34710.826445867606, 35118.82440587781, 35298.64701352954, 35534.0, 35762.0, 31057.22356941004, 31799.841000795772, 32094.51858222082, 32167.0, 32448.67551324551, 24103.879480602485, 24760.13339533108, 24801.379965501008, 24839.751602484466, 25168.24495265145], "unit": "score", "name": "ext.html", "value": 17216.068596976147}, {"lowerIsBetter": false, "replicates": [351.7309258417311, 356.8447725239521, 359.5990470625253, 361.4523996145838, 361.8733443294847, 15218.0, 15761.369545218191, 16111.516654500354, 16719.331226750914, 16892.915535422304, 11208.66374008779, 11214.495347709353, 11217.158713096509, 14108.717825643482, 16322.347106115742, 4657.2082745933185, 4767.404074490689, 4791.688540244873, 4795.544423279783, 4797.160496913044, 3399.5750531183603, 4213.136307057046, 5996.860596486654, 6001.849953751147, 6012.18835457212, 5770.365259821417, 5884.352721200665, 5892.852678683024, 5896.528277737771, 5936.287645482548, 3414.351273258073, 5022.4224214215465, 5177.844664660066, 5212.296339994109, 5865.35481097079, 4923.212286034217, 5057.69653820772, 5099.056674515226, 5106.872328191825, 5107.923381149286, 11725.4137293135, 11927.821082683766, 11928.343941083236, 16983.74524382135, 19639.410817675493, 1864.086597567196, 1901.4485799118238, 1907.3705677126516, 2001.7998200180011, 2478.925632231018, 8985.37102402832, 9464.384814987005, 9771.316007879452, 11110.888891111066, 13129.803052954214, 1751.816059313779, 1778.6175972165918, 1805.602767391172, 1811.25738447236, 1859.5072305838964, 56476.0, 58312.70843645797, 59065.7046714768, 61173.0, 62753.058704119474, 9274.721758347261, 9508.239340852853, 9594.42433453981, 9880.061394167542, 10052.246081543914, 12589.874101259053, 12591.874081259253, 12592.0, 12625.116241862981, 12645.367731613567, 6585.308542603054, 6964.547304425298, 6973.884178531411, 7073.762091633944, 7085.078939737904, 6732.360425759643, 6754.560953538103, 6814.863702725917, 6835.658217089126, 6838.350356716203, 4040.8181631826637, 4049.797510124482, 4051.230266249462, 4066.552679205285, 4124.505059392832, 1796.119901248379, 1825.6713791517388, 1829.1951541321775, 1840.503064172666, 1844.1701234444286, 828.5194587139445, 841.4446465332974, 882.7395918204145, 895.4537731983485, 916.9862452063225, 15576.688466230611, 15946.441874534336, 16156.515304540882, 16351.91824040896, 16485.258163382678, 868.084171199378, 884.0187391994881, 895.6417433026842, 899.4513346858411, 918.9954050229707, 8617.138286171332, 9117.908820911838, 9312.255019598417, 9369.297302702325, 9417.105374989365, 405966.0, 418574.0, 419233.0, 427007.0, 431248.0, 69941.65029174821, 71707.28292717111, 71805.0, 71928.2807171932, 76015.61992190115, 913.2648218184426, 930.6463543853292, 943.712167788831, 944.5088553952044, 946.1059298962415, 14454.0, 14475.131492110086, 14615.488457903923, 14638.414463421344, 14667.266636667911, 32960.67039329672, 33428.33143337071, 34620.65379346275, 34944.0409483296, 35083.47374789431, 46832.53167468418, 47198.0, 47640.52359476361, 47665.0, 47713.28430073482, 7630.2751238632245, 7682.923170768221, 7702.268284512962, 7708.113566939649, 7756.961215193888, 10611.2041596879, 11352.091832653203, 11559.190856639954, 11645.126615503701, 11728.530858765555, 9688.692026576604, 10217.897821021992, 10322.793544128925, 10329.070383665507, 10382.0, 7199.428362989434, 10163.23775716839, 10228.335158214692, 10353.74115647115, 10419.531121099417, 8953.418027828171, 9376.718698439057, 9986.550605222637, 10025.849612255675, 10128.949355253177, 7413.8146546336775, 7475.177730449537, 7495.063117110361, 7594.810129746579, 7612.885806713015, 9630.711078667651, 10003.799924001625, 10058.899411005796, 10063.597456101674, 10100.797984040131], "unit": "score", "name": "jquery.html", "value": 7873.115256872917}, {"lowerIsBetter": false, "replicates": [1207.3238986167742, 1358.6399604104913, 1359.2252416122808, 1470.9190994495298, 1713.340363959875, 7185.389241914437, 7337.046183996073, 7356.521826081301, 7365.042544469218, 7366.96316518418, 7204.819879503015, 7348.742794002211, 7352.595607241613, 7352.669129889155, 7355.227701091389, 1925.3261358524544, 2175.195177784222, 2208.02846747431, 2227.5433536125056, 2236.7427745809196, 2208.249195273607, 2214.3135627955303, 2215.8559693619864, 2217.1463986365206, 2218.6117429449864, 2162.243214874789, 2218.4564781628524, 2220.4781876259067, 2222.055626358799, 2225.1544413122992, 2173.1416090644184, 2194.8353873459555, 2202.944926376845, 2216.1135545781653, 2219.1567204462362, 2189.2665956904457, 2205.746339171, 2213.900374483152, 2216.0581752755015, 2218.0240694094546, 7499.325060744504, 7563.130240022413, 7564.546127232384, 7573.394128469709, 7578.052743407075, 4478.037221997253, 4532.773361331921, 4556.111558246143, 4573.63410927125, 4583.0, 3032.469317869364, 3043.1479185827784, 3069.2480342316276, 3089.582906307642, 3174.984125079383, 962.6823148361094, 971.7473456901186, 989.1196834817018, 995.4425521707794, 1069.9572017119306, 10257.743556411075, 10270.075693187575, 10272.845907311395, 10286.228532860065, 10289.22830787694, 4039.1719697462536, 4181.059261666162, 4225.9577404226175, 4233.872983810491, 4258.1696569169335, 8680.78298042554, 8723.389362744674, 8759.605817738217, 8783.253423459077, 8788.42875213109, 3969.64273215412, 4582.541745825458, 4587.243104887656, 4595.540445955445, 4608.723476591415, 4006.258842114218, 4029.879103626896, 4034.677225821927, 4043.8989025274013, 4065.918681626351, 3549.7692649978185, 3595.94606080909, 3615.421532554831, 3644.5444319460066, 3648.1609229877276, 1107.7618312062946, 1131.1742428027585, 1131.3777422417638, 1141.960031398897, 1146.0487795130023, 1143.3368646185193, 1152.7291086594644, 1154.6593754842343, 1162.9941850290695, 1183.8401815754935, 6635.86728265432, 6729.629870357079, 6730.394264516217, 6744.7976560703255, 6770.984352347187, 470.02000828273435, 476.1714616567148, 479.7984846364535, 480.5170803342688, 481.0547274605417, 5128.3333166688835, 5156.561692256125, 5187.118189907725, 5187.533122019036, 5191.896162076813, 8643.783905402415, 8754.912450875538, 8871.334649901155, 9208.769780755534, 9228.769280768034, 8638.82722345562, 8683.782905427415, 8692.348073894356, 8709.172628600272, 8747.693830715894, 6969.2682268362105, 7004.824879377954, 7063.011178435023, 7111.395531379891, 7164.283571642898, 6811.352921472452, 6824.727010919508, 6833.760818371333, 6855.0, 6889.689963951534, 8096.230858068474, 8168.1015088339045, 8235.423520353517, 8267.0, 8388.203120703523, 8498.107698691549, 8541.871871921801, 8605.35459840502, 8630.352723545633, 8765.868511972452, 5572.721363931706, 5660.773569057192, 6164.845878853064, 6315.810525684236, 6398.360163983564, 6994.33553812387, 7073.328033836778, 7074.186468556182, 7078.504504684623, 7079.504434689522, 6249.125122482947, 6453.741850326122, 6464.41820236181, 6465.77369792055, 6554.442872355712, 6363.077353783768, 6424.100625912282, 6436.903446448214, 6472.061551075162, 6552.770653027312, 6782.287859774653, 6785.830354240986, 6819.215790184192, 6820.454363650797, 6825.2151002633345, 5797.0, 5824.475797178105, 5850.736716847837, 5854.531637469077, 5883.823485295448, 5965.552583556164, 5977.133315669291, 5992.520598352208, 6004.279486461653, 6031.4270144336215], "unit": "score", "name": "mootools.html", "value": 4188.43554740504}, {"lowerIsBetter": false, "replicates": [321.872860220213, 322.4743667821451, 325.719880902424, 327.8803236818561, 331.9054069590166, 5345.599080069001, 5357.705326207057, 5366.838994830161, 5376.354837419511, 5380.892382152355, 5225.86935326617, 5277.788888444457, 5338.62629615927, 5341.023821186157, 5342.038433082043, 4015.6547556568585, 4062.431259623655, 4117.300058989964, 4148.43996060531, 4216.89457763556, 4131.2357213915375, 4153.0, 4197.643200327976, 4198.635443480881, 4220.683448741342, 4154.875353739378, 4155.480564929384, 4155.916881662365, 4158.022864626825, 4165.250254954107, 3937.803109844511, 4072.36878283865, 4139.648129908961, 4140.834366625331, 4150.958490415087, 3672.9632703672887, 3676.9888280723017, 3677.8161091945294, 3678.0437086357474, 3684.797336146511, 5147.845564633067, 5180.456052114511, 5187.014467251211, 5188.610854185951, 5191.247269145991, 4839.153148199051, 4839.467658557556, 4854.538818812207, 4856.805727770885, 4858.489858564835, 5641.125625528009, 5661.886762264731, 5662.631928924607, 5664.830055098354, 5665.12190610456, 4092.1201941582403, 4100.323446631302, 4104.15864747726, 4106.0, 4110.23960567296, 5704.914426283568, 5917.467427931464, 5955.761769529214, 5967.313758917693, 5969.134475501071, 4026.0941288210506, 4078.0824314529586, 4080.367543030835, 4081.5306239782212, 4086.2644723949975, 4108.856190033334, 4125.133721918371, 4135.60711732385, 4136.048708796993, 4136.172765446922, 4720.645951553647, 4733.786979585927, 4739.4075740532435, 4745.95254047462, 4748.525147485224, 5642.689652069093, 5652.0391533439415, 5662.065759149777, 5665.093585026376, 5666.320041594952, 1428.0, 1454.7308747881464, 1457.118443341784, 1457.118443341784, 1459.737247295497, 920.5949382271779, 953.1040821627648, 960.2318145483586, 989.366805244644, 990.1039559198937, 4817.325574419584, 4825.276208568673, 4827.903441931142, 4837.105135549935, 4839.032193561302, 5688.488036076773, 5740.052891272977, 5740.942590574125, 5742.971285143548, 5748.338941021836, 4894.1679914414635, 4894.926576101361, 4901.044296362246, 4902.583280421204, 4907.901841963141, 3092.3969825884187, 3127.9843600782306, 3129.6087989001376, 3129.749620030392, 3139.0269016604925, 5422.267993820863, 5440.156775699773, 5446.700431476228, 5449.1826226066405, 5449.3188351456065, 5771.451712087345, 6026.5178785697035, 6028.638281703112, 6038.486728628028, 6040.275166979991, 5401.864953376118, 5423.945760542502, 5425.403205647375, 5433.6196466247775, 5434.0490414176575, 5792.797252096325, 5822.73797679097, 5823.621464604787, 5824.0, 5825.3883342248455, 5695.0603150481365, 5706.914396284142, 5707.258056452634, 5716.628419152742, 5719.828405147852, 5398.217258497574, 5416.295881535375, 5424.511793938565, 5428.70142142186, 5447.428020057995, 3910.7458015228917, 3981.0, 4018.2566225248424, 4022.8994275143355, 4023.818928148182, 5776.9133462998925, 5787.971060144672, 5796.594238403271, 5801.709914504174, 5804.332501762183, 5574.16387541872, 5595.524380427709, 5596.1605759136455, 5598.244237027949, 5599.188117722826, 5585.3297604287745, 5586.050371436784, 5588.86027849307, 5593.860153496195, 5594.9720251398485, 5493.313335833021, 5500.0, 5505.394406615189, 5508.834734957958, 5512.751926163252, 5543.916841247304, 5762.394948530512, 5763.913541296968, 5769.394213607511, 5775.33583637887, 5572.693501857437, 5603.075492543848, 5609.831705048855, 5617.522510586482, 5617.719114044363], "unit": "score", "name": "prototype.html", "value": 4236.20710836143}, {"lowerIsBetter": false, "replicates": [762.6834863531639, 762.8245503534187, 776.8679324514831, 777.8444311137774, 780.1574299756263, 11087.889121108787, 11283.830742538868, 11315.207935444512, 11320.660380188598, 11335.546578136864, 10909.290896091748, 10920.836187457195, 10933.070688991425, 10976.835347469794, 10990.17573681973, 644.7485480662546, 781.8201813582865, 787.8542469643106, 809.4900212865887, 810.6190090657382, 797.1191833024511, 802.7752229375784, 804.9315808156314, 807.6850028488865, 808.2685169921201, 840.5461051032435, 843.7890527368158, 845.9873101903477, 849.902261239956, 849.961751721174, 668.8762578922915, 680.581442412915, 849.3120572336366, 850.7320194138857, 869.8869147010848, 621.3972446726668, 622.0762168180248, 622.327885883245, 622.4242575617536, 622.4802290087737, 10916.126709863192, 10968.835467467994, 10997.670069897917, 10997.725056873642, 10998.230123891331, 10875.510602022929, 11723.0, 11844.644660660195, 11966.64100076999, 12033.338166400845, 9256.39833410833, 9344.766380840465, 9375.10936461035, 9546.474943878084, 9576.0, 3228.4027454920915, 3251.3172233830924, 3259.820709860957, 3267.493538501536, 3294.7199488043543, 43457.56542434599, 43637.56362436367, 44412.0, 45172.3224151638, 45455.772721136185, 9336.253099752004, 9337.626494940263, 9418.952905235567, 9437.811243775086, 9529.761755956157, 17225.65548689019, 17307.134643267786, 17307.653846922993, 17308.221130049176, 17319.307227711004, 6747.122874026345, 6838.247792742794, 6891.104156459728, 6943.375096241362, 6969.1985421676145, 3722.553293604785, 3784.129650180419, 3819.694424446038, 3825.827837747308, 3851.8651847185215, 2799.202227365191, 2868.0248715436433, 2868.498012847743, 2870.7990440668955, 2874.2957975296185, 465.25326850405287, 508.9923651145236, 520.6433592988815, 523.3432042786355, 529.0239508107535, 511.4425276448689, 516.4654582507087, 520.456123351099, 528.801699362739, 533.3839415475132, 7435.40516758658, 7479.663415146331, 7543.585102819397, 7658.157602663702, 7690.653920573588, 472.62190247802306, 537.5914305128131, 537.7983256278895, 563.2452513631753, 571.4000299685314, 3342.7325813934826, 3414.3000684859544, 3459.2043829919257, 3470.5661792275964, 3691.206390626028, 53611.73194134004, 54714.45285547173, 54807.0, 54829.1775623366, 54857.45142548603, 46580.53419465762, 46728.76635616868, 47370.289445658345, 47730.761346193045, 47940.7602961983, 42489.78755106266, 42680.93297667521, 43002.78498607487, 43028.78485607615, 43189.999999999374, 7582.128055273714, 7617.428692847948, 7861.449698521049, 7878.409119315959, 7987.361011119213, 32852.342953141284, 33076.66923330832, 33757.83121084477, 33956.0, 34191.0, 42410.787946060074, 42538.361924570534, 43543.782281088395, 43770.0, 44050.33924491071, 10077.496125193858, 10161.390316581028, 10194.694159175237, 10320.12278956297, 10457.895421045996, 10677.519511622151, 10733.355998640107, 10768.3538987661, 10783.6225732099, 11100.333979961228, 8102.270795628422, 9251.76870578214, 10125.696229113139, 10697.411642359744, 11354.716132096764, 9776.804463910825, 10432.321899076536, 10454.163666906477, 10703.571857125939, 10888.836667449836, 10163.23775716839, 10519.474026298807, 10550.155987521133, 10650.201234907257, 10708.89291107079, 8683.08827573121, 8705.26005289532, 8778.0, 8881.822363552821, 9016.459012459274, 8904.19862212404, 8918.86621700688, 9252.352335336462, 9363.85954210701, 9422.104900034486], "unit": "score", "name": "yui.html", "value": 5760.608208104025}], "name": "dromaeo_css", "value": 6328.257605284172}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 108.0, 113.0, 113.0, 112.0, 102.0, 115.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 156.0, 174.0, 138.0, 162.0, 160.0, 145.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 153.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 163.0, 161.0, 160.0, 158.0, 161.0, 160.0, 161.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 104.0, 95.0, 73.0, 73.0, 72.0, 113.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 145.0, 92.0, 93.0, 93.0, 145.0, 93.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 98.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 77.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 82.0, 80.0, 83.0, 82.0, 80.0, 83.0, 82.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [114.0, 122.0, 113.0, 112.0, 123.0, 123.0, 124.0, 133.0, 131.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 141.0, 139.0, 141.0, 129.0, 141.0, 139.0, 139.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 66.0, 68.0, 67.0, 69.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1514.2}]} 17:28:49 INFO - Return code: 0 17:28:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:28:49 ERROR - # TBPL SUCCESS # 17:28:49 INFO - Running post-action listener: _resource_record_post_action 17:28:49 INFO - Running post-run listener: _resource_record_post_run 17:28:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 521355264; Read time: 0; Write time: 747892 17:28:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 236351488; Read time: 0; Write time: 498440 17:28:50 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 285003776; Read time: 0; Write time: 249452 17:28:50 INFO - Running post-run listener: _upload_blobber_files 17:28:50 INFO - Blob upload gear active. 17:28:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:28:51 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:28:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:52 INFO - (blobuploader) - INFO - Done attempting. 17:28:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:28:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:28:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:53 INFO - (blobuploader) - INFO - Done attempting. 17:28:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:53 INFO - Return code: 0 17:28:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/127aaf386ea624149fb3bea073d43aba5bb3c7ff9a3b13be51be46823c7b22aa479f28f08f67a78ad9aa283290e41d593c0a5be6e93af3ea2145a298eef14fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d6f5f1d8ab4fce060f9a67cf7e4ec4ef4a92ad73c1a6c78e6996ae85aa9b4bbc40e44aea35bb7b0301bc7b2f44716f045e33cdf8e423d971b94e065b2311f82"} 17:28:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:53 INFO - Contents: 17:28:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/127aaf386ea624149fb3bea073d43aba5bb3c7ff9a3b13be51be46823c7b22aa479f28f08f67a78ad9aa283290e41d593c0a5be6e93af3ea2145a298eef14fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d6f5f1d8ab4fce060f9a67cf7e4ec4ef4a92ad73c1a6c78e6996ae85aa9b4bbc40e44aea35bb7b0301bc7b2f44716f045e33cdf8e423d971b94e065b2311f82"} 17:28:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:53 INFO - Copying logs to upload dir... 17:28:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.557079 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-16 17:28:52.783856) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:28:52.787364) ========= 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 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/127aaf386ea624149fb3bea073d43aba5bb3c7ff9a3b13be51be46823c7b22aa479f28f08f67a78ad9aa283290e41d593c0a5be6e93af3ea2145a298eef14fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d6f5f1d8ab4fce060f9a67cf7e4ec4ef4a92ad73c1a6c78e6996ae85aa9b4bbc40e44aea35bb7b0301bc7b2f44716f045e33cdf8e423d971b94e065b2311f82"} build_url:https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/WRJoPkjVQK2U3HFXMret3Q/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/127aaf386ea624149fb3bea073d43aba5bb3c7ff9a3b13be51be46823c7b22aa479f28f08f67a78ad9aa283290e41d593c0a5be6e93af3ea2145a298eef14fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d6f5f1d8ab4fce060f9a67cf7e4ec4ef4a92ad73c1a6c78e6996ae85aa9b4bbc40e44aea35bb7b0301bc7b2f44716f045e33cdf8e423d971b94e065b2311f82"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:28:52.812001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:28:52.812315) ========= 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=db0483c52d987ecb441a263b000001ad-1458173296.922940-612411805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:28:52.897718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:28:52.898065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:28:52.898377) ========= ========= Total master_lag: 0.28 =========