builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1464631592.84 results: success (0) buildid: 20160530083045 builduid: bbe0b05cd6c94ecc81b7026ea609e2e0 revision: 4dbe106594fa8197404081eb801cbd4b2a42d06b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.835767) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.836297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.836597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.870120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.870491) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 11:06:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-30 11:06:34 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.984850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:32.985241) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.037041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.037621) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dbe106594fa8197404081eb801cbd4b2a42d06b --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 4dbe106594fa8197404081eb801cbd4b2a42d06b --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=5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 11:06:34,255 truncating revision to first 12 chars 2016-05-30 11:06:34,255 Setting DEBUG logging. 2016-05-30 11:06:34,255 attempt 1/10 2016-05-30 11:06:34,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dbe106594fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 11:06:34,582 unpacking tar archive at: fx-team-4dbe106594fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.778841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.779257) ========= script_repo_revision: 4dbe106594fa8197404081eb801cbd4b2a42d06b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.779844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.780260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 11:06:33.791273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-30 11:06:33.791716) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:35 INFO - MultiFileLogger online at 20160530 11:06:35 in /builds/slave/test 11:06:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:35 INFO - {'append_to_log': False, 11:06:35 INFO - 'base_work_dir': '/builds/slave/test', 11:06:35 INFO - 'blob_upload_branch': 'Fx-Team', 11:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:35 INFO - 'branch': 'Fx-Team', 11:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:35 INFO - 'config_files': ('talos/linux_config.py',), 11:06:35 INFO - 'default_actions': ('clobber', 11:06:35 INFO - 'read-buildbot-config', 11:06:35 INFO - 'download-and-extract', 11:06:35 INFO - 'populate-webroot', 11:06:35 INFO - 'create-virtualenv', 11:06:35 INFO - 'install', 11:06:35 INFO - 'run-tests'), 11:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:35 INFO - 'download_minidump_stackwalk': True, 11:06:35 INFO - 'download_symbols': 'ondemand', 11:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:35 INFO - 'installer_path': 'installer.exe', 11:06:35 INFO - 'log_level': 'info', 11:06:35 INFO - 'log_name': 'talos', 11:06:35 INFO - 'log_to_console': True, 11:06:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:35 INFO - 'opt_config_files': (), 11:06:35 INFO - 'pip_index': False, 11:06:35 INFO - 'sps_profile': False, 11:06:35 INFO - 'sps_profile_interval': 0, 11:06:35 INFO - 'suite': 'dromaeojs-e10s', 11:06:35 INFO - 'system_bits': '32', 11:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:35 INFO - 'title': 'talos-linux64-ix-039', 11:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:35 INFO - 'use_talos_json': True, 11:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:35 INFO - 'work_dir': 'build'} 11:06:35 INFO - ##### 11:06:35 INFO - ##### Running clobber step. 11:06:35 INFO - ##### 11:06:35 INFO - Running pre-action listener: _resource_record_pre_action 11:06:35 INFO - Running main action method: clobber 11:06:35 INFO - rmtree: /builds/slave/test/build 11:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:36 INFO - Running post-action listener: _resource_record_post_action 11:06:36 INFO - ##### 11:06:36 INFO - ##### Finished clobber step (success) 11:06:36 INFO - ##### 11:06:36 INFO - ##### 11:06:36 INFO - ##### Running read-buildbot-config step. 11:06:36 INFO - ##### 11:06:36 INFO - Running pre-action listener: _resource_record_pre_action 11:06:36 INFO - Running main action method: read_buildbot_config 11:06:36 INFO - Using buildbot properties: 11:06:36 INFO - { 11:06:36 INFO - "project": "", 11:06:36 INFO - "product": "firefox", 11:06:36 INFO - "script_repo_revision": "production", 11:06:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:06:36 INFO - "repository": "", 11:06:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:06:36 INFO - "buildid": "20160530083045", 11:06:36 INFO - "pgo_build": "True", 11:06:36 INFO - "basedir": "/builds/slave/test", 11:06:36 INFO - "buildnumber": 512, 11:06:36 INFO - "slavename": "talos-linux64-ix-039", 11:06:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:06:36 INFO - "platform": "ubuntu64_hw", 11:06:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:06:36 INFO - "branch": "fx-team", 11:06:36 INFO - "repo_path": "integration/fx-team", 11:06:36 INFO - "revision": "4dbe106594fa8197404081eb801cbd4b2a42d06b", 11:06:36 INFO - "stage_platform": "linux64-pgo", 11:06:36 INFO - "builduid": "bbe0b05cd6c94ecc81b7026ea609e2e0", 11:06:36 INFO - "slavebuilddir": "test" 11:06:36 INFO - } 11:06:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:06:36 INFO - Running post-action listener: _resource_record_post_action 11:06:36 INFO - ##### 11:06:36 INFO - ##### Finished read-buildbot-config step (success) 11:06:36 INFO - ##### 11:06:36 INFO - ##### 11:06:36 INFO - ##### Running download-and-extract step. 11:06:36 INFO - ##### 11:06:36 INFO - Running pre-action listener: _resource_record_pre_action 11:06:36 INFO - Running main action method: download_and_extract 11:06:36 INFO - mkdir: /builds/slave/test/build/tests 11:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:36 INFO - https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:06:39 INFO - Downloaded 1361 bytes. 11:06:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:39 INFO - Using the following test package requirements: 11:06:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:06:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'jsshell-linux-x86_64.zip'], 11:06:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:06:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:06:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:39 INFO - https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:41 INFO - Downloaded 24410503 bytes. 11:06:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:06:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:06:42 INFO - Return code: 0 11:06:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:42 INFO - https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:43 INFO - Downloaded 24410503 bytes. 11:06:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:06:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:06:45 INFO - Return code: 0 11:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:45 INFO - https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:06:46 INFO - Downloaded 10834055 bytes. 11:06:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:06:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:06:46 INFO - Return code: 0 11:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:46 INFO - https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:06:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:06:47 INFO - Downloaded 58925253 bytes. 11:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:47 INFO - mkdir: /builds/slave/test/properties 11:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:47 INFO - Contents: 11:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:48 INFO - Running post-action listener: _resource_record_post_action 11:06:48 INFO - Running post-action listener: set_extra_try_arguments 11:06:48 INFO - ##### 11:06:48 INFO - ##### Finished download-and-extract step (success) 11:06:48 INFO - ##### 11:06:48 INFO - ##### 11:06:48 INFO - ##### Running populate-webroot step. 11:06:48 INFO - ##### 11:06:48 INFO - Running pre-action listener: _resource_record_pre_action 11:06:48 INFO - Running main action method: populate_webroot 11:06:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:48 INFO - '--tppagecycles', 11:06:48 INFO - '7'], 11:06:48 INFO - 'tests': ['tsvgm']}}, 11:06:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['damp', 'tps']}, 11:06:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'tests': ['damp', 'tps']}, 11:06:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['dromaeo_dom']}, 11:06:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['a11yr', 11:06:48 INFO - 'ts_paint', 11:06:48 INFO - 'tpaint', 11:06:48 INFO - 'sessionrestore', 11:06:48 INFO - 'sessionrestore_no_auto_restore', 11:06:48 INFO - 'tabpaint']}, 11:06:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:48 INFO - 'ts_paint', 11:06:48 INFO - 'tpaint', 11:06:48 INFO - 'sessionrestore', 11:06:48 INFO - 'sessionrestore_no_auto_restore', 11:06:48 INFO - 'tabpaint']}, 11:06:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:48 INFO - 'ts_paint', 11:06:48 INFO - 'tpaint', 11:06:48 INFO - 'sessionrestore', 11:06:48 INFO - 'sessionrestore_no_auto_restore', 11:06:48 INFO - 'tabpaint']}, 11:06:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:48 INFO - 'ts_paint', 11:06:48 INFO - 'tpaint', 11:06:48 INFO - 'sessionrestore', 11:06:48 INFO - 'sessionrestore_no_auto_restore', 11:06:48 INFO - 'tabpaint']}, 11:06:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['a11yr', 11:06:48 INFO - 'ts_paint', 11:06:48 INFO - 'tpaint', 11:06:48 INFO - 'sessionrestore', 11:06:48 INFO - 'sessionrestore_no_auto_restore', 11:06:48 INFO - 'tabpaint']}, 11:06:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['a11yr', 11:06:48 INFO - 'ts_paint', 11:06:48 INFO - 'tpaint', 11:06:48 INFO - 'sessionrestore', 11:06:48 INFO - 'sessionrestore_no_auto_restore', 11:06:48 INFO - 'tabpaint']}, 11:06:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['tsvgx', 11:06:48 INFO - 'tsvgr_opacity', 11:06:48 INFO - 'tart', 11:06:48 INFO - 'tscrollx', 11:06:48 INFO - 'cart']}, 11:06:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:48 INFO - 'tsvgr_opacity', 11:06:48 INFO - 'tart', 11:06:48 INFO - 'tscrollx', 11:06:48 INFO - 'cart']}, 11:06:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'talos_options': ['--disable-e10s'], 11:06:48 INFO - 'tests': ['tp5o']}, 11:06:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'tests': ['tp5o']}, 11:06:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'talos_options': ['--disable-e10s', 11:06:48 INFO - '--xperf_path', 11:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:48 INFO - 'tests': ['tp5n']}, 11:06:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:48 INFO - 'talos_options': ['--xperf_path', 11:06:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:48 INFO - 'tests': ['tp5n']}}, 11:06:48 INFO - 'talos.zip': {'path': '', 11:06:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:48 INFO - Running post-action listener: _resource_record_post_action 11:06:48 INFO - ##### 11:06:48 INFO - ##### Finished populate-webroot step (success) 11:06:48 INFO - ##### 11:06:48 INFO - ##### 11:06:48 INFO - ##### Running create-virtualenv step. 11:06:48 INFO - ##### 11:06:48 INFO - Running pre-action listener: _resource_record_pre_action 11:06:48 INFO - Running main action method: create_virtualenv 11:06:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:48 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 11:06:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:48 INFO - Using real prefix '/usr' 11:06:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:51 INFO - Installing pip.................done. 11:06:51 INFO - Return code: 0 11:06:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:51 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:06:51 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 11:06:51 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 11:06:51 INFO - Using env: {'DISPLAY': ':0', 11:06:51 INFO - 'HOME': '/home/cltbld', 11:06:51 INFO - 'LANG': 'en_US.UTF-8', 11:06:51 INFO - 'LANGUAGE': 'en_US:en', 11:06:51 INFO - 'LOGNAME': 'cltbld', 11:06:51 INFO - 'MAIL': '/var/mail/cltbld', 11:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:51 INFO - 'MOZ_NO_REMOTE': '1', 11:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:51 INFO - 'NO_EM_RESTART': '1', 11:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:51 INFO - 'PWD': '/builds/slave/test', 11:06:51 INFO - 'SHELL': '/bin/bash', 11:06:51 INFO - 'SHLVL': '1', 11:06:51 INFO - 'TERM': 'linux', 11:06:51 INFO - 'TMOUT': '86400', 11:06:51 INFO - 'USER': 'cltbld', 11:06:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:51 INFO - '_': '/tools/buildbot/bin/python'} 11:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:51 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 11:06:51 INFO - Cleaning up... 11:06:51 INFO - Return code: 0 11:06:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:51 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:06:51 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>=3.1.1'] in /builds/slave/test/build 11:06:51 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>=3.1.1 11:06:51 INFO - Using env: {'DISPLAY': ':0', 11:06:51 INFO - 'HOME': '/home/cltbld', 11:06:51 INFO - 'LANG': 'en_US.UTF-8', 11:06:51 INFO - 'LANGUAGE': 'en_US:en', 11:06:51 INFO - 'LOGNAME': 'cltbld', 11:06:51 INFO - 'MAIL': '/var/mail/cltbld', 11:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:51 INFO - 'MOZ_NO_REMOTE': '1', 11:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:51 INFO - 'NO_EM_RESTART': '1', 11:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:51 INFO - 'PWD': '/builds/slave/test', 11:06:51 INFO - 'SHELL': '/bin/bash', 11:06:51 INFO - 'SHLVL': '1', 11:06:51 INFO - 'TERM': 'linux', 11:06:51 INFO - 'TMOUT': '86400', 11:06:51 INFO - 'USER': 'cltbld', 11:06:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:51 INFO - '_': '/tools/buildbot/bin/python'} 11:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:51 INFO - Downloading/unpacking psutil>=3.1.1 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:53 INFO - Installing collected packages: psutil 11:06:53 INFO - Running setup.py install for psutil 11:06:53 INFO - building 'psutil._psutil_linux' extension 11:06:53 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 11:06:53 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 11:06:53 INFO - building 'psutil._psutil_posix' extension 11:06:53 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 11:06:53 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 11:06:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:54 INFO - Successfully installed psutil 11:06:54 INFO - Cleaning up... 11:06:54 INFO - Return code: 0 11:06:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:54 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')]} 11:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:54 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')]} 11:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:54 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:06:54 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.3'] in /builds/slave/test/build 11:06:54 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.3 11:06:54 INFO - Using env: {'DISPLAY': ':0', 11:06:54 INFO - 'HOME': '/home/cltbld', 11:06:54 INFO - 'LANG': 'en_US.UTF-8', 11:06:54 INFO - 'LANGUAGE': 'en_US:en', 11:06:54 INFO - 'LOGNAME': 'cltbld', 11:06:54 INFO - 'MAIL': '/var/mail/cltbld', 11:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:54 INFO - 'MOZ_NO_REMOTE': '1', 11:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:54 INFO - 'NO_EM_RESTART': '1', 11:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:54 INFO - 'PWD': '/builds/slave/test', 11:06:54 INFO - 'SHELL': '/bin/bash', 11:06:54 INFO - 'SHLVL': '1', 11:06:54 INFO - 'TERM': 'linux', 11:06:54 INFO - 'TMOUT': '86400', 11:06:54 INFO - 'USER': 'cltbld', 11:06:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:54 INFO - '_': '/tools/buildbot/bin/python'} 11:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:56 INFO - Installing collected packages: mozsystemmonitor 11:06:56 INFO - Running setup.py install for mozsystemmonitor 11:06:56 INFO - Successfully installed mozsystemmonitor 11:06:56 INFO - Cleaning up... 11:06:56 INFO - Return code: 0 11:06:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:56 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')]} 11:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:56 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')]} 11:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:56 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:06:56 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 11:06:56 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 11:06:56 INFO - Using env: {'DISPLAY': ':0', 11:06:56 INFO - 'HOME': '/home/cltbld', 11:06:56 INFO - 'LANG': 'en_US.UTF-8', 11:06:56 INFO - 'LANGUAGE': 'en_US:en', 11:06:56 INFO - 'LOGNAME': 'cltbld', 11:06:56 INFO - 'MAIL': '/var/mail/cltbld', 11:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:56 INFO - 'MOZ_NO_REMOTE': '1', 11:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:56 INFO - 'NO_EM_RESTART': '1', 11:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:56 INFO - 'PWD': '/builds/slave/test', 11:06:56 INFO - 'SHELL': '/bin/bash', 11:06:56 INFO - 'SHLVL': '1', 11:06:56 INFO - 'TERM': 'linux', 11:06:56 INFO - 'TMOUT': '86400', 11:06:56 INFO - 'USER': 'cltbld', 11:06:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:56 INFO - '_': '/tools/buildbot/bin/python'} 11:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:56 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 11:06:56 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 11:06:56 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 11:06:56 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 11:06:56 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 11:06:56 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 11:06:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:58 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 11:06:58 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 11:06:58 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 11:06:58 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 11:06:58 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 11:06:58 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 11:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:59 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 11:06:59 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 11:06:59 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 11:06:59 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 11:06:59 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 11:06:59 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 11:06:59 INFO - Downloading docopt-0.6.1.tar.gz 11:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:59 INFO - Running setup.py install for blobuploader 11:06:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:59 INFO - Running setup.py install for requests 11:06:59 INFO - Running setup.py install for docopt 11:06:59 INFO - Successfully installed blobuploader requests docopt 11:06:59 INFO - Cleaning up... 11:06:59 INFO - Return code: 0 11:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:59 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')]} 11:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:59 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')]} 11:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:59 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:06:59 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 11:06:59 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 11:06:59 INFO - Using env: {'DISPLAY': ':0', 11:06:59 INFO - 'HOME': '/home/cltbld', 11:06:59 INFO - 'LANG': 'en_US.UTF-8', 11:06:59 INFO - 'LANGUAGE': 'en_US:en', 11:06:59 INFO - 'LOGNAME': 'cltbld', 11:06:59 INFO - 'MAIL': '/var/mail/cltbld', 11:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:59 INFO - 'MOZ_NO_REMOTE': '1', 11:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:59 INFO - 'NO_EM_RESTART': '1', 11:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:59 INFO - 'PWD': '/builds/slave/test', 11:06:59 INFO - 'SHELL': '/bin/bash', 11:06:59 INFO - 'SHLVL': '1', 11:06:59 INFO - 'TERM': 'linux', 11:06:59 INFO - 'TMOUT': '86400', 11:06:59 INFO - 'USER': 'cltbld', 11:06:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:59 INFO - '_': '/tools/buildbot/bin/python'} 11:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:00 INFO - Running setup.py (path:/tmp/pip-tmGlJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:00 INFO - Running setup.py (path:/tmp/pip-QW1RUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:00 INFO - Running setup.py (path:/tmp/pip-0xJ31G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:00 INFO - Running setup.py (path:/tmp/pip-1c5b0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:00 INFO - Running setup.py (path:/tmp/pip-77bMhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:00 INFO - Running setup.py (path:/tmp/pip-OYySkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:00 INFO - Running setup.py (path:/tmp/pip-32zYfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:00 INFO - Running setup.py (path:/tmp/pip-x4hFwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:00 INFO - Running setup.py (path:/tmp/pip-PTKF72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:00 INFO - Running setup.py (path:/tmp/pip-4MCSCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:00 INFO - Running setup.py (path:/tmp/pip-phzQ1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:00 INFO - Running setup.py (path:/tmp/pip-0jtRfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:00 INFO - Running setup.py (path:/tmp/pip-l0Sp8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:01 INFO - Running setup.py (path:/tmp/pip-6udjEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:01 INFO - Running setup.py (path:/tmp/pip-Aw1xi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:01 INFO - Running setup.py (path:/tmp/pip-s1709W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:01 INFO - Running setup.py (path:/tmp/pip-KXKUUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:01 INFO - Running setup.py install for manifestparser 11:07:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozcrash 11:07:01 INFO - Running setup.py install for mozdebug 11:07:01 INFO - Running setup.py install for mozdevice 11:07:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozfile 11:07:01 INFO - Running setup.py install for mozhttpd 11:07:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozinfo 11:07:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozInstall 11:07:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozleak 11:07:02 INFO - Running setup.py install for mozlog 11:07:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for moznetwork 11:07:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozprocess 11:07:02 INFO - Running setup.py install for mozprofile 11:07:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozrunner 11:07:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozscreenshot 11:07:02 INFO - Running setup.py install for moztest 11:07:02 INFO - Running setup.py install for mozversion 11:07:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:03 INFO - Cleaning up... 11:07:03 INFO - Return code: 0 11:07:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:03 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:07:03 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 11:07:03 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 11:07:03 INFO - Using env: {'DISPLAY': ':0', 11:07:03 INFO - 'HOME': '/home/cltbld', 11:07:03 INFO - 'LANG': 'en_US.UTF-8', 11:07:03 INFO - 'LANGUAGE': 'en_US:en', 11:07:03 INFO - 'LOGNAME': 'cltbld', 11:07:03 INFO - 'MAIL': '/var/mail/cltbld', 11:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:03 INFO - 'MOZ_NO_REMOTE': '1', 11:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:03 INFO - 'NO_EM_RESTART': '1', 11:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:03 INFO - 'PWD': '/builds/slave/test', 11:07:03 INFO - 'SHELL': '/bin/bash', 11:07:03 INFO - 'SHLVL': '1', 11:07:03 INFO - 'TERM': 'linux', 11:07:03 INFO - 'TMOUT': '86400', 11:07:03 INFO - 'USER': 'cltbld', 11:07:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:03 INFO - '_': '/tools/buildbot/bin/python'} 11:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:03 INFO - Running setup.py (path:/tmp/pip-wbMTLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:03 INFO - Running setup.py (path:/tmp/pip-MbQDxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:03 INFO - Running setup.py (path:/tmp/pip-uO9OyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:03 INFO - Running setup.py (path:/tmp/pip-pGh4Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:03 INFO - Running setup.py (path:/tmp/pip-jNY4nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:03 INFO - Running setup.py (path:/tmp/pip-L5yVhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:03 INFO - Running setup.py (path:/tmp/pip-YTZQQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:03 INFO - Running setup.py (path:/tmp/pip-XSrXo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:03 INFO - Running setup.py (path:/tmp/pip-1sig9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:03 INFO - Running setup.py (path:/tmp/pip-MygeZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:04 INFO - Running setup.py (path:/tmp/pip-YVTUUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:04 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:04 INFO - Running setup.py (path:/tmp/pip-E9p7lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:04 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:04 INFO - Running setup.py (path:/tmp/pip-yteK4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:04 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:04 INFO - Running setup.py (path:/tmp/pip-dd32l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:04 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:04 INFO - Running setup.py (path:/tmp/pip-TUi2TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:04 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:04 INFO - Running setup.py (path:/tmp/pip-cLfrre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:04 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)) 11:07:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:04 INFO - Running setup.py (path:/tmp/pip-FMgDH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:04 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)) 11:07:04 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)) 11:07:04 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)) 11:07:04 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)) 11:07:04 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)) 11:07:04 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)) 11:07:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:04 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 11:07:04 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 11:07:04 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 11:07:04 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 11:07:04 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 11:07:04 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 11:07:06 INFO - Downloading blessings-1.6.tar.gz 11:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:06 INFO - Installing collected packages: blessings 11:07:06 INFO - Running setup.py install for blessings 11:07:06 INFO - Successfully installed blessings 11:07:06 INFO - Cleaning up... 11:07:06 INFO - Return code: 0 11:07:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:06 INFO - Reading from file tmpfile_stdout 11:07:06 INFO - Current package versions: 11:07:06 INFO - argparse == 1.2.1 11:07:06 INFO - blessings == 1.6 11:07:06 INFO - blobuploader == 1.2.4 11:07:06 INFO - docopt == 0.6.1 11:07:06 INFO - manifestparser == 1.1 11:07:06 INFO - mozInstall == 1.12 11:07:06 INFO - mozcrash == 0.17 11:07:06 INFO - mozdebug == 0.1 11:07:06 INFO - mozdevice == 0.48 11:07:06 INFO - mozfile == 1.2 11:07:06 INFO - mozhttpd == 0.7 11:07:06 INFO - mozinfo == 0.9 11:07:06 INFO - mozleak == 0.1 11:07:06 INFO - mozlog == 3.2 11:07:06 INFO - moznetwork == 0.27 11:07:06 INFO - mozprocess == 0.22 11:07:06 INFO - mozprofile == 0.28 11:07:06 INFO - mozrunner == 6.11 11:07:06 INFO - mozscreenshot == 0.1 11:07:06 INFO - mozsystemmonitor == 0.3 11:07:06 INFO - moztest == 0.7 11:07:06 INFO - mozversion == 1.4 11:07:06 INFO - psutil == 3.1.1 11:07:06 INFO - requests == 1.2.3 11:07:06 INFO - wsgiref == 0.1.2 11:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:06 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:07:06 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 11:07:06 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 11:07:06 INFO - Using env: {'DISPLAY': ':0', 11:07:06 INFO - 'HOME': '/home/cltbld', 11:07:06 INFO - 'LANG': 'en_US.UTF-8', 11:07:06 INFO - 'LANGUAGE': 'en_US:en', 11:07:06 INFO - 'LOGNAME': 'cltbld', 11:07:06 INFO - 'MAIL': '/var/mail/cltbld', 11:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:06 INFO - 'MOZ_NO_REMOTE': '1', 11:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:06 INFO - 'NO_EM_RESTART': '1', 11:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:06 INFO - 'PWD': '/builds/slave/test', 11:07:06 INFO - 'SHELL': '/bin/bash', 11:07:06 INFO - 'SHLVL': '1', 11:07:06 INFO - 'TERM': 'linux', 11:07:06 INFO - 'TMOUT': '86400', 11:07:06 INFO - 'USER': 'cltbld', 11:07:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:06 INFO - '_': '/tools/buildbot/bin/python'} 11:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 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)) 11:07:07 INFO - Cleaning up... 11:07:07 INFO - Return code: 0 11:07:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:07 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')]} 11:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:07 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')]} 11:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:07 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:07:07 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 11:07:07 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 11:07:07 INFO - Using env: {'DISPLAY': ':0', 11:07:07 INFO - 'HOME': '/home/cltbld', 11:07:07 INFO - 'LANG': 'en_US.UTF-8', 11:07:07 INFO - 'LANGUAGE': 'en_US:en', 11:07:07 INFO - 'LOGNAME': 'cltbld', 11:07:07 INFO - 'MAIL': '/var/mail/cltbld', 11:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:07 INFO - 'MOZ_NO_REMOTE': '1', 11:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:07 INFO - 'NO_EM_RESTART': '1', 11:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:07 INFO - 'PWD': '/builds/slave/test', 11:07:07 INFO - 'SHELL': '/bin/bash', 11:07:07 INFO - 'SHLVL': '1', 11:07:07 INFO - 'TERM': 'linux', 11:07:07 INFO - 'TMOUT': '86400', 11:07:07 INFO - 'USER': 'cltbld', 11:07:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:07 INFO - '_': '/tools/buildbot/bin/python'} 11:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:07 INFO - Downloading/unpacking jsonschema 11:07:07 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 11:07:07 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 11:07:07 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 11:07:07 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 11:07:07 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 11:07:07 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 11:07:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:09 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:09 INFO - warning: no files found matching '*.txt' 11:07:09 INFO - no previously-included directories found matching 'build' 11:07:09 INFO - no previously-included directories found matching 'dist' 11:07:09 INFO - no previously-included directories found matching '.git*' 11:07:09 INFO - Installing collected packages: jsonschema, functools32 11:07:09 INFO - Running setup.py install for functools32 11:07:09 INFO - warning: no files found matching '*.txt' 11:07:09 INFO - no previously-included directories found matching 'build' 11:07:09 INFO - no previously-included directories found matching 'dist' 11:07:09 INFO - no previously-included directories found matching '.git*' 11:07:09 INFO - Successfully installed jsonschema functools32 11:07:09 INFO - Cleaning up... 11:07:09 INFO - Return code: 0 11:07:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:09 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 0x7fe2b7ed0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', '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 11:07:09 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 11:07:09 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 11:07:09 INFO - Using env: {'DISPLAY': ':0', 11:07:09 INFO - 'HOME': '/home/cltbld', 11:07:09 INFO - 'LANG': 'en_US.UTF-8', 11:07:09 INFO - 'LANGUAGE': 'en_US:en', 11:07:09 INFO - 'LOGNAME': 'cltbld', 11:07:09 INFO - 'MAIL': '/var/mail/cltbld', 11:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:09 INFO - 'MOZ_NO_REMOTE': '1', 11:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:09 INFO - 'NO_EM_RESTART': '1', 11:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:09 INFO - 'PWD': '/builds/slave/test', 11:07:09 INFO - 'SHELL': '/bin/bash', 11:07:09 INFO - 'SHLVL': '1', 11:07:09 INFO - 'TERM': 'linux', 11:07:09 INFO - 'TMOUT': '86400', 11:07:09 INFO - 'USER': 'cltbld', 11:07:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:09 INFO - '_': '/tools/buildbot/bin/python'} 11:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:09 INFO - Downloading/unpacking flake8 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 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 11:07:09 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 11:07:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07:11 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 11:07:11 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 11:07:11 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 11:07:11 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 11:07:11 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 11:07:11 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 11:07:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:12 INFO - no previously-included directories found matching 'docs/_build' 11:07:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:12 INFO - Running setup.py install for pep8 11:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:12 INFO - no previously-included directories found matching 'docs/_build' 11:07:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:12 INFO - Cleaning up... 11:07:12 INFO - Return code: 0 11:07:12 INFO - Running post-action listener: _resource_record_post_action 11:07:12 INFO - Running post-action listener: _start_resource_monitoring 11:07:12 INFO - Starting resource monitoring. 11:07:12 INFO - ##### 11:07:12 INFO - ##### Finished create-virtualenv step (success) 11:07:12 INFO - ##### 11:07:12 INFO - ##### 11:07:12 INFO - ##### Running install step. 11:07:12 INFO - ##### 11:07:12 INFO - Running pre-action listener: _resource_record_pre_action 11:07:12 INFO - Running main action method: install 11:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:13 INFO - Reading from file tmpfile_stdout 11:07:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:13 INFO - Reading from file tmpfile_stdout 11:07:13 INFO - Output received: 11:07:13 INFO - Usage: mozinstall [options] installer 11:07:13 INFO - Options: 11:07:13 INFO - -h, --help show this help message and exit 11:07:13 INFO - -d DEST, --destination=DEST 11:07:13 INFO - Directory to install application into. [default: 11:07:13 INFO - "/builds/slave/test"] 11:07:13 INFO - --app=APP Application being installed. [default: firefox] 11:07:13 INFO - mkdir: /builds/slave/test/build/application 11:07:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:07:29 INFO - Reading from file tmpfile_stdout 11:07:29 INFO - Output received: 11:07:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:29 INFO - Running post-action listener: _resource_record_post_action 11:07:29 INFO - ##### 11:07:29 INFO - ##### Finished install step (success) 11:07:29 INFO - ##### 11:07:29 INFO - ##### 11:07:29 INFO - ##### Running run-tests step. 11:07:29 INFO - ##### 11:07:29 INFO - Running pre-action listener: _resource_record_pre_action 11:07:29 INFO - Running main action method: run_tests 11:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:29 INFO - Python 2.7.3 11:07:29 INFO - Return code: 0 11:07:29 INFO - grabbing minidump binary from tooltool 11:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:29 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b9c0>, '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 0x208c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:29 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 11:07:29 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 11:07:29 INFO - Calling ['/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'] with output_timeout 600 11:07:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:29 INFO - Return code: 0 11:07:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:07:30 INFO - Return code: 0 11:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:07:30 INFO - Using env: {'DISPLAY': ':0', 11:07:30 INFO - 'HOME': '/home/cltbld', 11:07:30 INFO - 'LANG': 'en_US.UTF-8', 11:07:30 INFO - 'LANGUAGE': 'en_US:en', 11:07:30 INFO - 'LOGNAME': 'cltbld', 11:07:30 INFO - 'MAIL': '/var/mail/cltbld', 11:07:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:30 INFO - 'MOZ_NO_REMOTE': '1', 11:07:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:30 INFO - 'NO_EM_RESTART': '1', 11:07:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:30 INFO - 'PWD': '/builds/slave/test', 11:07:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:30 INFO - 'SHELL': '/bin/bash', 11:07:30 INFO - 'SHLVL': '1', 11:07:30 INFO - 'TERM': 'linux', 11:07:30 INFO - 'TMOUT': '86400', 11:07:30 INFO - 'USER': 'cltbld', 11:07:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830', 11:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:30 INFO - '_': '/tools/buildbot/bin/python'} 11:07:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:07:30 INFO - mozversion application_buildid: 20160530083045 11:07:30 INFO - mozversion application_changeset: 4dbe106594fa8197404081eb801cbd4b2a42d06b 11:07:30 INFO - mozversion application_display_name: Nightly 11:07:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:30 INFO - mozversion application_name: Firefox 11:07:30 INFO - mozversion application_remotingname: firefox 11:07:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:07:30 INFO - mozversion application_vendor: Mozilla 11:07:30 INFO - mozversion application_version: 49.0a1 11:07:30 INFO - mozversion platform_buildid: 20160530083045 11:07:31 INFO - mozversion platform_changeset: 4dbe106594fa8197404081eb801cbd4b2a42d06b 11:07:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:07:31 INFO - mozversion platform_version: 49.0a1 11:07:31 INFO - using testdate: 1464631650 11:07:31 INFO - actual date: 1464631650 11:07:31 INFO - starting webserver on 'localhost:45205' 11:07:31 INFO - SUITE-START | Running 2 tests 11:07:31 INFO - TEST-START | dromaeo_css 11:07:31 INFO - operating with platform_type : linux_ 11:07:31 INFO - Initialising browser for dromaeo_css test... 11:07:31 INFO - TEST-INFO | started process 16738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBzYiv/profile http://localhost:45205/getInfo.html) 11:07:35 INFO - PROCESS | 16738 | __metrics Screen width/height:1600/1200 11:07:35 INFO - PROCESS | 16738 | colorDepth:24 11:07:35 INFO - PROCESS | 16738 | Browser inner width/height: 1024/697 11:07:35 INFO - PROCESS | 16738 | __metrics 11:07:36 ERROR - PROCESS | 16738 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:07:37 INFO - TEST-INFO | 16738: exit 0 11:07:37 INFO - Browser initialized. 11:07:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:37 INFO - TEST-INFO | started process 16857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBzYiv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:49 INFO - PROCESS | 16857 | RSS: Main: 166400000 11:07:49 INFO - PROCESS | 16857 | 11:08:38 INFO - PROCESS | 16857 | 1464631718956 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] 11:10:47 INFO - PROCESS | 16857 | Cycle 1(1): loaded http://localhost:45205/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45205/tests/dromaeo/cssquery-ext.html) 11:10:48 INFO - PROCESS | 16857 | RSS: Main: 171118592 11:10:48 INFO - PROCESS | 16857 | 11:13:50 INFO - PROCESS | 16857 | Cycle 1(1): loaded http://localhost:45205/tests/dromaeo/cssquery-ext.html (next: http://localhost:45205/tests/dromaeo/cssquery-jquery.html) 11:13:51 INFO - PROCESS | 16857 | RSS: Main: 169660416 11:13:51 INFO - PROCESS | 16857 | 11:16:53 INFO - PROCESS | 16857 | Cycle 1(1): loaded http://localhost:45205/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45205/tests/dromaeo/cssquery-mootools.html) 11:16:53 INFO - PROCESS | 16857 | RSS: Main: 171008000 11:16:53 INFO - PROCESS | 16857 | 11:19:55 INFO - PROCESS | 16857 | Cycle 1(1): loaded http://localhost:45205/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45205/tests/dromaeo/cssquery-prototype.html) 11:19:56 INFO - PROCESS | 16857 | RSS: Main: 168505344 11:19:56 INFO - PROCESS | 16857 | 11:22:58 INFO - PROCESS | 16857 | Cycle 1(1): loaded http://localhost:45205/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45205/tests/dromaeo/cssquery-yui.html) 11:22:59 INFO - PROCESS | 16857 | RSS: Main: 170840064 11:22:59 INFO - PROCESS | 16857 | 11:26:01 INFO - PROCESS | 16857 | Cycle 1(1): loaded http://localhost:45205/tests/dromaeo/cssquery-yui.html (next: http://localhost:45205/tests/dromaeo/cssquery-dojo.html) 11:26:02 INFO - PROCESS | 16857 | RSS: Main: 171556864 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | __start_tp_report 11:26:02 INFO - PROCESS | 16857 | _x_x_mozilla_page_load 11:26:02 INFO - PROCESS | 16857 | _x_x_mozilla_page_load_details 11:26:02 INFO - PROCESS | 16857 | |i|pagename|runs| 11:26:02 INFO - PROCESS | 16857 | |0;dojo.html;3106.7514598832095;3117.8285194314303;3143.3713257348536;3151.3854798314323;3153.511205763106;5338.06583847827;5352.759125839337;5418;5444.156155795853;5484.396716361207;5446.972765136169;5462.317210348707;5473.589480788937;5521.3926468088475;5530.861728456791;4900.142475066867;5014.921791814759;5039.420466646346;5062.038212739568;5186.118359878829;5069.771860266297;5092.261622064799;5104.030234255498;5120.61595380348;5158.5873130149685;4988.775505102279;4997.625178111638;5026.623003274769;5032.295478632995;5085.338905942203;5038.899222015576;5053.4946505349535;5082.923756143661;5083.262926875619;5113.51421614946;4953.182724850431;5014.43791695707;5053;5062.468440813698;5065.518775716338;5384.946150538483;5391.838244852661;5453.072977593819;5455.863603409907;5511.641743286674;5893.911591326134;5900.822975310747;5911.674857882857;5912.320083190445;5916.733746981353;5690.943090569082;5779.508741756956;5816.040353341694;5957.910631340534;5965.791197308116;5442.891142177174;5443.618946673695;5454.290942177531;5470.261514695465;5492.725363731797;5970.492508136857;5970.552208584373;5971.850703732354;5987.730552125165;5989.8203053908455;5527.060399732055;5724;5737.3975732548315;5761.8559536011935;5800.419958004166;5896.086106653475;5896.410358964155;5910.970445147746;5921.289445266596;5924.822255332347;5651.547876169979;5723;5767.04843700793;5818.33089194748;5857.648541087548;5699.601027928005;5790.392008839095;5792.88414231713;5850.970745146247;5851.736671849777;4353.085851971058;4353.542877997765;4362.411074504965;4377.802998865059;4412.051408947092;3896.357101078347;3910.9804450977563;3916.5887581804072;3919.0594257378593;3954.031262340745;5559.6664200148125;5648.350439699405;5678.829635110953;5693.117566777156;5713.457221563945;5960.0761881908375;5972.492338151219;5981;6006.729697163638;6016.278046634345;5710.172025056344;5715.457031581993;5738.741756620962;5750.878578677201;5752.9424705753245;4754.191787396151;4836.46798852126;4873.00103478786;4880.926786098212;4896.608271338285;6190.783322583688;6210.223722034746;6216.7824126155365;6229.065640154013;6242.157308763259;5944.702764861653;5973;6003.5797494174985;6017.939820601738;6026.0659597762415;5902.321233058254;6068.271807383142;6104.725287361991;6112.8777424452155;6133.324062991892;5826.70866456684;5856.882862342644;5874.882502349844;5876.059830427112;5904.852378690567;5821.243238378984;5934.139549765347;5987.251593550806;5999.220101386792;6002;5503.7798488060025;5532.059549876451;5717.056685646988;5722.456366645162;5773.191753154478;5585.832425027255;5597.524210441995;5598.104303311614;5600.971995139998;5660.971695141498;5599.440055994368;5625.09998400254;5630.071038278638;5637.943620563742;5654.971725141348;5658.264425624642;5692.430756924275;5714.3999880012;5721;5770.249867517364;5601.383847776823;5608.691521966331;5632.464915832989;5638.436156384329;5668.943310566841 11:26:02 INFO - PROCESS | 16857 | |1;ext.html;564.3989151553595;620.5749061892604;622.9563930524862;643.1221382812461;651.7458191305394;38731.419028714554;42225.78887105568;42257.154856902845;42286.577134228646;42448.57551424488;43247;43257.78371108148;43832.3425148623;43836;43904;8584.570771461418;8779.29765618749;8782.824343513126;8786.604602792857;8793.7801554961;8737.825243495126;8800.559972001407;8844.646214151426;8846.911530884705;8849;8833.779155521099;8861.379703420764;8871.290296776275;8876.068012858621;8877.245434138105;8770.956145219265;8817.955910220408;8846.823063538724;8861.601227944759;8866.157715017063;8633.568321583958;8685;8720.607572659246;8732.650693972297;8737.650493980233;40491;40822.38766418506;40843.38734918978;40967.38548921768;41029.384559231636;2942.411517696469;3340.8997730068136;3497.0732755819727;3561.5013898054294;3606.062423769839;30099.699003009908;30199.547006794917;30372.544411833842;33060.669393306;33734.83132584322;4329.328954012101;4393.428854248959;4424.933625995613;4428.22506061438;4618.8152473901;320445.397773012;320510;320763;322440;323417;61277.62973036526;61449.69275153596;61966.38033619606;62008.37991620026;62015.6899215501;35942.820285898924;36493.635063649555;36616;38608.42087368692;65686.67156664186;13958.651033724238;14032.579022629337;14049.648758781112;14197.006209565232;14243.145411275356;11239.438028098562;11362;11386.886131138583;11396.316221026598;11412.714682133013;19876.60246795056;20103.29638462647;20139.79860201379;20183.192672292942;20250.69623955642;7242.529235599669;7351.669174887143;7397.482176247611;7478.663460144307;7581.848363032708;992.389680346596;1078.2853071169902;1086.4567716141928;1105.1490352428584;1125.7354521687396;32673.34653306968;33156.3368732624;33240;33327;33560.66439335576;1051.0645525482328;1123.9550417983353;1138.4535422996842;1179.6637958181877;1202.0984261803646;16707.33170673184;16924.323027079026;16990.235439405256;17120.229589668495;17924.641507169785;565369;800015;813208;825632;829065;59535.404645952985;60385.39614603798;60586.69706651438;60791.08813367715;60922.695386522784;1371.3760239091189;1411.6753146776093;1411.8517555656713;1427.7430062588626;1432.1621851216946;32071.358572828878;34131.317373651895;34174.82912585421;34396;34492.13921555986;53903.19145212903;54204.457955421516;54542.45457545374;54554.181687275515;54631;386128;386376;387294;387585;388043;28931.276718082216;29126.41747165087;29172.854135729187;29485.705142949155;30498.237544061576;47414.52585474101;48098.519014809404;48201.5179848197;48376.27435588399;48872.75563622159;38018.8099059514;39984.40023399593;40119.598804011584;40237;41089.79455102705;39092.21815563616;39376.803115984236;39930.40104398378;40186.79906600448;40205;39167.2166556673;39646.207075858896;39680.60319396769;40647.39028914628;42254.366184507875;35930.64069359378;37547.43678844765;37761.2447751038;37870;38094.428583571826;28537.42925141444;28813.855930721053;28985;29318.26704332409;29321.7067829319 11:26:02 INFO - PROCESS | 16857 | |2;jquery.html;374.99062523436913;385.75311800447736;386.5091334005813;400.6214127649371;412.2764548217877;16290.42983495578;18034.458966231035;18644.813551864478;18659.533511662197;18954.431367058976;17875.821241787577;18234.81765182348;18551.70138090331;18675.066246687646;18837.340693075745;5447.291852059227;5457.263269458632;5613.971930140344;5667.923094612011;5681.517071048966;5548;5616.52259557938;5641.971790141043;5643.181738647893;5645.350784659776;5358;5498.477644623775;5539.556835453154;5556.694381809019;5599.692016939067;5509.972450137764;5537.335519737637;5561.972190139044;5575.080111781551;5589.7205139743055;4877.829275975359;4919.434265059528;4934.111859865223;4946.356973593446;4953.653244272902;22385;22494.437639059153;22930;22931.885340573357;23068.42328941773;2278.874661893595;2467.580511313063;2490.5392502386935;2529.5699731045765;2531.038205481905;12421.751564968741;14277.78583321251;14411.495597654137;14457.349419276157;14558.272086395744;1938.3215874443972;1969.7439332886777;1989.7711763147279;1994.38174166009;2040.4694779357326;67535.27253092286;71705;72356.27643723549;82496.17503824945;82552.58723706403;9589.184919281799;10092.949535252277;10782.353058816496;10830.620928267474;11009.61466348674;15072.321745521478;15088.321025553876;15164.620884477976;15212.771808422882;15258.771118433233;7326.4505162113055;7433.553986760811;7437.739679111205;7489.85020299591;7549.9245007549225;7035.155781306276;7057.117860267466;7085.43316534676;7149.356557909813;7180.820479488055;4243;4409.368533642572;4649.256119020941;4726.692764970266;4835.129676658235;1837.595728939631;1849.324996376313;1873.4192400355932;1893.4319704088718;1904.9714254286196;889.8531742262454;975.5805003848413;996.6860438961704;1054.894510548939;1056.9260151789454;18846.811531884505;18939.81060189408;19210.51973700641;19337.709934350994;19591.706124408145;992.9304948653524;1002.0981116994762;1015.8476228565627;1017.4353233955226;1037.2790910317258;10516.421596812095;10771.946140269405;11042.447877606248;11075.833862492069;11083.833742493869;444263;449910.488731523;452157;454308;454484;93788;95140;95468;95668.52165739126;95933;968.3995922528078;993.9403635781877;1011.7369483934083;1014.7666036811574;1015.5633077776627;16810.66378672395;16833.831661683227;17165.914170429067;17257.482275531253;17611.55971100733;40468;41094.1781164369;41698.79150604349;42535.57464425316;43247;53588.73205633947;53796.46203538071;54838;55032.17451738307;55190;7797.844043119219;7925.247101525346;8049.557274349967;8154.510729356258;8294.129116442688;11970.341631210367;12082.093842961638;12332.445039973401;12515.624531263713;12548.749025019266;10655.25413221067;11208.215424920178;11568.479418426023;11609.245399049034;11692.47383867711;10595.841062384225;10624.734381640521;11034.337939723642;11109.722256943642;11349.262297950607;6865.41643960269;9261.953690231505;10800.567977280822;11495.425228738697;11558.942205289257;8184.549849758082;8357.95821020891;8467.49195048299;8713.869291960498;8756.51839148853;8451.577421128795;10490.685279441628;10852.294600850919;10912.181586380895;11091.33451992883 11:26:02 INFO - PROCESS | 16857 | |3;mootools.html;1349.7975303704445;1442.1923722715278;1587.595163233376;1749.8775085743996;1753.8333858283474;7767.106782719989;8223.177682231788;8373.790655233615;8979.191872731453;9059.728208153758;8263.545504997222;8375.288100511449;8596.656133754657;8607.827843443127;8624.698135565257;2314.6643736658175;2347.1667558016916;2367.183321753992;2367.709598268939;2375.6674065630827;2294.621387471074;2302.5510025545027;2373.1100837186054;2380.27401642499;2383.1420688552107;2368.159303447277;2371.039728909794;2395.8921848516857;2398.760123987596;2404.4469771952463;2277.202978957368;2283.5318759654315;2293.69035180251;2318.5594736999915;2341;2325.5348930213854;2342.390978345625;2356.057576969209;2358.8466749661216;2359.4691194481106;8475.364347673887;8553.144685531459;8608.569571521399;8611.569421528899;8621.310295176434;4889.511048895082;5008.29883816266;5011.198208286657;5028.346314979066;5033.068882256757;3097.1173215633435;3121.82829944353;3159.431302365573;3178.666240044808;3194.217416732892;1031.4842578710645;1053.5891002509027;1080.9081228095622;1100.834874768783;1104.5305745058317;12047.216930899463;12332.136750427473;12347.753044939142;12351.6912077197;12370;4470.798814053311;4515.9774201128785;4595.448546174413;4615.5845973862515;4653.837115700934;10520.579176832842;10531.104856087319;10548.156147508182;10555.26113172086;10557.419341936115;5069.847904562869;5118.283440318359;5139.434662187156;5160.200168973815;5186.351706036746;4112.856050038295;4659.883502912454;4726.976365118152;4798.95201047992;4805.111054454937;3957.6438120569287;3965.215652956181;3999.860004899873;4062.0657248832936;4107.404426358161;1215.8237055626885;1301.537954026326;1311.5965916469477;1314.5859054397833;1320.386020500472;824.4970567953544;925.8287216864901;947.7772723409993;949.6533765175661;950.8003319303024;5548.639338443069;5554.805581804618;5584.246126772915;5655;5661.405552417019;388.4852570344249;399.39890464850214;415.03297317250735;418.21167100016686;418.4183984261878;3801.7148713846573;3983.880483585497;4015.3374693175883;4020;4050.3924411338535;9803.901960980442;9960.750981225527;10034.397936123856;10052.899471005343;10075.193984481224;9808.411495310304;9883.357581757164;9988.101070903653;9998.950005250073;10055.145312648507;7653.808654783675;7756.961215193888;7785.571793551296;7790.376769858398;7836.294733473901;5414.133738601805;5420.322459692538;5514.558835293247;5551.805686800943;5565.749541270571;9098.953620333747;9356.719298421058;9357.111074447917;9417.62329506812;9442.85835712451;9836.60653573849;10081.899181008095;10177.185825133824;10301.793964120825;10441.112505437122;6974.267701891228;7542.170361260147;7671.923280767121;7802.492837965514;7826.295633393022;8281.17188281167;8313.210245026954;8345.873307103464;8440.746777596682;8452.112528184698;7570.507916985378;7676.462647614613;7740.535567865946;7771.92228077712;7869.252421019994;7341.155767086853;7618;7707.34487568563;7773.92226077732;7823.374130069695;6752.493562982698;6823.965880170567;6834.350736680008;6848.863022739617;6876.793696189123;5013.6490445669915;5082.517160869711;5135.666181698178;5161.354830646169;5182.792688292577;5020.795009197839;5122.282880396673;5168.457311982188;5275.287836142072;5341.065313570188 11:26:02 INFO - PROCESS | 16857 | |4;prototype.html;322.5516532020492;329.41693203030627;330.6825447570332;337.34386618027946;340.4501729706523;5432.348118225814;5535.363433205182;5591.692456914879;5601.29983752031;5624.437556244374;5439.646422982503;5466.207399927008;5495.2856128703215;5506.174073888908;5531.446855314466;4069.7151199416053;4090.059286364138;4203.159368126372;4263.957360426402;4278.465191851019;4250.9149817003645;4266;4270.466191726035;4279.331060886257;4285.635720963722;4264.59486348798;4269.722468039583;4275.572442755731;4278.1871444425615;4286.807093680776;4036.9999999999854;4255.829766809324;4259.233337999159;4267.18644576054;4293.935590966138;3699.315626609086;3703;3708.5735140458655;3715.3312403767313;3721.497597824286;5262.631615786897;5289.788408463657;5333.599980001515;5344.866378340534;5361.81233656824;4623.56076172763;4788.521147885183;4808.182608956486;4854.975725121351;4912.15794077221;5696.515796157331;5765.336986246593;5775.689724110347;5811.593188476808;5816.796412125597;4040.1717647882115;4054.209429161315;4064.9837540614844;4067.779666100158;4106.507219133723;5968.104784282349;6019.428154325332;6038.849028774228;6043.939560604382;6111.297200821918;4122.134351786099;4130.938035929464;4136.44158038667;4151.584841515824;4164.3961625564125;4169.91660166795;4206.621404073648;4235.216484950294;4253.680973926967;4254.787260637017;4711.882202944886;4792.185328494164;4870.6103511718975;4912.901741965141;4938.469074586889;5756.798512052058;5759.366469688331;5765.567582431335;5809.244798176294;5829.09649004405;1447.6163816588612;1451.4557041109583;1453.665656898898;1470.5000899082875;1470.8453863716932;931.4644079654225;932.128459890005;943.193569498083;961.4759955824093;993.6522217224058;5545.445455454423;5553.694546799884;5570.777168913198;5593.468620481048;5598.720063996784;5851.093080572433;5868.359238342763;5894.67579283135;5920.200772895604;5951.613145145639;5381.300430943952;5548.501904485847;5574.442555744474;5603.2435621191435;5603.982566276138;3135.38195606671;3148;3155.3216058547523;3173.508106243536;3190.5373720810353;5799.594028417971;6029.457348838626;6131.325554189036;6164.568480206342;6172.117504161184;5926.733297001645;5972.671503067373;5998.400159983967;6003.939960600425;6006.699665016732;6103.206583144163;6108.816735498031;6114.724837382329;6120.326764055951;6123.969380153071;5703;5894.793682221101;5930.678819860892;5943.970280148745;5949.345571986992;5802.796902108406;5837.766489340379;5843.211166492469;5867.9413205869105;5871.266091738533;5945.700136424153;6075.908861366995;6167.691615419121;6172.043333283348;6186.123452594565;4111.97944010278;4113.609207125318;4125.308623464365;4126.463559737215;4139.875803725893;5896.3514013457625;5922.940770592239;5936.317323507852;5941.168236446987;5986.4013598639785;5560.91658625129;5674.581354661334;5797.420257974169;5803.187553742395;5840.7583790996405;5682.318121825408;5699.629524080921;5722.713864306685;5732;5768.884622307614;5496.587755918402;5540.168974653834;5652.3217213934595;5719.771209151588;5753.827385178452;5860.853478663067;5865.266841644794;5918.780457328502;5937.703114844154;5947;5589.189567512769;5750.827475175752;5796.159556864315;5796.362400135898;5838.678872661874 11:26:02 INFO - PROCESS | 16857 | |5;yui.html;741.7997140771992;750.2310132114582;775.2015424113165;776.9028871391076;796.7178795199849;14452.494162704308;15237.085774853502;15294.158821264826;15418.30617622207;15430.228488575569;14234.501792437266;14255.3585088671;14349.497767578137;14390.208538530404;14390.928045359784;810.088650268448;836.1304243586693;837.0541288344193;844.0082902589432;844.3793811548506;817.1338381315794;818.8444195602816;821.7904434369258;833.204289903141;835.6239692138531;873.2490058549643;877.9209871111599;881;881.3698205782864;882.836675215084;859.6991053131417;861.814709837388;864.8313578852126;866.6663334616187;869.0614136732346;635.7488791927162;636.5130675033603;638.090720722968;638.3233772201481;639.1148259660404;14581.270936453135;14601.269936503239;14713.705725885422;14730.631734206623;14753.483628072965;14044.719105617933;14418.711625767426;14491.130532168103;14622.561323160322;14707.117572945657;10621.787564248749;10644.7914960771;10715.946420267848;10888.564457421693;11141.498632561474;3772.4907137536356;3866.516685414323;3888.9027774305587;3894.084890050836;3969.0672691917375;61420.692896535234;63067.6846615764;63261.68369158171;63548.68225658889;65070.3492965069;11010.559577616805;11204.887951120385;11237.943810280896;11316.26444281119;11322.716932076764;20873.68689469659;21432.357029289145;21572.4606884826;21592.784072159393;21598.56802863934;8170.7957301067945;8283.710070147636;8377.204165604258;8381.874271885927;8420;4559.3844830948065;4654.185517534485;4715.41057367829;4739.526047395302;4801.135795556764;3306.2560923791953;3362.159460134966;3369.3261347730554;3370.4607262837826;3377.4258376076127;562.7636392715069;586.750630981831;587.8119001919345;603.0652488642586;607.2136583124776;685.5201359048685;743.3792783026233;754.9169591344947;768.5696010234286;782.335015237044;9054.81890362189;9681.9031809681;9745.512724363894;9747.415155090717;9821.214302855755;704.6300692136567;719.5358993449196;731.2723839779347;754.7923322683662;759.6505607420538;4237.894052648647;4528.705634133837;4530.29780384041;4539.114872599877;4630.629549636021;68406.31593684098;71642.64178679073;71722.28277717157;71802.28197717956;72094.63952680203;29621.407571848442;52032.21951670728;52244.73877630587;63741.681291593246;64444.355556444774;52834.207486887724;52972.47027529753;53992.73003635035;57464.42535574591;58819.705901471076;9329.486878221764;9735.144615201587;9778.9022109778;9781.951090244787;9796.314258001872;36078.63921360753;37633.62366376301;37695.623043769214;37848.43227351537;37882.81058594689;49424.75287623539;49903.500964989886;50053.74973125111;50172.247416289516;50424.24363634622;13083.149595276276;13249;13294;13477.797833032708;13659.04386692922;14081.929590351983;14340.713185736435;14479.420823167377;14510.564683059525;14835.406583736529;13014.21914685122;13079.934600327319;13144;13162.934185329012;13205;13239;13483.123596966167;13489;13550.119242249222;13587.79618305746;12665;13070.346482675637;13134.474621015052;13154.60536183916;13175.077744558172;10527.94736026315;10562.260641755003;10690.251682382159;10738.355698658106;10858.565657373616;10369.222308326755;10748.990361983164;10879.836802447811;10931.508082136483;11009.669709908716 11:26:02 INFO - PROCESS | 16857 | __end_tp_report 11:26:02 INFO - PROCESS | 16857 | __start_cc_report 11:26:02 INFO - PROCESS | 16857 | _x_x_mozilla_cycle_collect,340 11:26:02 INFO - PROCESS | 16857 | __end_cc_report 11:26:02 INFO - PROCESS | 16857 | __startTimestamp1464632762099__endTimestamp 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | ------- Summary: start ------- 11:26:02 INFO - PROCESS | 16857 | Number of tests: 6 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | [#0] dojo.html Cycles:165 Average:5453.25 Median:5651.55 stddev:642.33 (11.4%) stddev-sans-first:617.36 11:26:02 INFO - PROCESS | 16857 | Values: 3106.8 3117.8 3143.4 3151.4 3153.5 5338.1 5352.8 5418.0 5444.2 5484.4 5447.0 5462.3 5473.6 5521.4 5530.9 4900.1 5014.9 5039.4 5062.0 5186.1 5069.8 5092.3 5104.0 5120.6 5158.6 4988.8 4997.6 5026.6 5032.3 5085.3 5038.9 5053.5 5082.9 5083.3 5113.5 4953.2 5014.4 5053.0 5062.5 5065.5 5384.9 5391.8 5453.1 5455.9 5511.6 5893.9 5900.8 5911.7 5912.3 5916.7 5690.9 5779.5 5816.0 5957.9 5965.8 5442.9 5443.6 5454.3 5470.3 5492.7 5970.5 5970.6 5971.9 5987.7 5989.8 5527.1 5724.0 5737.4 5761.9 5800.4 5896.1 5896.4 5911.0 5921.3 5924.8 5651.5 5723.0 5767.0 5818.3 5857.6 5699.6 5790.4 5792.9 5851.0 5851.7 4353.1 4353.5 4362.4 4377.8 4412.1 3896.4 3911.0 3916.6 3919.1 3954.0 5559.7 5648.4 5678.8 5693.1 5713.5 5960.1 5972.5 5981.0 6006.7 6016.3 5710.2 5715.5 5738.7 5750.9 5752.9 4754.2 4836.5 4873.0 4880.9 4896.6 6190.8 6210.2 6216.8 6229.1 6242.2 5944.7 5973.0 6003.6 6017.9 6026.1 5902.3 6068.3 6104.7 6112.9 6133.3 5826.7 5856.9 5874.9 5876.1 5904.9 5821.2 5934.1 5987.3 5999.2 6002.0 5503.8 5532.1 5717.1 5722.5 5773.2 5585.8 5597.5 5598.1 5601.0 5661.0 5599.4 5625.1 5630.1 5637.9 5655.0 5658.3 5692.4 5714.4 5721.0 5770.2 5601.4 5608.7 5632.5 5638.4 5668.9 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | [#1] ext.html Cycles:180 Average:64144.50 Median:39957.40 stddev:143357.38 (358.8%) stddev-sans-first:143680.05 11:26:02 INFO - PROCESS | 16857 | Values: 564.4 620.6 623.0 643.1 651.7 38731.4 42225.8 42257.2 42286.6 42448.6 43247.0 43257.8 43832.3 43836.0 43904.0 8584.6 8779.3 8782.8 8786.6 8793.8 8737.8 8800.6 8844.6 8846.9 8849.0 8833.8 8861.4 8871.3 8876.1 8877.2 8771.0 8818.0 8846.8 8861.6 8866.2 8633.6 8685.0 8720.6 8732.7 8737.7 40491.0 40822.4 40843.4 40967.4 41029.4 2942.4 3340.9 3497.1 3561.5 3606.1 30099.7 30199.5 30372.5 33060.7 33734.8 4329.3 4393.4 4424.9 4428.2 4618.8 320445.4 320510.0 320763.0 322440.0 323417.0 61277.6 61449.7 61966.4 62008.4 62015.7 35942.8 36493.6 36616.0 38608.4 65686.7 13958.7 14032.6 14049.6 14197.0 14243.1 11239.4 11362.0 11386.9 11396.3 11412.7 19876.6 20103.3 20139.8 20183.2 20250.7 7242.5 7351.7 7397.5 7478.7 7581.8 992.4 1078.3 1086.5 1105.1 1125.7 32673.3 33156.3 33240.0 33327.0 33560.7 1051.1 1124.0 1138.5 1179.7 1202.1 16707.3 16924.3 16990.2 17120.2 17924.6 565369.0 800015.0 813208.0 825632.0 829065.0 59535.4 60385.4 60586.7 60791.1 60922.7 1371.4 1411.7 1411.9 1427.7 1432.2 32071.4 34131.3 34174.8 34396.0 34492.1 53903.2 54204.5 54542.5 54554.2 54631.0 386128.0 386376.0 387294.0 387585.0 388043.0 28931.3 29126.4 29172.9 29485.7 30498.2 47414.5 48098.5 48201.5 48376.3 48872.8 38018.8 39984.4 40119.6 40237.0 41089.8 39092.2 39376.8 39930.4 40186.8 40205.0 39167.2 39646.2 39680.6 40647.4 42254.4 35930.6 37547.4 37761.2 37870.0 38094.4 28537.4 28813.9 28985.0 29318.3 29321.7 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | [#2] jquery.html Cycles:180 Average:27542.49 Median:380.37 stddev:74587.59 (19609.1%) stddev-sans-first:74768.94 11:26:02 INFO - PROCESS | 16857 | Values: 375.0 385.8 386.5 400.6 412.3 16290.4 18034.5 18644.8 18659.5 18954.4 17875.8 18234.8 18551.7 18675.1 18837.3 5447.3 5457.3 5614.0 5667.9 5681.5 5548.0 5616.5 5642.0 5643.2 5645.4 5358.0 5498.5 5539.6 5556.7 5599.7 5510.0 5537.3 5562.0 5575.1 5589.7 4877.8 4919.4 4934.1 4946.4 4953.7 22385.0 22494.4 22930.0 22931.9 23068.4 2278.9 2467.6 2490.5 2529.6 2531.0 12421.8 14277.8 14411.5 14457.3 14558.3 1938.3 1969.7 1989.8 1994.4 2040.5 67535.3 71705.0 72356.3 82496.2 82552.6 9589.2 10092.9 10782.4 10830.6 11009.6 15072.3 15088.3 15164.6 15212.8 15258.8 7326.5 7433.6 7437.7 7489.9 7549.9 7035.2 7057.1 7085.4 7149.4 7180.8 4243.0 4409.4 4649.3 4726.7 4835.1 1837.6 1849.3 1873.4 1893.4 1905.0 889.9 975.6 996.7 1054.9 1056.9 18846.8 18939.8 19210.5 19337.7 19591.7 992.9 1002.1 1015.8 1017.4 1037.3 10516.4 10771.9 11042.4 11075.8 11083.8 444263.0 449910.5 452157.0 454308.0 454484.0 93788.0 95140.0 95468.0 95668.5 95933.0 968.4 993.9 1011.7 1014.8 1015.6 16810.7 16833.8 17165.9 17257.5 17611.6 40468.0 41094.2 41698.8 42535.6 43247.0 53588.7 53796.5 54838.0 55032.2 55190.0 7797.8 7925.2 8049.6 8154.5 8294.1 11970.3 12082.1 12332.4 12515.6 12548.7 10655.3 11208.2 11568.5 11609.2 11692.5 10595.8 10624.7 11034.3 11109.7 11349.3 6865.4 9262.0 10800.6 11495.4 11558.9 8184.5 8358.0 8467.5 8713.9 8756.5 8451.6 10490.7 10852.3 10912.2 11091.3 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | [#3] mootools.html Cycles:180 Average:5627.36 Median:5012.42 stddev:3196.60 (63.8%) stddev-sans-first:3189.40 11:26:02 INFO - PROCESS | 16857 | Values: 1349.8 1442.2 1587.6 1749.9 1753.8 7767.1 8223.2 8373.8 8979.2 9059.7 8263.5 8375.3 8596.7 8607.8 8624.7 2314.7 2347.2 2367.2 2367.7 2375.7 2294.6 2302.6 2373.1 2380.3 2383.1 2368.2 2371.0 2395.9 2398.8 2404.4 2277.2 2283.5 2293.7 2318.6 2341.0 2325.5 2342.4 2356.1 2358.8 2359.5 8475.4 8553.1 8608.6 8611.6 8621.3 4889.5 5008.3 5011.2 5028.3 5033.1 3097.1 3121.8 3159.4 3178.7 3194.2 1031.5 1053.6 1080.9 1100.8 1104.5 12047.2 12332.1 12347.8 12351.7 12370.0 4470.8 4516.0 4595.4 4615.6 4653.8 10520.6 10531.1 10548.2 10555.3 10557.4 5069.8 5118.3 5139.4 5160.2 5186.4 4112.9 4659.9 4727.0 4799.0 4805.1 3957.6 3965.2 3999.9 4062.1 4107.4 1215.8 1301.5 1311.6 1314.6 1320.4 824.5 925.8 947.8 949.7 950.8 5548.6 5554.8 5584.2 5655.0 5661.4 388.5 399.4 415.0 418.2 418.4 3801.7 3983.9 4015.3 4020.0 4050.4 9803.9 9960.8 10034.4 10052.9 10075.2 9808.4 9883.4 9988.1 9999.0 10055.1 7653.8 7757.0 7785.6 7790.4 7836.3 5414.1 5420.3 5514.6 5551.8 5565.7 9099.0 9356.7 9357.1 9417.6 9442.9 9836.6 10081.9 10177.2 10301.8 10441.1 6974.3 7542.2 7671.9 7802.5 7826.3 8281.2 8313.2 8345.9 8440.7 8452.1 7570.5 7676.5 7740.5 7771.9 7869.3 7341.2 7618.0 7707.3 7773.9 7823.4 6752.5 6824.0 6834.4 6848.9 6876.8 5013.6 5082.5 5135.7 5161.4 5182.8 5020.8 5122.3 5168.5 5275.3 5341.1 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | [#4] prototype.html Cycles:180 Average:4844.69 Median:5581.82 stddev:1442.96 (25.9%) stddev-sans-first:1406.52 11:26:02 INFO - PROCESS | 16857 | Values: 322.6 329.4 330.7 337.3 340.5 5432.3 5535.4 5591.7 5601.3 5624.4 5439.6 5466.2 5495.3 5506.2 5531.4 4069.7 4090.1 4203.2 4264.0 4278.5 4250.9 4266.0 4270.5 4279.3 4285.6 4264.6 4269.7 4275.6 4278.2 4286.8 4037.0 4255.8 4259.2 4267.2 4293.9 3699.3 3703.0 3708.6 3715.3 3721.5 5262.6 5289.8 5333.6 5344.9 5361.8 4623.6 4788.5 4808.2 4855.0 4912.2 5696.5 5765.3 5775.7 5811.6 5816.8 4040.2 4054.2 4065.0 4067.8 4106.5 5968.1 6019.4 6038.8 6043.9 6111.3 4122.1 4130.9 4136.4 4151.6 4164.4 4169.9 4206.6 4235.2 4253.7 4254.8 4711.9 4792.2 4870.6 4912.9 4938.5 5756.8 5759.4 5765.6 5809.2 5829.1 1447.6 1451.5 1453.7 1470.5 1470.8 931.5 932.1 943.2 961.5 993.7 5545.4 5553.7 5570.8 5593.5 5598.7 5851.1 5868.4 5894.7 5920.2 5951.6 5381.3 5548.5 5574.4 5603.2 5604.0 3135.4 3148.0 3155.3 3173.5 3190.5 5799.6 6029.5 6131.3 6164.6 6172.1 5926.7 5972.7 5998.4 6003.9 6006.7 6103.2 6108.8 6114.7 6120.3 6124.0 5703.0 5894.8 5930.7 5944.0 5949.3 5802.8 5837.8 5843.2 5867.9 5871.3 5945.7 6075.9 6167.7 6172.0 6186.1 4112.0 4113.6 4125.3 4126.5 4139.9 5896.4 5922.9 5936.3 5941.2 5986.4 5560.9 5674.6 5797.4 5803.2 5840.8 5682.3 5699.6 5722.7 5732.0 5768.9 5496.6 5540.2 5652.3 5719.8 5753.8 5860.9 5865.3 5918.8 5937.7 5947.0 5589.2 5750.8 5796.2 5796.4 5838.7 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - PROCESS | 16857 | [#5] yui.html Cycles:180 Average:15870.63 Median:4595.01 stddev:18977.37 (413.0%) stddev-sans-first:18996.60 11:26:02 INFO - PROCESS | 16857 | Values: 741.8 750.2 775.2 776.9 796.7 14452.5 15237.1 15294.2 15418.3 15430.2 14234.5 14255.4 14349.5 14390.2 14390.9 810.1 836.1 837.1 844.0 844.4 817.1 818.8 821.8 833.2 835.6 873.2 877.9 881.0 881.4 882.8 859.7 861.8 864.8 866.7 869.1 635.7 636.5 638.1 638.3 639.1 14581.3 14601.3 14713.7 14730.6 14753.5 14044.7 14418.7 14491.1 14622.6 14707.1 10621.8 10644.8 10715.9 10888.6 11141.5 3772.5 3866.5 3888.9 3894.1 3969.1 61420.7 63067.7 63261.7 63548.7 65070.3 11010.6 11204.9 11237.9 11316.3 11322.7 20873.7 21432.4 21572.5 21592.8 21598.6 8170.8 8283.7 8377.2 8381.9 8420.0 4559.4 4654.2 4715.4 4739.5 4801.1 3306.3 3362.2 3369.3 3370.5 3377.4 562.8 586.8 587.8 603.1 607.2 685.5 743.4 754.9 768.6 782.3 9054.8 9681.9 9745.5 9747.4 9821.2 704.6 719.5 731.3 754.8 759.7 4237.9 4528.7 4530.3 4539.1 4630.6 68406.3 71642.6 71722.3 71802.3 72094.6 29621.4 52032.2 52244.7 63741.7 64444.4 52834.2 52972.5 53992.7 57464.4 58819.7 9329.5 9735.1 9778.9 9782.0 9796.3 36078.6 37633.6 37695.6 37848.4 37882.8 49424.8 49903.5 50053.7 50172.2 50424.2 13083.1 13249.0 13294.0 13477.8 13659.0 14081.9 14340.7 14479.4 14510.6 14835.4 13014.2 13079.9 13144.0 13162.9 13205.0 13239.0 13483.1 13489.0 13550.1 13587.8 12665.0 13070.3 13134.5 13154.6 13175.1 10527.9 10562.3 10690.3 10738.4 10858.6 10369.2 10749.0 10879.8 10931.5 11009.7 11:26:02 INFO - PROCESS | 16857 | -------- Summary: end -------- 11:26:02 INFO - PROCESS | 16857 | 11:26:02 INFO - TEST-INFO | 16857: exit 0 11:26:02 INFO - TEST-OK | dromaeo_css | took 1111763ms 11:26:02 INFO - TEST-START | kraken 11:26:02 INFO - operating with platform_type : linux_ 11:26:02 INFO - Initialising browser for kraken test... 11:26:02 INFO - TEST-INFO | started process 17090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8bgaGn/profile http://localhost:45205/getInfo.html) 11:26:07 INFO - PROCESS | 17090 | __metrics Screen width/height:1600/1200 11:26:07 INFO - PROCESS | 17090 | colorDepth:24 11:26:07 INFO - PROCESS | 17090 | Browser inner width/height: 1024/697 11:26:07 INFO - PROCESS | 17090 | __metrics 11:26:08 ERROR - PROCESS | 17090 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:26:08 INFO - TEST-INFO | 17090: exit 0 11:26:08 INFO - Browser initialized. 11:26:08 INFO - Running cycle 1/1 for kraken test... 11:26:08 INFO - TEST-INFO | started process 17208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8bgaGn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:20 INFO - PROCESS | 17208 | RSS: Main: 166825984 11:26:20 INFO - PROCESS | 17208 | 11:26:23 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45205/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:24 INFO - PROCESS | 17208 | RSS: Main: 171991040 11:26:24 INFO - PROCESS | 17208 | 11:26:26 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45205/tests/kraken/driver.html?testName=audio-dft) 11:26:27 INFO - PROCESS | 17208 | RSS: Main: 171315200 11:26:27 INFO - PROCESS | 17208 | 11:26:30 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45205/tests/kraken/driver.html?testName=audio-fft) 11:26:31 INFO - PROCESS | 17208 | RSS: Main: 166039552 11:26:31 INFO - PROCESS | 17208 | 11:26:33 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45205/tests/kraken/driver.html?testName=audio-oscillator) 11:26:33 INFO - PROCESS | 17208 | RSS: Main: 167190528 11:26:33 INFO - PROCESS | 17208 | 11:26:36 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45205/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:36 INFO - PROCESS | 17208 | RSS: Main: 167845888 11:26:36 INFO - PROCESS | 17208 | 11:26:39 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45205/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:40 INFO - PROCESS | 17208 | RSS: Main: 167682048 11:26:40 INFO - PROCESS | 17208 | 11:26:43 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45205/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:44 INFO - PROCESS | 17208 | RSS: Main: 168443904 11:26:44 INFO - PROCESS | 17208 | 11:26:47 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45205/tests/kraken/driver.html?testName=json-parse-financial) 11:26:47 INFO - PROCESS | 17208 | RSS: Main: 168280064 11:26:47 INFO - PROCESS | 17208 | 11:26:49 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45205/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:50 INFO - PROCESS | 17208 | RSS: Main: 168230912 11:26:50 INFO - PROCESS | 17208 | 11:26:51 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:52 INFO - PROCESS | 17208 | RSS: Main: 168099840 11:26:52 INFO - PROCESS | 17208 | 11:26:54 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:55 INFO - PROCESS | 17208 | RSS: Main: 168230912 11:26:55 INFO - PROCESS | 17208 | 11:26:57 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:58 INFO - PROCESS | 17208 | RSS: Main: 168243200 11:26:58 INFO - PROCESS | 17208 | 11:27:01 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:01 INFO - PROCESS | 17208 | RSS: Main: 168316928 11:27:01 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | Cycle 1(1): loaded http://localhost:45205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45205/tests/kraken/driver.html?testName=ai-astar) 11:27:03 INFO - PROCESS | 17208 | RSS: Main: 169201664 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | __start_tp_report 11:27:03 INFO - PROCESS | 17208 | _x_x_mozilla_page_load 11:27:03 INFO - PROCESS | 17208 | _x_x_mozilla_page_load_details 11:27:03 INFO - PROCESS | 17208 | |i|pagename|runs| 11:27:03 INFO - PROCESS | 17208 | |0;ai-astar;111;106;113;111;111;112;111;111;110;111 11:27:03 INFO - PROCESS | 17208 | |1;audio-beat-detection;159;126;153;178;129;163;149;128;190;125 11:27:03 INFO - PROCESS | 17208 | |2;audio-dft;162;164;163;164;163;166;167;162;164;163 11:27:03 INFO - PROCESS | 17208 | |3;audio-fft;75;77;76;160;75;77;75;75;163;78 11:27:03 INFO - PROCESS | 17208 | |4;audio-oscillator;83;83;149;84;84;94;148;83;85;134 11:27:03 INFO - PROCESS | 17208 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;117 11:27:03 INFO - PROCESS | 17208 | |6;imaging-darkroom;146;148;149;148;147;147;148;147;146;147 11:27:03 INFO - PROCESS | 17208 | |7;imaging-desaturate;95;98;96;96;95;95;95;95;95;95 11:27:03 INFO - PROCESS | 17208 | |8;json-parse-financial;54;53;53;53;56;52;54;53;53;53 11:27:03 INFO - PROCESS | 17208 | |9;json-stringify-tinderbox;66;63;63;63;64;64;64;62;64;64 11:27:03 INFO - PROCESS | 17208 | |10;stanford-crypto-aes;79;79;82;80;81;81;88;82;107;86 11:27:03 INFO - PROCESS | 17208 | |11;stanford-crypto-ccm;137;130;138;129;138;126;133;128;130;125 11:27:03 INFO - PROCESS | 17208 | |12;stanford-crypto-pbkdf2;159;172;161;160;163;156;162;157;157;158 11:27:03 INFO - PROCESS | 17208 | |13;stanford-crypto-sha256-iterative;64;66;65;62;63;61;63;62;62;61 11:27:03 INFO - PROCESS | 17208 | __end_tp_report 11:27:03 INFO - PROCESS | 17208 | __start_cc_report 11:27:03 INFO - PROCESS | 17208 | _x_x_mozilla_cycle_collect,884 11:27:03 INFO - PROCESS | 17208 | __end_cc_report 11:27:03 INFO - PROCESS | 17208 | __startTimestamp1464632823707__endTimestamp 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | ------- Summary: start ------- 11:27:03 INFO - PROCESS | 17208 | Number of tests: 14 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.83 (1.6%) stddev-sans-first:1.94 11:27:03 INFO - PROCESS | 17208 | Values: 111.0 106.0 113.0 111.0 111.0 112.0 111.0 111.0 110.0 111.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:156.00 stddev:23.02 (14.8%) stddev-sans-first:24.19 11:27:03 INFO - PROCESS | 17208 | Values: 159.0 126.0 153.0 178.0 129.0 163.0 149.0 128.0 190.0 125.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.62 (1.0%) stddev-sans-first:1.58 11:27:03 INFO - PROCESS | 17208 | Values: 162.0 164.0 163.0 164.0 163.0 166.0 167.0 162.0 164.0 163.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:36.07 (47.8%) stddev-sans-first:37.66 11:27:03 INFO - PROCESS | 17208 | Values: 75.0 77.0 76.0 160.0 75.0 77.0 75.0 75.0 163.0 78.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:83.50 stddev:28.73 (34.4%) stddev-sans-first:29.57 11:27:03 INFO - PROCESS | 17208 | Values: 83.0 83.0 149.0 84.0 84.0 94.0 148.0 83.0 85.0 134.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:27:03 INFO - PROCESS | 17208 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 11:27:03 INFO - PROCESS | 17208 | Values: 146.0 148.0 149.0 148.0 147.0 147.0 148.0 147.0 146.0 147.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 11:27:03 INFO - PROCESS | 17208 | Values: 95.0 98.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 11:27:03 INFO - PROCESS | 17208 | Values: 54.0 53.0 53.0 53.0 56.0 52.0 54.0 53.0 53.0 53.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:0.73 11:27:03 INFO - PROCESS | 17208 | Values: 66.0 63.0 63.0 63.0 64.0 64.0 64.0 62.0 64.0 64.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:81.50 stddev:8.42 (10.3%) stddev-sans-first:8.70 11:27:03 INFO - PROCESS | 17208 | Values: 79.0 79.0 82.0 80.0 81.0 81.0 88.0 82.0 107.0 86.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:131.50 stddev:4.86 (3.7%) stddev-sans-first:4.71 11:27:03 INFO - PROCESS | 17208 | Values: 137.0 130.0 138.0 129.0 138.0 126.0 133.0 128.0 130.0 125.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:4.65 (2.9%) stddev-sans-first:4.90 11:27:03 INFO - PROCESS | 17208 | Values: 159.0 172.0 161.0 160.0 163.0 156.0 162.0 157.0 157.0 158.0 11:27:03 INFO - PROCESS | 17208 | 11:27:03 INFO - PROCESS | 17208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.66 (2.6%) stddev-sans-first:1.72 11:27:03 INFO - PROCESS | 17208 | Values: 64.0 66.0 65.0 62.0 63.0 61.0 63.0 62.0 62.0 61.0 11:27:03 INFO - PROCESS | 17208 | -------- Summary: end -------- 11:27:03 INFO - PROCESS | 17208 | 11:27:04 INFO - TEST-INFO | 17208: exit 0 11:27:04 INFO - TEST-OK | kraken | took 61916ms 11:27:04 INFO - SUITE-END | took 1173s 11:27:04 INFO - Completed test suite (00:19:33) 11:27:04 INFO - javascript benchmark 11:27:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7137.859764399052, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.7514598832095, 3117.8285194314303, 3143.3713257348536, 3151.3854798314323, 3153.511205763106, 5338.06583847827, 5352.759125839337, 5418.0, 5444.156155795853, 5484.396716361207, 5446.972765136169, 5462.317210348707, 5473.589480788937, 5521.3926468088475, 5530.861728456791, 4900.142475066867, 5014.921791814759, 5039.420466646346, 5062.038212739568, 5186.118359878829, 5069.771860266297, 5092.261622064799, 5104.030234255498, 5120.61595380348, 5158.5873130149685, 4988.775505102279, 4997.625178111638, 5026.623003274769, 5032.295478632995, 5085.338905942203, 5038.899222015576, 5053.4946505349535, 5082.923756143661, 5083.262926875619, 5113.51421614946, 4953.182724850431, 5014.43791695707, 5053.0, 5062.468440813698, 5065.518775716338, 5384.946150538483, 5391.838244852661, 5453.072977593819, 5455.863603409907, 5511.641743286674, 5893.911591326134, 5900.822975310747, 5911.674857882857, 5912.320083190445, 5916.733746981353, 5690.943090569082, 5779.508741756956, 5816.040353341694, 5957.910631340534, 5965.791197308116, 5442.891142177174, 5443.618946673695, 5454.290942177531, 5470.261514695465, 5492.725363731797, 5970.492508136857, 5970.552208584373, 5971.850703732354, 5987.730552125165, 5989.8203053908455, 5527.060399732055, 5724.0, 5737.3975732548315, 5761.8559536011935, 5800.419958004166, 5896.086106653475, 5896.410358964155, 5910.970445147746, 5921.289445266596, 5924.822255332347, 5651.547876169979, 5723.0, 5767.04843700793, 5818.33089194748, 5857.648541087548, 5699.601027928005, 5790.392008839095, 5792.88414231713, 5850.970745146247, 5851.736671849777, 4353.085851971058, 4353.542877997765, 4362.411074504965, 4377.802998865059, 4412.051408947092, 3896.357101078347, 3910.9804450977563, 3916.5887581804072, 3919.0594257378593, 3954.031262340745, 5559.6664200148125, 5648.350439699405, 5678.829635110953, 5693.117566777156, 5713.457221563945, 5960.0761881908375, 5972.492338151219, 5981.0, 6006.729697163638, 6016.278046634345, 5710.172025056344, 5715.457031581993, 5738.741756620962, 5750.878578677201, 5752.9424705753245, 4754.191787396151, 4836.46798852126, 4873.00103478786, 4880.926786098212, 4896.608271338285, 6190.783322583688, 6210.223722034746, 6216.7824126155365, 6229.065640154013, 6242.157308763259, 5944.702764861653, 5973.0, 6003.5797494174985, 6017.939820601738, 6026.0659597762415, 5902.321233058254, 6068.271807383142, 6104.725287361991, 6112.8777424452155, 6133.324062991892, 5826.70866456684, 5856.882862342644, 5874.882502349844, 5876.059830427112, 5904.852378690567, 5821.243238378984, 5934.139549765347, 5987.251593550806, 5999.220101386792, 6002.0, 5503.7798488060025, 5532.059549876451, 5717.056685646988, 5722.456366645162, 5773.191753154478, 5585.832425027255, 5597.524210441995, 5598.104303311614, 5600.971995139998, 5660.971695141498, 5599.440055994368, 5625.09998400254, 5630.071038278638, 5637.943620563742, 5654.971725141348, 5658.264425624642, 5692.430756924275, 5714.3999880012, 5721.0, 5770.249867517364, 5601.383847776823, 5608.691521966331, 5632.464915832989, 5638.436156384329, 5668.943310566841], "value": 5408.059222041321, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3989151553595, 620.5749061892604, 622.9563930524862, 643.1221382812461, 651.7458191305394, 38731.419028714554, 42225.78887105568, 42257.154856902845, 42286.577134228646, 42448.57551424488, 43247.0, 43257.78371108148, 43832.3425148623, 43836.0, 43904.0, 8584.570771461418, 8779.29765618749, 8782.824343513126, 8786.604602792857, 8793.7801554961, 8737.825243495126, 8800.559972001407, 8844.646214151426, 8846.911530884705, 8849.0, 8833.779155521099, 8861.379703420764, 8871.290296776275, 8876.068012858621, 8877.245434138105, 8770.956145219265, 8817.955910220408, 8846.823063538724, 8861.601227944759, 8866.157715017063, 8633.568321583958, 8685.0, 8720.607572659246, 8732.650693972297, 8737.650493980233, 40491.0, 40822.38766418506, 40843.38734918978, 40967.38548921768, 41029.384559231636, 2942.411517696469, 3340.8997730068136, 3497.0732755819727, 3561.5013898054294, 3606.062423769839, 30099.699003009908, 30199.547006794917, 30372.544411833842, 33060.669393306, 33734.83132584322, 4329.328954012101, 4393.428854248959, 4424.933625995613, 4428.22506061438, 4618.8152473901, 320445.397773012, 320510.0, 320763.0, 322440.0, 323417.0, 61277.62973036526, 61449.69275153596, 61966.38033619606, 62008.37991620026, 62015.6899215501, 35942.820285898924, 36493.635063649555, 36616.0, 38608.42087368692, 65686.67156664186, 13958.651033724238, 14032.579022629337, 14049.648758781112, 14197.006209565232, 14243.145411275356, 11239.438028098562, 11362.0, 11386.886131138583, 11396.316221026598, 11412.714682133013, 19876.60246795056, 20103.29638462647, 20139.79860201379, 20183.192672292942, 20250.69623955642, 7242.529235599669, 7351.669174887143, 7397.482176247611, 7478.663460144307, 7581.848363032708, 992.389680346596, 1078.2853071169902, 1086.4567716141928, 1105.1490352428584, 1125.7354521687396, 32673.34653306968, 33156.3368732624, 33240.0, 33327.0, 33560.66439335576, 1051.0645525482328, 1123.9550417983353, 1138.4535422996842, 1179.6637958181877, 1202.0984261803646, 16707.33170673184, 16924.323027079026, 16990.235439405256, 17120.229589668495, 17924.641507169785, 565369.0, 800015.0, 813208.0, 825632.0, 829065.0, 59535.404645952985, 60385.39614603798, 60586.69706651438, 60791.08813367715, 60922.695386522784, 1371.3760239091189, 1411.6753146776093, 1411.8517555656713, 1427.7430062588626, 1432.1621851216946, 32071.358572828878, 34131.317373651895, 34174.82912585421, 34396.0, 34492.13921555986, 53903.19145212903, 54204.457955421516, 54542.45457545374, 54554.181687275515, 54631.0, 386128.0, 386376.0, 387294.0, 387585.0, 388043.0, 28931.276718082216, 29126.41747165087, 29172.854135729187, 29485.705142949155, 30498.237544061576, 47414.52585474101, 48098.519014809404, 48201.5179848197, 48376.27435588399, 48872.75563622159, 38018.8099059514, 39984.40023399593, 40119.598804011584, 40237.0, 41089.79455102705, 39092.21815563616, 39376.803115984236, 39930.40104398378, 40186.79906600448, 40205.0, 39167.2166556673, 39646.207075858896, 39680.60319396769, 40647.39028914628, 42254.366184507875, 35930.64069359378, 37547.43678844765, 37761.2447751038, 37870.0, 38094.428583571826, 28537.42925141444, 28813.855930721053, 28985.0, 29318.26704332409, 29321.7067829319], "value": 20043.4364978285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.99062523436913, 385.75311800447736, 386.5091334005813, 400.6214127649371, 412.2764548217877, 16290.42983495578, 18034.458966231035, 18644.813551864478, 18659.533511662197, 18954.431367058976, 17875.821241787577, 18234.81765182348, 18551.70138090331, 18675.066246687646, 18837.340693075745, 5447.291852059227, 5457.263269458632, 5613.971930140344, 5667.923094612011, 5681.517071048966, 5548.0, 5616.52259557938, 5641.971790141043, 5643.181738647893, 5645.350784659776, 5358.0, 5498.477644623775, 5539.556835453154, 5556.694381809019, 5599.692016939067, 5509.972450137764, 5537.335519737637, 5561.972190139044, 5575.080111781551, 5589.7205139743055, 4877.829275975359, 4919.434265059528, 4934.111859865223, 4946.356973593446, 4953.653244272902, 22385.0, 22494.437639059153, 22930.0, 22931.885340573357, 23068.42328941773, 2278.874661893595, 2467.580511313063, 2490.5392502386935, 2529.5699731045765, 2531.038205481905, 12421.751564968741, 14277.78583321251, 14411.495597654137, 14457.349419276157, 14558.272086395744, 1938.3215874443972, 1969.7439332886777, 1989.7711763147279, 1994.38174166009, 2040.4694779357326, 67535.27253092286, 71705.0, 72356.27643723549, 82496.17503824945, 82552.58723706403, 9589.184919281799, 10092.949535252277, 10782.353058816496, 10830.620928267474, 11009.61466348674, 15072.321745521478, 15088.321025553876, 15164.620884477976, 15212.771808422882, 15258.771118433233, 7326.4505162113055, 7433.553986760811, 7437.739679111205, 7489.85020299591, 7549.9245007549225, 7035.155781306276, 7057.117860267466, 7085.43316534676, 7149.356557909813, 7180.820479488055, 4243.0, 4409.368533642572, 4649.256119020941, 4726.692764970266, 4835.129676658235, 1837.595728939631, 1849.324996376313, 1873.4192400355932, 1893.4319704088718, 1904.9714254286196, 889.8531742262454, 975.5805003848413, 996.6860438961704, 1054.894510548939, 1056.9260151789454, 18846.811531884505, 18939.81060189408, 19210.51973700641, 19337.709934350994, 19591.706124408145, 992.9304948653524, 1002.0981116994762, 1015.8476228565627, 1017.4353233955226, 1037.2790910317258, 10516.421596812095, 10771.946140269405, 11042.447877606248, 11075.833862492069, 11083.833742493869, 444263.0, 449910.488731523, 452157.0, 454308.0, 454484.0, 93788.0, 95140.0, 95468.0, 95668.52165739126, 95933.0, 968.3995922528078, 993.9403635781877, 1011.7369483934083, 1014.7666036811574, 1015.5633077776627, 16810.66378672395, 16833.831661683227, 17165.914170429067, 17257.482275531253, 17611.55971100733, 40468.0, 41094.1781164369, 41698.79150604349, 42535.57464425316, 43247.0, 53588.73205633947, 53796.46203538071, 54838.0, 55032.17451738307, 55190.0, 7797.844043119219, 7925.247101525346, 8049.557274349967, 8154.510729356258, 8294.129116442688, 11970.341631210367, 12082.093842961638, 12332.445039973401, 12515.624531263713, 12548.749025019266, 10655.25413221067, 11208.215424920178, 11568.479418426023, 11609.245399049034, 11692.47383867711, 10595.841062384225, 10624.734381640521, 11034.337939723642, 11109.722256943642, 11349.262297950607, 6865.41643960269, 9261.953690231505, 10800.567977280822, 11495.425228738697, 11558.942205289257, 8184.549849758082, 8357.95821020891, 8467.49195048299, 8713.869291960498, 8756.51839148853, 8451.577421128795, 10490.685279441628, 10852.294600850919, 10912.181586380895, 11091.33451992883], "value": 8970.63004345251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.7975303704445, 1442.1923722715278, 1587.595163233376, 1749.8775085743996, 1753.8333858283474, 7767.106782719989, 8223.177682231788, 8373.790655233615, 8979.191872731453, 9059.728208153758, 8263.545504997222, 8375.288100511449, 8596.656133754657, 8607.827843443127, 8624.698135565257, 2314.6643736658175, 2347.1667558016916, 2367.183321753992, 2367.709598268939, 2375.6674065630827, 2294.621387471074, 2302.5510025545027, 2373.1100837186054, 2380.27401642499, 2383.1420688552107, 2368.159303447277, 2371.039728909794, 2395.8921848516857, 2398.760123987596, 2404.4469771952463, 2277.202978957368, 2283.5318759654315, 2293.69035180251, 2318.5594736999915, 2341.0, 2325.5348930213854, 2342.390978345625, 2356.057576969209, 2358.8466749661216, 2359.4691194481106, 8475.364347673887, 8553.144685531459, 8608.569571521399, 8611.569421528899, 8621.310295176434, 4889.511048895082, 5008.29883816266, 5011.198208286657, 5028.346314979066, 5033.068882256757, 3097.1173215633435, 3121.82829944353, 3159.431302365573, 3178.666240044808, 3194.217416732892, 1031.4842578710645, 1053.5891002509027, 1080.9081228095622, 1100.834874768783, 1104.5305745058317, 12047.216930899463, 12332.136750427473, 12347.753044939142, 12351.6912077197, 12370.0, 4470.798814053311, 4515.9774201128785, 4595.448546174413, 4615.5845973862515, 4653.837115700934, 10520.579176832842, 10531.104856087319, 10548.156147508182, 10555.26113172086, 10557.419341936115, 5069.847904562869, 5118.283440318359, 5139.434662187156, 5160.200168973815, 5186.351706036746, 4112.856050038295, 4659.883502912454, 4726.976365118152, 4798.95201047992, 4805.111054454937, 3957.6438120569287, 3965.215652956181, 3999.860004899873, 4062.0657248832936, 4107.404426358161, 1215.8237055626885, 1301.537954026326, 1311.5965916469477, 1314.5859054397833, 1320.386020500472, 824.4970567953544, 925.8287216864901, 947.7772723409993, 949.6533765175661, 950.8003319303024, 5548.639338443069, 5554.805581804618, 5584.246126772915, 5655.0, 5661.405552417019, 388.4852570344249, 399.39890464850214, 415.03297317250735, 418.21167100016686, 418.4183984261878, 3801.7148713846573, 3983.880483585497, 4015.3374693175883, 4020.0, 4050.3924411338535, 9803.901960980442, 9960.750981225527, 10034.397936123856, 10052.899471005343, 10075.193984481224, 9808.411495310304, 9883.357581757164, 9988.101070903653, 9998.950005250073, 10055.145312648507, 7653.808654783675, 7756.961215193888, 7785.571793551296, 7790.376769858398, 7836.294733473901, 5414.133738601805, 5420.322459692538, 5514.558835293247, 5551.805686800943, 5565.749541270571, 9098.953620333747, 9356.719298421058, 9357.111074447917, 9417.62329506812, 9442.85835712451, 9836.60653573849, 10081.899181008095, 10177.185825133824, 10301.793964120825, 10441.112505437122, 6974.267701891228, 7542.170361260147, 7671.923280767121, 7802.492837965514, 7826.295633393022, 8281.17188281167, 8313.210245026954, 8345.873307103464, 8440.746777596682, 8452.112528184698, 7570.507916985378, 7676.462647614613, 7740.535567865946, 7771.92228077712, 7869.252421019994, 7341.155767086853, 7618.0, 7707.34487568563, 7773.92226077732, 7823.374130069695, 6752.493562982698, 6823.965880170567, 6834.350736680008, 6848.863022739617, 6876.793696189123, 5013.6490445669915, 5082.517160869711, 5135.666181698178, 5161.354830646169, 5182.792688292577, 5020.795009197839, 5122.282880396673, 5168.457311982188, 5275.287836142072, 5341.065313570188], "value": 4436.002850416313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.5516532020492, 329.41693203030627, 330.6825447570332, 337.34386618027946, 340.4501729706523, 5432.348118225814, 5535.363433205182, 5591.692456914879, 5601.29983752031, 5624.437556244374, 5439.646422982503, 5466.207399927008, 5495.2856128703215, 5506.174073888908, 5531.446855314466, 4069.7151199416053, 4090.059286364138, 4203.159368126372, 4263.957360426402, 4278.465191851019, 4250.9149817003645, 4266.0, 4270.466191726035, 4279.331060886257, 4285.635720963722, 4264.59486348798, 4269.722468039583, 4275.572442755731, 4278.1871444425615, 4286.807093680776, 4036.9999999999854, 4255.829766809324, 4259.233337999159, 4267.18644576054, 4293.935590966138, 3699.315626609086, 3703.0, 3708.5735140458655, 3715.3312403767313, 3721.497597824286, 5262.631615786897, 5289.788408463657, 5333.599980001515, 5344.866378340534, 5361.81233656824, 4623.56076172763, 4788.521147885183, 4808.182608956486, 4854.975725121351, 4912.15794077221, 5696.515796157331, 5765.336986246593, 5775.689724110347, 5811.593188476808, 5816.796412125597, 4040.1717647882115, 4054.209429161315, 4064.9837540614844, 4067.779666100158, 4106.507219133723, 5968.104784282349, 6019.428154325332, 6038.849028774228, 6043.939560604382, 6111.297200821918, 4122.134351786099, 4130.938035929464, 4136.44158038667, 4151.584841515824, 4164.3961625564125, 4169.91660166795, 4206.621404073648, 4235.216484950294, 4253.680973926967, 4254.787260637017, 4711.882202944886, 4792.185328494164, 4870.6103511718975, 4912.901741965141, 4938.469074586889, 5756.798512052058, 5759.366469688331, 5765.567582431335, 5809.244798176294, 5829.09649004405, 1447.6163816588612, 1451.4557041109583, 1453.665656898898, 1470.5000899082875, 1470.8453863716932, 931.4644079654225, 932.128459890005, 943.193569498083, 961.4759955824093, 993.6522217224058, 5545.445455454423, 5553.694546799884, 5570.777168913198, 5593.468620481048, 5598.720063996784, 5851.093080572433, 5868.359238342763, 5894.67579283135, 5920.200772895604, 5951.613145145639, 5381.300430943952, 5548.501904485847, 5574.442555744474, 5603.2435621191435, 5603.982566276138, 3135.38195606671, 3148.0, 3155.3216058547523, 3173.508106243536, 3190.5373720810353, 5799.594028417971, 6029.457348838626, 6131.325554189036, 6164.568480206342, 6172.117504161184, 5926.733297001645, 5972.671503067373, 5998.400159983967, 6003.939960600425, 6006.699665016732, 6103.206583144163, 6108.816735498031, 6114.724837382329, 6120.326764055951, 6123.969380153071, 5703.0, 5894.793682221101, 5930.678819860892, 5943.970280148745, 5949.345571986992, 5802.796902108406, 5837.766489340379, 5843.211166492469, 5867.9413205869105, 5871.266091738533, 5945.700136424153, 6075.908861366995, 6167.691615419121, 6172.043333283348, 6186.123452594565, 4111.97944010278, 4113.609207125318, 4125.308623464365, 4126.463559737215, 4139.875803725893, 5896.3514013457625, 5922.940770592239, 5936.317323507852, 5941.168236446987, 5986.4013598639785, 5560.91658625129, 5674.581354661334, 5797.420257974169, 5803.187553742395, 5840.7583790996405, 5682.318121825408, 5699.629524080921, 5722.713864306685, 5732.0, 5768.884622307614, 5496.587755918402, 5540.168974653834, 5652.3217213934595, 5719.771209151588, 5753.827385178452, 5860.853478663067, 5865.266841644794, 5918.780457328502, 5937.703114844154, 5947.0, 5589.189567512769, 5750.827475175752, 5796.159556864315, 5796.362400135898, 5838.678872661874], "value": 4379.386413981226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.7997140771992, 750.2310132114582, 775.2015424113165, 776.9028871391076, 796.7178795199849, 14452.494162704308, 15237.085774853502, 15294.158821264826, 15418.30617622207, 15430.228488575569, 14234.501792437266, 14255.3585088671, 14349.497767578137, 14390.208538530404, 14390.928045359784, 810.088650268448, 836.1304243586693, 837.0541288344193, 844.0082902589432, 844.3793811548506, 817.1338381315794, 818.8444195602816, 821.7904434369258, 833.204289903141, 835.6239692138531, 873.2490058549643, 877.9209871111599, 881.0, 881.3698205782864, 882.836675215084, 859.6991053131417, 861.814709837388, 864.8313578852126, 866.6663334616187, 869.0614136732346, 635.7488791927162, 636.5130675033603, 638.090720722968, 638.3233772201481, 639.1148259660404, 14581.270936453135, 14601.269936503239, 14713.705725885422, 14730.631734206623, 14753.483628072965, 14044.719105617933, 14418.711625767426, 14491.130532168103, 14622.561323160322, 14707.117572945657, 10621.787564248749, 10644.7914960771, 10715.946420267848, 10888.564457421693, 11141.498632561474, 3772.4907137536356, 3866.516685414323, 3888.9027774305587, 3894.084890050836, 3969.0672691917375, 61420.692896535234, 63067.6846615764, 63261.68369158171, 63548.68225658889, 65070.3492965069, 11010.559577616805, 11204.887951120385, 11237.943810280896, 11316.26444281119, 11322.716932076764, 20873.68689469659, 21432.357029289145, 21572.4606884826, 21592.784072159393, 21598.56802863934, 8170.7957301067945, 8283.710070147636, 8377.204165604258, 8381.874271885927, 8420.0, 4559.3844830948065, 4654.185517534485, 4715.41057367829, 4739.526047395302, 4801.135795556764, 3306.2560923791953, 3362.159460134966, 3369.3261347730554, 3370.4607262837826, 3377.4258376076127, 562.7636392715069, 586.750630981831, 587.8119001919345, 603.0652488642586, 607.2136583124776, 685.5201359048685, 743.3792783026233, 754.9169591344947, 768.5696010234286, 782.335015237044, 9054.81890362189, 9681.9031809681, 9745.512724363894, 9747.415155090717, 9821.214302855755, 704.6300692136567, 719.5358993449196, 731.2723839779347, 754.7923322683662, 759.6505607420538, 4237.894052648647, 4528.705634133837, 4530.29780384041, 4539.114872599877, 4630.629549636021, 68406.31593684098, 71642.64178679073, 71722.28277717157, 71802.28197717956, 72094.63952680203, 29621.407571848442, 52032.21951670728, 52244.73877630587, 63741.681291593246, 64444.355556444774, 52834.207486887724, 52972.47027529753, 53992.73003635035, 57464.42535574591, 58819.705901471076, 9329.486878221764, 9735.144615201587, 9778.9022109778, 9781.951090244787, 9796.314258001872, 36078.63921360753, 37633.62366376301, 37695.623043769214, 37848.43227351537, 37882.81058594689, 49424.75287623539, 49903.500964989886, 50053.74973125111, 50172.247416289516, 50424.24363634622, 13083.149595276276, 13249.0, 13294.0, 13477.797833032708, 13659.04386692922, 14081.929590351983, 14340.713185736435, 14479.420823167377, 14510.564683059525, 14835.406583736529, 13014.21914685122, 13079.934600327319, 13144.0, 13162.934185329012, 13205.0, 13239.0, 13483.123596966167, 13489.0, 13550.119242249222, 13587.79618305746, 12665.0, 13070.346482675637, 13134.474621015052, 13154.60536183916, 13175.077744558172, 10527.94736026315, 10562.260641755003, 10690.251682382159, 10738.355698658106, 10858.565657373616, 10369.222308326755, 10748.990361983164, 10879.836802447811, 10931.508082136483, 11009.669709908716], "value": 7000.386115992401, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.7000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 153.0, 178.0, 129.0, 163.0, 149.0, 128.0, 190.0, 125.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 164.0, 163.0, 166.0, 167.0, 162.0, 164.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 160.0, 75.0, 77.0, 75.0, 75.0, 163.0, 78.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 149.0, 84.0, 84.0, 94.0, 148.0, 83.0, 85.0, 134.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 56.0, 52.0, 54.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 62.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 82.0, 80.0, 81.0, 81.0, 88.0, 82.0, 107.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 138.0, 129.0, 138.0, 126.0, 133.0, 128.0, 130.0, 125.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 172.0, 161.0, 160.0, 163.0, 156.0, 162.0, 157.0, 157.0, 158.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 62.0, 63.0, 61.0, 63.0, 62.0, 62.0, 61.0], "value": 62.9, "unit": "score"}]}]} 11:27:04 INFO - Return code: 0 11:27:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:05 ERROR - # TBPL SUCCESS # 11:27:05 INFO - Running post-action listener: _resource_record_post_action 11:27:05 INFO - ##### 11:27:05 INFO - ##### Finished run-tests step (success) 11:27:05 INFO - ##### 11:27:05 INFO - Running post-run listener: _resource_record_post_run 11:27:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556388352; Read time: 296; Write time: 764116 11:27:05 INFO - TinderboxPrint: CPU usage
13.4% 11:27:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 296 11:27:05 INFO - TinderboxPrint: I/O write bytes / time
556,388,352 / 764,116 11:27:05 INFO - TinderboxPrint: CPU idle
8,230.5 (86.5%) 11:27:05 INFO - TinderboxPrint: CPU user
1,221.7 (12.8%) 11:27:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:05 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 264835072; Read time: 0; Write time: 390476 11:27:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291495936; Read time: 296; Write time: 373616 11:27:05 INFO - Running post-run listener: _upload_blobber_files 11:27:05 INFO - Blob upload gear active. 11:27:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:05 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 11:27:05 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:05 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:10 INFO - (blobuploader) - INFO - Done attempting. 11:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:11 INFO - (blobuploader) - INFO - Done attempting. 11:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:12 INFO - (blobuploader) - INFO - Done attempting. 11:27:12 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:12 INFO - Return code: 0 11:27:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c42af2ff9ce5e71d0a2d7f16ec176cff8ec2a01a5737c88d85b22dfd77a13b058cd44569f3d1568b817bb8d090b191e45b1a38bd4a126f87190a47c9044daff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11901e3d05b4853a72c0ab83fb8b7e08d768e6fc2109526af721477ab43cc1d8b5f23e8d293747682e1eaf118329aa65298dc4bdda6e9df5afc1b69b5e330d4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58509d54c98cb4e1dcebb0867de633cc3463a1a8952b3414e25f5f77d51a031cd6990e7c52ab15cec85c36d32c647d256eec8d3b8b000da7b710e8e5c9ca333"} 11:27:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:12 INFO - Contents: 11:27:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c42af2ff9ce5e71d0a2d7f16ec176cff8ec2a01a5737c88d85b22dfd77a13b058cd44569f3d1568b817bb8d090b191e45b1a38bd4a126f87190a47c9044daff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11901e3d05b4853a72c0ab83fb8b7e08d768e6fc2109526af721477ab43cc1d8b5f23e8d293747682e1eaf118329aa65298dc4bdda6e9df5afc1b69b5e330d4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58509d54c98cb4e1dcebb0867de633cc3463a1a8952b3414e25f5f77d51a031cd6990e7c52ab15cec85c36d32c647d256eec8d3b8b000da7b710e8e5c9ca333"} 11:27:12 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:12 INFO - Copying logs to upload dir... 11:27:12 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.464791 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-30 11:27:11.270203) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 11:27:11.273823) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c42af2ff9ce5e71d0a2d7f16ec176cff8ec2a01a5737c88d85b22dfd77a13b058cd44569f3d1568b817bb8d090b191e45b1a38bd4a126f87190a47c9044daff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11901e3d05b4853a72c0ab83fb8b7e08d768e6fc2109526af721477ab43cc1d8b5f23e8d293747682e1eaf118329aa65298dc4bdda6e9df5afc1b69b5e330d4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58509d54c98cb4e1dcebb0867de633cc3463a1a8952b3414e25f5f77d51a031cd6990e7c52ab15cec85c36d32c647d256eec8d3b8b000da7b710e8e5c9ca333"} build_url:https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/FtWp5Sm0Rr60dThGyyl_tg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c42af2ff9ce5e71d0a2d7f16ec176cff8ec2a01a5737c88d85b22dfd77a13b058cd44569f3d1568b817bb8d090b191e45b1a38bd4a126f87190a47c9044daff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11901e3d05b4853a72c0ab83fb8b7e08d768e6fc2109526af721477ab43cc1d8b5f23e8d293747682e1eaf118329aa65298dc4bdda6e9df5afc1b69b5e330d4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58509d54c98cb4e1dcebb0867de633cc3463a1a8952b3414e25f5f77d51a031cd6990e7c52ab15cec85c36d32c647d256eec8d3b8b000da7b710e8e5c9ca333"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 11:27:11.299227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:27:11.299534) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464631418.765953-805791830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 11:27:11.385011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 11:27:11.385367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 11:27:11.385749) ========= ========= Total master_lag: 0.18 =========