builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1459528497.33 results: success (0) buildid: 20160401085456 builduid: a730c68d22d14c8ba73cd86e232beb97 revision: a1df259b9ea322baaff78eeafa3bbf7b5f366e8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.327099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.327535) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.327820) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006292 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.350296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.350582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.364275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.364568) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.414388) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.414663) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.414996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.415284) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 09:34:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-04-01 09:34:58 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.514718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.515029) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023012 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.564940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:57.565286) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1df259b9ea322baaff78eeafa3bbf7b5f366e8b --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 a1df259b9ea322baaff78eeafa3bbf7b5f366e8b --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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 09:34:58,121 truncating revision to first 12 chars 2016-04-01 09:34:58,121 Setting DEBUG logging. 2016-04-01 09:34:58,121 attempt 1/10 2016-04-01 09:34:58,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1df259b9ea3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 09:34:58,708 unpacking tar archive at: fx-team-a1df259b9ea3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:58.464695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:58.465061) ========= echo a1df259b9ea322baaff78eeafa3bbf7b5f366e8b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a1df259b9ea322baaff78eeafa3bbf7b5f366e8b'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a1df259b9ea322baaff78eeafa3bbf7b5f366e8b program finished with exit code 0 elapsedTime=0.004380 script_repo_revision: 'a1df259b9ea322baaff78eeafa3bbf7b5f366e8b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:58.513757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:58.514051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 09:34:58.523899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-01 09:34:58.524171) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:34:59 INFO - MultiFileLogger online at 20160401 09:34:59 in /builds/slave/test 09:34:59 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 09:34:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:34:59 INFO - {'append_to_log': False, 09:34:59 INFO - 'base_work_dir': '/builds/slave/test', 09:34:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:34:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:34:59 INFO - 'branch': 'Fx-Team-Non-PGO', 09:34:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:34:59 INFO - 'config_files': ('talos/linux_config.py',), 09:34:59 INFO - 'default_actions': ('clobber', 09:34:59 INFO - 'read-buildbot-config', 09:34:59 INFO - 'download-and-extract', 09:34:59 INFO - 'populate-webroot', 09:34:59 INFO - 'create-virtualenv', 09:34:59 INFO - 'install', 09:34:59 INFO - 'run-tests'), 09:34:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:34:59 INFO - 'download_minidump_stackwalk': True, 09:34:59 INFO - 'download_symbols': 'ondemand', 09:34:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:34:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:34:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:34:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:34:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:34:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:34:59 INFO - 'installer_path': 'installer.exe', 09:34:59 INFO - 'log_level': 'info', 09:34:59 INFO - 'log_name': 'talos', 09:34:59 INFO - 'log_to_console': True, 09:34:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:34:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:34:59 INFO - 'opt_config_files': (), 09:34:59 INFO - 'pip_index': False, 09:34:59 INFO - 'sps_profile': False, 09:34:59 INFO - 'sps_profile_interval': 0, 09:34:59 INFO - 'suite': 'dromaeojs', 09:34:59 INFO - 'system_bits': '32', 09:34:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:34:59 INFO - 'title': 'talos-linux64-ix-041', 09:34:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:34:59 INFO - 'use_talos_json': True, 09:34:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:34:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:34:59 INFO - 'work_dir': 'build'} 09:34:59 INFO - ##### 09:34:59 INFO - ##### Running clobber step. 09:34:59 INFO - ##### 09:34:59 INFO - Running pre-action listener: _resource_record_pre_action 09:34:59 INFO - Running main action method: clobber 09:34:59 INFO - rmtree: /builds/slave/test/build 09:34:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:00 INFO - Running post-action listener: _resource_record_post_action 09:35:00 INFO - ##### 09:35:00 INFO - ##### Running read-buildbot-config step. 09:35:00 INFO - ##### 09:35:00 INFO - Running pre-action listener: _resource_record_pre_action 09:35:00 INFO - Running main action method: read_buildbot_config 09:35:00 INFO - Using buildbot properties: 09:35:00 INFO - { 09:35:00 INFO - "project": "", 09:35:00 INFO - "product": "firefox", 09:35:00 INFO - "script_repo_revision": "production", 09:35:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:35:00 INFO - "repository": "", 09:35:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:35:00 INFO - "buildid": "20160401085456", 09:35:00 INFO - "pgo_build": "False", 09:35:00 INFO - "basedir": "/builds/slave/test", 09:35:00 INFO - "buildnumber": 1526, 09:35:00 INFO - "slavename": "talos-linux64-ix-041", 09:35:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:35:00 INFO - "platform": "ubuntu64_hw", 09:35:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:35:00 INFO - "branch": "fx-team", 09:35:00 INFO - "repo_path": "integration/fx-team", 09:35:00 INFO - "revision": "a1df259b9ea322baaff78eeafa3bbf7b5f366e8b", 09:35:00 INFO - "stage_platform": "linux64", 09:35:00 INFO - "builduid": "a730c68d22d14c8ba73cd86e232beb97", 09:35:00 INFO - "slavebuilddir": "test" 09:35:00 INFO - } 09:35:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:35:00 INFO - Running post-action listener: _resource_record_post_action 09:35:00 INFO - ##### 09:35:00 INFO - ##### Running download-and-extract step. 09:35:00 INFO - ##### 09:35:00 INFO - Running pre-action listener: _resource_record_pre_action 09:35:00 INFO - Running main action method: download_and_extract 09:35:00 INFO - mkdir: /builds/slave/test/build/tests 09:35:00 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')]} 09:35:00 INFO - https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:35:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:35:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:35:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:00 INFO - Downloaded 1361 bytes. 09:35:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:35:00 INFO - Using the following test package requirements: 09:35:00 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:00 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:00 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:35:00 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'jsshell-linux-x86_64.zip'], 09:35:00 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:00 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:00 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:35:00 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:35:00 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:00 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:00 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35:00 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')]} 09:35:00 INFO - https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:35:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:35:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:01 INFO - Downloaded 22112239 bytes. 09:35:01 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'] 09:35:01 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 09:35:03 INFO - Return code: 0 09:35:03 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 09:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:03 INFO - https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:35:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:35:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:04 INFO - Downloaded 22112239 bytes. 09:35:04 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'] 09:35:04 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 09:35:05 INFO - Return code: 0 09:35:05 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')]} 09:35:05 INFO - https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:35:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:06 INFO - Downloaded 10847534 bytes. 09:35:06 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'] 09:35:06 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 09:35:06 INFO - Return code: 0 09:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:06 INFO - https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:35:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:35:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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 09:35:10 INFO - Downloaded 54222849 bytes. 09:35:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:35:10 INFO - mkdir: /builds/slave/test/properties 09:35:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:10 INFO - Contents: 09:35:10 INFO - build_url:https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:35:11 INFO - Running post-action listener: _resource_record_post_action 09:35:11 INFO - Running post-action listener: set_extra_try_arguments 09:35:11 INFO - ##### 09:35:11 INFO - ##### Running populate-webroot step. 09:35:11 INFO - ##### 09:35:11 INFO - Running pre-action listener: _resource_record_pre_action 09:35:11 INFO - Running main action method: populate_webroot 09:35:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:11 INFO - '--tppagecycles', 09:35:11 INFO - '7'], 09:35:11 INFO - 'tests': ['tsvgm']}}, 09:35:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:35:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:35:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'tests': ['damp', 'tps']}, 09:35:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['damp', 'tps']}, 09:35:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:35:11 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['dromaeo_dom']}, 09:35:11 INFO - 'other': {'tests': ['a11yr', 09:35:11 INFO - 'ts_paint', 09:35:11 INFO - 'tpaint', 09:35:11 INFO - 'sessionrestore', 09:35:11 INFO - 'sessionrestore_no_auto_restore', 09:35:11 INFO - 'tabpaint']}, 09:35:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['a11yr', 09:35:11 INFO - 'ts_paint', 09:35:11 INFO - 'tpaint', 09:35:11 INFO - 'sessionrestore', 09:35:11 INFO - 'sessionrestore_no_auto_restore', 09:35:11 INFO - 'tabpaint']}, 09:35:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['a11yr', 09:35:11 INFO - 'ts_paint', 09:35:11 INFO - 'tpaint', 09:35:11 INFO - 'sessionrestore', 09:35:11 INFO - 'sessionrestore_no_auto_restore', 09:35:11 INFO - 'tabpaint']}, 09:35:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['a11yr', 09:35:11 INFO - 'ts_paint', 09:35:11 INFO - 'tpaint', 09:35:11 INFO - 'sessionrestore', 09:35:11 INFO - 'sessionrestore_no_auto_restore', 09:35:11 INFO - 'tabpaint']}, 09:35:11 INFO - 'other_l64': {'tests': ['a11yr', 09:35:11 INFO - 'ts_paint', 09:35:11 INFO - 'tpaint', 09:35:11 INFO - 'sessionrestore', 09:35:11 INFO - 'sessionrestore_no_auto_restore', 09:35:11 INFO - 'tabpaint']}, 09:35:11 INFO - 'other_nol64': {'tests': ['a11yr', 09:35:11 INFO - 'ts_paint', 09:35:11 INFO - 'tpaint', 09:35:11 INFO - 'sessionrestore', 09:35:11 INFO - 'sessionrestore_no_auto_restore', 09:35:11 INFO - 'tabpaint']}, 09:35:11 INFO - 'svgr': {'tests': ['tsvgx', 09:35:11 INFO - 'tsvgr_opacity', 09:35:11 INFO - 'tart', 09:35:11 INFO - 'tscrollx', 09:35:11 INFO - 'cart']}, 09:35:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['tsvgx', 09:35:11 INFO - 'tsvgr_opacity', 09:35:11 INFO - 'tart', 09:35:11 INFO - 'tscrollx', 09:35:11 INFO - 'cart']}, 09:35:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'tests': ['tp5o']}, 09:35:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'talos_options': ['--e10s'], 09:35:11 INFO - 'tests': ['tp5o']}, 09:35:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'talos_options': ['--xperf_path', 09:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:11 INFO - 'tests': ['tp5n']}, 09:35:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:11 INFO - 'talos_options': ['--e10s', 09:35:11 INFO - '--xperf_path', 09:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:11 INFO - 'tests': ['tp5n']}}, 09:35:11 INFO - 'talos.zip': {'path': '', 09:35:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:11 INFO - Running post-action listener: _resource_record_post_action 09:35:11 INFO - ##### 09:35:11 INFO - ##### Running create-virtualenv step. 09:35:11 INFO - ##### 09:35:11 INFO - Running pre-action listener: _resource_record_pre_action 09:35:11 INFO - Running main action method: create_virtualenv 09:35:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:11 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 09:35:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:11 INFO - Using real prefix '/usr' 09:35:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:14 INFO - Installing pip.................done. 09:35:14 INFO - Return code: 0 09:35:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35:14 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')]} 09:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:14 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')]} 09:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:14 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:14 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 09:35:14 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 09:35:14 INFO - Using env: {'DISPLAY': ':0', 09:35:14 INFO - 'HOME': '/home/cltbld', 09:35:14 INFO - 'LANG': 'en_US.UTF-8', 09:35:14 INFO - 'LANGUAGE': 'en_US:en', 09:35:14 INFO - 'LOGNAME': 'cltbld', 09:35:14 INFO - 'MAIL': '/var/mail/cltbld', 09:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:14 INFO - 'MOZ_NO_REMOTE': '1', 09:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:14 INFO - 'NO_EM_RESTART': '1', 09:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:14 INFO - 'PWD': '/builds/slave/test', 09:35:14 INFO - 'SHELL': '/bin/bash', 09:35:14 INFO - 'SHLVL': '1', 09:35:14 INFO - 'TERM': 'linux', 09:35:14 INFO - 'TMOUT': '86400', 09:35:14 INFO - 'USER': 'cltbld', 09:35:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:14 INFO - '_': '/tools/buildbot/bin/python'} 09:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:14 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 09:35:14 INFO - Cleaning up... 09:35:14 INFO - Return code: 0 09:35:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:35:14 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')]} 09:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:14 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')]} 09:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:14 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:14 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 09:35:14 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 09:35:14 INFO - Using env: {'DISPLAY': ':0', 09:35:14 INFO - 'HOME': '/home/cltbld', 09:35:14 INFO - 'LANG': 'en_US.UTF-8', 09:35:14 INFO - 'LANGUAGE': 'en_US:en', 09:35:14 INFO - 'LOGNAME': 'cltbld', 09:35:14 INFO - 'MAIL': '/var/mail/cltbld', 09:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:14 INFO - 'MOZ_NO_REMOTE': '1', 09:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:14 INFO - 'NO_EM_RESTART': '1', 09:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:14 INFO - 'PWD': '/builds/slave/test', 09:35:14 INFO - 'SHELL': '/bin/bash', 09:35:14 INFO - 'SHLVL': '1', 09:35:14 INFO - 'TERM': 'linux', 09:35:14 INFO - 'TMOUT': '86400', 09:35:14 INFO - 'USER': 'cltbld', 09:35:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:14 INFO - '_': '/tools/buildbot/bin/python'} 09:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:14 INFO - Downloading/unpacking psutil>=0.7.1 09:35:14 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 09:35:14 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 09:35:14 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 09:35:14 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 09:35:14 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 09:35:14 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 09:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:16 INFO - Installing collected packages: psutil 09:35:16 INFO - Running setup.py install for psutil 09:35:16 INFO - building 'psutil._psutil_linux' extension 09:35:16 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 09:35:16 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 09:35:16 INFO - building 'psutil._psutil_posix' extension 09:35:16 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 09:35:17 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 09:35:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:17 INFO - Successfully installed psutil 09:35:17 INFO - Cleaning up... 09:35:17 INFO - Return code: 0 09:35:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:17 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:17 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 09:35:17 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 09:35:17 INFO - Using env: {'DISPLAY': ':0', 09:35:17 INFO - 'HOME': '/home/cltbld', 09:35:17 INFO - 'LANG': 'en_US.UTF-8', 09:35:17 INFO - 'LANGUAGE': 'en_US:en', 09:35:17 INFO - 'LOGNAME': 'cltbld', 09:35:17 INFO - 'MAIL': '/var/mail/cltbld', 09:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:17 INFO - 'MOZ_NO_REMOTE': '1', 09:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:17 INFO - 'NO_EM_RESTART': '1', 09:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:17 INFO - 'PWD': '/builds/slave/test', 09:35:17 INFO - 'SHELL': '/bin/bash', 09:35:17 INFO - 'SHLVL': '1', 09:35:17 INFO - 'TERM': 'linux', 09:35:17 INFO - 'TMOUT': '86400', 09:35:17 INFO - 'USER': 'cltbld', 09:35:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:17 INFO - '_': '/tools/buildbot/bin/python'} 09:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 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 09:35:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:35:19 INFO - Installing collected packages: mozsystemmonitor 09:35:19 INFO - Running setup.py install for mozsystemmonitor 09:35:19 INFO - Successfully installed mozsystemmonitor 09:35:19 INFO - Cleaning up... 09:35:19 INFO - Return code: 0 09:35:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:19 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:19 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 09:35:19 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 09:35:19 INFO - Using env: {'DISPLAY': ':0', 09:35:19 INFO - 'HOME': '/home/cltbld', 09:35:19 INFO - 'LANG': 'en_US.UTF-8', 09:35:19 INFO - 'LANGUAGE': 'en_US:en', 09:35:19 INFO - 'LOGNAME': 'cltbld', 09:35:19 INFO - 'MAIL': '/var/mail/cltbld', 09:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:19 INFO - 'MOZ_NO_REMOTE': '1', 09:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:19 INFO - 'NO_EM_RESTART': '1', 09:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:19 INFO - 'PWD': '/builds/slave/test', 09:35:19 INFO - 'SHELL': '/bin/bash', 09:35:19 INFO - 'SHLVL': '1', 09:35:19 INFO - 'TERM': 'linux', 09:35:19 INFO - 'TMOUT': '86400', 09:35:19 INFO - 'USER': 'cltbld', 09:35:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:19 INFO - '_': '/tools/buildbot/bin/python'} 09:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:19 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 09:35:19 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 09:35:19 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 09:35:19 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 09:35:19 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 09:35:19 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 09:35:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:35:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 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 09:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:35:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 INFO - Downloading docopt-0.6.1.tar.gz 09:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:35:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:35:22 INFO - Running setup.py install for blobuploader 09:35:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:35:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:35:22 INFO - Running setup.py install for requests 09:35:22 INFO - Running setup.py install for docopt 09:35:22 INFO - Successfully installed blobuploader requests docopt 09:35:22 INFO - Cleaning up... 09:35:23 INFO - Return code: 0 09:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:23 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 09:35:23 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 09:35:23 INFO - Using env: {'DISPLAY': ':0', 09:35:23 INFO - 'HOME': '/home/cltbld', 09:35:23 INFO - 'LANG': 'en_US.UTF-8', 09:35:23 INFO - 'LANGUAGE': 'en_US:en', 09:35:23 INFO - 'LOGNAME': 'cltbld', 09:35:23 INFO - 'MAIL': '/var/mail/cltbld', 09:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:23 INFO - 'MOZ_NO_REMOTE': '1', 09:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:23 INFO - 'NO_EM_RESTART': '1', 09:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:23 INFO - 'PWD': '/builds/slave/test', 09:35:23 INFO - 'SHELL': '/bin/bash', 09:35:23 INFO - 'SHLVL': '1', 09:35:23 INFO - 'TERM': 'linux', 09:35:23 INFO - 'TMOUT': '86400', 09:35:23 INFO - 'USER': 'cltbld', 09:35:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:23 INFO - '_': '/tools/buildbot/bin/python'} 09:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:23 INFO - Running setup.py (path:/tmp/pip-AByh6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:23 INFO - Running setup.py (path:/tmp/pip-qk2Qku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:23 INFO - Running setup.py (path:/tmp/pip-UpGkgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:23 INFO - Running setup.py (path:/tmp/pip-Ja09ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:23 INFO - Running setup.py (path:/tmp/pip-8h_LLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:23 INFO - Running setup.py (path:/tmp/pip-64b2W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:23 INFO - Running setup.py (path:/tmp/pip-ld8X51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:23 INFO - Running setup.py (path:/tmp/pip-cFtCOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:23 INFO - Running setup.py (path:/tmp/pip-ApOPEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:23 INFO - Running setup.py (path:/tmp/pip-qtwzfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:23 INFO - Running setup.py (path:/tmp/pip-DSRqxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:24 INFO - Running setup.py (path:/tmp/pip-MJw3x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:24 INFO - Running setup.py (path:/tmp/pip-8r7hzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:24 INFO - Running setup.py (path:/tmp/pip-mI1G7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:24 INFO - Running setup.py (path:/tmp/pip-6x5oz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:24 INFO - Running setup.py (path:/tmp/pip-PRjnXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:24 INFO - Running setup.py (path:/tmp/pip-vOXpc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:35:24 INFO - Running setup.py install for manifestparser 09:35:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:35:24 INFO - Running setup.py install for mozcrash 09:35:24 INFO - Running setup.py install for mozdebug 09:35:24 INFO - Running setup.py install for mozdevice 09:35:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:35:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:35:24 INFO - Running setup.py install for mozfile 09:35:25 INFO - Running setup.py install for mozhttpd 09:35:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozinfo 09:35:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozInstall 09:35:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozleak 09:35:25 INFO - Running setup.py install for mozlog 09:35:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for moznetwork 09:35:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozprocess 09:35:25 INFO - Running setup.py install for mozprofile 09:35:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozrunner 09:35:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozscreenshot 09:35:26 INFO - Running setup.py install for moztest 09:35:26 INFO - Running setup.py install for mozversion 09:35:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:35:26 INFO - Cleaning up... 09:35:26 INFO - Return code: 0 09:35:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:26 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:26 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 09:35:26 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 09:35:26 INFO - Using env: {'DISPLAY': ':0', 09:35:26 INFO - 'HOME': '/home/cltbld', 09:35:26 INFO - 'LANG': 'en_US.UTF-8', 09:35:26 INFO - 'LANGUAGE': 'en_US:en', 09:35:26 INFO - 'LOGNAME': 'cltbld', 09:35:26 INFO - 'MAIL': '/var/mail/cltbld', 09:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:26 INFO - 'MOZ_NO_REMOTE': '1', 09:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:26 INFO - 'NO_EM_RESTART': '1', 09:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:26 INFO - 'PWD': '/builds/slave/test', 09:35:26 INFO - 'SHELL': '/bin/bash', 09:35:26 INFO - 'SHLVL': '1', 09:35:26 INFO - 'TERM': 'linux', 09:35:26 INFO - 'TMOUT': '86400', 09:35:26 INFO - 'USER': 'cltbld', 09:35:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:26 INFO - '_': '/tools/buildbot/bin/python'} 09:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:26 INFO - Running setup.py (path:/tmp/pip-Mr3x5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:26 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)) 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:26 INFO - Running setup.py (path:/tmp/pip-JqmDaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:26 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)) 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:26 INFO - Running setup.py (path:/tmp/pip-ExEYYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:26 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)) 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:26 INFO - Running setup.py (path:/tmp/pip-0YlH7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:26 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)) 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:26 INFO - Running setup.py (path:/tmp/pip-nhKwQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:26 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)) 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:26 INFO - Running setup.py (path:/tmp/pip-bJ_saU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:26 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)) 09:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:26 INFO - Running setup.py (path:/tmp/pip-zTmzh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:27 INFO - Running setup.py (path:/tmp/pip-SVSH4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:27 INFO - Running setup.py (path:/tmp/pip-IgNEbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:27 INFO - Running setup.py (path:/tmp/pip-muWD3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:27 INFO - Running setup.py (path:/tmp/pip-gNIUJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:27 INFO - Running setup.py (path:/tmp/pip-0h7F9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:27 INFO - Running setup.py (path:/tmp/pip-mkiyAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:27 INFO - Running setup.py (path:/tmp/pip-9f3fKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:27 INFO - Running setup.py (path:/tmp/pip-4aqG0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:27 INFO - Running setup.py (path:/tmp/pip-aXiDiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:27 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)) 09:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:27 INFO - Running setup.py (path:/tmp/pip-R7QZHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:27 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)) 09:35:27 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)) 09:35:27 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)) 09:35:27 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)) 09:35:27 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)) 09:35:27 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)) 09:35:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:29 INFO - Downloading blessings-1.6.tar.gz 09:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:35:29 INFO - Installing collected packages: blessings 09:35:29 INFO - Running setup.py install for blessings 09:35:29 INFO - Successfully installed blessings 09:35:29 INFO - Cleaning up... 09:35:29 INFO - Return code: 0 09:35:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:30 INFO - Reading from file tmpfile_stdout 09:35:30 INFO - Current package versions: 09:35:30 INFO - argparse == 1.2.1 09:35:30 INFO - blessings == 1.6 09:35:30 INFO - blobuploader == 1.2.4 09:35:30 INFO - docopt == 0.6.1 09:35:30 INFO - manifestparser == 1.1 09:35:30 INFO - mozInstall == 1.12 09:35:30 INFO - mozcrash == 0.17 09:35:30 INFO - mozdebug == 0.1 09:35:30 INFO - mozdevice == 0.48 09:35:30 INFO - mozfile == 1.2 09:35:30 INFO - mozhttpd == 0.7 09:35:30 INFO - mozinfo == 0.9 09:35:30 INFO - mozleak == 0.1 09:35:30 INFO - mozlog == 3.1 09:35:30 INFO - moznetwork == 0.27 09:35:30 INFO - mozprocess == 0.22 09:35:30 INFO - mozprofile == 0.28 09:35:30 INFO - mozrunner == 6.11 09:35:30 INFO - mozscreenshot == 0.1 09:35:30 INFO - mozsystemmonitor == 0.0 09:35:30 INFO - moztest == 0.7 09:35:30 INFO - mozversion == 1.4 09:35:30 INFO - psutil == 3.1.1 09:35:30 INFO - requests == 1.2.3 09:35:30 INFO - wsgiref == 0.1.2 09:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:30 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')]} 09:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:30 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')]} 09:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:30 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:30 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 09:35:30 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 09:35:30 INFO - Using env: {'DISPLAY': ':0', 09:35:30 INFO - 'HOME': '/home/cltbld', 09:35:30 INFO - 'LANG': 'en_US.UTF-8', 09:35:30 INFO - 'LANGUAGE': 'en_US:en', 09:35:30 INFO - 'LOGNAME': 'cltbld', 09:35:30 INFO - 'MAIL': '/var/mail/cltbld', 09:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:30 INFO - 'MOZ_NO_REMOTE': '1', 09:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:30 INFO - 'NO_EM_RESTART': '1', 09:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:30 INFO - 'PWD': '/builds/slave/test', 09:35:30 INFO - 'SHELL': '/bin/bash', 09:35:30 INFO - 'SHLVL': '1', 09:35:30 INFO - 'TERM': 'linux', 09:35:30 INFO - 'TMOUT': '86400', 09:35:30 INFO - 'USER': 'cltbld', 09:35:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:30 INFO - '_': '/tools/buildbot/bin/python'} 09:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 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)) 09:35:30 INFO - Cleaning up... 09:35:30 INFO - Return code: 0 09:35:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:35:30 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')]} 09:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:30 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')]} 09:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:30 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:30 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 09:35:30 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 09:35:30 INFO - Using env: {'DISPLAY': ':0', 09:35:30 INFO - 'HOME': '/home/cltbld', 09:35:30 INFO - 'LANG': 'en_US.UTF-8', 09:35:30 INFO - 'LANGUAGE': 'en_US:en', 09:35:30 INFO - 'LOGNAME': 'cltbld', 09:35:30 INFO - 'MAIL': '/var/mail/cltbld', 09:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:30 INFO - 'MOZ_NO_REMOTE': '1', 09:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:30 INFO - 'NO_EM_RESTART': '1', 09:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:30 INFO - 'PWD': '/builds/slave/test', 09:35:30 INFO - 'SHELL': '/bin/bash', 09:35:30 INFO - 'SHLVL': '1', 09:35:30 INFO - 'TERM': 'linux', 09:35:30 INFO - 'TMOUT': '86400', 09:35:30 INFO - 'USER': 'cltbld', 09:35:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:30 INFO - '_': '/tools/buildbot/bin/python'} 09:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:30 INFO - Downloading/unpacking jsonschema 09:35:30 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 09:35:30 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 09:35:30 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 09:35:30 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 09:35:30 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 09:35:30 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 09:35:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:32 INFO - Downloading/unpacking functools32 (from jsonschema) 09:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:32 INFO - warning: no files found matching '*.txt' 09:35:32 INFO - no previously-included directories found matching 'build' 09:35:32 INFO - no previously-included directories found matching 'dist' 09:35:32 INFO - no previously-included directories found matching '.git*' 09:35:32 INFO - Installing collected packages: jsonschema, functools32 09:35:32 INFO - Running setup.py install for functools32 09:35:32 INFO - warning: no files found matching '*.txt' 09:35:32 INFO - no previously-included directories found matching 'build' 09:35:32 INFO - no previously-included directories found matching 'dist' 09:35:32 INFO - no previously-included directories found matching '.git*' 09:35:32 INFO - Successfully installed jsonschema functools32 09:35:32 INFO - Cleaning up... 09:35:32 INFO - Return code: 0 09:35:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:35:32 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')]} 09:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:32 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')]} 09:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:32 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 0x7f5bc3361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', '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 09:35:32 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 09:35:32 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 09:35:32 INFO - Using env: {'DISPLAY': ':0', 09:35:32 INFO - 'HOME': '/home/cltbld', 09:35:32 INFO - 'LANG': 'en_US.UTF-8', 09:35:32 INFO - 'LANGUAGE': 'en_US:en', 09:35:32 INFO - 'LOGNAME': 'cltbld', 09:35:32 INFO - 'MAIL': '/var/mail/cltbld', 09:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:32 INFO - 'MOZ_NO_REMOTE': '1', 09:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:32 INFO - 'NO_EM_RESTART': '1', 09:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:32 INFO - 'PWD': '/builds/slave/test', 09:35:32 INFO - 'SHELL': '/bin/bash', 09:35:32 INFO - 'SHLVL': '1', 09:35:32 INFO - 'TERM': 'linux', 09:35:32 INFO - 'TMOUT': '86400', 09:35:32 INFO - 'USER': 'cltbld', 09:35:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:32 INFO - '_': '/tools/buildbot/bin/python'} 09:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:33 INFO - Downloading/unpacking flake8 09:35:33 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 09:35:33 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 09:35:33 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 09:35:33 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 09:35:33 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 09:35:33 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 09:35:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:35:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:35:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 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 09:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:35:35 INFO - no previously-included directories found matching 'docs/_build' 09:35:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:35:35 INFO - Running setup.py install for pep8 09:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:35:35 INFO - no previously-included directories found matching 'docs/_build' 09:35:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:35:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:35:35 INFO - Cleaning up... 09:35:35 INFO - Return code: 0 09:35:35 INFO - Running post-action listener: _resource_record_post_action 09:35:35 INFO - Running post-action listener: _start_resource_monitoring 09:35:35 INFO - Starting resource monitoring. 09:35:35 INFO - ##### 09:35:35 INFO - ##### Running install step. 09:35:35 INFO - ##### 09:35:35 INFO - Running pre-action listener: _resource_record_pre_action 09:35:35 INFO - Running main action method: install 09:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:36 INFO - Reading from file tmpfile_stdout 09:35:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:35:36 INFO - Reading from file tmpfile_stdout 09:35:36 INFO - Output received: 09:35:36 INFO - Usage: mozinstall [options] installer 09:35:36 INFO - Options: 09:35:36 INFO - -h, --help show this help message and exit 09:35:36 INFO - -d DEST, --destination=DEST 09:35:36 INFO - Directory to install application into. [default: 09:35:36 INFO - "/builds/slave/test"] 09:35:36 INFO - --app=APP Application being installed. [default: firefox] 09:35:36 INFO - mkdir: /builds/slave/test/build/application 09:35:36 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'] 09:35:36 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 09:35:51 INFO - Reading from file tmpfile_stdout 09:35:51 INFO - Output received: 09:35:51 INFO - /builds/slave/test/build/application/firefox/firefox 09:35:51 INFO - Running post-action listener: _resource_record_post_action 09:35:51 INFO - ##### 09:35:51 INFO - ##### Running run-tests step. 09:35:51 INFO - ##### 09:35:51 INFO - Running pre-action listener: _resource_record_pre_action 09:35:51 INFO - Running main action method: run_tests 09:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:35:51 INFO - Python 2.7.3 09:35:51 INFO - Return code: 0 09:35:51 INFO - grabbing minidump binary from tooltool 09:35:51 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')]} 09:35:51 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 0x1acf410>, '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 0x1ad0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:35:51 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 09:35:51 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 09:35:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:35:51 INFO - Return code: 0 09:35:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:35:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:35:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:35:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:35:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:35:52 INFO - Return code: 0 09:35:52 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/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:35:52 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/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 09:35:52 INFO - Using env: {'DISPLAY': ':0', 09:35:52 INFO - 'HOME': '/home/cltbld', 09:35:52 INFO - 'LANG': 'en_US.UTF-8', 09:35:52 INFO - 'LANGUAGE': 'en_US:en', 09:35:52 INFO - 'LOGNAME': 'cltbld', 09:35:52 INFO - 'MAIL': '/var/mail/cltbld', 09:35:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:35:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:52 INFO - 'MOZ_NO_REMOTE': '1', 09:35:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:52 INFO - 'NO_EM_RESTART': '1', 09:35:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:52 INFO - 'PWD': '/builds/slave/test', 09:35:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:35:52 INFO - 'SHELL': '/bin/bash', 09:35:52 INFO - 'SHLVL': '1', 09:35:52 INFO - 'TERM': 'linux', 09:35:52 INFO - 'TMOUT': '86400', 09:35:52 INFO - 'USER': 'cltbld', 09:35:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007', 09:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:52 INFO - '_': '/tools/buildbot/bin/python'} 09:35:52 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/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:35:53 INFO - mozversion application_buildid: 20160401085456 09:35:53 INFO - mozversion application_changeset: a1df259b9ea322baaff78eeafa3bbf7b5f366e8b 09:35:53 INFO - mozversion application_display_name: Nightly 09:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:35:53 INFO - mozversion application_name: Firefox 09:35:53 INFO - mozversion application_remotingname: firefox 09:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:35:53 INFO - mozversion application_vendor: Mozilla 09:35:53 INFO - mozversion application_version: 48.0a1 09:35:53 INFO - mozversion platform_buildid: 20160401085456 09:35:53 INFO - mozversion platform_changeset: a1df259b9ea322baaff78eeafa3bbf7b5f366e8b 09:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:35:53 INFO - mozversion platform_version: 48.0a1 09:35:53 INFO - using testdate: 1459528553 09:35:53 INFO - actual date: 1459528553 09:35:53 INFO - starting webserver on 'localhost:33907' 09:35:53 INFO - SUITE-START | Running 2 tests 09:35:53 INFO - TEST-START | dromaeo_css 09:35:53 INFO - operating with platform_type : linux_ 09:35:53 INFO - Initialising browser for dromaeo_css test... 09:35:53 INFO - TEST-INFO | started process 11000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWHsHOU/profile http://localhost:33907/getInfo.html) 09:35:57 INFO - PROCESS | 11000 | __metrics Screen width/height:1600/1200 09:35:57 INFO - PROCESS | 11000 | colorDepth:24 09:35:57 INFO - PROCESS | 11000 | Browser inner width/height: 1024/697 09:35:57 INFO - PROCESS | 11000 | __metrics 09:35:58 ERROR - PROCESS | 11000 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:35:59 INFO - TEST-INFO | 11000: exit 0 09:35:59 INFO - Browser initialized. 09:35:59 INFO - Running cycle 1/1 for dromaeo_css test... 09:35:59 INFO - TEST-INFO | started process 11085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWHsHOU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:11 INFO - PROCESS | 11085 | RSS: Main: 154337280 09:36:11 INFO - PROCESS | 11085 | 09:37:03 INFO - PROCESS | 11085 | 1459528623109 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] 09:39:15 INFO - PROCESS | 11085 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33907/tests/dromaeo/cssquery-ext.html) 09:39:16 INFO - PROCESS | 11085 | RSS: Main: 266063872 09:39:16 INFO - PROCESS | 11085 | 09:42:19 INFO - PROCESS | 11085 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-ext.html (next: http://localhost:33907/tests/dromaeo/cssquery-jquery.html) 09:42:19 INFO - PROCESS | 11085 | RSS: Main: 236142592 09:42:19 INFO - PROCESS | 11085 | 09:45:21 INFO - PROCESS | 11085 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33907/tests/dromaeo/cssquery-mootools.html) 09:45:22 INFO - PROCESS | 11085 | RSS: Main: 232345600 09:45:22 INFO - PROCESS | 11085 | 09:48:24 INFO - PROCESS | 11085 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33907/tests/dromaeo/cssquery-prototype.html) 09:48:24 INFO - PROCESS | 11085 | RSS: Main: 206254080 09:48:24 INFO - PROCESS | 11085 | 09:51:27 INFO - PROCESS | 11085 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33907/tests/dromaeo/cssquery-yui.html) 09:51:28 INFO - PROCESS | 11085 | RSS: Main: 198672384 09:51:28 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | Cycle 1(1): loaded http://localhost:33907/tests/dromaeo/cssquery-yui.html (next: http://localhost:33907/tests/dromaeo/cssquery-dojo.html) 09:54:30 INFO - PROCESS | 11085 | RSS: Main: 258490368 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | __start_tp_report 09:54:30 INFO - PROCESS | 11085 | _x_x_mozilla_page_load 09:54:30 INFO - PROCESS | 11085 | _x_x_mozilla_page_load_details 09:54:30 INFO - PROCESS | 11085 | |i|pagename|runs| 09:54:30 INFO - PROCESS | 11085 | |0;dojo.html;2610.830296030758;2717.157681118852;2723.7003929567754;2729.522333591621;2754.66943966724;4592.678512504126;4674.25211966085;4676.789544470498;4677.22825733754;4683.4379874415035;4638.698484598499;4658.976705116478;4660.114578230134;4750.28745688147;4767.499412561683;4265.744055356681;4306.698531102824;4344.370066340379;4363.476382834065;4471.374007638933;4417.514073451934;4445.8221671133115;4448.421705178323;4483.08096840147;4506.707064040843;4276.957230427687;4313.245182093153;4352.804123814436;4362.498312694049;4383.846565370229;4323.2434323993175;4327.982924012855;4362.738235705836;4377.23398405281;4391.846285380028;4305.720128191658;4307.1601037797645;4319.935200971988;4346.826126954918;4350.7172033818015;4506.121306345264;4516.54834516549;4540;4587.885302867422;4623.329617205486;5060.746962651852;5080.441151473335;5082.364704411949;5090.669106508102;5127.692338459704;5077.517635824628;5087.643864929457;5096.974515127437;5101.362329708786;5151.5878729701535;4658.208104622222;4727.739974301447;4736.83421080264;4767.308740232646;4811.350467686818;5127.333446651986;5153.304303918923;5154.123798954187;5154.974225128851;5175.896482070338;4914.827981020647;4939;4939.604831613462;4939.777710003059;4988;4975.154223781966;4976.975115124474;4991.376077990251;5032.169692000852;5082.974585127125;5021.171506701354;5037.118504261813;5056.367954005749;5063.139266324733;5115.386153661584;5026.673266237683;5043.646944713908;5047.621428392885;5047.949520504748;5050.116229659795;4179.832806687698;4236.322188449833;4256.233877902007;4259;4301.677374196947;3717.7955212463035;3723.6090210527504;3726.8695595654563;3732.309522738302;3772.4152756322815;4315.503717072514;4332.610065094157;4332.913341733148;4354.238008348526;4370.104128653618;4903.779329930162;5040.79836806531;5047.318611987408;5052.9747351263;5125.692458452505;4331.6534677225745;4333.285007973712;4343.652507799368;4352.782360882006;4379.0585024219945;4511.571400716926;4528.071745292207;4562.338460923214;4567.223571992769;4576.6109880660515;4667.416572928384;4751.287306903992;4768.642351823558;4842.878928026827;4848;5013.674111182907;5014.72419016943;5048.091343558048;5051.671641343448;5106.872328191676;4771.308160316666;4771.403574553181;4777.95222047789;4778.068276686013;4819;4808.422989241313;4930.975345123252;4978.253262010728;5003.899922001612;5026.447090819934;4989.675671081368;5008.248762685481;5030.144875371123;5036.798528058983;5092.872678183075;4721.881952951204;4850.151223535797;4857.95142048575;4860.9513904861915;4902.63230257725;4916.926246106383;4922.901541969212;4944.901101978012;4980.750962451791;4992.950070499249;4744.715317080986;4746.667733258639;4764.14245435811;4772.379590653193;4808.663393562557;4778.617710583215;4873.171560834596;4873.926891096708;4903.681260718042;4929.162042452864;4644.8374306899095;4712.905741885212;4791.257355109963;4806.44725856517;4855.1260773061185 09:54:30 INFO - PROCESS | 11085 | |1;ext.html;520.5575261028124;543.7063985447857;553.8283132229009;560.8362647506424;566.2412367427646;33306;33806.66193338066;33885.830570847174;33909.152271193205;33917.32165356698;34010.48984265238;34531.82734086326;34543.13642158947;34552.30895382091;34571;7472.4395670324675;7651.196624354446;7656.425768067389;7659.770206893774;7667.118281397627;7532.472726909118;7837.451378403514;7839.78483335084;7841.294283514482;7842.41181911356;7808.297253247207;7893.210678932118;7897.960510197441;7899;7901.446898717092;7806.687732490694;7856.292933635971;7864.803379915491;7868.763937081897;7877.645505952246;7759.030121234846;7882.842343153162;7883.684652613946;7885.408594355446;7888.329491993188;35798.64201358005;36216;36252.81873590642;36303.09242268938;36323.4551481728;1886.9181447247875;3117.423276693819;3198.6001749781276;3205.5512228288057;3753.7560058596105;26012;26202;26390.6041409379;26418.339541511425;26460.294622810143;3410.8294585270887;3429.5027221053056;3445.7243420526297;3479.6346383629607;3584.1039740064984;166834;167306;167355;167722;167950;51356.48643513517;54042;54591.45408545943;58826;60139.699301504086;53031;53085.734571326895;53259.46740532623;53273.46726532685;53332;13237.205767653972;13456.394462249222;13464.326783660777;13466.394012269471;13466.461341546425;9768.51157442125;9786.363886347364;9814.705558833246;9819.06718861707;9851.655192068243;19239.20373654392;19823.20707171697;19851.60296794085;19918;19925.402237932594;6367.936320636827;7031.332023457763;7094.787156385317;7172.28277172289;7255.564666119944;879.771259472529;959.9824186362478;997.8203923293877;1008.2740426892625;1014.964735969322;25631.56868918573;25781.871090644803;25967;26275;26337.604935925978;961.0341606685377;971.5433746139303;990.8662330585423;1039.0804138337626;1098.4013712526692;13951;14036.943487437558;14257.429702811978;14384.424623015171;14388.928055359656;357465;366606;366738;366833;367205;50328.496715033114;51181.48818511842;51187.488125119016;51339;51353.7432312836;1031.293563908725;1146.1518476327624;1199.8140288255333;1202.945867435985;1227.8281040654315;27064.376137431816;27170.1848944532;27589.448211035266;27733.168004959884;27822.86088569544;40871;40893.182136357704;41138;41195.38206926958;41248.79375603103;240953;242140;242559;242618;242843;34398.484022739176;35413.1146721334;39072.2185556293;39953.80023099866;40110.79944600258;38929.80535097307;40826;41414.792926035174;41434.40635514167;41520;34270.48594271138;34585.30829383348;34628.48057279193;34727.47908781421;34775.65224347825;34283.657163429045;34315.485267720505;34378.82810585931;34470.65529344675;34749.305013900084;34699.82650086733;34887.47668785021;34906.47640285347;35320.29359412849;37330.81334593309;26999.73000269972;28554.286142846595;28589.42821143524;28807.56788648214;29986.30784933638;24318.148864789648;24586.754132459162;24622.41464646258;24966.37584060413;25008.874955625834 09:54:30 INFO - PROCESS | 11085 | |2;jquery.html;353.8142475200519;358.3800025955098;360.38734151941696;370.4147447033685;374.0611066223781;13221.338933053357;13630.04589678723;15559.533214003584;15884.84115158848;16718.99686018838;15516.30176642051;16046.919765401186;16079.437219697313;16875.746863797052;17606.911965440187;5292.311999440077;5435.755391007414;5462.289902312694;5484.287042684446;5484.451554844503;5440.4287549807295;5505.229267902477;5621.0444224481935;5687.431256874321;5688.715564221793;5632.3804381518;5648.491635752802;5649.039663257236;5652.378238393773;5653.802116925908;5626.859328516779;6149.661768602725;6420.5184611154355;6427.5822071565435;6430.196225471816;6121.755129794803;6159.722812473449;6179.907301390483;6181.289151747562;6183.721732522047;21924.123035078577;22085.447863803372;22760.430989225235;22765.658515122286;22855;2037.3684157911096;2062.453449835795;2111.609352269835;2278.2595656411568;2560.577504711739;13519.797203041864;13799.172049677052;13810.171389716648;13893;13926.582202533838;1844.732513785507;1870.4482177757593;1898.392514395394;1914.2247389807012;1940.2820956246137;70650.64674676594;71813.64093179553;72337;72395;72939.63530182368;14985.40058397652;15029.745538169362;15074.54776356711;15158.545243642708;15312.234388280764;21858;25402.491950161264;25565.744342556707;25576.360590985376;25590;7650.38796896247;7826.7651970440975;7937.801554961172;7986.520808751494;8071.434999549975;6540.70566824494;6711.865762684816;6764.458843292623;6776.119104516381;6790.558613690095;7462.395584949262;7647.923520764833;7662.348700360531;7698.884516732253;7770.766876993699;2996.235959830229;3001.1896787867154;3052.496338104188;3125.1093438369953;3131.6711745266875;782.8943092682415;833.2792134803351;857.5969294431607;914.3188324698142;954.7756277274835;14743.852561474248;15051;15292.770608440882;15371.846281537042;15604.609884752972;839.9421417527083;862.5374555643673;883.9911600884037;888.7555922121468;911.1253196930888;8352.16478352172;8658.090900455361;8689.304855611535;8858.512781797062;8975.416597921114;275799;277168;369657;373020;375099;70876.64561677158;71028.64485677538;71804;73092.63453682805;73463.26536734671;951.167728237792;963.7012526116927;969.5055521684133;997.4713401897006;1003.4180175498193;14746.705065898837;14946.925265373604;15116.244187790346;15265.923670381577;15429.768553471482;24463.38841528976;31518.527222091227;33825.661743382254;34015.14962125967;34301.14247143841;33574.66425335813;33976.15059623529;34458;36254;36793;7408.444366672414;7423.962880185781;7466.290702383265;7509.023826902468;7619.009528761226;11139.554417823196;11572.768544628892;11720.062395008208;11825.64523064275;12004.279743215435;9729.659461918798;9746.707598772047;9946.900530994597;10064.54709538058;10782.514786834454;9452.858207127036;9918.504074796376;9938.403695778277;9997.750056248651;10022.298439109483;9900.504974751379;9977.650782222587;10214;10355.741106472398;10700.892991070301;7519.924800751923;7596.734114305973;7622.733204337822;7631.465797394129;7750.418718596015;8798.340124490816;10039.648612298535;10260.846087308846;10262.486875656037;10442.63450779219 09:54:30 INFO - PROCESS | 11085 | |3;mootools.html;1300.5318085489228;1417.192200445746;1437.6334034821118;1557.5560965124942;1758.2878934031721;7193.316634919681;7345.8163545911375;7389.039424874765;7392.889106663404;7425.071866016741;7373.852522949538;7563.394928405728;7567;7568.470207085506;7568.848623027536;1938.3797184900836;2159.946001349971;2229.320057382498;2264.071730590458;2289.633658614622;2236.9217077402295;2245.023414814553;2246.528229071897;2249.3589327041796;2250.628646273363;2151.5051538146236;2224.0992398078806;2227.175944900389;2229.9888500557477;2234.2515257388795;2211.259228158569;2218.7226596675414;2219.711437513121;2276.9886150569305;2283.120998415622;2158.4927542027613;2179.3679832848456;2187.890605469736;2188.3106821351225;2222.3999520129637;7377.852442951164;7425.331720145213;7449.106107267163;7451.403887688972;7456.142543607501;4557.065801510682;4670;4671.416072990876;4697.553732395417;4700.929486057677;2861.856907154634;2885.2498350428828;2928.07765553852;2937.7943543951933;3016.0348688419713;913.5152385511399;922.0456827183832;935.4901578639658;940.8870935487716;942.2885721280389;10566.101881340095;10571.577136914591;10594.788104237872;10611.204159687977;10623.57505699771;4041.7979101045416;4185.121124563815;4216.3464662977285;4301.827926882952;4308.935365969451;8914.598843052077;8933.240674542607;8958.328125390623;8971.551422428853;9019.594118264693;4085.8569950051606;4364.847230346986;4392.714473559208;4407.074514352022;4411.3824064630335;4087.9386809197886;4145.1295228002455;4178.91642167155;4186.811593478301;4199.97100710328;3576.7317451191266;3655.817209139532;3680.723945704083;3704.240630670706;3708.0915175782106;1186.424584076722;1202.4408649977802;1210.2073142091945;1213.6662417835166;1216.8418105646385;841.1084250694283;849.0745087854268;851.2891735400885;858.4463021351319;1080.0873262093519;7220.602866842269;7224.855502890018;7246;7272.563646181246;7284.963575182091;452.15221459762944;465.17431558983077;468.6040295949917;470.9929351059737;473.6992010073559;5331.680099194061;5341.679499230058;5417.214503896913;5452.536534394541;5454.91817622736;9050.456972581665;9172;9423.905760942303;9525.52372381392;9533.904660953302;9250.583723732449;9251.629934802668;9340.953295233481;9405.153536181777;9424.246060315158;7076.0801095857205;7223.494355395072;7323.121225452873;7337.19290878003;7354.595497247596;6831.28271531482;6855.177378714586;6855.4172895304455;6872.862542749217;6900.2409734930125;7938.285554300141;8296.626651800803;8324.334053275603;8329.125441828763;8433;8472.788180295542;8627.784305392415;8776.91223087761;8779.868301975603;8801.647934082564;5725.51333136688;6369.617822930639;6504.902426463512;6540;6604.603723776397;7105.25394833535;7128.786136415916;7144.106986626672;7145.892811607726;7149.53528020677;6353.332900045429;6491.058796474579;6574.3754343337305;6575;6693.09643198162;6120.816375508742;6504.447121994684;6598.934010659832;6600;6615.867682646416;6757.560758550679;6760.526763126731;6767.796966091025;6781.93218067813;6790.049393085071;6174;6226.62640241587;6249.9375006251175;6257.812265632038;6259.96870015647;6133.018717005258;6147.631142131308;6162.168107305456;6162.291336496361;6201.224846894138 09:54:30 INFO - PROCESS | 11085 | |4;prototype.html;324.5067497403946;324.7207401634595;326.55099238546995;328.1893722505412;333.71800828300076;5278.577713782898;5311.973440132799;5355.9020400817835;5372.4090350061515;5375.838724838251;5242.973785131069;5274.235235890794;5277.419483856782;5280.788768449257;5282.181261904401;3979.781112038837;4040;4143.730657507267;4187.685923555738;4189.07840275139;4168.5623009584015;4184.100418410041;4193.937090943638;4197.748135111903;4198.6011328923705;4134.131832315217;4139.130782535671;4146.937795933063;4156.189543039109;4164.292070348048;3921;4033.1530378620523;4139.875803725893;4147.6474499667565;4151.584841515854;3665.0470877571756;3676.889693309205;3681.895431370578;3684.1158122050783;3690.225052738928;5026.321446604698;5069.797208111671;5075.720835354054;5081.390233172006;5082.237664350377;4723.740194289313;4774.546418090275;4776.665633405663;4780.163471392492;4786.114568804782;5527.861803454905;5569.832905012856;5572.832815015556;5584.6090773645865;5585.860353491195;4034.536028356747;4036.576159503239;4038.7374820636564;4043.454133691973;4049.1091959768805;5564.137558678412;5873;5889.116632505115;5892.116182572606;5931.525477961796;3933.488646475997;4010.7393019453643;4012.61880121388;4015.5382131054716;4020.0351915540646;4061.1065565575527;4066.4510291110914;4068;4068.613481719232;4069.7761623110423;4669.4630117536235;4675.7895894684825;4679.836205732783;4686.133065382915;4686.71879687213;5562.443755624486;5567.415421380778;5571.13647384656;5572.331320241516;5575.860603484945;1401.1943132698739;1430.7210094031773;1431.5490620454523;1432.1335591966917;1433.426629348269;883.9292856571587;918.7289749523907;930.4463844012802;964.3538828984597;966.9033096690275;4793.952060479421;4879.048585525788;4889.706617602955;4902.313676085351;4909.337239472697;5728.914066289009;5754.395788442237;5758.078707406795;5764.337101233328;5804.88390232193;4928.5317894800655;4936.111499930047;4936.506349365035;4941.8517444476;4944.208926571731;3076.8307743073897;3111.191090316534;3114.4394009078583;3119.313750974782;3119.937601248008;5523.4200408956485;5525.889482210333;5532.3914369419335;5535.667859928417;5537.750801213955;5733.627314224562;5924.940750592439;5944.643321400643;5960.433758792908;5962.3739507351975;5469.753861076261;5484.972575137019;5508.338999320107;5517.44825517445;5519.034169020405;5800.24596802413;5800.854978625399;5802.100674395476;5805.274340707411;5808.680522571299;5671.886562268649;5674.829755107354;5682.147677848356;5683.7442315095095;5685.772569097356;5489.752961116679;5507.944920550904;5508.889822203613;5517.641353312022;5521.089020311603;3830.6552410283207;3965.583613720518;4027.0737730322776;4036.9596304036586;4037.0916543777416;5725.341585717696;5743.966086104541;5747.9137812932;5751.971240143773;5758.625689330348;5573.359063707726;5578.497935185853;5578.972105139448;5583.441655834384;5586.1062230043;5574.136008918624;5576.163575463551;5578.748956297058;5583.218349431002;5583.720813959205;5348.465153484776;5484.122540393518;5486.890262194814;5488.121900495901;5501.174823776466;5585.1901474286815;5591.021571225101;5595.944040559542;5599.32808063035;5601.159826026129;5455.481729235717;5473.31583552056;5483.369412517612;5486.423925487767;5487.835364939058 09:54:30 INFO - PROCESS | 11085 | |5;yui.html;647.5499527828159;722.2596838240805;741.280957471253;754.0762565856825;766.6856588798594;12026.458809353579;12035.398230088493;12054.397280136001;12069.939650301747;12091.455884485198;11067.557297708103;11106;11121.777564448706;11152.665420037412;11218.887811121886;638.4126603524757;652.4291245160484;653.2585515439962;653.6013032050446;787.4173111897184;807.5840941914919;809.7165991902816;811.1604489353521;815.2214635023538;818.4557269415861;841.0580150231749;847.6482259862181;848.7241646464923;849.1381248033251;849.3332733803965;839.3914412051275;843.3506200225853;843.5023336231592;843.569779412501;844.4679851693425;499.8175665881927;508.34677439490076;620.9285932117774;626.3673689573518;626.6929204689715;11082.05802506788;11099.778004439946;11109.500072496758;11131.109511239081;11172.273802202832;11798.174127811057;12678.683032924158;12786.232826030468;12800.167989080774;13237.470501179941;9642.951785241028;9822.607095716163;9843.803123937481;9914.305998580103;9918.752031199278;3272.3291725196277;3351.128706536318;3372.359251742161;3385;3413.4026545354463;42511.78744106291;43380.78309608463;43425.34861977073;43480.347794782785;43492.3476147858;9452.480113593818;9711.514424278757;9958.651447199314;9981.727384526524;10101.19190464761;17696.380626678005;17781.555461113574;17782;17789.288428462976;17791.644167116843;6606.603603783692;6635.303293154149;6639.468842492685;6704.731810727614;6843.657817109125;3577.338192434408;3732.309522738302;3752.45589389537;3765.1151979284846;3790.6209379062425;2742.1088146352517;2774.6531683539556;2774.7918906082123;2782.1653503949137;2794.1617514745494;486.6131425516723;486.7006790823618;486.9269609558524;497.08536293220646;499.51796516361884;556.3046192259675;559.9524040456525;612.4334990134108;617.3764497857106;617.5090802811685;7773.805654858561;8110.270075693216;8116.553589552514;8180.550069746102;8273.83452330962;625.1685258606134;625.4058644287853;627.2253766598247;632.9651869147149;634.8063840528683;3716.273544883769;3764.8305826237884;3804.9429258561145;3805.6384643458828;3870.2646497165447;55639;55698;56077;56181;56326;47899.52100478951;48289;49097.50902491001;49502.75248623734;49713;42859.14281714348;43283.56716432858;43404.78297608429;44059.77970110193;44333;7479.214682458263;7510;7548.320651141424;7561.9243807563425;7571.242875712384;31606.683933160373;32010.039698809072;32230.19424514406;32295.51556726698;32305.676943230268;37919;39612.80193599014;43001;43343.56656433395;43423.78288108539;9492.098250666175;9656.855147172939;9669.758256043655;9711.174550163316;9721.513924303898;10359;10380.221483388625;10460.529276182438;10629.734256643645;10972.945135274273;9773;9847.901520984986;9929.851052234078;10020.949895250476;10110.49447527606;9226.584803683985;9284.535773211177;9374.718758437259;9637.277204209571;9709.126178643955;9702.75743106428;9728.951355243462;9877.40735555869;9891.752706182404;10007.249456290661;7907.275470120057;8111.351091912515;8199.877001845096;8282.50304981703;8435.53604551731;8524.573771311534;8738;8819.162179592928;8869.334799890163;8956.104389560991 09:54:30 INFO - PROCESS | 11085 | __end_tp_report 09:54:30 INFO - PROCESS | 11085 | __start_cc_report 09:54:30 INFO - PROCESS | 11085 | _x_x_mozilla_cycle_collect,1031 09:54:30 INFO - PROCESS | 11085 | __end_cc_report 09:54:30 INFO - PROCESS | 11085 | __startTimestamp1459529670928__endTimestamp 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | ------- Summary: start ------- 09:54:30 INFO - PROCESS | 11085 | Number of tests: 6 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | [#0] dojo.html Cycles:165 Average:4655.28 Median:4768.64 stddev:475.92 (10.0%) stddev-sans-first:449.55 09:54:30 INFO - PROCESS | 11085 | Values: 2610.8 2717.2 2723.7 2729.5 2754.7 4592.7 4674.3 4676.8 4677.2 4683.4 4638.7 4659.0 4660.1 4750.3 4767.5 4265.7 4306.7 4344.4 4363.5 4471.4 4417.5 4445.8 4448.4 4483.1 4506.7 4277.0 4313.2 4352.8 4362.5 4383.8 4323.2 4328.0 4362.7 4377.2 4391.8 4305.7 4307.2 4319.9 4346.8 4350.7 4506.1 4516.5 4540.0 4587.9 4623.3 5060.7 5080.4 5082.4 5090.7 5127.7 5077.5 5087.6 5097.0 5101.4 5151.6 4658.2 4727.7 4736.8 4767.3 4811.4 5127.3 5153.3 5154.1 5155.0 5175.9 4914.8 4939.0 4939.6 4939.8 4988.0 4975.2 4977.0 4991.4 5032.2 5083.0 5021.2 5037.1 5056.4 5063.1 5115.4 5026.7 5043.6 5047.6 5047.9 5050.1 4179.8 4236.3 4256.2 4259.0 4301.7 3717.8 3723.6 3726.9 3732.3 3772.4 4315.5 4332.6 4332.9 4354.2 4370.1 4903.8 5040.8 5047.3 5053.0 5125.7 4331.7 4333.3 4343.7 4352.8 4379.1 4511.6 4528.1 4562.3 4567.2 4576.6 4667.4 4751.3 4768.6 4842.9 4848.0 5013.7 5014.7 5048.1 5051.7 5106.9 4771.3 4771.4 4778.0 4778.1 4819.0 4808.4 4931.0 4978.3 5003.9 5026.4 4989.7 5008.2 5030.1 5036.8 5092.9 4721.9 4850.2 4858.0 4861.0 4902.6 4916.9 4922.9 4944.9 4980.8 4993.0 4744.7 4746.7 4764.1 4772.4 4808.7 4778.6 4873.2 4873.9 4903.7 4929.2 4644.8 4712.9 4791.3 4806.4 4855.1 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | [#1] ext.html Cycles:180 Average:41934.55 Median:35113.38 stddev:71308.45 (203.1%) stddev-sans-first:71440.69 09:54:30 INFO - PROCESS | 11085 | Values: 520.6 543.7 553.8 560.8 566.2 33306.0 33806.7 33885.8 33909.2 33917.3 34010.5 34531.8 34543.1 34552.3 34571.0 7472.4 7651.2 7656.4 7659.8 7667.1 7532.5 7837.5 7839.8 7841.3 7842.4 7808.3 7893.2 7898.0 7899.0 7901.4 7806.7 7856.3 7864.8 7868.8 7877.6 7759.0 7882.8 7883.7 7885.4 7888.3 35798.6 36216.0 36252.8 36303.1 36323.5 1886.9 3117.4 3198.6 3205.6 3753.8 26012.0 26202.0 26390.6 26418.3 26460.3 3410.8 3429.5 3445.7 3479.6 3584.1 166834.0 167306.0 167355.0 167722.0 167950.0 51356.5 54042.0 54591.5 58826.0 60139.7 53031.0 53085.7 53259.5 53273.5 53332.0 13237.2 13456.4 13464.3 13466.4 13466.5 9768.5 9786.4 9814.7 9819.1 9851.7 19239.2 19823.2 19851.6 19918.0 19925.4 6367.9 7031.3 7094.8 7172.3 7255.6 879.8 960.0 997.8 1008.3 1015.0 25631.6 25781.9 25967.0 26275.0 26337.6 961.0 971.5 990.9 1039.1 1098.4 13951.0 14036.9 14257.4 14384.4 14388.9 357465.0 366606.0 366738.0 366833.0 367205.0 50328.5 51181.5 51187.5 51339.0 51353.7 1031.3 1146.2 1199.8 1202.9 1227.8 27064.4 27170.2 27589.4 27733.2 27822.9 40871.0 40893.2 41138.0 41195.4 41248.8 240953.0 242140.0 242559.0 242618.0 242843.0 34398.5 35413.1 39072.2 39953.8 40110.8 38929.8 40826.0 41414.8 41434.4 41520.0 34270.5 34585.3 34628.5 34727.5 34775.7 34283.7 34315.5 34378.8 34470.7 34749.3 34699.8 34887.5 34906.5 35320.3 37330.8 26999.7 28554.3 28589.4 28807.6 29986.3 24318.1 24586.8 24622.4 24966.4 25008.9 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | [#2] jquery.html Cycles:180 Average:22775.54 Median:190195.66 stddev:55784.50 (29.3%) stddev-sans-first:55915.59 09:54:30 INFO - PROCESS | 11085 | Values: 353.8 358.4 360.4 370.4 374.1 13221.3 13630.0 15559.5 15884.8 16719.0 15516.3 16046.9 16079.4 16875.7 17606.9 5292.3 5435.8 5462.3 5484.3 5484.5 5440.4 5505.2 5621.0 5687.4 5688.7 5632.4 5648.5 5649.0 5652.4 5653.8 5626.9 6149.7 6420.5 6427.6 6430.2 6121.8 6159.7 6179.9 6181.3 6183.7 21924.1 22085.4 22760.4 22765.7 22855.0 2037.4 2062.5 2111.6 2278.3 2560.6 13519.8 13799.2 13810.2 13893.0 13926.6 1844.7 1870.4 1898.4 1914.2 1940.3 70650.6 71813.6 72337.0 72395.0 72939.6 14985.4 15029.7 15074.5 15158.5 15312.2 21858.0 25402.5 25565.7 25576.4 25590.0 7650.4 7826.8 7937.8 7986.5 8071.4 6540.7 6711.9 6764.5 6776.1 6790.6 7462.4 7647.9 7662.3 7698.9 7770.8 2996.2 3001.2 3052.5 3125.1 3131.7 782.9 833.3 857.6 914.3 954.8 14743.9 15051.0 15292.8 15371.8 15604.6 839.9 862.5 884.0 888.8 911.1 8352.2 8658.1 8689.3 8858.5 8975.4 275799.0 277168.0 369657.0 373020.0 375099.0 70876.6 71028.6 71804.0 73092.6 73463.3 951.2 963.7 969.5 997.5 1003.4 14746.7 14946.9 15116.2 15265.9 15429.8 24463.4 31518.5 33825.7 34015.1 34301.1 33574.7 33976.2 34458.0 36254.0 36793.0 7408.4 7424.0 7466.3 7509.0 7619.0 11139.6 11572.8 11720.1 11825.6 12004.3 9729.7 9746.7 9946.9 10064.5 10782.5 9452.9 9918.5 9938.4 9997.8 10022.3 9900.5 9977.7 10214.0 10355.7 10700.9 7519.9 7596.7 7622.7 7631.5 7750.4 8798.3 10039.6 10260.8 10262.5 10442.6 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | [#3] mootools.html Cycles:180 Average:5276.56 Median:6253.87 stddev:2809.34 (44.9%) stddev-sans-first:2801.33 09:54:30 INFO - PROCESS | 11085 | Values: 1300.5 1417.2 1437.6 1557.6 1758.3 7193.3 7345.8 7389.0 7392.9 7425.1 7373.9 7563.4 7567.0 7568.5 7568.8 1938.4 2159.9 2229.3 2264.1 2289.6 2236.9 2245.0 2246.5 2249.4 2250.6 2151.5 2224.1 2227.2 2230.0 2234.3 2211.3 2218.7 2219.7 2277.0 2283.1 2158.5 2179.4 2187.9 2188.3 2222.4 7377.9 7425.3 7449.1 7451.4 7456.1 4557.1 4670.0 4671.4 4697.6 4700.9 2861.9 2885.2 2928.1 2937.8 3016.0 913.5 922.0 935.5 940.9 942.3 10566.1 10571.6 10594.8 10611.2 10623.6 4041.8 4185.1 4216.3 4301.8 4308.9 8914.6 8933.2 8958.3 8971.6 9019.6 4085.9 4364.8 4392.7 4407.1 4411.4 4087.9 4145.1 4178.9 4186.8 4200.0 3576.7 3655.8 3680.7 3704.2 3708.1 1186.4 1202.4 1210.2 1213.7 1216.8 841.1 849.1 851.3 858.4 1080.1 7220.6 7224.9 7246.0 7272.6 7285.0 452.2 465.2 468.6 471.0 473.7 5331.7 5341.7 5417.2 5452.5 5454.9 9050.5 9172.0 9423.9 9525.5 9533.9 9250.6 9251.6 9341.0 9405.2 9424.2 7076.1 7223.5 7323.1 7337.2 7354.6 6831.3 6855.2 6855.4 6872.9 6900.2 7938.3 8296.6 8324.3 8329.1 8433.0 8472.8 8627.8 8776.9 8779.9 8801.6 5725.5 6369.6 6504.9 6540.0 6604.6 7105.3 7128.8 7144.1 7145.9 7149.5 6353.3 6491.1 6574.4 6575.0 6693.1 6120.8 6504.4 6598.9 6600.0 6615.9 6757.6 6760.5 6767.8 6781.9 6790.0 6174.0 6226.6 6249.9 6257.8 6260.0 6133.0 6147.6 6162.2 6162.3 6201.2 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | [#4] prototype.html Cycles:180 Average:4642.15 Median:5297.08 stddev:1355.83 (25.6%) stddev-sans-first:1320.34 09:54:30 INFO - PROCESS | 11085 | Values: 324.5 324.7 326.6 328.2 333.7 5278.6 5312.0 5355.9 5372.4 5375.8 5243.0 5274.2 5277.4 5280.8 5282.2 3979.8 4040.0 4143.7 4187.7 4189.1 4168.6 4184.1 4193.9 4197.7 4198.6 4134.1 4139.1 4146.9 4156.2 4164.3 3921.0 4033.2 4139.9 4147.6 4151.6 3665.0 3676.9 3681.9 3684.1 3690.2 5026.3 5069.8 5075.7 5081.4 5082.2 4723.7 4774.5 4776.7 4780.2 4786.1 5527.9 5569.8 5572.8 5584.6 5585.9 4034.5 4036.6 4038.7 4043.5 4049.1 5564.1 5873.0 5889.1 5892.1 5931.5 3933.5 4010.7 4012.6 4015.5 4020.0 4061.1 4066.5 4068.0 4068.6 4069.8 4669.5 4675.8 4679.8 4686.1 4686.7 5562.4 5567.4 5571.1 5572.3 5575.9 1401.2 1430.7 1431.5 1432.1 1433.4 883.9 918.7 930.4 964.4 966.9 4794.0 4879.0 4889.7 4902.3 4909.3 5728.9 5754.4 5758.1 5764.3 5804.9 4928.5 4936.1 4936.5 4941.9 4944.2 3076.8 3111.2 3114.4 3119.3 3119.9 5523.4 5525.9 5532.4 5535.7 5537.8 5733.6 5924.9 5944.6 5960.4 5962.4 5469.8 5485.0 5508.3 5517.4 5519.0 5800.2 5800.9 5802.1 5805.3 5808.7 5671.9 5674.8 5682.1 5683.7 5685.8 5489.8 5507.9 5508.9 5517.6 5521.1 3830.7 3965.6 4027.1 4037.0 4037.1 5725.3 5744.0 5747.9 5752.0 5758.6 5573.4 5578.5 5579.0 5583.4 5586.1 5574.1 5576.2 5578.7 5583.2 5583.7 5348.5 5484.1 5486.9 5488.1 5501.2 5585.2 5591.0 5595.9 5599.3 5601.2 5455.5 5473.3 5483.4 5486.4 5487.8 09:54:30 INFO - PROCESS | 11085 | 09:54:30 INFO - PROCESS | 11085 | [#5] yui.html Cycles:180 Average:12729.03 Median:56129.00 stddev:15072.98 (26.9%) stddev-sans-first:15087.96 09:54:30 INFO - PROCESS | 11085 | Values: 647.5 722.3 741.3 754.1 766.7 12026.5 12035.4 12054.4 12069.9 12091.5 11067.6 11106.0 11121.8 11152.7 11218.9 638.4 652.4 653.3 653.6 787.4 807.6 809.7 811.2 815.2 818.5 841.1 847.6 848.7 849.1 849.3 839.4 843.4 843.5 843.6 844.5 499.8 508.3 620.9 626.4 626.7 11082.1 11099.8 11109.5 11131.1 11172.3 11798.2 12678.7 12786.2 12800.2 13237.5 9643.0 9822.6 9843.8 9914.3 9918.8 3272.3 3351.1 3372.4 3385.0 3413.4 42511.8 43380.8 43425.3 43480.3 43492.3 9452.5 9711.5 9958.7 9981.7 10101.2 17696.4 17781.6 17782.0 17789.3 17791.6 6606.6 6635.3 6639.5 6704.7 6843.7 3577.3 3732.3 3752.5 3765.1 3790.6 2742.1 2774.7 2774.8 2782.2 2794.2 486.6 486.7 486.9 497.1 499.5 556.3 560.0 612.4 617.4 617.5 7773.8 8110.3 8116.6 8180.6 8273.8 625.2 625.4 627.2 633.0 634.8 3716.3 3764.8 3804.9 3805.6 3870.3 55639.0 55698.0 56077.0 56181.0 56326.0 47899.5 48289.0 49097.5 49502.8 49713.0 42859.1 43283.6 43404.8 44059.8 44333.0 7479.2 7510.0 7548.3 7561.9 7571.2 31606.7 32010.0 32230.2 32295.5 32305.7 37919.0 39612.8 43001.0 43343.6 43423.8 9492.1 9656.9 9669.8 9711.2 9721.5 10359.0 10380.2 10460.5 10629.7 10972.9 9773.0 9847.9 9929.9 10020.9 10110.5 9226.6 9284.5 9374.7 9637.3 9709.1 9702.8 9729.0 9877.4 9891.8 10007.2 7907.3 8111.4 8199.9 8282.5 8435.5 8524.6 8738.0 8819.2 8869.3 8956.1 09:54:30 INFO - PROCESS | 11085 | -------- Summary: end -------- 09:54:30 INFO - PROCESS | 11085 | 09:54:31 INFO - TEST-INFO | 11085: exit 0 09:54:31 INFO - TEST-OK | dromaeo_css | took 1118434ms 09:54:31 INFO - TEST-START | kraken 09:54:31 INFO - operating with platform_type : linux_ 09:54:31 INFO - Initialising browser for kraken test... 09:54:31 INFO - TEST-INFO | started process 11262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY0Okb_/profile http://localhost:33907/getInfo.html) 09:54:35 INFO - PROCESS | 11262 | __metrics Screen width/height:1600/1200 09:54:35 INFO - PROCESS | 11262 | colorDepth:24 09:54:35 INFO - PROCESS | 11262 | Browser inner width/height: 1024/697 09:54:35 INFO - PROCESS | 11262 | __metrics 09:54:36 ERROR - PROCESS | 11262 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:54:37 INFO - TEST-INFO | 11262: exit 0 09:54:37 INFO - Browser initialized. 09:54:37 INFO - Running cycle 1/1 for kraken test... 09:54:37 INFO - TEST-INFO | started process 11345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY0Okb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:49 INFO - PROCESS | 11345 | RSS: Main: 153972736 09:54:49 INFO - PROCESS | 11345 | 09:54:52 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-beat-detection) 09:54:52 INFO - PROCESS | 11345 | RSS: Main: 195776512 09:54:52 INFO - PROCESS | 11345 | 09:54:55 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-dft) 09:54:56 INFO - PROCESS | 11345 | RSS: Main: 185491456 09:54:56 INFO - PROCESS | 11345 | 09:54:59 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-fft) 09:54:59 INFO - PROCESS | 11345 | RSS: Main: 171945984 09:54:59 INFO - PROCESS | 11345 | 09:55:02 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33907/tests/kraken/driver.html?testName=audio-oscillator) 09:55:02 INFO - PROCESS | 11345 | RSS: Main: 173391872 09:55:02 INFO - PROCESS | 11345 | 09:55:04 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33907/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:05 INFO - PROCESS | 11345 | RSS: Main: 173142016 09:55:05 INFO - PROCESS | 11345 | 09:55:08 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33907/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:09 INFO - PROCESS | 11345 | RSS: Main: 173285376 09:55:09 INFO - PROCESS | 11345 | 09:55:12 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33907/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:13 INFO - PROCESS | 11345 | RSS: Main: 173412352 09:55:13 INFO - PROCESS | 11345 | 09:55:16 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33907/tests/kraken/driver.html?testName=json-parse-financial) 09:55:16 INFO - PROCESS | 11345 | RSS: Main: 174452736 09:55:16 INFO - PROCESS | 11345 | 09:55:18 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33907/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:18 INFO - PROCESS | 11345 | RSS: Main: 187498496 09:55:18 INFO - PROCESS | 11345 | 09:55:20 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:21 INFO - PROCESS | 11345 | RSS: Main: 185843712 09:55:21 INFO - PROCESS | 11345 | 09:55:23 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:24 INFO - PROCESS | 11345 | RSS: Main: 193429504 09:55:24 INFO - PROCESS | 11345 | 09:55:26 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:27 INFO - PROCESS | 11345 | RSS: Main: 199811072 09:55:27 INFO - PROCESS | 11345 | 09:55:29 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:30 INFO - PROCESS | 11345 | RSS: Main: 196820992 09:55:30 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:33907/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33907/tests/kraken/driver.html?testName=ai-astar) 09:55:32 INFO - PROCESS | 11345 | RSS: Main: 260112384 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | __start_tp_report 09:55:32 INFO - PROCESS | 11345 | _x_x_mozilla_page_load 09:55:32 INFO - PROCESS | 11345 | _x_x_mozilla_page_load_details 09:55:32 INFO - PROCESS | 11345 | |i|pagename|runs| 09:55:32 INFO - PROCESS | 11345 | |0;ai-astar;110;111;106;112;112;111;100;111;111;111 09:55:32 INFO - PROCESS | 11345 | |1;audio-beat-detection;164;131;160;185;134;162;158;133;177;140 09:55:32 INFO - PROCESS | 11345 | |2;audio-dft;163;161;162;163;162;161;161;161;162;160 09:55:32 INFO - PROCESS | 11345 | |3;audio-fft;74;73;75;159;77;74;74;75;156;75 09:55:32 INFO - PROCESS | 11345 | |4;audio-oscillator;94;94;141;94;95;94;133;93;95;134 09:55:32 INFO - PROCESS | 11345 | |5;imaging-gaussian-blur;117;116;118;117;117;117;117;117;117;117 09:55:32 INFO - PROCESS | 11345 | |6;imaging-darkroom;145;146;146;146;147;145;146;146;145;146 09:55:32 INFO - PROCESS | 11345 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 09:55:32 INFO - PROCESS | 11345 | |8;json-parse-financial;63;65;64;64;64;64;64;75;62;61 09:55:32 INFO - PROCESS | 11345 | |9;json-stringify-tinderbox;63;64;64;63;63;64;64;64;65;64 09:55:32 INFO - PROCESS | 11345 | |10;stanford-crypto-aes;80;82;81;82;82;81;81;82;81;82 09:55:32 INFO - PROCESS | 11345 | |11;stanford-crypto-ccm;116;115;126;117;126;119;122;117;120;120 09:55:32 INFO - PROCESS | 11345 | |12;stanford-crypto-pbkdf2;141;128;140;139;139;129;141;150;141;139 09:55:32 INFO - PROCESS | 11345 | |13;stanford-crypto-sha256-iterative;69;67;70;70;67;69;67;67;67;67 09:55:32 INFO - PROCESS | 11345 | __end_tp_report 09:55:32 INFO - PROCESS | 11345 | __start_cc_report 09:55:32 INFO - PROCESS | 11345 | _x_x_mozilla_cycle_collect,1182 09:55:32 INFO - PROCESS | 11345 | __end_cc_report 09:55:32 INFO - PROCESS | 11345 | __startTimestamp1459529732382__endTimestamp 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | ------- Summary: start ------- 09:55:32 INFO - PROCESS | 11345 | Number of tests: 14 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:3.97 09:55:32 INFO - PROCESS | 11345 | Values: 110.0 111.0 106.0 112.0 112.0 111.0 100.0 111.0 111.0 111.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:161.00 stddev:19.06 (11.8%) stddev-sans-first:19.90 09:55:32 INFO - PROCESS | 11345 | Values: 164.0 131.0 160.0 185.0 134.0 162.0 158.0 133.0 177.0 140.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 09:55:32 INFO - PROCESS | 11345 | Values: 163.0 161.0 162.0 163.0 162.0 161.0 161.0 161.0 162.0 160.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.50 stddev:34.97 (46.9%) stddev-sans-first:36.53 09:55:32 INFO - PROCESS | 11345 | Values: 74.0 73.0 75.0 159.0 77.0 74.0 74.0 75.0 156.0 75.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:94.00 stddev:20.33 (21.6%) stddev-sans-first:21.04 09:55:32 INFO - PROCESS | 11345 | Values: 94.0 94.0 141.0 94.0 95.0 94.0 133.0 93.0 95.0 134.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:55:32 INFO - PROCESS | 11345 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 09:55:32 INFO - PROCESS | 11345 | Values: 145.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 145.0 146.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:55:32 INFO - PROCESS | 11345 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:3.84 (6.0%) stddev-sans-first:4.02 09:55:32 INFO - PROCESS | 11345 | Values: 63.0 65.0 64.0 64.0 64.0 64.0 64.0 75.0 62.0 61.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 09:55:32 INFO - PROCESS | 11345 | Values: 63.0 64.0 64.0 63.0 63.0 64.0 64.0 64.0 65.0 64.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:0.70 (0.9%) stddev-sans-first:0.53 09:55:32 INFO - PROCESS | 11345 | Values: 80.0 82.0 81.0 82.0 82.0 81.0 81.0 82.0 81.0 82.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:120.00 stddev:3.88 (3.2%) stddev-sans-first:3.87 09:55:32 INFO - PROCESS | 11345 | Values: 116.0 115.0 126.0 117.0 126.0 119.0 122.0 117.0 120.0 120.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.70 Median:140.50 stddev:6.27 (4.5%) stddev-sans-first:6.60 09:55:32 INFO - PROCESS | 11345 | Values: 141.0 128.0 140.0 139.0 139.0 129.0 141.0 150.0 141.0 139.0 09:55:32 INFO - PROCESS | 11345 | 09:55:32 INFO - PROCESS | 11345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 09:55:32 INFO - PROCESS | 11345 | Values: 69.0 67.0 70.0 70.0 67.0 69.0 67.0 67.0 67.0 67.0 09:55:32 INFO - PROCESS | 11345 | -------- Summary: end -------- 09:55:32 INFO - PROCESS | 11345 | 09:55:33 INFO - TEST-INFO | 11345: exit 0 09:55:33 INFO - TEST-OK | kraken | took 61896ms 09:55:33 INFO - SUITE-END | took 1180s 09:55:33 INFO - Completed test suite (00:19:40) 09:55:33 INFO - javascript benchmark 09:55:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.830296030758, 2717.157681118852, 2723.7003929567754, 2729.522333591621, 2754.66943966724, 4592.678512504126, 4674.25211966085, 4676.789544470498, 4677.22825733754, 4683.4379874415035, 4638.698484598499, 4658.976705116478, 4660.114578230134, 4750.28745688147, 4767.499412561683, 4265.744055356681, 4306.698531102824, 4344.370066340379, 4363.476382834065, 4471.374007638933, 4417.514073451934, 4445.8221671133115, 4448.421705178323, 4483.08096840147, 4506.707064040843, 4276.957230427687, 4313.245182093153, 4352.804123814436, 4362.498312694049, 4383.846565370229, 4323.2434323993175, 4327.982924012855, 4362.738235705836, 4377.23398405281, 4391.846285380028, 4305.720128191658, 4307.1601037797645, 4319.935200971988, 4346.826126954918, 4350.7172033818015, 4506.121306345264, 4516.54834516549, 4540.0, 4587.885302867422, 4623.329617205486, 5060.746962651852, 5080.441151473335, 5082.364704411949, 5090.669106508102, 5127.692338459704, 5077.517635824628, 5087.643864929457, 5096.974515127437, 5101.362329708786, 5151.5878729701535, 4658.208104622222, 4727.739974301447, 4736.83421080264, 4767.308740232646, 4811.350467686818, 5127.333446651986, 5153.304303918923, 5154.123798954187, 5154.974225128851, 5175.896482070338, 4914.827981020647, 4939.0, 4939.604831613462, 4939.777710003059, 4988.0, 4975.154223781966, 4976.975115124474, 4991.376077990251, 5032.169692000852, 5082.974585127125, 5021.171506701354, 5037.118504261813, 5056.367954005749, 5063.139266324733, 5115.386153661584, 5026.673266237683, 5043.646944713908, 5047.621428392885, 5047.949520504748, 5050.116229659795, 4179.832806687698, 4236.322188449833, 4256.233877902007, 4259.0, 4301.677374196947, 3717.7955212463035, 3723.6090210527504, 3726.8695595654563, 3732.309522738302, 3772.4152756322815, 4315.503717072514, 4332.610065094157, 4332.913341733148, 4354.238008348526, 4370.104128653618, 4903.779329930162, 5040.79836806531, 5047.318611987408, 5052.9747351263, 5125.692458452505, 4331.6534677225745, 4333.285007973712, 4343.652507799368, 4352.782360882006, 4379.0585024219945, 4511.571400716926, 4528.071745292207, 4562.338460923214, 4567.223571992769, 4576.6109880660515, 4667.416572928384, 4751.287306903992, 4768.642351823558, 4842.878928026827, 4848.0, 5013.674111182907, 5014.72419016943, 5048.091343558048, 5051.671641343448, 5106.872328191676, 4771.308160316666, 4771.403574553181, 4777.95222047789, 4778.068276686013, 4819.0, 4808.422989241313, 4930.975345123252, 4978.253262010728, 5003.899922001612, 5026.447090819934, 4989.675671081368, 5008.248762685481, 5030.144875371123, 5036.798528058983, 5092.872678183075, 4721.881952951204, 4850.151223535797, 4857.95142048575, 4860.9513904861915, 4902.63230257725, 4916.926246106383, 4922.901541969212, 4944.901101978012, 4980.750962451791, 4992.950070499249, 4744.715317080986, 4746.667733258639, 4764.14245435811, 4772.379590653193, 4808.663393562557, 4778.617710583215, 4873.171560834596, 4873.926891096708, 4903.681260718042, 4929.162042452864, 4644.8374306899095, 4712.905741885212, 4791.257355109963, 4806.44725856517, 4855.1260773061185], "unit": "score", "name": "dojo.html", "value": 4626.069276987291}, {"lowerIsBetter": false, "replicates": [520.5575261028124, 543.7063985447857, 553.8283132229009, 560.8362647506424, 566.2412367427646, 33306.0, 33806.66193338066, 33885.830570847174, 33909.152271193205, 33917.32165356698, 34010.48984265238, 34531.82734086326, 34543.13642158947, 34552.30895382091, 34571.0, 7472.4395670324675, 7651.196624354446, 7656.425768067389, 7659.770206893774, 7667.118281397627, 7532.472726909118, 7837.451378403514, 7839.78483335084, 7841.294283514482, 7842.41181911356, 7808.297253247207, 7893.210678932118, 7897.960510197441, 7899.0, 7901.446898717092, 7806.687732490694, 7856.292933635971, 7864.803379915491, 7868.763937081897, 7877.645505952246, 7759.030121234846, 7882.842343153162, 7883.684652613946, 7885.408594355446, 7888.329491993188, 35798.64201358005, 36216.0, 36252.81873590642, 36303.09242268938, 36323.4551481728, 1886.9181447247875, 3117.423276693819, 3198.6001749781276, 3205.5512228288057, 3753.7560058596105, 26012.0, 26202.0, 26390.6041409379, 26418.339541511425, 26460.294622810143, 3410.8294585270887, 3429.5027221053056, 3445.7243420526297, 3479.6346383629607, 3584.1039740064984, 166834.0, 167306.0, 167355.0, 167722.0, 167950.0, 51356.48643513517, 54042.0, 54591.45408545943, 58826.0, 60139.699301504086, 53031.0, 53085.734571326895, 53259.46740532623, 53273.46726532685, 53332.0, 13237.205767653972, 13456.394462249222, 13464.326783660777, 13466.394012269471, 13466.461341546425, 9768.51157442125, 9786.363886347364, 9814.705558833246, 9819.06718861707, 9851.655192068243, 19239.20373654392, 19823.20707171697, 19851.60296794085, 19918.0, 19925.402237932594, 6367.936320636827, 7031.332023457763, 7094.787156385317, 7172.28277172289, 7255.564666119944, 879.771259472529, 959.9824186362478, 997.8203923293877, 1008.2740426892625, 1014.964735969322, 25631.56868918573, 25781.871090644803, 25967.0, 26275.0, 26337.604935925978, 961.0341606685377, 971.5433746139303, 990.8662330585423, 1039.0804138337626, 1098.4013712526692, 13951.0, 14036.943487437558, 14257.429702811978, 14384.424623015171, 14388.928055359656, 357465.0, 366606.0, 366738.0, 366833.0, 367205.0, 50328.496715033114, 51181.48818511842, 51187.488125119016, 51339.0, 51353.7432312836, 1031.293563908725, 1146.1518476327624, 1199.8140288255333, 1202.945867435985, 1227.8281040654315, 27064.376137431816, 27170.1848944532, 27589.448211035266, 27733.168004959884, 27822.86088569544, 40871.0, 40893.182136357704, 41138.0, 41195.38206926958, 41248.79375603103, 240953.0, 242140.0, 242559.0, 242618.0, 242843.0, 34398.484022739176, 35413.1146721334, 39072.2185556293, 39953.80023099866, 40110.79944600258, 38929.80535097307, 40826.0, 41414.792926035174, 41434.40635514167, 41520.0, 34270.48594271138, 34585.30829383348, 34628.48057279193, 34727.47908781421, 34775.65224347825, 34283.657163429045, 34315.485267720505, 34378.82810585931, 34470.65529344675, 34749.305013900084, 34699.82650086733, 34887.47668785021, 34906.47640285347, 35320.29359412849, 37330.81334593309, 26999.73000269972, 28554.286142846595, 28589.42821143524, 28807.56788648214, 29986.30784933638, 24318.148864789648, 24586.754132459162, 24622.41464646258, 24966.37584060413, 25008.874955625834], "unit": "score", "name": "ext.html", "value": 16915.479729889455}, {"lowerIsBetter": false, "replicates": [353.8142475200519, 358.3800025955098, 360.38734151941696, 370.4147447033685, 374.0611066223781, 13221.338933053357, 13630.04589678723, 15559.533214003584, 15884.84115158848, 16718.99686018838, 15516.30176642051, 16046.919765401186, 16079.437219697313, 16875.746863797052, 17606.911965440187, 5292.311999440077, 5435.755391007414, 5462.289902312694, 5484.287042684446, 5484.451554844503, 5440.4287549807295, 5505.229267902477, 5621.0444224481935, 5687.431256874321, 5688.715564221793, 5632.3804381518, 5648.491635752802, 5649.039663257236, 5652.378238393773, 5653.802116925908, 5626.859328516779, 6149.661768602725, 6420.5184611154355, 6427.5822071565435, 6430.196225471816, 6121.755129794803, 6159.722812473449, 6179.907301390483, 6181.289151747562, 6183.721732522047, 21924.123035078577, 22085.447863803372, 22760.430989225235, 22765.658515122286, 22855.0, 2037.3684157911096, 2062.453449835795, 2111.609352269835, 2278.2595656411568, 2560.577504711739, 13519.797203041864, 13799.172049677052, 13810.171389716648, 13893.0, 13926.582202533838, 1844.732513785507, 1870.4482177757593, 1898.392514395394, 1914.2247389807012, 1940.2820956246137, 70650.64674676594, 71813.64093179553, 72337.0, 72395.0, 72939.63530182368, 14985.40058397652, 15029.745538169362, 15074.54776356711, 15158.545243642708, 15312.234388280764, 21858.0, 25402.491950161264, 25565.744342556707, 25576.360590985376, 25590.0, 7650.38796896247, 7826.7651970440975, 7937.801554961172, 7986.520808751494, 8071.434999549975, 6540.70566824494, 6711.865762684816, 6764.458843292623, 6776.119104516381, 6790.558613690095, 7462.395584949262, 7647.923520764833, 7662.348700360531, 7698.884516732253, 7770.766876993699, 2996.235959830229, 3001.1896787867154, 3052.496338104188, 3125.1093438369953, 3131.6711745266875, 782.8943092682415, 833.2792134803351, 857.5969294431607, 914.3188324698142, 954.7756277274835, 14743.852561474248, 15051.0, 15292.770608440882, 15371.846281537042, 15604.609884752972, 839.9421417527083, 862.5374555643673, 883.9911600884037, 888.7555922121468, 911.1253196930888, 8352.16478352172, 8658.090900455361, 8689.304855611535, 8858.512781797062, 8975.416597921114, 275799.0, 277168.0, 369657.0, 373020.0, 375099.0, 70876.64561677158, 71028.64485677538, 71804.0, 73092.63453682805, 73463.26536734671, 951.167728237792, 963.7012526116927, 969.5055521684133, 997.4713401897006, 1003.4180175498193, 14746.705065898837, 14946.925265373604, 15116.244187790346, 15265.923670381577, 15429.768553471482, 24463.38841528976, 31518.527222091227, 33825.661743382254, 34015.14962125967, 34301.14247143841, 33574.66425335813, 33976.15059623529, 34458.0, 36254.0, 36793.0, 7408.444366672414, 7423.962880185781, 7466.290702383265, 7509.023826902468, 7619.009528761226, 11139.554417823196, 11572.768544628892, 11720.062395008208, 11825.64523064275, 12004.279743215435, 9729.659461918798, 9746.707598772047, 9946.900530994597, 10064.54709538058, 10782.514786834454, 9452.858207127036, 9918.504074796376, 9938.403695778277, 9997.750056248651, 10022.298439109483, 9900.504974751379, 9977.650782222587, 10214.0, 10355.741106472398, 10700.892991070301, 7519.924800751923, 7596.734114305973, 7622.733204337822, 7631.465797394129, 7750.418718596015, 8798.340124490816, 10039.648612298535, 10260.846087308846, 10262.486875656037, 10442.63450779219], "unit": "score", "name": "jquery.html", "value": 8707.580472442076}, {"lowerIsBetter": false, "replicates": [1300.5318085489228, 1417.192200445746, 1437.6334034821118, 1557.5560965124942, 1758.2878934031721, 7193.316634919681, 7345.8163545911375, 7389.039424874765, 7392.889106663404, 7425.071866016741, 7373.852522949538, 7563.394928405728, 7567.0, 7568.470207085506, 7568.848623027536, 1938.3797184900836, 2159.946001349971, 2229.320057382498, 2264.071730590458, 2289.633658614622, 2236.9217077402295, 2245.023414814553, 2246.528229071897, 2249.3589327041796, 2250.628646273363, 2151.5051538146236, 2224.0992398078806, 2227.175944900389, 2229.9888500557477, 2234.2515257388795, 2211.259228158569, 2218.7226596675414, 2219.711437513121, 2276.9886150569305, 2283.120998415622, 2158.4927542027613, 2179.3679832848456, 2187.890605469736, 2188.3106821351225, 2222.3999520129637, 7377.852442951164, 7425.331720145213, 7449.106107267163, 7451.403887688972, 7456.142543607501, 4557.065801510682, 4670.0, 4671.416072990876, 4697.553732395417, 4700.929486057677, 2861.856907154634, 2885.2498350428828, 2928.07765553852, 2937.7943543951933, 3016.0348688419713, 913.5152385511399, 922.0456827183832, 935.4901578639658, 940.8870935487716, 942.2885721280389, 10566.101881340095, 10571.577136914591, 10594.788104237872, 10611.204159687977, 10623.57505699771, 4041.7979101045416, 4185.121124563815, 4216.3464662977285, 4301.827926882952, 4308.935365969451, 8914.598843052077, 8933.240674542607, 8958.328125390623, 8971.551422428853, 9019.594118264693, 4085.8569950051606, 4364.847230346986, 4392.714473559208, 4407.074514352022, 4411.3824064630335, 4087.9386809197886, 4145.1295228002455, 4178.91642167155, 4186.811593478301, 4199.97100710328, 3576.7317451191266, 3655.817209139532, 3680.723945704083, 3704.240630670706, 3708.0915175782106, 1186.424584076722, 1202.4408649977802, 1210.2073142091945, 1213.6662417835166, 1216.8418105646385, 841.1084250694283, 849.0745087854268, 851.2891735400885, 858.4463021351319, 1080.0873262093519, 7220.602866842269, 7224.855502890018, 7246.0, 7272.563646181246, 7284.963575182091, 452.15221459762944, 465.17431558983077, 468.6040295949917, 470.9929351059737, 473.6992010073559, 5331.680099194061, 5341.679499230058, 5417.214503896913, 5452.536534394541, 5454.91817622736, 9050.456972581665, 9172.0, 9423.905760942303, 9525.52372381392, 9533.904660953302, 9250.583723732449, 9251.629934802668, 9340.953295233481, 9405.153536181777, 9424.246060315158, 7076.0801095857205, 7223.494355395072, 7323.121225452873, 7337.19290878003, 7354.595497247596, 6831.28271531482, 6855.177378714586, 6855.4172895304455, 6872.862542749217, 6900.2409734930125, 7938.285554300141, 8296.626651800803, 8324.334053275603, 8329.125441828763, 8433.0, 8472.788180295542, 8627.784305392415, 8776.91223087761, 8779.868301975603, 8801.647934082564, 5725.51333136688, 6369.617822930639, 6504.902426463512, 6540.0, 6604.603723776397, 7105.25394833535, 7128.786136415916, 7144.106986626672, 7145.892811607726, 7149.53528020677, 6353.332900045429, 6491.058796474579, 6574.3754343337305, 6575.0, 6693.09643198162, 6120.816375508742, 6504.447121994684, 6598.934010659832, 6600.0, 6615.867682646416, 6757.560758550679, 6760.526763126731, 6767.796966091025, 6781.93218067813, 6790.049393085071, 6174.0, 6226.62640241587, 6249.9375006251175, 6257.812265632038, 6259.96870015647, 6133.018717005258, 6147.631142131308, 6162.168107305456, 6162.291336496361, 6201.224846894138], "unit": "score", "name": "mootools.html", "value": 4224.4571979896755}, {"lowerIsBetter": false, "replicates": [324.5067497403946, 324.7207401634595, 326.55099238546995, 328.1893722505412, 333.71800828300076, 5278.577713782898, 5311.973440132799, 5355.9020400817835, 5372.4090350061515, 5375.838724838251, 5242.973785131069, 5274.235235890794, 5277.419483856782, 5280.788768449257, 5282.181261904401, 3979.781112038837, 4040.0, 4143.730657507267, 4187.685923555738, 4189.07840275139, 4168.5623009584015, 4184.100418410041, 4193.937090943638, 4197.748135111903, 4198.6011328923705, 4134.131832315217, 4139.130782535671, 4146.937795933063, 4156.189543039109, 4164.292070348048, 3921.0, 4033.1530378620523, 4139.875803725893, 4147.6474499667565, 4151.584841515854, 3665.0470877571756, 3676.889693309205, 3681.895431370578, 3684.1158122050783, 3690.225052738928, 5026.321446604698, 5069.797208111671, 5075.720835354054, 5081.390233172006, 5082.237664350377, 4723.740194289313, 4774.546418090275, 4776.665633405663, 4780.163471392492, 4786.114568804782, 5527.861803454905, 5569.832905012856, 5572.832815015556, 5584.6090773645865, 5585.860353491195, 4034.536028356747, 4036.576159503239, 4038.7374820636564, 4043.454133691973, 4049.1091959768805, 5564.137558678412, 5873.0, 5889.116632505115, 5892.116182572606, 5931.525477961796, 3933.488646475997, 4010.7393019453643, 4012.61880121388, 4015.5382131054716, 4020.0351915540646, 4061.1065565575527, 4066.4510291110914, 4068.0, 4068.613481719232, 4069.7761623110423, 4669.4630117536235, 4675.7895894684825, 4679.836205732783, 4686.133065382915, 4686.71879687213, 5562.443755624486, 5567.415421380778, 5571.13647384656, 5572.331320241516, 5575.860603484945, 1401.1943132698739, 1430.7210094031773, 1431.5490620454523, 1432.1335591966917, 1433.426629348269, 883.9292856571587, 918.7289749523907, 930.4463844012802, 964.3538828984597, 966.9033096690275, 4793.952060479421, 4879.048585525788, 4889.706617602955, 4902.313676085351, 4909.337239472697, 5728.914066289009, 5754.395788442237, 5758.078707406795, 5764.337101233328, 5804.88390232193, 4928.5317894800655, 4936.111499930047, 4936.506349365035, 4941.8517444476, 4944.208926571731, 3076.8307743073897, 3111.191090316534, 3114.4394009078583, 3119.313750974782, 3119.937601248008, 5523.4200408956485, 5525.889482210333, 5532.3914369419335, 5535.667859928417, 5537.750801213955, 5733.627314224562, 5924.940750592439, 5944.643321400643, 5960.433758792908, 5962.3739507351975, 5469.753861076261, 5484.972575137019, 5508.338999320107, 5517.44825517445, 5519.034169020405, 5800.24596802413, 5800.854978625399, 5802.100674395476, 5805.274340707411, 5808.680522571299, 5671.886562268649, 5674.829755107354, 5682.147677848356, 5683.7442315095095, 5685.772569097356, 5489.752961116679, 5507.944920550904, 5508.889822203613, 5517.641353312022, 5521.089020311603, 3830.6552410283207, 3965.583613720518, 4027.0737730322776, 4036.9596304036586, 4037.0916543777416, 5725.341585717696, 5743.966086104541, 5747.9137812932, 5751.971240143773, 5758.625689330348, 5573.359063707726, 5578.497935185853, 5578.972105139448, 5583.441655834384, 5586.1062230043, 5574.136008918624, 5576.163575463551, 5578.748956297058, 5583.218349431002, 5583.720813959205, 5348.465153484776, 5484.122540393518, 5486.890262194814, 5488.121900495901, 5501.174823776466, 5585.1901474286815, 5591.021571225101, 5595.944040559542, 5599.32808063035, 5601.159826026129, 5455.481729235717, 5473.31583552056, 5483.369412517612, 5486.423925487767, 5487.835364939058], "unit": "score", "name": "prototype.html", "value": 4209.410729390835}, {"lowerIsBetter": false, "replicates": [647.5499527828159, 722.2596838240805, 741.280957471253, 754.0762565856825, 766.6856588798594, 12026.458809353579, 12035.398230088493, 12054.397280136001, 12069.939650301747, 12091.455884485198, 11067.557297708103, 11106.0, 11121.777564448706, 11152.665420037412, 11218.887811121886, 638.4126603524757, 652.4291245160484, 653.2585515439962, 653.6013032050446, 787.4173111897184, 807.5840941914919, 809.7165991902816, 811.1604489353521, 815.2214635023538, 818.4557269415861, 841.0580150231749, 847.6482259862181, 848.7241646464923, 849.1381248033251, 849.3332733803965, 839.3914412051275, 843.3506200225853, 843.5023336231592, 843.569779412501, 844.4679851693425, 499.8175665881927, 508.34677439490076, 620.9285932117774, 626.3673689573518, 626.6929204689715, 11082.05802506788, 11099.778004439946, 11109.500072496758, 11131.109511239081, 11172.273802202832, 11798.174127811057, 12678.683032924158, 12786.232826030468, 12800.167989080774, 13237.470501179941, 9642.951785241028, 9822.607095716163, 9843.803123937481, 9914.305998580103, 9918.752031199278, 3272.3291725196277, 3351.128706536318, 3372.359251742161, 3385.0, 3413.4026545354463, 42511.78744106291, 43380.78309608463, 43425.34861977073, 43480.347794782785, 43492.3476147858, 9452.480113593818, 9711.514424278757, 9958.651447199314, 9981.727384526524, 10101.19190464761, 17696.380626678005, 17781.555461113574, 17782.0, 17789.288428462976, 17791.644167116843, 6606.603603783692, 6635.303293154149, 6639.468842492685, 6704.731810727614, 6843.657817109125, 3577.338192434408, 3732.309522738302, 3752.45589389537, 3765.1151979284846, 3790.6209379062425, 2742.1088146352517, 2774.6531683539556, 2774.7918906082123, 2782.1653503949137, 2794.1617514745494, 486.6131425516723, 486.7006790823618, 486.9269609558524, 497.08536293220646, 499.51796516361884, 556.3046192259675, 559.9524040456525, 612.4334990134108, 617.3764497857106, 617.5090802811685, 7773.805654858561, 8110.270075693216, 8116.553589552514, 8180.550069746102, 8273.83452330962, 625.1685258606134, 625.4058644287853, 627.2253766598247, 632.9651869147149, 634.8063840528683, 3716.273544883769, 3764.8305826237884, 3804.9429258561145, 3805.6384643458828, 3870.2646497165447, 55639.0, 55698.0, 56077.0, 56181.0, 56326.0, 47899.52100478951, 48289.0, 49097.50902491001, 49502.75248623734, 49713.0, 42859.14281714348, 43283.56716432858, 43404.78297608429, 44059.77970110193, 44333.0, 7479.214682458263, 7510.0, 7548.320651141424, 7561.9243807563425, 7571.242875712384, 31606.683933160373, 32010.039698809072, 32230.19424514406, 32295.51556726698, 32305.676943230268, 37919.0, 39612.80193599014, 43001.0, 43343.56656433395, 43423.78288108539, 9492.098250666175, 9656.855147172939, 9669.758256043655, 9711.174550163316, 9721.513924303898, 10359.0, 10380.221483388625, 10460.529276182438, 10629.734256643645, 10972.945135274273, 9773.0, 9847.901520984986, 9929.851052234078, 10020.949895250476, 10110.49447527606, 9226.584803683985, 9284.535773211177, 9374.718758437259, 9637.277204209571, 9709.126178643955, 9702.75743106428, 9728.951355243462, 9877.40735555869, 9891.752706182404, 10007.249456290661, 7907.275470120057, 8111.351091912515, 8199.877001845096, 8282.50304981703, 8435.53604551731, 8524.573771311534, 8738.0, 8819.162179592928, 8869.334799890163, 8956.104389560991], "unit": "score", "name": "yui.html", "value": 5766.035952167366}], "name": "dromaeo_css", "value": 6417.778149635746}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 112.0, 112.0, 111.0, 100.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [164.0, 131.0, 160.0, 185.0, 134.0, 162.0, 158.0, 133.0, 177.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 154.4}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 159.0, 77.0, 74.0, 74.0, 75.0, 156.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 94.0, 95.0, 94.0, 133.0, 93.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 75.0, 62.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 82.0, 82.0, 81.0, 81.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 126.0, 117.0, 126.0, 119.0, 122.0, 117.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 140.0, 139.0, 139.0, 129.0, 141.0, 150.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 70.0, 67.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1517.7}]} 09:55:33 INFO - Return code: 0 09:55:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:55:33 ERROR - # TBPL SUCCESS # 09:55:33 INFO - Running post-action listener: _resource_record_post_action 09:55:33 INFO - Running post-run listener: _resource_record_post_run 09:55:34 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 520261632; Read time: 272; Write time: 547712 09:55:34 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 239386624; Read time: 0; Write time: 302272 09:55:34 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 280875008; Read time: 272; Write time: 245440 09:55:34 INFO - Running post-run listener: _upload_blobber_files 09:55:34 INFO - Blob upload gear active. 09:55:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:55:34 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 09:55:34 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'] 09:55:34 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 09:55:35 INFO - (blobuploader) - INFO - Open directory for files ... 09:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:55:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:36 INFO - (blobuploader) - INFO - Done attempting. 09:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:55:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:36 INFO - (blobuploader) - INFO - Done attempting. 09:55:36 INFO - (blobuploader) - INFO - Iteration through files over. 09:55:36 INFO - Return code: 0 09:55:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:55:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:55:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b08e9d93624e4b162e5c563a98bd73b0b8f58ae3c6c6c95c051f98622f43f5bccedb322858d2a43a26944eeff09e7a8a754cfcc14d097a53a689b5f0377a7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ca83df065f5c282bd1b70483b779ad57eccf1ab32fc9e3d13f2bbcb2d301548efd381933ff940be86c3663c9e51053f401609ccc3e0a6568c88a2e8500c9ae8"} 09:55:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:55:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:55:36 INFO - Contents: 09:55:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b08e9d93624e4b162e5c563a98bd73b0b8f58ae3c6c6c95c051f98622f43f5bccedb322858d2a43a26944eeff09e7a8a754cfcc14d097a53a689b5f0377a7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ca83df065f5c282bd1b70483b779ad57eccf1ab32fc9e3d13f2bbcb2d301548efd381933ff940be86c3663c9e51053f401609ccc3e0a6568c88a2e8500c9ae8"} 09:55:36 INFO - Running post-run listener: copy_logs_to_upload_dir 09:55:36 INFO - Copying logs to upload dir... 09:55:36 INFO - mkdir: /builds/slave/test/build/upload/logs 09:55:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.914491 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-01 09:55:36.454905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 09:55:36.458641) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 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/a9b08e9d93624e4b162e5c563a98bd73b0b8f58ae3c6c6c95c051f98622f43f5bccedb322858d2a43a26944eeff09e7a8a754cfcc14d097a53a689b5f0377a7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ca83df065f5c282bd1b70483b779ad57eccf1ab32fc9e3d13f2bbcb2d301548efd381933ff940be86c3663c9e51053f401609ccc3e0a6568c88a2e8500c9ae8"} build_url:https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/elf2AWgyTLqQH0EyMa8MtQ/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/a9b08e9d93624e4b162e5c563a98bd73b0b8f58ae3c6c6c95c051f98622f43f5bccedb322858d2a43a26944eeff09e7a8a754cfcc14d097a53a689b5f0377a7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1ca83df065f5c282bd1b70483b779ad57eccf1ab32fc9e3d13f2bbcb2d301548efd381933ff940be86c3663c9e51053f401609ccc3e0a6568c88a2e8500c9ae8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 09:55:36.482968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:55:36.483268) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1459528497.208442-2092633007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 09:55:36.566768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 09:55:36.567056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 09:55:36.567320) ========= ========= Total master_lag: 0.27 =========