builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1457695817.08 results: success (0) buildid: 20160311024912 builduid: c2c0d08c11c0419b8109ef455df5dc71 revision: b015db3afa462d65b3bd58ab6cc080401f85bafa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.085212) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.085572) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.085864) ========= 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006461 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.114446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.117757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.135080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.135428) ========= 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.184239) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.184529) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.187916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.188202) ========= 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 03:30:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 360K=0.03s 2016-03-11 03:30:18 (360 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178140 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.399937) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.400214) ========= 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018146 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.454140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:17.454453) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b015db3afa462d65b3bd58ab6cc080401f85bafa --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 b015db3afa462d65b3bd58ab6cc080401f85bafa --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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 03:30:18,613 truncating revision to first 12 chars 2016-03-11 03:30:18,613 Setting DEBUG logging. 2016-03-11 03:30:18,613 attempt 1/10 2016-03-11 03:30:18,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b015db3afa46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 03:30:18,877 unpacking tar archive at: fx-team-b015db3afa46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:18.020710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:18.021514) ========= echo b015db3afa462d65b3bd58ab6cc080401f85bafa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b015db3afa462d65b3bd58ab6cc080401f85bafa'] 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b015db3afa462d65b3bd58ab6cc080401f85bafa program finished with exit code 0 elapsedTime=0.004687 script_repo_revision: 'b015db3afa462d65b3bd58ab6cc080401f85bafa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:18.074208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:18.074520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 03:30:18.085054) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-11 03:30:18.085321) ========= /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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:19 INFO - MultiFileLogger online at 20160311 03:30:19 in /builds/slave/test 03:30:19 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 03:30:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:19 INFO - {'append_to_log': False, 03:30:19 INFO - 'base_work_dir': '/builds/slave/test', 03:30:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:30:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:19 INFO - 'branch': 'Fx-Team-Non-PGO', 03:30:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:19 INFO - 'config_files': ('talos/linux_config.py',), 03:30:19 INFO - 'default_actions': ('clobber', 03:30:19 INFO - 'read-buildbot-config', 03:30:19 INFO - 'download-and-extract', 03:30:19 INFO - 'populate-webroot', 03:30:19 INFO - 'create-virtualenv', 03:30:19 INFO - 'install', 03:30:19 INFO - 'run-tests'), 03:30:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:19 INFO - 'download_minidump_stackwalk': True, 03:30:19 INFO - 'download_symbols': 'ondemand', 03:30:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:19 INFO - 'installer_path': 'installer.exe', 03:30:19 INFO - 'log_level': 'info', 03:30:19 INFO - 'log_name': 'talos', 03:30:19 INFO - 'log_to_console': True, 03:30:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:19 INFO - 'opt_config_files': (), 03:30:19 INFO - 'pip_index': False, 03:30:19 INFO - 'sps_profile': False, 03:30:19 INFO - 'sps_profile_interval': 0, 03:30:19 INFO - 'suite': 'dromaeojs', 03:30:19 INFO - 'system_bits': '32', 03:30:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:19 INFO - 'title': 'talos-linux64-ix-048', 03:30:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:19 INFO - 'use_talos_json': True, 03:30:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:19 INFO - 'work_dir': 'build'} 03:30:19 INFO - ##### 03:30:19 INFO - ##### Running clobber step. 03:30:19 INFO - ##### 03:30:19 INFO - Running pre-action listener: _resource_record_pre_action 03:30:19 INFO - Running main action method: clobber 03:30:19 INFO - rmtree: /builds/slave/test/build 03:30:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:19 INFO - Running post-action listener: _resource_record_post_action 03:30:19 INFO - ##### 03:30:19 INFO - ##### Running read-buildbot-config step. 03:30:19 INFO - ##### 03:30:19 INFO - Running pre-action listener: _resource_record_pre_action 03:30:19 INFO - Running main action method: read_buildbot_config 03:30:19 INFO - Using buildbot properties: 03:30:19 INFO - { 03:30:19 INFO - "project": "", 03:30:19 INFO - "product": "firefox", 03:30:19 INFO - "script_repo_revision": "production", 03:30:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:30:19 INFO - "repository": "", 03:30:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:30:19 INFO - "buildid": "20160311024912", 03:30:19 INFO - "pgo_build": "False", 03:30:19 INFO - "basedir": "/builds/slave/test", 03:30:19 INFO - "buildnumber": 2626, 03:30:19 INFO - "slavename": "talos-linux64-ix-048", 03:30:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:30:19 INFO - "platform": "ubuntu64_hw", 03:30:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:30:19 INFO - "branch": "fx-team", 03:30:19 INFO - "repo_path": "integration/fx-team", 03:30:19 INFO - "revision": "b015db3afa462d65b3bd58ab6cc080401f85bafa", 03:30:19 INFO - "stage_platform": "linux64", 03:30:19 INFO - "builduid": "c2c0d08c11c0419b8109ef455df5dc71", 03:30:19 INFO - "slavebuilddir": "test" 03:30:19 INFO - } 03:30:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:30:19 INFO - Running post-action listener: _resource_record_post_action 03:30:19 INFO - ##### 03:30:19 INFO - ##### Running download-and-extract step. 03:30:19 INFO - ##### 03:30:19 INFO - Running pre-action listener: _resource_record_pre_action 03:30:19 INFO - Running main action method: download_and_extract 03:30:19 INFO - mkdir: /builds/slave/test/build/tests 03:30: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')]} 03:30:19 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:30:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:30:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:20 INFO - Downloaded 1361 bytes. 03:30:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:30:20 INFO - Using the following test package requirements: 03:30:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:30:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'jsshell-linux-x86_64.zip'], 03:30:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:30:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:30:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:20 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:21 INFO - Downloaded 22093190 bytes. 03:30:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:22 INFO - Return code: 0 03:30: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 03:30: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')]} 03:30:22 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:23 INFO - Downloaded 22093190 bytes. 03:30: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'] 03:30: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 03:30:25 INFO - Return code: 0 03:30:25 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')]} 03:30:25 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:26 INFO - Downloaded 10845161 bytes. 03:30: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'] 03:30: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 03:30:26 INFO - Return code: 0 03:30: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')]} 03:30:26 INFO - https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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 03:30:27 INFO - Downloaded 54456406 bytes. 03:30:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:27 INFO - mkdir: /builds/slave/test/properties 03:30:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:27 INFO - Contents: 03:30:27 INFO - build_url:https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:30:28 INFO - Running post-action listener: _resource_record_post_action 03:30:28 INFO - Running post-action listener: set_extra_try_arguments 03:30:28 INFO - ##### 03:30:28 INFO - ##### Running populate-webroot step. 03:30:28 INFO - ##### 03:30:28 INFO - Running pre-action listener: _resource_record_pre_action 03:30:28 INFO - Running main action method: populate_webroot 03:30:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:28 INFO - '--tppagecycles', 03:30:28 INFO - '7'], 03:30:28 INFO - 'tests': ['tsvgm']}}, 03:30:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:30:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:30:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'tests': ['damp', 'tps']}, 03:30:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['damp', 'tps']}, 03:30:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:30:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:28 INFO - 'other': {'tests': ['a11yr', 03:30:28 INFO - 'ts_paint', 03:30:28 INFO - 'tpaint', 03:30:28 INFO - 'sessionrestore', 03:30:28 INFO - 'sessionrestore_no_auto_restore', 03:30:28 INFO - 'tabpaint']}, 03:30:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['a11yr', 03:30:28 INFO - 'ts_paint', 03:30:28 INFO - 'tpaint', 03:30:28 INFO - 'sessionrestore', 03:30:28 INFO - 'sessionrestore_no_auto_restore', 03:30:28 INFO - 'tabpaint']}, 03:30:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['a11yr', 03:30:28 INFO - 'ts_paint', 03:30:28 INFO - 'tpaint', 03:30:28 INFO - 'sessionrestore', 03:30:28 INFO - 'sessionrestore_no_auto_restore', 03:30:28 INFO - 'tabpaint']}, 03:30:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['a11yr', 03:30:28 INFO - 'ts_paint', 03:30:28 INFO - 'tpaint', 03:30:28 INFO - 'sessionrestore', 03:30:28 INFO - 'sessionrestore_no_auto_restore', 03:30:28 INFO - 'tabpaint']}, 03:30:28 INFO - 'other_l64': {'tests': ['a11yr', 03:30:28 INFO - 'ts_paint', 03:30:28 INFO - 'tpaint', 03:30:28 INFO - 'sessionrestore', 03:30:28 INFO - 'sessionrestore_no_auto_restore', 03:30:28 INFO - 'tabpaint']}, 03:30:28 INFO - 'other_nol64': {'tests': ['a11yr', 03:30:28 INFO - 'ts_paint', 03:30:28 INFO - 'tpaint', 03:30:28 INFO - 'sessionrestore', 03:30:28 INFO - 'sessionrestore_no_auto_restore', 03:30:28 INFO - 'tabpaint']}, 03:30:28 INFO - 'svgr': {'tests': ['tsvgx', 03:30:28 INFO - 'tsvgr_opacity', 03:30:28 INFO - 'tart', 03:30:28 INFO - 'tscrollx', 03:30:28 INFO - 'cart']}, 03:30:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['tsvgx', 03:30:28 INFO - 'tsvgr_opacity', 03:30:28 INFO - 'tart', 03:30:28 INFO - 'tscrollx', 03:30:28 INFO - 'cart']}, 03:30:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'tests': ['tp5o']}, 03:30:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'talos_options': ['--e10s'], 03:30:28 INFO - 'tests': ['tp5o']}, 03:30:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'talos_options': ['--xperf_path', 03:30:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:28 INFO - 'tests': ['tp5n']}, 03:30:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:28 INFO - 'talos_options': ['--e10s', 03:30:28 INFO - '--xperf_path', 03:30:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:28 INFO - 'tests': ['tp5n']}}, 03:30:28 INFO - 'talos.zip': {'path': '', 03:30:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:28 INFO - Running post-action listener: _resource_record_post_action 03:30:28 INFO - ##### 03:30:28 INFO - ##### Running create-virtualenv step. 03:30:28 INFO - ##### 03:30:28 INFO - Running pre-action listener: _resource_record_pre_action 03:30:28 INFO - Running main action method: create_virtualenv 03:30:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30: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 03:30:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:28 INFO - Using real prefix '/usr' 03:30:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:31 INFO - Installing pip.................done. 03:30:31 INFO - Return code: 0 03:30:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30: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 03:30: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 03:30:31 INFO - Using env: {'DISPLAY': ':0', 03:30:31 INFO - 'HOME': '/home/cltbld', 03:30:31 INFO - 'LANG': 'en_US.UTF-8', 03:30:31 INFO - 'LANGUAGE': 'en_US:en', 03:30:31 INFO - 'LOGNAME': 'cltbld', 03:30:31 INFO - 'MAIL': '/var/mail/cltbld', 03:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:31 INFO - 'MOZ_NO_REMOTE': '1', 03:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:31 INFO - 'NO_EM_RESTART': '1', 03:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:31 INFO - 'PWD': '/builds/slave/test', 03:30:31 INFO - 'SHELL': '/bin/bash', 03:30:31 INFO - 'SHLVL': '1', 03:30:31 INFO - 'TERM': 'linux', 03:30:31 INFO - 'TMOUT': '86400', 03:30:31 INFO - 'USER': 'cltbld', 03:30:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:31 INFO - '_': '/tools/buildbot/bin/python'} 03:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30: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 03:30:31 INFO - Cleaning up... 03:30:31 INFO - Return code: 0 03:30:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30: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 03:30: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 03:30:31 INFO - Using env: {'DISPLAY': ':0', 03:30:31 INFO - 'HOME': '/home/cltbld', 03:30:31 INFO - 'LANG': 'en_US.UTF-8', 03:30:31 INFO - 'LANGUAGE': 'en_US:en', 03:30:31 INFO - 'LOGNAME': 'cltbld', 03:30:31 INFO - 'MAIL': '/var/mail/cltbld', 03:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:31 INFO - 'MOZ_NO_REMOTE': '1', 03:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:31 INFO - 'NO_EM_RESTART': '1', 03:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:31 INFO - 'PWD': '/builds/slave/test', 03:30:31 INFO - 'SHELL': '/bin/bash', 03:30:31 INFO - 'SHLVL': '1', 03:30:31 INFO - 'TERM': 'linux', 03:30:31 INFO - 'TMOUT': '86400', 03:30:31 INFO - 'USER': 'cltbld', 03:30:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:31 INFO - '_': '/tools/buildbot/bin/python'} 03:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:31 INFO - Downloading/unpacking psutil>=0.7.1 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:33 INFO - Installing collected packages: psutil 03:30:33 INFO - Running setup.py install for psutil 03:30:33 INFO - building 'psutil._psutil_linux' extension 03:30: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 03:30:33 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 03:30:34 INFO - building 'psutil._psutil_posix' extension 03:30: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 03:30: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 03:30:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:34 INFO - Successfully installed psutil 03:30:34 INFO - Cleaning up... 03:30:34 INFO - Return code: 0 03:30:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30: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 03:30: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 03:30:34 INFO - Using env: {'DISPLAY': ':0', 03:30:34 INFO - 'HOME': '/home/cltbld', 03:30:34 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30: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) 03:30:36 INFO - Installing collected packages: mozsystemmonitor 03:30:36 INFO - Running setup.py install for mozsystemmonitor 03:30:36 INFO - Successfully installed mozsystemmonitor 03:30:36 INFO - Cleaning up... 03:30:36 INFO - Return code: 0 03:30:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30: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 03:30: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 03:30:36 INFO - Using env: {'DISPLAY': ':0', 03:30:36 INFO - 'HOME': '/home/cltbld', 03:30:36 INFO - 'LANG': 'en_US.UTF-8', 03:30:36 INFO - 'LANGUAGE': 'en_US:en', 03:30:36 INFO - 'LOGNAME': 'cltbld', 03:30:36 INFO - 'MAIL': '/var/mail/cltbld', 03:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:36 INFO - 'MOZ_NO_REMOTE': '1', 03:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:36 INFO - 'NO_EM_RESTART': '1', 03:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:36 INFO - 'PWD': '/builds/slave/test', 03:30:36 INFO - 'SHELL': '/bin/bash', 03:30:36 INFO - 'SHLVL': '1', 03:30:36 INFO - 'TERM': 'linux', 03:30:36 INFO - 'TMOUT': '86400', 03:30:36 INFO - 'USER': 'cltbld', 03:30:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:36 INFO - '_': '/tools/buildbot/bin/python'} 03:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:39 INFO - Downloading docopt-0.6.1.tar.gz 03:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:39 INFO - Running setup.py install for blobuploader 03:30:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:39 INFO - Running setup.py install for requests 03:30:39 INFO - Running setup.py install for docopt 03:30:39 INFO - Successfully installed blobuploader requests docopt 03:30:39 INFO - Cleaning up... 03:30:39 INFO - Return code: 0 03:30:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:39 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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30:39 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 03:30:39 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 03:30:39 INFO - Using env: {'DISPLAY': ':0', 03:30:39 INFO - 'HOME': '/home/cltbld', 03:30:39 INFO - 'LANG': 'en_US.UTF-8', 03:30:39 INFO - 'LANGUAGE': 'en_US:en', 03:30:39 INFO - 'LOGNAME': 'cltbld', 03:30:39 INFO - 'MAIL': '/var/mail/cltbld', 03:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:39 INFO - 'MOZ_NO_REMOTE': '1', 03:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:39 INFO - 'NO_EM_RESTART': '1', 03:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:39 INFO - 'PWD': '/builds/slave/test', 03:30:39 INFO - 'SHELL': '/bin/bash', 03:30:39 INFO - 'SHLVL': '1', 03:30:39 INFO - 'TERM': 'linux', 03:30:39 INFO - 'TMOUT': '86400', 03:30:39 INFO - 'USER': 'cltbld', 03:30:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:39 INFO - '_': '/tools/buildbot/bin/python'} 03:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:40 INFO - Running setup.py (path:/tmp/pip-ooB6_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:40 INFO - Running setup.py (path:/tmp/pip-dYbmxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:40 INFO - Running setup.py (path:/tmp/pip-VTzvAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:40 INFO - Running setup.py (path:/tmp/pip-36T2pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:40 INFO - Running setup.py (path:/tmp/pip-L09EQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:40 INFO - Running setup.py (path:/tmp/pip-SoHmnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:40 INFO - Running setup.py (path:/tmp/pip-GjswZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:40 INFO - Running setup.py (path:/tmp/pip-SfPyvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:40 INFO - Running setup.py (path:/tmp/pip-5nCXL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:40 INFO - Running setup.py (path:/tmp/pip-YsVr_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:40 INFO - Running setup.py (path:/tmp/pip-l4400F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:40 INFO - Running setup.py (path:/tmp/pip-ly1CMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:41 INFO - Running setup.py (path:/tmp/pip-VD699Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:41 INFO - Running setup.py (path:/tmp/pip-_TE3ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:41 INFO - Running setup.py (path:/tmp/pip-DrgyQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:41 INFO - Running setup.py (path:/tmp/pip-rSUT7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:41 INFO - Running setup.py (path:/tmp/pip-5cJcxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:41 INFO - Running setup.py install for manifestparser 03:30:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:41 INFO - Running setup.py install for mozcrash 03:30:41 INFO - Running setup.py install for mozdebug 03:30:41 INFO - Running setup.py install for mozdevice 03:30:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:41 INFO - Running setup.py install for mozfile 03:30:41 INFO - Running setup.py install for mozhttpd 03:30:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozinfo 03:30:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozInstall 03:30:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozleak 03:30:42 INFO - Running setup.py install for mozlog 03:30:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for moznetwork 03:30:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozprocess 03:30:42 INFO - Running setup.py install for mozprofile 03:30:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozrunner 03:30:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozscreenshot 03:30:42 INFO - Running setup.py install for moztest 03:30:43 INFO - Running setup.py install for mozversion 03:30:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:43 INFO - Cleaning up... 03:30:43 INFO - Return code: 0 03:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30: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 03:30: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 03:30:43 INFO - Using env: {'DISPLAY': ':0', 03:30:43 INFO - 'HOME': '/home/cltbld', 03:30:43 INFO - 'LANG': 'en_US.UTF-8', 03:30:43 INFO - 'LANGUAGE': 'en_US:en', 03:30:43 INFO - 'LOGNAME': 'cltbld', 03:30:43 INFO - 'MAIL': '/var/mail/cltbld', 03:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:43 INFO - 'MOZ_NO_REMOTE': '1', 03:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:43 INFO - 'NO_EM_RESTART': '1', 03:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:43 INFO - 'PWD': '/builds/slave/test', 03:30:43 INFO - 'SHELL': '/bin/bash', 03:30:43 INFO - 'SHLVL': '1', 03:30:43 INFO - 'TERM': 'linux', 03:30:43 INFO - 'TMOUT': '86400', 03:30:43 INFO - 'USER': 'cltbld', 03:30:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:43 INFO - '_': '/tools/buildbot/bin/python'} 03:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:43 INFO - Running setup.py (path:/tmp/pip-XdXGLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30: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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:43 INFO - Running setup.py (path:/tmp/pip-Nhobac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30: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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:43 INFO - Running setup.py (path:/tmp/pip-2std27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:43 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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:43 INFO - Running setup.py (path:/tmp/pip-kIRcYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:43 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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:43 INFO - Running setup.py (path:/tmp/pip-hiaJyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:43 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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:43 INFO - Running setup.py (path:/tmp/pip-z_t6rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:43 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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:43 INFO - Running setup.py (path:/tmp/pip-LqCu9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:43 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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:43 INFO - Running setup.py (path:/tmp/pip-mE1VU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:43 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)) 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:43 INFO - Running setup.py (path:/tmp/pip-6QoWHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:44 INFO - Running setup.py (path:/tmp/pip-KR0GZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:44 INFO - Running setup.py (path:/tmp/pip-X9tD2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:44 INFO - Running setup.py (path:/tmp/pip-WsH9Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:44 INFO - Running setup.py (path:/tmp/pip-7y4U2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:44 INFO - Running setup.py (path:/tmp/pip-UgU9ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:44 INFO - Running setup.py (path:/tmp/pip-EpZlU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:44 INFO - Running setup.py (path:/tmp/pip-Ult9D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30: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)) 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:44 INFO - Running setup.py (path:/tmp/pip-q8Xd_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:44 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)) 03:30:44 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)) 03:30:44 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)) 03:30:44 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)) 03:30:44 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)) 03:30:44 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)) 03:30:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:46 INFO - Downloading blessings-1.6.tar.gz 03:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:46 INFO - Installing collected packages: blessings 03:30:46 INFO - Running setup.py install for blessings 03:30:46 INFO - Successfully installed blessings 03:30:46 INFO - Cleaning up... 03:30:46 INFO - Return code: 0 03:30:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:46 INFO - Reading from file tmpfile_stdout 03:30:46 INFO - Current package versions: 03:30:46 INFO - argparse == 1.2.1 03:30:46 INFO - blessings == 1.6 03:30:46 INFO - blobuploader == 1.2.4 03:30:46 INFO - docopt == 0.6.1 03:30:46 INFO - manifestparser == 1.1 03:30:46 INFO - mozInstall == 1.12 03:30:46 INFO - mozcrash == 0.17 03:30:46 INFO - mozdebug == 0.1 03:30:46 INFO - mozdevice == 0.48 03:30:46 INFO - mozfile == 1.2 03:30:46 INFO - mozhttpd == 0.7 03:30:46 INFO - mozinfo == 0.9 03:30:46 INFO - mozleak == 0.1 03:30:46 INFO - mozlog == 3.1 03:30:46 INFO - moznetwork == 0.27 03:30:46 INFO - mozprocess == 0.22 03:30:46 INFO - mozprofile == 0.28 03:30:46 INFO - mozrunner == 6.11 03:30:46 INFO - mozscreenshot == 0.1 03:30:46 INFO - mozsystemmonitor == 0.0 03:30:46 INFO - moztest == 0.7 03:30:46 INFO - mozversion == 1.4 03:30:46 INFO - psutil == 3.1.1 03:30:46 INFO - requests == 1.2.3 03:30:46 INFO - wsgiref == 0.1.2 03:30:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:46 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')]} 03:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:46 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')]} 03:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:46 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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30:46 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 03:30:46 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 03:30:46 INFO - Using env: {'DISPLAY': ':0', 03:30:46 INFO - 'HOME': '/home/cltbld', 03:30:46 INFO - 'LANG': 'en_US.UTF-8', 03:30:46 INFO - 'LANGUAGE': 'en_US:en', 03:30:46 INFO - 'LOGNAME': 'cltbld', 03:30:46 INFO - 'MAIL': '/var/mail/cltbld', 03:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:46 INFO - 'MOZ_NO_REMOTE': '1', 03:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:46 INFO - 'NO_EM_RESTART': '1', 03:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:46 INFO - 'PWD': '/builds/slave/test', 03:30:46 INFO - 'SHELL': '/bin/bash', 03:30:46 INFO - 'SHLVL': '1', 03:30:46 INFO - 'TERM': 'linux', 03:30:46 INFO - 'TMOUT': '86400', 03:30:46 INFO - 'USER': 'cltbld', 03:30:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:46 INFO - '_': '/tools/buildbot/bin/python'} 03:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30:47 INFO - Cleaning up... 03:30:47 INFO - Return code: 0 03:30:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30: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 03:30: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 03:30:47 INFO - Using env: {'DISPLAY': ':0', 03:30:47 INFO - 'HOME': '/home/cltbld', 03:30:47 INFO - 'LANG': 'en_US.UTF-8', 03:30:47 INFO - 'LANGUAGE': 'en_US:en', 03:30:47 INFO - 'LOGNAME': 'cltbld', 03:30:47 INFO - 'MAIL': '/var/mail/cltbld', 03:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:47 INFO - 'MOZ_NO_REMOTE': '1', 03:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:47 INFO - 'NO_EM_RESTART': '1', 03:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:47 INFO - 'PWD': '/builds/slave/test', 03:30:47 INFO - 'SHELL': '/bin/bash', 03:30:47 INFO - 'SHLVL': '1', 03:30:47 INFO - 'TERM': 'linux', 03:30:47 INFO - 'TMOUT': '86400', 03:30:47 INFO - 'USER': 'cltbld', 03:30:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:47 INFO - '_': '/tools/buildbot/bin/python'} 03:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:47 INFO - Downloading/unpacking jsonschema 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:49 INFO - Downloading/unpacking functools32 (from jsonschema) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:49 INFO - warning: no files found matching '*.txt' 03:30:49 INFO - no previously-included directories found matching 'build' 03:30:49 INFO - no previously-included directories found matching 'dist' 03:30:49 INFO - no previously-included directories found matching '.git*' 03:30:49 INFO - Installing collected packages: jsonschema, functools32 03:30:49 INFO - Running setup.py install for functools32 03:30:49 INFO - warning: no files found matching '*.txt' 03:30:49 INFO - no previously-included directories found matching 'build' 03:30:49 INFO - no previously-included directories found matching 'dist' 03:30:49 INFO - no previously-included directories found matching '.git*' 03:30:49 INFO - Successfully installed jsonschema functools32 03:30:49 INFO - Cleaning up... 03:30:49 INFO - Return code: 0 03:30:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b650af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c71410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, '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': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', '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 03:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:30:49 INFO - Using env: {'DISPLAY': ':0', 03:30:49 INFO - 'HOME': '/home/cltbld', 03:30:49 INFO - 'LANG': 'en_US.UTF-8', 03:30:49 INFO - 'LANGUAGE': 'en_US:en', 03:30:49 INFO - 'LOGNAME': 'cltbld', 03:30:49 INFO - 'MAIL': '/var/mail/cltbld', 03:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:49 INFO - 'MOZ_NO_REMOTE': '1', 03:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:49 INFO - 'NO_EM_RESTART': '1', 03:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:49 INFO - 'PWD': '/builds/slave/test', 03:30:49 INFO - 'SHELL': '/bin/bash', 03:30:49 INFO - 'SHLVL': '1', 03:30:49 INFO - 'TERM': 'linux', 03:30:49 INFO - 'TMOUT': '86400', 03:30:49 INFO - 'USER': 'cltbld', 03:30:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:49 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:49 INFO - Downloading/unpacking flake8 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:30:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:30:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:51 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 03:30:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:52 INFO - no previously-included directories found matching 'docs/_build' 03:30:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:30:52 INFO - Running setup.py install for pep8 03:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:30:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:30:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:30:52 INFO - no previously-included directories found matching 'docs/_build' 03:30:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:30:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:30:52 INFO - Cleaning up... 03:30:52 INFO - Return code: 0 03:30:52 INFO - Running post-action listener: _resource_record_post_action 03:30:52 INFO - Running post-action listener: _start_resource_monitoring 03:30:52 INFO - Starting resource monitoring. 03:30:52 INFO - ##### 03:30:52 INFO - ##### Running install step. 03:30:52 INFO - ##### 03:30:52 INFO - Running pre-action listener: _resource_record_pre_action 03:30:52 INFO - Running main action method: install 03:30:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:52 INFO - Reading from file tmpfile_stdout 03:30:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:52 INFO - Reading from file tmpfile_stdout 03:30:52 INFO - Output received: 03:30:52 INFO - Usage: mozinstall [options] installer 03:30:52 INFO - Options: 03:30:52 INFO - -h, --help show this help message and exit 03:30:52 INFO - -d DEST, --destination=DEST 03:30:52 INFO - Directory to install application into. [default: 03:30:52 INFO - "/builds/slave/test"] 03:30:52 INFO - --app=APP Application being installed. [default: firefox] 03:30:52 INFO - mkdir: /builds/slave/test/build/application 03:30:52 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'] 03:30:52 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 03:31:09 INFO - Reading from file tmpfile_stdout 03:31:09 INFO - Output received: 03:31:09 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:09 INFO - Running post-action listener: _resource_record_post_action 03:31:09 INFO - ##### 03:31:09 INFO - ##### Running run-tests step. 03:31:09 INFO - ##### 03:31:09 INFO - Running pre-action listener: _resource_record_pre_action 03:31:09 INFO - Running main action method: run_tests 03:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:09 INFO - Python 2.7.3 03:31:09 INFO - Return code: 0 03:31:09 INFO - grabbing minidump binary from tooltool 03:31: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')]} 03:31: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 0x2d00160>, '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 0x2d01060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d014f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31: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 03:31: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 03:31:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:09 INFO - Return code: 0 03:31:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:10 INFO - Return code: 0 03:31: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/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 03:31: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/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 03:31:10 INFO - Using env: {'DISPLAY': ':0', 03:31:10 INFO - 'HOME': '/home/cltbld', 03:31:10 INFO - 'LANG': 'en_US.UTF-8', 03:31:10 INFO - 'LANGUAGE': 'en_US:en', 03:31:10 INFO - 'LOGNAME': 'cltbld', 03:31:10 INFO - 'MAIL': '/var/mail/cltbld', 03:31:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:10 INFO - 'MOZ_NO_REMOTE': '1', 03:31:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:10 INFO - 'NO_EM_RESTART': '1', 03:31:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:10 INFO - 'PWD': '/builds/slave/test', 03:31:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:10 INFO - 'SHELL': '/bin/bash', 03:31:10 INFO - 'SHLVL': '1', 03:31:10 INFO - 'TERM': 'linux', 03:31:10 INFO - 'TMOUT': '86400', 03:31:10 INFO - 'USER': 'cltbld', 03:31:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957', 03:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:10 INFO - '_': '/tools/buildbot/bin/python'} 03:31: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/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 03:31:10 INFO - mozversion application_buildid: 20160311024912 03:31:10 INFO - mozversion application_changeset: b015db3afa462d65b3bd58ab6cc080401f85bafa 03:31:10 INFO - mozversion application_display_name: Nightly 03:31:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:10 INFO - mozversion application_name: Firefox 03:31:10 INFO - mozversion application_remotingname: firefox 03:31:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:31:10 INFO - mozversion application_vendor: Mozilla 03:31:10 INFO - mozversion application_version: 48.0a1 03:31:10 INFO - mozversion platform_buildid: 20160311024912 03:31:10 INFO - mozversion platform_changeset: b015db3afa462d65b3bd58ab6cc080401f85bafa 03:31:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:31:10 INFO - mozversion platform_version: 48.0a1 03:31:10 INFO - using testdate: 1457695870 03:31:10 INFO - actual date: 1457695870 03:31:10 INFO - starting webserver on 'localhost:49689' 03:31:10 INFO - SUITE-START | Running 2 tests 03:31:10 INFO - TEST-START | dromaeo_css 03:31:10 INFO - operating with platform_type : linux_ 03:31:10 INFO - Initialising browser for dromaeo_css test... 03:31:10 INFO - TEST-INFO | started process 16524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAbQaPg/profile http://localhost:49689/getInfo.html) 03:31:15 INFO - PROCESS | 16524 | __metrics Screen width/height:1600/1200 03:31:15 INFO - PROCESS | 16524 | colorDepth:24 03:31:15 INFO - PROCESS | 16524 | Browser inner width/height: 1024/697 03:31:15 INFO - PROCESS | 16524 | __metrics 03:31:16 ERROR - PROCESS | 16524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:31:17 INFO - TEST-INFO | 16524: exit 0 03:31:17 INFO - Browser initialized. 03:31:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:17 INFO - TEST-INFO | started process 16615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAbQaPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:29 INFO - PROCESS | 16615 | RSS: Main: 155357184 03:31:29 INFO - PROCESS | 16615 | 03:32:20 INFO - PROCESS | 16615 | 1457695940654 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] 03:34:32 INFO - PROCESS | 16615 | Cycle 1(1): loaded http://localhost:49689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49689/tests/dromaeo/cssquery-ext.html) 03:34:33 INFO - PROCESS | 16615 | RSS: Main: 264843264 03:34:33 INFO - PROCESS | 16615 | 03:37:35 INFO - PROCESS | 16615 | Cycle 1(1): loaded http://localhost:49689/tests/dromaeo/cssquery-ext.html (next: http://localhost:49689/tests/dromaeo/cssquery-jquery.html) 03:37:36 INFO - PROCESS | 16615 | RSS: Main: 238395392 03:37:36 INFO - PROCESS | 16615 | 03:40:38 INFO - PROCESS | 16615 | Cycle 1(1): loaded http://localhost:49689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49689/tests/dromaeo/cssquery-mootools.html) 03:40:38 INFO - PROCESS | 16615 | RSS: Main: 230920192 03:40:38 INFO - PROCESS | 16615 | 03:43:40 INFO - PROCESS | 16615 | Cycle 1(1): loaded http://localhost:49689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49689/tests/dromaeo/cssquery-prototype.html) 03:43:41 INFO - PROCESS | 16615 | RSS: Main: 195207168 03:43:41 INFO - PROCESS | 16615 | 03:46:44 INFO - PROCESS | 16615 | Cycle 1(1): loaded http://localhost:49689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49689/tests/dromaeo/cssquery-yui.html) 03:46:44 INFO - PROCESS | 16615 | RSS: Main: 196075520 03:46:44 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | Cycle 1(1): loaded http://localhost:49689/tests/dromaeo/cssquery-yui.html (next: http://localhost:49689/tests/dromaeo/cssquery-dojo.html) 03:49:47 INFO - PROCESS | 16615 | RSS: Main: 300949504 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | __start_tp_report 03:49:47 INFO - PROCESS | 16615 | _x_x_mozilla_page_load 03:49:47 INFO - PROCESS | 16615 | _x_x_mozilla_page_load_details 03:49:47 INFO - PROCESS | 16615 | |i|pagename|runs| 03:49:47 INFO - PROCESS | 16615 | |0;dojo.html;2568.152509671808;2619.345163709073;2642.220544939243;2651.4431969286447;2658.1892522780545;4368.4102646142765;4460.843870464534;4463.040446304044;4485.215087359711;4491.887702807431;4442.755648439334;4506.887327816807;4521.389612402333;4521.434820647419;4528.8867778305475;4107.897302567445;4133.813978370973;4168.499780026401;4173;4236.97881510592;4125.546189919107;4173.457450531442;4190.20386126635;4204.11713540157;4206.936895946563;4027.3153563894207;4105.507339119325;4125.690573206992;4130.256553820311;4217.430646862665;4105.0763578194965;4124.05146816234;4206.137741762931;4227.725197862129;4236.745795252264;4143.3784932260105;4150.522689890641;4163.250614889319;4192.685548583869;4210;4262.808173632194;4431.047324825146;4443.577860103285;4453.220686379903;4467.24056910326;4733.24268117103;4769.308450274691;4770.308305295747;4781.187198176283;4809.470958194595;4794.328793968847;4795.4964728703335;4798.23228283473;4801.159797035505;4828.372311599504;4364.9127017460105;4449.221386257456;4458.197524445566;4460.799264033127;4489.393931819195;4843.24929635907;4892.315075889378;4910.091633047826;4957.90084198314;4959.280904268933;4694.201985662446;4721.197396442544;4722.740249286322;4723.197056500335;4771.475137734847;4627.514111018362;4741.905161896742;4773.236282194832;4804.975975120102;4854.805807767721;4733.95266047342;4748.762561871893;4752.2158843790385;4782.210935195723;4788.784504697227;4721.220998535272;4737.644676649265;4741.028089241766;4784.282357646381;4789.928151077736;3941.9014524637114;3999.9000024999027;4002.7198096132993;4009.939850902239;4019.2966230909474;3535.911602209914;3545.096000519851;3562.9109272267883;3564;3609.2601016791496;4151.14901445203;4153.91692166161;4155.314373128461;4165;4189.97905010473;4595.862124136282;4624.44506659203;4802.327674125625;4807.230843065093;4820.807167713322;4107.404426358221;4111.7944102794745;4112.157007813391;4145.481814773153;4148.979255103705;4189.49726032878;4230.809613567397;4232.470941132358;4264.936025959613;4270.636995855325;4416.094700586372;4491.191585514639;4505.954940450619;4599.954000459952;4615.607673347803;4800.975995120002;4807.326974223542;4818.855434336975;4825.3485779420735;4846.345743324606;4552.317152427162;4560.4071470708595;4565.201089809204;4565.452145742533;4610.40064791575;4583.335416364675;4671.205894997926;4713.952860471489;4753.9049219016115;4762.880927976828;4789.521047895182;4792;4803.3995750531185;4804.807807687793;4837.274408838703;4535.092981403666;4651.906961860812;4655.767211639337;4655.790489428052;4697.577218050392;4517.5030746617185;4554.385158003627;4560.908781824279;4590.2196626572895;4605;4541.43232095988;4553.886152846206;4554.9316760249285;4556.749378784199;4611.146937816515;4548.408706868086;4660.067986402665;4665.930011049905;4666.510016448224;4667.39323887906;4394.868153955259;4486.416765820422;4491.056878055645;4559.156556037144;4577.038821847316 03:49:47 INFO - PROCESS | 16615 | |1;ext.html;498.5562849064331;526.310533201506;547.6932917566163;558.5615291995781;563.0821760530335;32883;33386.165345866364;33476.33047339052;33491.49762753561;33561.83219083901;36377.63622363775;36907.4463883042;36929.26141477169;36943.63056369442;36959.630403695955;7602.2777836105615;7790.143084260727;7791.181925897784;7791.532508049535;7794.454388192828;7649.579273140003;7777.922220777805;7783.688652453895;7979.601019949008;7984.720534781284;7931.286184243417;7990.320822730075;8013.0384353877325;8029.437939344249;8029.839403211961;7895.8420831583335;7972;7974.800629984239;7976.920230797676;7985.201479852027;7855.13593504714;7979.441439099207;7986.0816006158875;7987.161348058428;7989.920100798976;37379.25241495182;37895.62104378976;38020;38070.80964595187;38093.238135237414;2656.296081538394;2834.6881842997254;2862.4418238443513;3005.7144571265694;3583.33708263972;28253.717462825312;28472;29002.27494312638;29196.124116276333;29277.26806829825;3459.135216195951;3470.774399664014;3494.248736521635;3543.7519373643854;3650.7992060436663;221043;221489;221765;222207;222620;38058.809705951295;53119.46880531222;53353;53486;53503.46496534985;36255;36420;36425.27149456996;36430;36458.27083458369;13267.270300133585;13496.595102146952;13517.121387109806;13527.729445411036;13533.932330338483;10409.219308551888;10409.843852342221;10426.635067772591;10461.790764184674;10481.109105725945;13252.867471325357;13273.469061237636;13281.335933203301;13364.19814811095;13440.865591343962;5353.57171426285;5393.541548968382;5400.702961337164;5453.972730136324;5473.261109750133;756.2097607999654;791.9683212671429;879.3712495565701;959.6209497248688;1018.7147598672384;28253;29233.85383073071;29263.268418289714;29716.40567188644;29786;907.5235501361706;979.8236317462782;989.2382865193761;1020.8417695257247;1047.350642601592;13332.275058783744;13775.795872660527;13977.161370317814;13987.440502379792;14082.155070695791;314170;317114;319716;319795;320441;46926.53073469221;47496.5250347499;47536;47621.28568071482;47649.285260720426;1145.8223975283677;1187.3410257307105;1226.6074856046157;1236.486857953957;1305.3147097773556;24288;26533.60199596969;26577;26663.20010399691;27032;36922.261554768214;37099;37434.43848342223;37467.2506549862;37473.06317342088;198533;199407;200641;200851;200923;23448.765512344657;27624.72375276302;27852;28273.57589636116;28380.716192838634;32125.518117228727;32440.351192975537;41070;41419.58580414157;42196.367054493596;32309.838450807594;33228;33250.16874578155;33419.66580334165;33952.83023584965;32387.838060809547;32771.50842737313;32825.67174328226;33103.66896331102;33354.666453336125;31867.681323186473;32517.34965300728;32774.50838237381;32790;32868.83565582157;29612.259693507836;29835.254118647208;30167.396652066396;30350.54474182845;30365.848170759888;23921.64117538273;24051.27846164618;24210.515789683755;24373.14693985702;24475 03:49:47 INFO - PROCESS | 16615 | |2;jquery.html;322.5505091479454;324.263920899558;330.43660558747325;335.4096789650215;340.2090140423516;14373.20947347894;15032.398704051839;15558.299876505556;15792.210389480537;16178.19109044546;11197.888021119787;11589.304641721481;13851.238181899991;14473.276336183202;15229.238538073107;4673.392458980328;4782.617390608743;4820;4860.829870954517;4949.678270912397;5068.96086302309;5083.491650834905;5099.898002039957;5105.5149760772665;5110.182370820669;3260.8532616032217;5016.122178618727;5065.620078494109;5200.427952925175;5211.947880521184;5185.585153187736;5191.377034755854;5192.662476938987;5199.038177937075;5200.973995130038;4982.17794063979;4995.700257984533;4996.600271978233;5026.949730502684;5035.823746168867;11868.050555955502;13560.11859229147;16945.830541694548;17243.655126897393;17458.825411745973;1787.6156626325403;1790.1049475262369;2113.8625989310644;2214.247155966963;2372.5373552157334;8220.05469371024;8646.956765216197;8789.912100878973;8867.512286824222;8921.86617200736;1676.0697812713938;1738.610606022861;1789.337944960373;1791.3192986665115;1816.5095424235383;54563.72718136424;57402.71298643522;58338.41661583415;58570.41429585735;58998.11502827461;9567.856482152773;9618.807623847484;9728.124468797841;9751.317407781387;9839.55721992512;12417.130800844036;12455.937720311522;12464.314462704457;12469.189502682297;12490.25058496475;6439.291677915426;6537.607743535308;7126.857462850714;7221.386182174469;7268.6729097190755;5498.202760599691;6290.339514351019;6430.164078669743;6549.476041916635;6553.508486863504;4065.739620717528;4103.373052520158;4112.773797441169;4124.711270211056;4201.991522034689;1594.3702237616076;1602.6394061336107;1674.4223242981152;1729.6540691861678;1755.1662960094109;368.57245595109544;411.88261345516383;750.36594078004;817.7015389382951;825.108882406999;9473.810523789485;9817.558209880572;9855.26085543587;9921.702348929544;10068.496575171212;818.1491249100987;857.9613917373733;898.9640414383482;937.7139972308512;949.7340744591526;8158.551279679675;8264.132266112092;8289.41974061822;8294.58527073644;8658.437201581877;142422;143294;232822;387667;393448;68900.6554967232;68920;69583;70332.29667703257;70629.2937070633;927.6428574998539;931.0596297739197;945.3524335829978;952.8856537215579;956.5838860095741;12858.485660573473;12878.742425151257;13028.934855325662;13045.673858153623;13114.868851311747;28006.159815204763;30484.847575761978;30984.380312393176;31470;32022.839885800422;39220.607793922834;39384.60615393924;39395.40906886342;39697.40453893252;40291.597084028785;6873.175218973755;7075.80940259332;7086.751963681247;7169.964150179216;7289.671964761705;10212.285140040423;10970.451477426257;10971.177161712743;11138.220324577202;11206.43967801623;8896.911030889867;9121;9394.718158455258;9433.57548910287;9576.138147566753;9249.260059195383;9272.072792720674;9345.299102567471;9543;9571.760705982406;9161.954190229006;9494.098060684224;9600.519974001132;9603.135717785433;9626.95186524063;6968.79093627192;7229.277072292729;7251.601161936144;7306.31954650444;7372.926270737438;8343.374246931384;9701.369410988545;9787.902120978699;9807.166390856857;9919.355241909252 03:49:47 INFO - PROCESS | 16615 | |3;mootools.html;1238.455079764904;1340.778771502702;1386.9167849929001;1505.427937383794;1727.9222434990415;7073.328033836784;7301.977723118767;7304.233055529173;7306.817329566757;7309;7123.252058533857;7305.817354566138;7313.926860731391;7316.122065352152;7318.817029574263;2027.3917824652583;2053.260826102602;2056.5064384547677;2058.495668561197;2059.7837227091163;2092.257248676721;2097.937061888138;2126.914923403062;2188.73735151782;2191.5069109450405;2113.9048742806535;2132.1577976699273;2139.187108898624;2143.046344376753;2143.2498625481035;2124.022949443258;2126.2770657976207;2127.4149608857533;2127.6914847347202;2129.180265597748;2098.5068508900395;2148.215901196068;2148.8495805293637;2149.9140034398606;2151.4836439254623;7438.442116841205;7478.887816682754;7483.4013278937555;7487.887681684779;7506.099268087864;4199.622034016953;4331.480222373304;4334.13317336534;4339.262325404688;4340.13197360526;2720.986395068032;2811.9437611247863;2833.0650885207833;2852.101587999794;2853.885844566215;888.3337496877342;897.4839467306259;917.3716004536914;940.5955439161158;940.9858852117223;9952.80094398108;9968.601255949754;9999.35004224723;10018.048285412875;10025.498725063791;3859.3246181918053;4005.4792876925812;4010.639042486132;4028.9798551007057;4066.369712694537;8541.359398045171;8601.39790214679;8610.062735884376;8615.741527754177;8617.655293788179;4345.652347812231;4367.432233809584;4369.169857727085;4372.1692878353015;4373.781310934504;3374.898753037413;3764.9435258471144;3898.4931958845737;3928.2339943710704;3929.685625149981;3397.0827876473213;3421.4525675891737;3427.451607742799;3464.116650254169;3479;1059.4014381874217;1061.8354155105972;1069.2782371898936;1069.775347177086;1077.0306723948509;843.8354520868372;846.4032856835915;846.8814365988767;912.6531917871166;1152.2107356460851;6515.381038801306;6732.663366831639;6751.4261287790105;6755.93244067553;6761.966190169018;878.5870640798814;908.7500937242311;952.8618350339301;962.7496850818837;981.7300242433388;5165.560927321145;5203.661761985459;5204.193350030751;5233.450487698813;5238.947610523922;8529.104444033412;9018.684346047858;9061.818763624691;9169.770755731026;9176.724698259062;8931.330150238759;9000.144986226298;9024.323175761712;9045.502497362577;9067.54662266884;6892.276310987374;6998.705239530703;7021.859562808715;7069.929300706927;7077.858442831114;6759.459243260429;6759.493038022069;6783.050372947692;6786.287439818748;6795.150606174228;7826.7651970440975;7983.081945576333;8000.759977200693;8023.398245131521;8137.877931831145;8149.592520373839;8306.916930830614;8510.659573616986;8521.786955326166;8530.616122274389;6062.393760623902;6076.66578338178;6200.689965501797;6222.81331560054;6230.719617617127;6983.860322793617;7003.26465721092;7045.26024767392;7049.29507049291;7102.893456598258;6174.567780255339;6448.290688024407;6465.676716164267;6513.381228783258;6528.183977002875;5535;5765.827025189251;6396.072569477493;6416.45460135875;6446.4520515756685;6548.476121910331;6624.701888414937;6664.5334826561675;6679.532432729662;6682.866342673216;5919.526437884872;5950.285965684146;5955.344912059583;5969.283685957713;5995;6071.089336599545;6107.358727333743;6117.694115294128;6117.908231376444;6122.418370254997 03:49:47 INFO - PROCESS | 16615 | |4;prototype.html;296.76258992805754;302.1373977294823;304.31984514609843;308.9536569514574;309.05121277677523;5179.792808287673;5259.500347466994;5275.8153464628695;5315.840524784253;5328.333958255218;5256.106461901476;5283.682979021251;5324.946750532494;5332.200169974506;5335.279737235472;3829.444730514074;3909.76541407515;4026.4161696553983;4029.375446805735;4061.8984525386954;4042.7170098093147;4052.4731784868072;4055.047063939972;4056.9188616227657;4060.1067765091634;4001.899952501182;4005.879823605282;4008.298547754146;4009.719319647626;4010.7994600270017;3821.0065383000483;3908.9804550977346;4013.4581831452965;4017.8191981360765;4022.9195416091807;3438.828058597085;3466.757326987112;3467.514547963287;3482.2687235680537;3489.4416893297202;5037.622178336603;5041.092603331399;5045.571126454256;5064.544191022789;5068.214426763858;4584.633229341644;4586.403767510203;4596.448426188878;4598.287265473857;4601.838935637236;5516.668999859981;5518.2826232589905;5518.33779946405;5522.6134170608075;5529.585281103933;3790.8862734117743;3795.69634429245;3799.6010418905894;3801.1257410795397;3807.0292075520842;5674.489295963342;5754.165645981309;5828.825135245949;5837;5845;3876.4379165020914;3893.4354518594646;3893.5717071122153;3896.473976013202;3901.492805935267;3952.2293152835496;3954.070793363557;3957.050307926135;3965.107850733562;3968.5634580196156;4555.840545580955;4575.771211439482;4576.313552967082;4576.748278844629;4579.839705610288;5551.555875530029;5554.305711786027;5563.582731295169;5564.4991950724625;5567.24842146305;1373.478078330248;1399.8530154333853;1400.7828786538103;1401.0542883553765;1402.137685323539;861.793169639282;906.4470672889532;933.7665583604099;959.7168835193635;961.0677642686583;4781.617470602343;4874.902501950012;4876.268559716;4882.633802464829;4884.9511504884495;5713.628614140068;5721.771129154788;5723.656580605177;5726.9713651431475;5747.425257474303;4914.975425122923;4933.654644174945;4935.605151587864;4939.110960027229;4940.481249468754;3071.9078427647205;3099.1477343730653;3115.3302040061494;3116.56368108465;3119.906402807919;5453.509184173444;5461.918071228934;5464.672119672832;5466.289382380344;5467.890642187134;5746.339170995306;5946.167536544887;5963.165156878041;6004.039353703386;6061.484773794277;5444;5464.426235245242;5468.097763868917;5469.535089517356;5473.124300111963;5789.94210057894;5803.535717142703;5803.622764520293;5809.709514524341;5813.069908814569;5658.292713410824;5687.573431992534;5687.630304030225;5695.8860822784145;5711.8000869969355;5422.105352616774;5462.20797984298;5465.672059676433;5473;5474.315710536183;3767.190054138264;3887.047673320055;3887.825047872909;3909.7849618271266;3968.4642573253395;5713.114467257582;5740.225069615715;5742.36833948257;5743.253377060955;5749.252597162342;5530.917036244379;5532.419095994863;5539.473749993744;5542.418046105101;5544.972275138599;5477.4796394342475;5518.779248830162;5533.7786488540005;5542.8337149885565;5550.084236100998;5432;5434.266374039454;5437.9396017777735;5443.564514838883;5445.727713614224;5414.35027796667;5576.275084239023;5583.916241256466;5588.133839254922;5591.9375318690945;5317.920231196458;5345.251664766858;5351.143816989263;5351.732413379394;5354.705491198021 03:49:47 INFO - PROCESS | 16615 | |5;yui.html;580.814139475368;601.1043545117775;721.90976127984;734.3501001613573;735.2463724682196;11714.53141874325;11943.940280298597;11957.820632690517;11987.880121198785;11991.580294689687;13447.462101515928;13708.177509349445;13715.314234288271;13735.313234338293;13741.106828056169;628.8207860759684;790.5651891459703;794.4002278279919;801.4710291207804;803.0724513187278;808.7816289601803;811.9553424561647;813.6704634622957;814.2590242878952;814.9470284431522;840.1598401598402;841.7600983719641;841.9368547358941;843.877637742527;845.2730651639584;654.5777973207279;839.2866063845744;840.7435732101707;841.20506121715;856.2336708645789;628.7862126876838;630.1839118341759;630.6941133550224;631.2929518938818;631.5042691487206;12650.746985060247;13129.474821007148;13130.34348282582;13144.802827957588;13152.671183220496;12141.210821296676;12657.556985505464;12690.746185076247;12706.364681765876;12906.935465322613;9719.416834989852;9761.51192440375;9793.608255669764;9893.159081478083;9921.107100361001;3264.967350326514;3308.354870800195;3368.8484018219237;3415.351083294191;3419.059758566389;41307.7934610328;42576.1484770306;42767;42807;42864.57135428637;9801.705948821404;9813.901860981441;9814.263930205263;9956.850647240297;9979.10188083076;17286.913565432344;17320.220590073477;17323.653526929644;17352.566185845455;17363;6472.708728107246;6601.966990165114;6620.602763834186;6735.966320168368;6807.183138023469;3534.6642069003406;3660.450932360114;3676.3933950897804;3723.3298006359114;3785.167263202091;2840.2189397915326;2880.683124856264;2884.322184286691;2887.768978481716;2893.6382952130984;520.5029197116744;533.6451259912193;538.4265756968815;540.9756560954767;545.1087471983257;493.181319010441;520.4613225311859;527.2328761651787;531.7846272259741;539.54947618738;7078.115235595551;7172.892406613905;7263;7404;7488.625568721543;491.1257960829729;521.3274875410677;522.9163333866563;525.1282870435059;531.3051366141995;3375.206826395795;3376.2652251676222;3381.898543043713;3413.9317213655586;3431.262278610111;46870.296945545844;47345.5265447348;47356.526434735904;47922.76038619784;48817.75591122093;40290.798546007085;40926.590734092875;41193.79403103025;41233;41356;37025.81487092601;39383.092536119235;39441.605583944365;39700.20599587992;40183.59816401857;7979.640916158671;8053.557054362066;8147.655636819858;8226.341892648454;8460.619272132646;30205.69794302029;30768.538471923388;31943.201419964687;31962.52056219205;32104.83947580247;35959.460608090376;36807.26385472329;36901.815490922374;38112.809435952644;40056.3991540133;10297.794044118926;10308.896911030793;10391.636292729718;10421.68734937953;10422.635207767691;10574.894251057698;10889;11096.33421994683;11189.04893084097;11233.775324493628;8324.417290789586;8919.910800891908;10324.638637647646;10363.356704820108;10737.677869663923;10132.493375331056;10288.434136122585;10428.687139385831;10543.472826358804;10583.894161058599;9992.52876425784;10174.796504069729;10436.739081523023;10469.895301047196;10596.099331556905;8710.69512567057;8768.386212965032;8911.37620366568;9033.187013168847;9204.217641500547;8747.518886461306;8800.295976322006;9103.954480227556;9158.221551168226;9253.213476854542 03:49:47 INFO - PROCESS | 16615 | __end_tp_report 03:49:47 INFO - PROCESS | 16615 | __start_cc_report 03:49:47 INFO - PROCESS | 16615 | _x_x_mozilla_cycle_collect,1007 03:49:47 INFO - PROCESS | 16615 | __end_cc_report 03:49:47 INFO - PROCESS | 16615 | __startTimestamp1457696987560__endTimestamp 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | ------- Summary: start ------- 03:49:47 INFO - PROCESS | 16615 | Number of tests: 6 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | [#0] dojo.html Cycles:165 Average:4421.09 Median:4535.09 stddev:439.38 (9.7%) stddev-sans-first:415.99 03:49:47 INFO - PROCESS | 16615 | Values: 2568.2 2619.3 2642.2 2651.4 2658.2 4368.4 4460.8 4463.0 4485.2 4491.9 4442.8 4506.9 4521.4 4521.4 4528.9 4107.9 4133.8 4168.5 4173.0 4237.0 4125.5 4173.5 4190.2 4204.1 4206.9 4027.3 4105.5 4125.7 4130.3 4217.4 4105.1 4124.1 4206.1 4227.7 4236.7 4143.4 4150.5 4163.3 4192.7 4210.0 4262.8 4431.0 4443.6 4453.2 4467.2 4733.2 4769.3 4770.3 4781.2 4809.5 4794.3 4795.5 4798.2 4801.2 4828.4 4364.9 4449.2 4458.2 4460.8 4489.4 4843.2 4892.3 4910.1 4957.9 4959.3 4694.2 4721.2 4722.7 4723.2 4771.5 4627.5 4741.9 4773.2 4805.0 4854.8 4734.0 4748.8 4752.2 4782.2 4788.8 4721.2 4737.6 4741.0 4784.3 4789.9 3941.9 3999.9 4002.7 4009.9 4019.3 3535.9 3545.1 3562.9 3564.0 3609.3 4151.1 4153.9 4155.3 4165.0 4190.0 4595.9 4624.4 4802.3 4807.2 4820.8 4107.4 4111.8 4112.2 4145.5 4149.0 4189.5 4230.8 4232.5 4264.9 4270.6 4416.1 4491.2 4506.0 4600.0 4615.6 4801.0 4807.3 4818.9 4825.3 4846.3 4552.3 4560.4 4565.2 4565.5 4610.4 4583.3 4671.2 4714.0 4753.9 4762.9 4789.5 4792.0 4803.4 4804.8 4837.3 4535.1 4651.9 4655.8 4655.8 4697.6 4517.5 4554.4 4560.9 4590.2 4605.0 4541.4 4553.9 4554.9 4556.7 4611.1 4548.4 4660.1 4665.9 4666.5 4667.4 4394.9 4486.4 4491.1 4559.2 4577.0 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | [#1] ext.html Cycles:180 Average:39666.74 Median:33239.08 stddev:65937.20 (198.4%) stddev-sans-first:66056.58 03:49:47 INFO - PROCESS | 16615 | Values: 498.6 526.3 547.7 558.6 563.1 32883.0 33386.2 33476.3 33491.5 33561.8 36377.6 36907.4 36929.3 36943.6 36959.6 7602.3 7790.1 7791.2 7791.5 7794.5 7649.6 7777.9 7783.7 7979.6 7984.7 7931.3 7990.3 8013.0 8029.4 8029.8 7895.8 7972.0 7974.8 7976.9 7985.2 7855.1 7979.4 7986.1 7987.2 7989.9 37379.3 37895.6 38020.0 38070.8 38093.2 2656.3 2834.7 2862.4 3005.7 3583.3 28253.7 28472.0 29002.3 29196.1 29277.3 3459.1 3470.8 3494.2 3543.8 3650.8 221043.0 221489.0 221765.0 222207.0 222620.0 38058.8 53119.5 53353.0 53486.0 53503.5 36255.0 36420.0 36425.3 36430.0 36458.3 13267.3 13496.6 13517.1 13527.7 13533.9 10409.2 10409.8 10426.6 10461.8 10481.1 13252.9 13273.5 13281.3 13364.2 13440.9 5353.6 5393.5 5400.7 5454.0 5473.3 756.2 792.0 879.4 959.6 1018.7 28253.0 29233.9 29263.3 29716.4 29786.0 907.5 979.8 989.2 1020.8 1047.4 13332.3 13775.8 13977.2 13987.4 14082.2 314170.0 317114.0 319716.0 319795.0 320441.0 46926.5 47496.5 47536.0 47621.3 47649.3 1145.8 1187.3 1226.6 1236.5 1305.3 24288.0 26533.6 26577.0 26663.2 27032.0 36922.3 37099.0 37434.4 37467.3 37473.1 198533.0 199407.0 200641.0 200851.0 200923.0 23448.8 27624.7 27852.0 28273.6 28380.7 32125.5 32440.4 41070.0 41419.6 42196.4 32309.8 33228.0 33250.2 33419.7 33952.8 32387.8 32771.5 32825.7 33103.7 33354.7 31867.7 32517.3 32774.5 32790.0 32868.8 29612.3 29835.3 30167.4 30350.5 30365.8 23921.6 24051.3 24210.5 24373.1 24475.0 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | [#2] jquery.html Cycles:180 Average:18800.23 Median:5147.88 stddev:47305.24 (918.9%) stddev-sans-first:47417.60 03:49:47 INFO - PROCESS | 16615 | Values: 322.6 324.3 330.4 335.4 340.2 14373.2 15032.4 15558.3 15792.2 16178.2 11197.9 11589.3 13851.2 14473.3 15229.2 4673.4 4782.6 4820.0 4860.8 4949.7 5069.0 5083.5 5099.9 5105.5 5110.2 3260.9 5016.1 5065.6 5200.4 5211.9 5185.6 5191.4 5192.7 5199.0 5201.0 4982.2 4995.7 4996.6 5026.9 5035.8 11868.1 13560.1 16945.8 17243.7 17458.8 1787.6 1790.1 2113.9 2214.2 2372.5 8220.1 8647.0 8789.9 8867.5 8921.9 1676.1 1738.6 1789.3 1791.3 1816.5 54563.7 57402.7 58338.4 58570.4 58998.1 9567.9 9618.8 9728.1 9751.3 9839.6 12417.1 12455.9 12464.3 12469.2 12490.3 6439.3 6537.6 7126.9 7221.4 7268.7 5498.2 6290.3 6430.2 6549.5 6553.5 4065.7 4103.4 4112.8 4124.7 4202.0 1594.4 1602.6 1674.4 1729.7 1755.2 368.6 411.9 750.4 817.7 825.1 9473.8 9817.6 9855.3 9921.7 10068.5 818.1 858.0 899.0 937.7 949.7 8158.6 8264.1 8289.4 8294.6 8658.4 142422.0 143294.0 232822.0 387667.0 393448.0 68900.7 68920.0 69583.0 70332.3 70629.3 927.6 931.1 945.4 952.9 956.6 12858.5 12878.7 13028.9 13045.7 13114.9 28006.2 30484.8 30984.4 31470.0 32022.8 39220.6 39384.6 39395.4 39697.4 40291.6 6873.2 7075.8 7086.8 7170.0 7289.7 10212.3 10970.5 10971.2 11138.2 11206.4 8896.9 9121.0 9394.7 9433.6 9576.1 9249.3 9272.1 9345.3 9543.0 9571.8 9162.0 9494.1 9600.5 9603.1 9627.0 6968.8 7229.3 7251.6 7306.3 7372.9 8343.4 9701.4 9787.9 9807.2 9919.4 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | [#3] mootools.html Cycles:180 Average:5103.34 Median:6313.40 stddev:2698.75 (42.7%) stddev-sans-first:2690.68 03:49:47 INFO - PROCESS | 16615 | Values: 1238.5 1340.8 1386.9 1505.4 1727.9 7073.3 7302.0 7304.2 7306.8 7309.0 7123.3 7305.8 7313.9 7316.1 7318.8 2027.4 2053.3 2056.5 2058.5 2059.8 2092.3 2097.9 2126.9 2188.7 2191.5 2113.9 2132.2 2139.2 2143.0 2143.2 2124.0 2126.3 2127.4 2127.7 2129.2 2098.5 2148.2 2148.8 2149.9 2151.5 7438.4 7478.9 7483.4 7487.9 7506.1 4199.6 4331.5 4334.1 4339.3 4340.1 2721.0 2811.9 2833.1 2852.1 2853.9 888.3 897.5 917.4 940.6 941.0 9952.8 9968.6 9999.4 10018.0 10025.5 3859.3 4005.5 4010.6 4029.0 4066.4 8541.4 8601.4 8610.1 8615.7 8617.7 4345.7 4367.4 4369.2 4372.2 4373.8 3374.9 3764.9 3898.5 3928.2 3929.7 3397.1 3421.5 3427.5 3464.1 3479.0 1059.4 1061.8 1069.3 1069.8 1077.0 843.8 846.4 846.9 912.7 1152.2 6515.4 6732.7 6751.4 6755.9 6762.0 878.6 908.8 952.9 962.7 981.7 5165.6 5203.7 5204.2 5233.5 5238.9 8529.1 9018.7 9061.8 9169.8 9176.7 8931.3 9000.1 9024.3 9045.5 9067.5 6892.3 6998.7 7021.9 7069.9 7077.9 6759.5 6759.5 6783.1 6786.3 6795.2 7826.8 7983.1 8000.8 8023.4 8137.9 8149.6 8306.9 8510.7 8521.8 8530.6 6062.4 6076.7 6200.7 6222.8 6230.7 6983.9 7003.3 7045.3 7049.3 7102.9 6174.6 6448.3 6465.7 6513.4 6528.2 5535.0 5765.8 6396.1 6416.5 6446.5 6548.5 6624.7 6664.5 6679.5 6682.9 5919.5 5950.3 5955.3 5969.3 5995.0 6071.1 6107.4 6117.7 6117.9 6122.4 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | [#4] prototype.html Cycles:180 Average:4579.53 Median:5316.88 stddev:1367.52 (25.7%) stddev-sans-first:1333.04 03:49:47 INFO - PROCESS | 16615 | Values: 296.8 302.1 304.3 309.0 309.1 5179.8 5259.5 5275.8 5315.8 5328.3 5256.1 5283.7 5324.9 5332.2 5335.3 3829.4 3909.8 4026.4 4029.4 4061.9 4042.7 4052.5 4055.0 4056.9 4060.1 4001.9 4005.9 4008.3 4009.7 4010.8 3821.0 3909.0 4013.5 4017.8 4022.9 3438.8 3466.8 3467.5 3482.3 3489.4 5037.6 5041.1 5045.6 5064.5 5068.2 4584.6 4586.4 4596.4 4598.3 4601.8 5516.7 5518.3 5518.3 5522.6 5529.6 3790.9 3795.7 3799.6 3801.1 3807.0 5674.5 5754.2 5828.8 5837.0 5845.0 3876.4 3893.4 3893.6 3896.5 3901.5 3952.2 3954.1 3957.1 3965.1 3968.6 4555.8 4575.8 4576.3 4576.7 4579.8 5551.6 5554.3 5563.6 5564.5 5567.2 1373.5 1399.9 1400.8 1401.1 1402.1 861.8 906.4 933.8 959.7 961.1 4781.6 4874.9 4876.3 4882.6 4885.0 5713.6 5721.8 5723.7 5727.0 5747.4 4915.0 4933.7 4935.6 4939.1 4940.5 3071.9 3099.1 3115.3 3116.6 3119.9 5453.5 5461.9 5464.7 5466.3 5467.9 5746.3 5946.2 5963.2 6004.0 6061.5 5444.0 5464.4 5468.1 5469.5 5473.1 5789.9 5803.5 5803.6 5809.7 5813.1 5658.3 5687.6 5687.6 5695.9 5711.8 5422.1 5462.2 5465.7 5473.0 5474.3 3767.2 3887.0 3887.8 3909.8 3968.5 5713.1 5740.2 5742.4 5743.3 5749.3 5530.9 5532.4 5539.5 5542.4 5545.0 5477.5 5518.8 5533.8 5542.8 5550.1 5432.0 5434.3 5437.9 5443.6 5445.7 5414.4 5576.3 5583.9 5588.1 5591.9 5317.9 5345.3 5351.1 5351.7 5354.7 03:49:47 INFO - PROCESS | 16615 | 03:49:47 INFO - PROCESS | 16615 | [#5] yui.html Cycles:180 Average:12188.62 Median:42835.79 stddev:13378.47 (31.2%) stddev-sans-first:13387.60 03:49:47 INFO - PROCESS | 16615 | Values: 580.8 601.1 721.9 734.4 735.2 11714.5 11943.9 11957.8 11987.9 11991.6 13447.5 13708.2 13715.3 13735.3 13741.1 628.8 790.6 794.4 801.5 803.1 808.8 812.0 813.7 814.3 814.9 840.2 841.8 841.9 843.9 845.3 654.6 839.3 840.7 841.2 856.2 628.8 630.2 630.7 631.3 631.5 12650.7 13129.5 13130.3 13144.8 13152.7 12141.2 12657.6 12690.7 12706.4 12906.9 9719.4 9761.5 9793.6 9893.2 9921.1 3265.0 3308.4 3368.8 3415.4 3419.1 41307.8 42576.1 42767.0 42807.0 42864.6 9801.7 9813.9 9814.3 9956.9 9979.1 17286.9 17320.2 17323.7 17352.6 17363.0 6472.7 6602.0 6620.6 6736.0 6807.2 3534.7 3660.5 3676.4 3723.3 3785.2 2840.2 2880.7 2884.3 2887.8 2893.6 520.5 533.6 538.4 541.0 545.1 493.2 520.5 527.2 531.8 539.5 7078.1 7172.9 7263.0 7404.0 7488.6 491.1 521.3 522.9 525.1 531.3 3375.2 3376.3 3381.9 3413.9 3431.3 46870.3 47345.5 47356.5 47922.8 48817.8 40290.8 40926.6 41193.8 41233.0 41356.0 37025.8 39383.1 39441.6 39700.2 40183.6 7979.6 8053.6 8147.7 8226.3 8460.6 30205.7 30768.5 31943.2 31962.5 32104.8 35959.5 36807.3 36901.8 38112.8 40056.4 10297.8 10308.9 10391.6 10421.7 10422.6 10574.9 10889.0 11096.3 11189.0 11233.8 8324.4 8919.9 10324.6 10363.4 10737.7 10132.5 10288.4 10428.7 10543.5 10583.9 9992.5 10174.8 10436.7 10469.9 10596.1 8710.7 8768.4 8911.4 9033.2 9204.2 8747.5 8800.3 9104.0 9158.2 9253.2 03:49:47 INFO - PROCESS | 16615 | -------- Summary: end -------- 03:49:47 INFO - PROCESS | 16615 | 03:49:48 INFO - TEST-INFO | 16615: exit 0 03:49:48 INFO - TEST-OK | dromaeo_css | took 1117672ms 03:49:48 INFO - TEST-START | kraken 03:49:48 INFO - operating with platform_type : linux_ 03:49:48 INFO - Initialising browser for kraken test... 03:49:48 INFO - TEST-INFO | started process 16793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywvfun/profile http://localhost:49689/getInfo.html) 03:49:52 INFO - PROCESS | 16793 | __metrics Screen width/height:1600/1200 03:49:52 INFO - PROCESS | 16793 | colorDepth:24 03:49:52 INFO - PROCESS | 16793 | Browser inner width/height: 1024/697 03:49:52 INFO - PROCESS | 16793 | __metrics 03:49:53 ERROR - PROCESS | 16793 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:49:53 INFO - PROCESS | 16793 | 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. 03:49:54 INFO - TEST-INFO | 16793: exit 0 03:49:54 INFO - Browser initialized. 03:49:54 INFO - Running cycle 1/1 for kraken test... 03:49:54 INFO - TEST-INFO | started process 16874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywvfun/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:06 INFO - PROCESS | 16874 | RSS: Main: 154632192 03:50:06 INFO - PROCESS | 16874 | 03:50:09 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49689/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:09 INFO - PROCESS | 16874 | RSS: Main: 193617920 03:50:09 INFO - PROCESS | 16874 | 03:50:12 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49689/tests/kraken/driver.html?testName=audio-dft) 03:50:13 INFO - PROCESS | 16874 | RSS: Main: 185307136 03:50:13 INFO - PROCESS | 16874 | 03:50:16 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49689/tests/kraken/driver.html?testName=audio-fft) 03:50:16 INFO - PROCESS | 16874 | RSS: Main: 172572672 03:50:16 INFO - PROCESS | 16874 | 03:50:18 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49689/tests/kraken/driver.html?testName=audio-oscillator) 03:50:19 INFO - PROCESS | 16874 | RSS: Main: 173658112 03:50:19 INFO - PROCESS | 16874 | 03:50:21 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:22 INFO - PROCESS | 16874 | RSS: Main: 175599616 03:50:22 INFO - PROCESS | 16874 | 03:50:25 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49689/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:26 INFO - PROCESS | 16874 | RSS: Main: 176156672 03:50:26 INFO - PROCESS | 16874 | 03:50:29 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49689/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:30 INFO - PROCESS | 16874 | RSS: Main: 172486656 03:50:30 INFO - PROCESS | 16874 | 03:50:33 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49689/tests/kraken/driver.html?testName=json-parse-financial) 03:50:33 INFO - PROCESS | 16874 | RSS: Main: 173449216 03:50:33 INFO - PROCESS | 16874 | 03:50:35 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:36 INFO - PROCESS | 16874 | RSS: Main: 186515456 03:50:36 INFO - PROCESS | 16874 | 03:50:37 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:38 INFO - PROCESS | 16874 | RSS: Main: 182190080 03:50:38 INFO - PROCESS | 16874 | 03:50:40 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:41 INFO - PROCESS | 16874 | RSS: Main: 193257472 03:50:41 INFO - PROCESS | 16874 | 03:50:43 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:44 INFO - PROCESS | 16874 | RSS: Main: 197066752 03:50:44 INFO - PROCESS | 16874 | 03:50:47 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:47 INFO - PROCESS | 16874 | RSS: Main: 197996544 03:50:47 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | Cycle 1(1): loaded http://localhost:49689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49689/tests/kraken/driver.html?testName=ai-astar) 03:50:49 INFO - PROCESS | 16874 | RSS: Main: 258621440 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | __start_tp_report 03:50:49 INFO - PROCESS | 16874 | _x_x_mozilla_page_load 03:50:49 INFO - PROCESS | 16874 | _x_x_mozilla_page_load_details 03:50:49 INFO - PROCESS | 16874 | |i|pagename|runs| 03:50:49 INFO - PROCESS | 16874 | |0;ai-astar;112;114;108;113;114;115;105;114;115;113 03:50:49 INFO - PROCESS | 16874 | |1;audio-beat-detection;158;136;156;171;133;161;159;136;174;133 03:50:49 INFO - PROCESS | 16874 | |2;audio-dft;161;163;161;160;161;163;164;162;162;161 03:50:49 INFO - PROCESS | 16874 | |3;audio-fft;77;79;108;92;73;80;74;114;97;74 03:50:49 INFO - PROCESS | 16874 | |4;audio-oscillator;95;95;132;94;95;96;144;95;94;143 03:50:49 INFO - PROCESS | 16874 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;118;117;117 03:50:49 INFO - PROCESS | 16874 | |6;imaging-darkroom;146;147;147;148;146;147;147;146;146;146 03:50:49 INFO - PROCESS | 16874 | |7;imaging-desaturate;96;96;96;96;95;96;96;96;96;96 03:50:49 INFO - PROCESS | 16874 | |8;json-parse-financial;67;66;66;66;67;66;66;76;73;66 03:50:49 INFO - PROCESS | 16874 | |9;json-stringify-tinderbox;69;69;69;69;70;69;70;69;69;69 03:50:49 INFO - PROCESS | 16874 | |10;stanford-crypto-aes;84;83;86;86;85;83;88;83;84;84 03:50:49 INFO - PROCESS | 16874 | |11;stanford-crypto-ccm;120;123;118;119;124;140;120;122;119;125 03:50:49 INFO - PROCESS | 16874 | |12;stanford-crypto-pbkdf2;154;139;155;156;160;138;146;146;147;153 03:50:49 INFO - PROCESS | 16874 | |13;stanford-crypto-sha256-iterative;71;70;73;69;71;70;71;70;70;69 03:50:49 INFO - PROCESS | 16874 | __end_tp_report 03:50:49 INFO - PROCESS | 16874 | __start_cc_report 03:50:49 INFO - PROCESS | 16874 | _x_x_mozilla_cycle_collect,1156 03:50:49 INFO - PROCESS | 16874 | __end_cc_report 03:50:49 INFO - PROCESS | 16874 | __startTimestamp1457697049782__endTimestamp 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | ------- Summary: start ------- 03:50:49 INFO - PROCESS | 16874 | Number of tests: 14 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:3.27 (2.9%) stddev-sans-first:3.46 03:50:49 INFO - PROCESS | 16874 | Values: 112.0 114.0 108.0 113.0 114.0 115.0 105.0 114.0 115.0 113.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.50 stddev:15.85 (10.0%) stddev-sans-first:16.64 03:50:49 INFO - PROCESS | 16874 | Values: 158.0 136.0 156.0 171.0 133.0 161.0 159.0 136.0 174.0 133.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 03:50:49 INFO - PROCESS | 16874 | Values: 161.0 163.0 161.0 160.0 161.0 163.0 164.0 162.0 162.0 161.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#3] audio-fft Cycles:10 Average:86.80 Median:78.00 stddev:15.06 (19.3%) stddev-sans-first:15.55 03:50:49 INFO - PROCESS | 16874 | Values: 77.0 79.0 108.0 92.0 73.0 80.0 74.0 114.0 97.0 74.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.88 (23.0%) stddev-sans-first:22.67 03:50:49 INFO - PROCESS | 16874 | Values: 95.0 95.0 132.0 94.0 95.0 96.0 144.0 95.0 94.0 143.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:50:49 INFO - PROCESS | 16874 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 03:50:49 INFO - PROCESS | 16874 | Values: 146.0 147.0 147.0 148.0 146.0 147.0 147.0 146.0 146.0 146.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:50:49 INFO - PROCESS | 16874 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:66.50 stddev:3.57 (5.4%) stddev-sans-first:3.77 03:50:49 INFO - PROCESS | 16874 | Values: 67.0 66.0 66.0 66.0 67.0 66.0 66.0 76.0 73.0 66.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 03:50:49 INFO - PROCESS | 16874 | Values: 69.0 69.0 69.0 69.0 70.0 69.0 70.0 69.0 69.0 69.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.65 (1.9%) stddev-sans-first:1.73 03:50:49 INFO - PROCESS | 16874 | Values: 84.0 83.0 86.0 86.0 85.0 83.0 88.0 83.0 84.0 84.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.50 stddev:6.41 (5.2%) stddev-sans-first:6.71 03:50:49 INFO - PROCESS | 16874 | Values: 120.0 123.0 118.0 119.0 124.0 140.0 120.0 122.0 119.0 125.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:153.50 stddev:7.37 (4.8%) stddev-sans-first:7.62 03:50:49 INFO - PROCESS | 16874 | Values: 154.0 139.0 155.0 156.0 160.0 138.0 146.0 146.0 147.0 153.0 03:50:49 INFO - PROCESS | 16874 | 03:50:49 INFO - PROCESS | 16874 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 03:50:49 INFO - PROCESS | 16874 | Values: 71.0 70.0 73.0 69.0 71.0 70.0 71.0 70.0 70.0 69.0 03:50:49 INFO - PROCESS | 16874 | -------- Summary: end -------- 03:50:49 INFO - PROCESS | 16874 | 03:50:50 INFO - TEST-INFO | 16874: exit 0 03:50:50 INFO - TEST-OK | kraken | took 62470ms 03:50:50 INFO - SUITE-END | took 1180s 03:50:50 INFO - Completed test suite (00:19:40) 03:50:50 INFO - javascript benchmark 03:50:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2568.152509671808, 2619.345163709073, 2642.220544939243, 2651.4431969286447, 2658.1892522780545, 4368.4102646142765, 4460.843870464534, 4463.040446304044, 4485.215087359711, 4491.887702807431, 4442.755648439334, 4506.887327816807, 4521.389612402333, 4521.434820647419, 4528.8867778305475, 4107.897302567445, 4133.813978370973, 4168.499780026401, 4173.0, 4236.97881510592, 4125.546189919107, 4173.457450531442, 4190.20386126635, 4204.11713540157, 4206.936895946563, 4027.3153563894207, 4105.507339119325, 4125.690573206992, 4130.256553820311, 4217.430646862665, 4105.0763578194965, 4124.05146816234, 4206.137741762931, 4227.725197862129, 4236.745795252264, 4143.3784932260105, 4150.522689890641, 4163.250614889319, 4192.685548583869, 4210.0, 4262.808173632194, 4431.047324825146, 4443.577860103285, 4453.220686379903, 4467.24056910326, 4733.24268117103, 4769.308450274691, 4770.308305295747, 4781.187198176283, 4809.470958194595, 4794.328793968847, 4795.4964728703335, 4798.23228283473, 4801.159797035505, 4828.372311599504, 4364.9127017460105, 4449.221386257456, 4458.197524445566, 4460.799264033127, 4489.393931819195, 4843.24929635907, 4892.315075889378, 4910.091633047826, 4957.90084198314, 4959.280904268933, 4694.201985662446, 4721.197396442544, 4722.740249286322, 4723.197056500335, 4771.475137734847, 4627.514111018362, 4741.905161896742, 4773.236282194832, 4804.975975120102, 4854.805807767721, 4733.95266047342, 4748.762561871893, 4752.2158843790385, 4782.210935195723, 4788.784504697227, 4721.220998535272, 4737.644676649265, 4741.028089241766, 4784.282357646381, 4789.928151077736, 3941.9014524637114, 3999.9000024999027, 4002.7198096132993, 4009.939850902239, 4019.2966230909474, 3535.911602209914, 3545.096000519851, 3562.9109272267883, 3564.0, 3609.2601016791496, 4151.14901445203, 4153.91692166161, 4155.314373128461, 4165.0, 4189.97905010473, 4595.862124136282, 4624.44506659203, 4802.327674125625, 4807.230843065093, 4820.807167713322, 4107.404426358221, 4111.7944102794745, 4112.157007813391, 4145.481814773153, 4148.979255103705, 4189.49726032878, 4230.809613567397, 4232.470941132358, 4264.936025959613, 4270.636995855325, 4416.094700586372, 4491.191585514639, 4505.954940450619, 4599.954000459952, 4615.607673347803, 4800.975995120002, 4807.326974223542, 4818.855434336975, 4825.3485779420735, 4846.345743324606, 4552.317152427162, 4560.4071470708595, 4565.201089809204, 4565.452145742533, 4610.40064791575, 4583.335416364675, 4671.205894997926, 4713.952860471489, 4753.9049219016115, 4762.880927976828, 4789.521047895182, 4792.0, 4803.3995750531185, 4804.807807687793, 4837.274408838703, 4535.092981403666, 4651.906961860812, 4655.767211639337, 4655.790489428052, 4697.577218050392, 4517.5030746617185, 4554.385158003627, 4560.908781824279, 4590.2196626572895, 4605.0, 4541.43232095988, 4553.886152846206, 4554.9316760249285, 4556.749378784199, 4611.146937816515, 4548.408706868086, 4660.067986402665, 4665.930011049905, 4666.510016448224, 4667.39323887906, 4394.868153955259, 4486.416765820422, 4491.056878055645, 4559.156556037144, 4577.038821847316], "unit": "score", "name": "dojo.html", "value": 4395.141172206104}, {"lowerIsBetter": false, "replicates": [498.5562849064331, 526.310533201506, 547.6932917566163, 558.5615291995781, 563.0821760530335, 32883.0, 33386.165345866364, 33476.33047339052, 33491.49762753561, 33561.83219083901, 36377.63622363775, 36907.4463883042, 36929.26141477169, 36943.63056369442, 36959.630403695955, 7602.2777836105615, 7790.143084260727, 7791.181925897784, 7791.532508049535, 7794.454388192828, 7649.579273140003, 7777.922220777805, 7783.688652453895, 7979.601019949008, 7984.720534781284, 7931.286184243417, 7990.320822730075, 8013.0384353877325, 8029.437939344249, 8029.839403211961, 7895.8420831583335, 7972.0, 7974.800629984239, 7976.920230797676, 7985.201479852027, 7855.13593504714, 7979.441439099207, 7986.0816006158875, 7987.161348058428, 7989.920100798976, 37379.25241495182, 37895.62104378976, 38020.0, 38070.80964595187, 38093.238135237414, 2656.296081538394, 2834.6881842997254, 2862.4418238443513, 3005.7144571265694, 3583.33708263972, 28253.717462825312, 28472.0, 29002.27494312638, 29196.124116276333, 29277.26806829825, 3459.135216195951, 3470.774399664014, 3494.248736521635, 3543.7519373643854, 3650.7992060436663, 221043.0, 221489.0, 221765.0, 222207.0, 222620.0, 38058.809705951295, 53119.46880531222, 53353.0, 53486.0, 53503.46496534985, 36255.0, 36420.0, 36425.27149456996, 36430.0, 36458.27083458369, 13267.270300133585, 13496.595102146952, 13517.121387109806, 13527.729445411036, 13533.932330338483, 10409.219308551888, 10409.843852342221, 10426.635067772591, 10461.790764184674, 10481.109105725945, 13252.867471325357, 13273.469061237636, 13281.335933203301, 13364.19814811095, 13440.865591343962, 5353.57171426285, 5393.541548968382, 5400.702961337164, 5453.972730136324, 5473.261109750133, 756.2097607999654, 791.9683212671429, 879.3712495565701, 959.6209497248688, 1018.7147598672384, 28253.0, 29233.85383073071, 29263.268418289714, 29716.40567188644, 29786.0, 907.5235501361706, 979.8236317462782, 989.2382865193761, 1020.8417695257247, 1047.350642601592, 13332.275058783744, 13775.795872660527, 13977.161370317814, 13987.440502379792, 14082.155070695791, 314170.0, 317114.0, 319716.0, 319795.0, 320441.0, 46926.53073469221, 47496.5250347499, 47536.0, 47621.28568071482, 47649.285260720426, 1145.8223975283677, 1187.3410257307105, 1226.6074856046157, 1236.486857953957, 1305.3147097773556, 24288.0, 26533.60199596969, 26577.0, 26663.20010399691, 27032.0, 36922.261554768214, 37099.0, 37434.43848342223, 37467.2506549862, 37473.06317342088, 198533.0, 199407.0, 200641.0, 200851.0, 200923.0, 23448.765512344657, 27624.72375276302, 27852.0, 28273.57589636116, 28380.716192838634, 32125.518117228727, 32440.351192975537, 41070.0, 41419.58580414157, 42196.367054493596, 32309.838450807594, 33228.0, 33250.16874578155, 33419.66580334165, 33952.83023584965, 32387.838060809547, 32771.50842737313, 32825.67174328226, 33103.66896331102, 33354.666453336125, 31867.681323186473, 32517.34965300728, 32774.50838237381, 32790.0, 32868.83565582157, 29612.259693507836, 29835.254118647208, 30167.396652066396, 30350.54474182845, 30365.848170759888, 23921.64117538273, 24051.27846164618, 24210.515789683755, 24373.14693985702, 24475.0], "unit": "score", "name": "ext.html", "value": 16172.248327426272}, {"lowerIsBetter": false, "replicates": [322.5505091479454, 324.263920899558, 330.43660558747325, 335.4096789650215, 340.2090140423516, 14373.20947347894, 15032.398704051839, 15558.299876505556, 15792.210389480537, 16178.19109044546, 11197.888021119787, 11589.304641721481, 13851.238181899991, 14473.276336183202, 15229.238538073107, 4673.392458980328, 4782.617390608743, 4820.0, 4860.829870954517, 4949.678270912397, 5068.96086302309, 5083.491650834905, 5099.898002039957, 5105.5149760772665, 5110.182370820669, 3260.8532616032217, 5016.122178618727, 5065.620078494109, 5200.427952925175, 5211.947880521184, 5185.585153187736, 5191.377034755854, 5192.662476938987, 5199.038177937075, 5200.973995130038, 4982.17794063979, 4995.700257984533, 4996.600271978233, 5026.949730502684, 5035.823746168867, 11868.050555955502, 13560.11859229147, 16945.830541694548, 17243.655126897393, 17458.825411745973, 1787.6156626325403, 1790.1049475262369, 2113.8625989310644, 2214.247155966963, 2372.5373552157334, 8220.05469371024, 8646.956765216197, 8789.912100878973, 8867.512286824222, 8921.86617200736, 1676.0697812713938, 1738.610606022861, 1789.337944960373, 1791.3192986665115, 1816.5095424235383, 54563.72718136424, 57402.71298643522, 58338.41661583415, 58570.41429585735, 58998.11502827461, 9567.856482152773, 9618.807623847484, 9728.124468797841, 9751.317407781387, 9839.55721992512, 12417.130800844036, 12455.937720311522, 12464.314462704457, 12469.189502682297, 12490.25058496475, 6439.291677915426, 6537.607743535308, 7126.857462850714, 7221.386182174469, 7268.6729097190755, 5498.202760599691, 6290.339514351019, 6430.164078669743, 6549.476041916635, 6553.508486863504, 4065.739620717528, 4103.373052520158, 4112.773797441169, 4124.711270211056, 4201.991522034689, 1594.3702237616076, 1602.6394061336107, 1674.4223242981152, 1729.6540691861678, 1755.1662960094109, 368.57245595109544, 411.88261345516383, 750.36594078004, 817.7015389382951, 825.108882406999, 9473.810523789485, 9817.558209880572, 9855.26085543587, 9921.702348929544, 10068.496575171212, 818.1491249100987, 857.9613917373733, 898.9640414383482, 937.7139972308512, 949.7340744591526, 8158.551279679675, 8264.132266112092, 8289.41974061822, 8294.58527073644, 8658.437201581877, 142422.0, 143294.0, 232822.0, 387667.0, 393448.0, 68900.6554967232, 68920.0, 69583.0, 70332.29667703257, 70629.2937070633, 927.6428574998539, 931.0596297739197, 945.3524335829978, 952.8856537215579, 956.5838860095741, 12858.485660573473, 12878.742425151257, 13028.934855325662, 13045.673858153623, 13114.868851311747, 28006.159815204763, 30484.847575761978, 30984.380312393176, 31470.0, 32022.839885800422, 39220.607793922834, 39384.60615393924, 39395.40906886342, 39697.40453893252, 40291.597084028785, 6873.175218973755, 7075.80940259332, 7086.751963681247, 7169.964150179216, 7289.671964761705, 10212.285140040423, 10970.451477426257, 10971.177161712743, 11138.220324577202, 11206.43967801623, 8896.911030889867, 9121.0, 9394.718158455258, 9433.57548910287, 9576.138147566753, 9249.260059195383, 9272.072792720674, 9345.299102567471, 9543.0, 9571.760705982406, 9161.954190229006, 9494.098060684224, 9600.519974001132, 9603.135717785433, 9626.95186524063, 6968.79093627192, 7229.277072292729, 7251.601161936144, 7306.31954650444, 7372.926270737438, 8343.374246931384, 9701.369410988545, 9787.902120978699, 9807.166390856857, 9919.355241909252], "unit": "score", "name": "jquery.html", "value": 7289.450502068097}, {"lowerIsBetter": false, "replicates": [1238.455079764904, 1340.778771502702, 1386.9167849929001, 1505.427937383794, 1727.9222434990415, 7073.328033836784, 7301.977723118767, 7304.233055529173, 7306.817329566757, 7309.0, 7123.252058533857, 7305.817354566138, 7313.926860731391, 7316.122065352152, 7318.817029574263, 2027.3917824652583, 2053.260826102602, 2056.5064384547677, 2058.495668561197, 2059.7837227091163, 2092.257248676721, 2097.937061888138, 2126.914923403062, 2188.73735151782, 2191.5069109450405, 2113.9048742806535, 2132.1577976699273, 2139.187108898624, 2143.046344376753, 2143.2498625481035, 2124.022949443258, 2126.2770657976207, 2127.4149608857533, 2127.6914847347202, 2129.180265597748, 2098.5068508900395, 2148.215901196068, 2148.8495805293637, 2149.9140034398606, 2151.4836439254623, 7438.442116841205, 7478.887816682754, 7483.4013278937555, 7487.887681684779, 7506.099268087864, 4199.622034016953, 4331.480222373304, 4334.13317336534, 4339.262325404688, 4340.13197360526, 2720.986395068032, 2811.9437611247863, 2833.0650885207833, 2852.101587999794, 2853.885844566215, 888.3337496877342, 897.4839467306259, 917.3716004536914, 940.5955439161158, 940.9858852117223, 9952.80094398108, 9968.601255949754, 9999.35004224723, 10018.048285412875, 10025.498725063791, 3859.3246181918053, 4005.4792876925812, 4010.639042486132, 4028.9798551007057, 4066.369712694537, 8541.359398045171, 8601.39790214679, 8610.062735884376, 8615.741527754177, 8617.655293788179, 4345.652347812231, 4367.432233809584, 4369.169857727085, 4372.1692878353015, 4373.781310934504, 3374.898753037413, 3764.9435258471144, 3898.4931958845737, 3928.2339943710704, 3929.685625149981, 3397.0827876473213, 3421.4525675891737, 3427.451607742799, 3464.116650254169, 3479.0, 1059.4014381874217, 1061.8354155105972, 1069.2782371898936, 1069.775347177086, 1077.0306723948509, 843.8354520868372, 846.4032856835915, 846.8814365988767, 912.6531917871166, 1152.2107356460851, 6515.381038801306, 6732.663366831639, 6751.4261287790105, 6755.93244067553, 6761.966190169018, 878.5870640798814, 908.7500937242311, 952.8618350339301, 962.7496850818837, 981.7300242433388, 5165.560927321145, 5203.661761985459, 5204.193350030751, 5233.450487698813, 5238.947610523922, 8529.104444033412, 9018.684346047858, 9061.818763624691, 9169.770755731026, 9176.724698259062, 8931.330150238759, 9000.144986226298, 9024.323175761712, 9045.502497362577, 9067.54662266884, 6892.276310987374, 6998.705239530703, 7021.859562808715, 7069.929300706927, 7077.858442831114, 6759.459243260429, 6759.493038022069, 6783.050372947692, 6786.287439818748, 6795.150606174228, 7826.7651970440975, 7983.081945576333, 8000.759977200693, 8023.398245131521, 8137.877931831145, 8149.592520373839, 8306.916930830614, 8510.659573616986, 8521.786955326166, 8530.616122274389, 6062.393760623902, 6076.66578338178, 6200.689965501797, 6222.81331560054, 6230.719617617127, 6983.860322793617, 7003.26465721092, 7045.26024767392, 7049.29507049291, 7102.893456598258, 6174.567780255339, 6448.290688024407, 6465.676716164267, 6513.381228783258, 6528.183977002875, 5535.0, 5765.827025189251, 6396.072569477493, 6416.45460135875, 6446.4520515756685, 6548.476121910331, 6624.701888414937, 6664.5334826561675, 6679.532432729662, 6682.866342673216, 5919.526437884872, 5950.285965684146, 5955.344912059583, 5969.283685957713, 5995.0, 6071.089336599545, 6107.358727333743, 6117.694115294128, 6117.908231376444, 6122.418370254997], "unit": "score", "name": "mootools.html", "value": 4151.451631900337}, {"lowerIsBetter": false, "replicates": [296.76258992805754, 302.1373977294823, 304.31984514609843, 308.9536569514574, 309.05121277677523, 5179.792808287673, 5259.500347466994, 5275.8153464628695, 5315.840524784253, 5328.333958255218, 5256.106461901476, 5283.682979021251, 5324.946750532494, 5332.200169974506, 5335.279737235472, 3829.444730514074, 3909.76541407515, 4026.4161696553983, 4029.375446805735, 4061.8984525386954, 4042.7170098093147, 4052.4731784868072, 4055.047063939972, 4056.9188616227657, 4060.1067765091634, 4001.899952501182, 4005.879823605282, 4008.298547754146, 4009.719319647626, 4010.7994600270017, 3821.0065383000483, 3908.9804550977346, 4013.4581831452965, 4017.8191981360765, 4022.9195416091807, 3438.828058597085, 3466.757326987112, 3467.514547963287, 3482.2687235680537, 3489.4416893297202, 5037.622178336603, 5041.092603331399, 5045.571126454256, 5064.544191022789, 5068.214426763858, 4584.633229341644, 4586.403767510203, 4596.448426188878, 4598.287265473857, 4601.838935637236, 5516.668999859981, 5518.2826232589905, 5518.33779946405, 5522.6134170608075, 5529.585281103933, 3790.8862734117743, 3795.69634429245, 3799.6010418905894, 3801.1257410795397, 3807.0292075520842, 5674.489295963342, 5754.165645981309, 5828.825135245949, 5837.0, 5845.0, 3876.4379165020914, 3893.4354518594646, 3893.5717071122153, 3896.473976013202, 3901.492805935267, 3952.2293152835496, 3954.070793363557, 3957.050307926135, 3965.107850733562, 3968.5634580196156, 4555.840545580955, 4575.771211439482, 4576.313552967082, 4576.748278844629, 4579.839705610288, 5551.555875530029, 5554.305711786027, 5563.582731295169, 5564.4991950724625, 5567.24842146305, 1373.478078330248, 1399.8530154333853, 1400.7828786538103, 1401.0542883553765, 1402.137685323539, 861.793169639282, 906.4470672889532, 933.7665583604099, 959.7168835193635, 961.0677642686583, 4781.617470602343, 4874.902501950012, 4876.268559716, 4882.633802464829, 4884.9511504884495, 5713.628614140068, 5721.771129154788, 5723.656580605177, 5726.9713651431475, 5747.425257474303, 4914.975425122923, 4933.654644174945, 4935.605151587864, 4939.110960027229, 4940.481249468754, 3071.9078427647205, 3099.1477343730653, 3115.3302040061494, 3116.56368108465, 3119.906402807919, 5453.509184173444, 5461.918071228934, 5464.672119672832, 5466.289382380344, 5467.890642187134, 5746.339170995306, 5946.167536544887, 5963.165156878041, 6004.039353703386, 6061.484773794277, 5444.0, 5464.426235245242, 5468.097763868917, 5469.535089517356, 5473.124300111963, 5789.94210057894, 5803.535717142703, 5803.622764520293, 5809.709514524341, 5813.069908814569, 5658.292713410824, 5687.573431992534, 5687.630304030225, 5695.8860822784145, 5711.8000869969355, 5422.105352616774, 5462.20797984298, 5465.672059676433, 5473.0, 5474.315710536183, 3767.190054138264, 3887.047673320055, 3887.825047872909, 3909.7849618271266, 3968.4642573253395, 5713.114467257582, 5740.225069615715, 5742.36833948257, 5743.253377060955, 5749.252597162342, 5530.917036244379, 5532.419095994863, 5539.473749993744, 5542.418046105101, 5544.972275138599, 5477.4796394342475, 5518.779248830162, 5533.7786488540005, 5542.8337149885565, 5550.084236100998, 5432.0, 5434.266374039454, 5437.9396017777735, 5443.564514838883, 5445.727713614224, 5414.35027796667, 5576.275084239023, 5583.916241256466, 5588.133839254922, 5591.9375318690945, 5317.920231196458, 5345.251664766858, 5351.143816989263, 5351.732413379394, 5354.705491198021], "unit": "score", "name": "prototype.html", "value": 4138.949450324254}, {"lowerIsBetter": false, "replicates": [580.814139475368, 601.1043545117775, 721.90976127984, 734.3501001613573, 735.2463724682196, 11714.53141874325, 11943.940280298597, 11957.820632690517, 11987.880121198785, 11991.580294689687, 13447.462101515928, 13708.177509349445, 13715.314234288271, 13735.313234338293, 13741.106828056169, 628.8207860759684, 790.5651891459703, 794.4002278279919, 801.4710291207804, 803.0724513187278, 808.7816289601803, 811.9553424561647, 813.6704634622957, 814.2590242878952, 814.9470284431522, 840.1598401598402, 841.7600983719641, 841.9368547358941, 843.877637742527, 845.2730651639584, 654.5777973207279, 839.2866063845744, 840.7435732101707, 841.20506121715, 856.2336708645789, 628.7862126876838, 630.1839118341759, 630.6941133550224, 631.2929518938818, 631.5042691487206, 12650.746985060247, 13129.474821007148, 13130.34348282582, 13144.802827957588, 13152.671183220496, 12141.210821296676, 12657.556985505464, 12690.746185076247, 12706.364681765876, 12906.935465322613, 9719.416834989852, 9761.51192440375, 9793.608255669764, 9893.159081478083, 9921.107100361001, 3264.967350326514, 3308.354870800195, 3368.8484018219237, 3415.351083294191, 3419.059758566389, 41307.7934610328, 42576.1484770306, 42767.0, 42807.0, 42864.57135428637, 9801.705948821404, 9813.901860981441, 9814.263930205263, 9956.850647240297, 9979.10188083076, 17286.913565432344, 17320.220590073477, 17323.653526929644, 17352.566185845455, 17363.0, 6472.708728107246, 6601.966990165114, 6620.602763834186, 6735.966320168368, 6807.183138023469, 3534.6642069003406, 3660.450932360114, 3676.3933950897804, 3723.3298006359114, 3785.167263202091, 2840.2189397915326, 2880.683124856264, 2884.322184286691, 2887.768978481716, 2893.6382952130984, 520.5029197116744, 533.6451259912193, 538.4265756968815, 540.9756560954767, 545.1087471983257, 493.181319010441, 520.4613225311859, 527.2328761651787, 531.7846272259741, 539.54947618738, 7078.115235595551, 7172.892406613905, 7263.0, 7404.0, 7488.625568721543, 491.1257960829729, 521.3274875410677, 522.9163333866563, 525.1282870435059, 531.3051366141995, 3375.206826395795, 3376.2652251676222, 3381.898543043713, 3413.9317213655586, 3431.262278610111, 46870.296945545844, 47345.5265447348, 47356.526434735904, 47922.76038619784, 48817.75591122093, 40290.798546007085, 40926.590734092875, 41193.79403103025, 41233.0, 41356.0, 37025.81487092601, 39383.092536119235, 39441.605583944365, 39700.20599587992, 40183.59816401857, 7979.640916158671, 8053.557054362066, 8147.655636819858, 8226.341892648454, 8460.619272132646, 30205.69794302029, 30768.538471923388, 31943.201419964687, 31962.52056219205, 32104.83947580247, 35959.460608090376, 36807.26385472329, 36901.815490922374, 38112.809435952644, 40056.3991540133, 10297.794044118926, 10308.896911030793, 10391.636292729718, 10421.68734937953, 10422.635207767691, 10574.894251057698, 10889.0, 11096.33421994683, 11189.04893084097, 11233.775324493628, 8324.417290789586, 8919.910800891908, 10324.638637647646, 10363.356704820108, 10737.677869663923, 10132.493375331056, 10288.434136122585, 10428.687139385831, 10543.472826358804, 10583.894161058599, 9992.52876425784, 10174.796504069729, 10436.739081523023, 10469.895301047196, 10596.099331556905, 8710.69512567057, 8768.386212965032, 8911.37620366568, 9033.187013168847, 9204.217641500547, 8747.518886461306, 8800.295976322006, 9103.954480227556, 9158.221551168226, 9253.213476854542], "unit": "score", "name": "yui.html", "value": 5738.674506592344}], "name": "dromaeo_css", "value": 6091.5862971082215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 113.0, 114.0, 115.0, 105.0, 114.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [158.0, 136.0, 156.0, 171.0, 133.0, 161.0, 159.0, 136.0, 174.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 160.0, 161.0, 163.0, 164.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 108.0, 92.0, 73.0, 80.0, 74.0, 114.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 132.0, 94.0, 95.0, 96.0, 144.0, 95.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 76.0, 73.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 86.0, 86.0, 85.0, 83.0, 88.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [120.0, 123.0, 118.0, 119.0, 124.0, 140.0, 120.0, 122.0, 119.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [154.0, 139.0, 155.0, 156.0, 160.0, 138.0, 146.0, 146.0, 147.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 73.0, 69.0, 71.0, 70.0, 71.0, 70.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1545.2}]} 03:50:51 INFO - Return code: 0 03:50:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:50:51 ERROR - # TBPL SUCCESS # 03:50:51 INFO - Running post-action listener: _resource_record_post_action 03:50:51 INFO - Running post-run listener: _resource_record_post_run 03:50:52 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 534659072; Read time: 0; Write time: 822376 03:50:52 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 243437568; Read time: 0; Write time: 442520 03:50:52 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287277056; Read time: 0; Write time: 379004 03:50:52 INFO - Running post-run listener: _upload_blobber_files 03:50:52 INFO - Blob upload gear active. 03:50:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:52 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 03:50:52 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'] 03:50:52 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 03:50:52 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:53 INFO - (blobuploader) - INFO - Done attempting. 03:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:54 INFO - (blobuploader) - INFO - Done attempting. 03:50:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:54 INFO - Return code: 0 03:50:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bb3240a323fa1d9cdc7c82b40a9f44cc8750c6ae4cd24550efa8e6e71703b11cc8585d640c0daaf9bee6d1d3ecfc0e531db28f4d6041328e4146696846b395a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8819a0eadf52c123617af1774077f7f4c96491393414ce914f7fab334302d5cbe59efc1b72683ec4f693b81f6bad745d9c7ef0fb50e6330b0add4fa473d455dd"} 03:50:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:54 INFO - Contents: 03:50:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bb3240a323fa1d9cdc7c82b40a9f44cc8750c6ae4cd24550efa8e6e71703b11cc8585d640c0daaf9bee6d1d3ecfc0e531db28f4d6041328e4146696846b395a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8819a0eadf52c123617af1774077f7f4c96491393414ce914f7fab334302d5cbe59efc1b72683ec4f693b81f6bad745d9c7ef0fb50e6330b0add4fa473d455dd"} 03:50:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:54 INFO - Copying logs to upload dir... 03:50:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.966563 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-11 03:50:53.059360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:53.064115) ========= 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 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/1bb3240a323fa1d9cdc7c82b40a9f44cc8750c6ae4cd24550efa8e6e71703b11cc8585d640c0daaf9bee6d1d3ecfc0e531db28f4d6041328e4146696846b395a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8819a0eadf52c123617af1774077f7f4c96491393414ce914f7fab334302d5cbe59efc1b72683ec4f693b81f6bad745d9c7ef0fb50e6330b0add4fa473d455dd"} build_url:https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/NtRuNaOCRsuteKrDGvJvUQ/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/1bb3240a323fa1d9cdc7c82b40a9f44cc8750c6ae4cd24550efa8e6e71703b11cc8585d640c0daaf9bee6d1d3ecfc0e531db28f4d6041328e4146696846b395a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8819a0eadf52c123617af1774077f7f4c96491393414ce914f7fab334302d5cbe59efc1b72683ec4f693b81f6bad745d9c7ef0fb50e6330b0add4fa473d455dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:53.091760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:53.092139) ========= 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=fa44defc139c4ba8574fe040000001db-1457690486.213572-295820957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:50:53.176987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 03:50:53.177391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 03:50:53.177767) ========= ========= Total master_lag: 0.31 =========