builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1463811554.03 results: success (0) buildid: 20160520203038 builduid: abeca14195a54ba0a7b3eb8e3a460e64 revision: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.035088) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.035571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.035862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.081380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.081664) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 23:19:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-20 23:19:14 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129811 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.244731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.245019) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021792 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:14.313927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 23:19:14.314435) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 --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 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 --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=3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 23:19:14,880 truncating revision to first 12 chars 2016-05-20 23:19:14,880 Setting DEBUG logging. 2016-05-20 23:19:14,880 attempt 1/10 2016-05-20 23:19:14,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06d9362a57a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 23:19:15,758 unpacking tar archive at: fx-team-06d9362a57a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.166993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 23:19:15.502142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:15.504282) ========= script_repo_revision: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:15.504897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:15.505409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 23:19:15.515394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-20 23:19:15.515767) ========= /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=3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:19:16 INFO - MultiFileLogger online at 20160520 23:19:16 in /builds/slave/test 23:19:16 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 23:19:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:19:16 INFO - {'append_to_log': False, 23:19:16 INFO - 'base_work_dir': '/builds/slave/test', 23:19:16 INFO - 'blob_upload_branch': 'Fx-Team', 23:19:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:19:16 INFO - 'branch': 'Fx-Team', 23:19:16 INFO - 'buildbot_json_path': 'buildprops.json', 23:19:16 INFO - 'config_files': ('talos/linux_config.py',), 23:19:16 INFO - 'default_actions': ('clobber', 23:19:16 INFO - 'read-buildbot-config', 23:19:16 INFO - 'download-and-extract', 23:19:16 INFO - 'populate-webroot', 23:19:16 INFO - 'create-virtualenv', 23:19:16 INFO - 'install', 23:19:16 INFO - 'run-tests'), 23:19:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:19:16 INFO - 'download_minidump_stackwalk': True, 23:19:16 INFO - 'download_symbols': 'ondemand', 23:19:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:19:16 INFO - 'tooltool.py': '/tools/tooltool.py', 23:19:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:19:16 INFO - '/tools/misc-python/virtualenv.py')}, 23:19:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:19:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:19:16 INFO - 'installer_path': 'installer.exe', 23:19:16 INFO - 'log_level': 'info', 23:19:16 INFO - 'log_name': 'talos', 23:19:16 INFO - 'log_to_console': True, 23:19:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:19:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:19:16 INFO - 'opt_config_files': (), 23:19:16 INFO - 'pip_index': False, 23:19:16 INFO - 'sps_profile': False, 23:19:16 INFO - 'sps_profile_interval': 0, 23:19:16 INFO - 'suite': 'dromaeojs-e10s', 23:19:16 INFO - 'system_bits': '32', 23:19:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:19:16 INFO - 'title': 'talos-linux64-ix-059', 23:19:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:19:16 INFO - 'use_talos_json': True, 23:19:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:19:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:19:16 INFO - 'work_dir': 'build'} 23:19:16 INFO - ##### 23:19:16 INFO - ##### Running clobber step. 23:19:16 INFO - ##### 23:19:16 INFO - Running pre-action listener: _resource_record_pre_action 23:19:16 INFO - Running main action method: clobber 23:19:16 INFO - rmtree: /builds/slave/test/build 23:19:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:19:17 INFO - Running post-action listener: _resource_record_post_action 23:19:17 INFO - ##### 23:19:17 INFO - ##### Finished clobber step (success) 23:19:17 INFO - ##### 23:19:17 INFO - ##### 23:19:17 INFO - ##### Running read-buildbot-config step. 23:19:17 INFO - ##### 23:19:17 INFO - Running pre-action listener: _resource_record_pre_action 23:19:17 INFO - Running main action method: read_buildbot_config 23:19:17 INFO - Using buildbot properties: 23:19:17 INFO - { 23:19:17 INFO - "project": "", 23:19:17 INFO - "product": "firefox", 23:19:17 INFO - "script_repo_revision": "production", 23:19:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:19:17 INFO - "repository": "", 23:19:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:19:17 INFO - "buildid": "20160520203038", 23:19:17 INFO - "pgo_build": "True", 23:19:17 INFO - "basedir": "/builds/slave/test", 23:19:17 INFO - "buildnumber": 479, 23:19:17 INFO - "slavename": "talos-linux64-ix-059", 23:19:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:19:17 INFO - "platform": "ubuntu64_hw", 23:19:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:19:17 INFO - "branch": "fx-team", 23:19:17 INFO - "repo_path": "integration/fx-team", 23:19:17 INFO - "revision": "06d9362a57a10396f3f7c7989c21f1a416f4c7e9", 23:19:17 INFO - "stage_platform": "linux64-pgo", 23:19:17 INFO - "builduid": "abeca14195a54ba0a7b3eb8e3a460e64", 23:19:17 INFO - "slavebuilddir": "test" 23:19:17 INFO - } 23:19:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:19:17 INFO - Running post-action listener: _resource_record_post_action 23:19:17 INFO - ##### 23:19:17 INFO - ##### Finished read-buildbot-config step (success) 23:19:17 INFO - ##### 23:19:17 INFO - ##### 23:19:17 INFO - ##### Running download-and-extract step. 23:19:17 INFO - ##### 23:19:17 INFO - Running pre-action listener: _resource_record_pre_action 23:19:17 INFO - Running main action method: download_and_extract 23:19:17 INFO - mkdir: /builds/slave/test/build/tests 23:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:17 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:19:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:19:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:19:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:18 INFO - Downloaded 1361 bytes. 23:19:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:19:18 INFO - Using the following test package requirements: 23:19:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:19:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:19:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:19:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'jsshell-linux-x86_64.zip'], 23:19:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:19:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:19:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:19:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:19:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:19:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:19:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:19:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:18 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:19 INFO - Downloaded 24389251 bytes. 23:19:19 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'] 23:19:19 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 23:19:21 INFO - Return code: 0 23:19:21 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 23:19:21 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')]} 23:19:21 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:19:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:19:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:19:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:23 INFO - Downloaded 24389251 bytes. 23:19:23 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'] 23:19:23 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 23:19:25 INFO - Return code: 0 23:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:25 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:19:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:19:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:19:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:26 INFO - Downloaded 10840359 bytes. 23:19:26 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'] 23:19:26 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 23:19:26 INFO - Return code: 0 23:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:26 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:19:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:19:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:19:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:19:28 INFO - Downloaded 58593479 bytes. 23:19:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:19:28 INFO - mkdir: /builds/slave/test/properties 23:19:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:19:28 INFO - Writing to file /builds/slave/test/properties/build_url 23:19:28 INFO - Contents: 23:19:28 INFO - build_url:https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:19:28 INFO - Running post-action listener: _resource_record_post_action 23:19:28 INFO - Running post-action listener: set_extra_try_arguments 23:19:28 INFO - ##### 23:19:28 INFO - ##### Finished download-and-extract step (success) 23:19:28 INFO - ##### 23:19:28 INFO - ##### 23:19:28 INFO - ##### Running populate-webroot step. 23:19:28 INFO - ##### 23:19:28 INFO - Running pre-action listener: _resource_record_pre_action 23:19:28 INFO - Running main action method: populate_webroot 23:19:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:19:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:19:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:19:28 INFO - '--tppagecycles', 23:19:28 INFO - '7'], 23:19:28 INFO - 'tests': ['tsvgm']}}, 23:19:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:19:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:19:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:19:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:19:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['damp', 'tps']}, 23:19:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'tests': ['damp', 'tps']}, 23:19:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['dromaeo_dom']}, 23:19:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:19:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['a11yr', 23:19:28 INFO - 'ts_paint', 23:19:28 INFO - 'tpaint', 23:19:28 INFO - 'sessionrestore', 23:19:28 INFO - 'sessionrestore_no_auto_restore', 23:19:28 INFO - 'tabpaint']}, 23:19:28 INFO - 'other-e10s': {'tests': ['a11yr', 23:19:28 INFO - 'ts_paint', 23:19:28 INFO - 'tpaint', 23:19:28 INFO - 'sessionrestore', 23:19:28 INFO - 'sessionrestore_no_auto_restore', 23:19:28 INFO - 'tabpaint']}, 23:19:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:19:28 INFO - 'ts_paint', 23:19:28 INFO - 'tpaint', 23:19:28 INFO - 'sessionrestore', 23:19:28 INFO - 'sessionrestore_no_auto_restore', 23:19:28 INFO - 'tabpaint']}, 23:19:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:19:28 INFO - 'ts_paint', 23:19:28 INFO - 'tpaint', 23:19:28 INFO - 'sessionrestore', 23:19:28 INFO - 'sessionrestore_no_auto_restore', 23:19:28 INFO - 'tabpaint']}, 23:19:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['a11yr', 23:19:28 INFO - 'ts_paint', 23:19:28 INFO - 'tpaint', 23:19:28 INFO - 'sessionrestore', 23:19:28 INFO - 'sessionrestore_no_auto_restore', 23:19:28 INFO - 'tabpaint']}, 23:19:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['a11yr', 23:19:28 INFO - 'ts_paint', 23:19:28 INFO - 'tpaint', 23:19:28 INFO - 'sessionrestore', 23:19:28 INFO - 'sessionrestore_no_auto_restore', 23:19:28 INFO - 'tabpaint']}, 23:19:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['tsvgx', 23:19:28 INFO - 'tsvgr_opacity', 23:19:28 INFO - 'tart', 23:19:28 INFO - 'tscrollx', 23:19:28 INFO - 'cart']}, 23:19:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:19:28 INFO - 'tsvgr_opacity', 23:19:28 INFO - 'tart', 23:19:28 INFO - 'tscrollx', 23:19:28 INFO - 'cart']}, 23:19:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'talos_options': ['--disable-e10s'], 23:19:28 INFO - 'tests': ['tp5o']}, 23:19:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'tests': ['tp5o']}, 23:19:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'talos_options': ['--disable-e10s', 23:19:28 INFO - '--xperf_path', 23:19:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:28 INFO - 'tests': ['tp5n']}, 23:19:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:19:28 INFO - 'talos_options': ['--xperf_path', 23:19:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:28 INFO - 'tests': ['tp5n']}}, 23:19:28 INFO - 'talos.zip': {'path': '', 23:19:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:19:28 INFO - Running post-action listener: _resource_record_post_action 23:19:28 INFO - ##### 23:19:28 INFO - ##### Finished populate-webroot step (success) 23:19:28 INFO - ##### 23:19:28 INFO - ##### 23:19:28 INFO - ##### Running create-virtualenv step. 23:19:28 INFO - ##### 23:19:28 INFO - Running pre-action listener: _resource_record_pre_action 23:19:28 INFO - Running main action method: create_virtualenv 23:19:28 INFO - Creating virtualenv /builds/slave/test/build/venv 23:19:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:19:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:19:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:19:28 INFO - Using real prefix '/usr' 23:19:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:19:29 INFO - Installing distribute.............................................................................................................................................................................................done. 23:19:31 INFO - Installing pip.................done. 23:19:31 INFO - Return code: 0 23:19:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:19:31 INFO - Using env: {'DISPLAY': ':0', 23:19:31 INFO - 'HOME': '/home/cltbld', 23:19:31 INFO - 'LANG': 'en_US.UTF-8', 23:19:31 INFO - 'LANGUAGE': 'en_US:en', 23:19:31 INFO - 'LOGNAME': 'cltbld', 23:19:31 INFO - 'MAIL': '/var/mail/cltbld', 23:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:31 INFO - 'MOZ_NO_REMOTE': '1', 23:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:31 INFO - 'NO_EM_RESTART': '1', 23:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:31 INFO - 'PWD': '/builds/slave/test', 23:19:31 INFO - 'SHELL': '/bin/bash', 23:19:31 INFO - 'SHLVL': '1', 23:19:31 INFO - 'TERM': 'linux', 23:19:31 INFO - 'TMOUT': '86400', 23:19:31 INFO - 'USER': 'cltbld', 23:19:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:31 INFO - '_': '/tools/buildbot/bin/python'} 23:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:19:31 INFO - Cleaning up... 23:19:31 INFO - Return code: 0 23:19:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:19:31 INFO - Using env: {'DISPLAY': ':0', 23:19:31 INFO - 'HOME': '/home/cltbld', 23:19:31 INFO - 'LANG': 'en_US.UTF-8', 23:19:31 INFO - 'LANGUAGE': 'en_US:en', 23:19:31 INFO - 'LOGNAME': 'cltbld', 23:19:31 INFO - 'MAIL': '/var/mail/cltbld', 23:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:31 INFO - 'MOZ_NO_REMOTE': '1', 23:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:31 INFO - 'NO_EM_RESTART': '1', 23:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:31 INFO - 'PWD': '/builds/slave/test', 23:19:31 INFO - 'SHELL': '/bin/bash', 23:19:31 INFO - 'SHLVL': '1', 23:19:31 INFO - 'TERM': 'linux', 23:19:31 INFO - 'TMOUT': '86400', 23:19:31 INFO - 'USER': 'cltbld', 23:19:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:31 INFO - '_': '/tools/buildbot/bin/python'} 23:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:31 INFO - Downloading/unpacking psutil>=3.1.1 23:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:19:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:33 INFO - Installing collected packages: psutil 23:19:33 INFO - Running setup.py install for psutil 23:19:33 INFO - building 'psutil._psutil_linux' extension 23:19:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:19:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:19:34 INFO - building 'psutil._psutil_posix' extension 23:19:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:19:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:34 INFO - Successfully installed psutil 23:19:34 INFO - Cleaning up... 23:19:34 INFO - Return code: 0 23:19:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:19:34 INFO - Using env: {'DISPLAY': ':0', 23:19:34 INFO - 'HOME': '/home/cltbld', 23:19:34 INFO - 'LANG': 'en_US.UTF-8', 23:19:34 INFO - 'LANGUAGE': 'en_US:en', 23:19:34 INFO - 'LOGNAME': 'cltbld', 23:19:34 INFO - 'MAIL': '/var/mail/cltbld', 23:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:34 INFO - 'MOZ_NO_REMOTE': '1', 23:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:34 INFO - 'NO_EM_RESTART': '1', 23:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:34 INFO - 'PWD': '/builds/slave/test', 23:19:34 INFO - 'SHELL': '/bin/bash', 23:19:34 INFO - 'SHLVL': '1', 23:19:34 INFO - 'TERM': 'linux', 23:19:34 INFO - 'TMOUT': '86400', 23:19:34 INFO - 'USER': 'cltbld', 23:19:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:34 INFO - '_': '/tools/buildbot/bin/python'} 23:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:19:36 INFO - Installing collected packages: mozsystemmonitor 23:19:36 INFO - Running setup.py install for mozsystemmonitor 23:19:36 INFO - Successfully installed mozsystemmonitor 23:19:36 INFO - Cleaning up... 23:19:36 INFO - Return code: 0 23:19:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:19: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')]} 23:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19: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')]} 23:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:19:36 INFO - Using env: {'DISPLAY': ':0', 23:19:36 INFO - 'HOME': '/home/cltbld', 23:19:36 INFO - 'LANG': 'en_US.UTF-8', 23:19:36 INFO - 'LANGUAGE': 'en_US:en', 23:19:36 INFO - 'LOGNAME': 'cltbld', 23:19:36 INFO - 'MAIL': '/var/mail/cltbld', 23:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:36 INFO - 'MOZ_NO_REMOTE': '1', 23:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:36 INFO - 'NO_EM_RESTART': '1', 23:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:36 INFO - 'PWD': '/builds/slave/test', 23:19:36 INFO - 'SHELL': '/bin/bash', 23:19:36 INFO - 'SHLVL': '1', 23:19:36 INFO - 'TERM': 'linux', 23:19:36 INFO - 'TMOUT': '86400', 23:19:36 INFO - 'USER': 'cltbld', 23:19:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:36 INFO - '_': '/tools/buildbot/bin/python'} 23:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:36 INFO - Downloading/unpacking blobuploader==1.2.4 23:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:38 INFO - Downloading blobuploader-1.2.4.tar.gz 23:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:19:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:19:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:39 INFO - Downloading docopt-0.6.1.tar.gz 23:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:19:39 INFO - Installing collected packages: blobuploader, requests, docopt 23:19:39 INFO - Running setup.py install for blobuploader 23:19:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:19:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:19:39 INFO - Running setup.py install for requests 23:19:39 INFO - Running setup.py install for docopt 23:19:40 INFO - Successfully installed blobuploader requests docopt 23:19:40 INFO - Cleaning up... 23:19:40 INFO - Return code: 0 23:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:19:40 INFO - Using env: {'DISPLAY': ':0', 23:19:40 INFO - 'HOME': '/home/cltbld', 23:19:40 INFO - 'LANG': 'en_US.UTF-8', 23:19:40 INFO - 'LANGUAGE': 'en_US:en', 23:19:40 INFO - 'LOGNAME': 'cltbld', 23:19:40 INFO - 'MAIL': '/var/mail/cltbld', 23:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:40 INFO - 'MOZ_NO_REMOTE': '1', 23:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:40 INFO - 'NO_EM_RESTART': '1', 23:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:40 INFO - 'PWD': '/builds/slave/test', 23:19:40 INFO - 'SHELL': '/bin/bash', 23:19:40 INFO - 'SHLVL': '1', 23:19:40 INFO - 'TERM': 'linux', 23:19:40 INFO - 'TMOUT': '86400', 23:19:40 INFO - 'USER': 'cltbld', 23:19:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:40 INFO - '_': '/tools/buildbot/bin/python'} 23:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:19:40 INFO - Running setup.py (path:/tmp/pip-pt5U5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:19:40 INFO - Running setup.py (path:/tmp/pip-oq4re1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:19:40 INFO - Running setup.py (path:/tmp/pip-2vLUEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:19:40 INFO - Running setup.py (path:/tmp/pip-7WX_oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:19:40 INFO - Running setup.py (path:/tmp/pip-uq8XQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:19:40 INFO - Running setup.py (path:/tmp/pip-1j5O3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:19:40 INFO - Running setup.py (path:/tmp/pip-FkkMSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:19:40 INFO - Running setup.py (path:/tmp/pip-kBnXxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:19:40 INFO - Running setup.py (path:/tmp/pip-TJ89kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:19:40 INFO - Running setup.py (path:/tmp/pip-Ph9mqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:19:41 INFO - Running setup.py (path:/tmp/pip-pP5CKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:19:41 INFO - Running setup.py (path:/tmp/pip-CBFBd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:19:41 INFO - Running setup.py (path:/tmp/pip-4Sqcfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:19:41 INFO - Running setup.py (path:/tmp/pip-d5Yll2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:41 INFO - Running setup.py (path:/tmp/pip-84xmNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:19:41 INFO - Running setup.py (path:/tmp/pip-_Tr_fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:19:41 INFO - Running setup.py (path:/tmp/pip-FHZ14d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:19:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:19:41 INFO - Running setup.py install for manifestparser 23:19:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:19:41 INFO - Running setup.py install for mozcrash 23:19:41 INFO - Running setup.py install for mozdebug 23:19:41 INFO - Running setup.py install for mozdevice 23:19:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:19:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:19:41 INFO - Running setup.py install for mozfile 23:19:42 INFO - Running setup.py install for mozhttpd 23:19:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Running setup.py install for mozinfo 23:19:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Running setup.py install for mozInstall 23:19:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Running setup.py install for mozleak 23:19:42 INFO - Running setup.py install for mozlog 23:19:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Running setup.py install for moznetwork 23:19:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Running setup.py install for mozprocess 23:19:42 INFO - Running setup.py install for mozprofile 23:19:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:19:42 INFO - Running setup.py install for mozrunner 23:19:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:19:43 INFO - Running setup.py install for mozscreenshot 23:19:43 INFO - Running setup.py install for moztest 23:19:43 INFO - Running setup.py install for mozversion 23:19:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:19:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:19:43 INFO - Cleaning up... 23:19:43 INFO - Return code: 0 23:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:19:43 INFO - Using env: {'DISPLAY': ':0', 23:19:43 INFO - 'HOME': '/home/cltbld', 23:19:43 INFO - 'LANG': 'en_US.UTF-8', 23:19:43 INFO - 'LANGUAGE': 'en_US:en', 23:19:43 INFO - 'LOGNAME': 'cltbld', 23:19:43 INFO - 'MAIL': '/var/mail/cltbld', 23:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:43 INFO - 'MOZ_NO_REMOTE': '1', 23:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:43 INFO - 'NO_EM_RESTART': '1', 23:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:43 INFO - 'PWD': '/builds/slave/test', 23:19:43 INFO - 'SHELL': '/bin/bash', 23:19:43 INFO - 'SHLVL': '1', 23:19:43 INFO - 'TERM': 'linux', 23:19:43 INFO - 'TMOUT': '86400', 23:19:43 INFO - 'USER': 'cltbld', 23:19:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:43 INFO - '_': '/tools/buildbot/bin/python'} 23:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:19:43 INFO - Running setup.py (path:/tmp/pip-J48qbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:19:43 INFO - Running setup.py (path:/tmp/pip-EeyrZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:19:43 INFO - Running setup.py (path:/tmp/pip-RgXWf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:19:43 INFO - Running setup.py (path:/tmp/pip-BGxNvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:19:43 INFO - Running setup.py (path:/tmp/pip-LgIQ45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:19:43 INFO - Running setup.py (path:/tmp/pip-FY4fTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:19:44 INFO - Running setup.py (path:/tmp/pip-H0yUBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:19:44 INFO - Running setup.py (path:/tmp/pip-Nd_f7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:19:44 INFO - Running setup.py (path:/tmp/pip-AEKsMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:19:44 INFO - Running setup.py (path:/tmp/pip-eHNvxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:19:44 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)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:19:44 INFO - Running setup.py (path:/tmp/pip-evB0XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:19:44 INFO - Running setup.py (path:/tmp/pip-q4HcZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:19:44 INFO - Running setup.py (path:/tmp/pip-6NNdX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:19:44 INFO - Running setup.py (path:/tmp/pip-Hx6CzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:44 INFO - Running setup.py (path:/tmp/pip-tBoHKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:19:44 INFO - Running setup.py (path:/tmp/pip-9WtBf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:19:44 INFO - Running setup.py (path:/tmp/pip-v1chcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:19:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:46 INFO - Downloading blessings-1.6.tar.gz 23:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:19:46 INFO - Installing collected packages: blessings 23:19:46 INFO - Running setup.py install for blessings 23:19:46 INFO - Successfully installed blessings 23:19:46 INFO - Cleaning up... 23:19:46 INFO - Return code: 0 23:19:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:19:47 INFO - Reading from file tmpfile_stdout 23:19:47 INFO - Current package versions: 23:19:47 INFO - argparse == 1.2.1 23:19:47 INFO - blessings == 1.6 23:19:47 INFO - blobuploader == 1.2.4 23:19:47 INFO - docopt == 0.6.1 23:19:47 INFO - manifestparser == 1.1 23:19:47 INFO - mozInstall == 1.12 23:19:47 INFO - mozcrash == 0.17 23:19:47 INFO - mozdebug == 0.1 23:19:47 INFO - mozdevice == 0.48 23:19:47 INFO - mozfile == 1.2 23:19:47 INFO - mozhttpd == 0.7 23:19:47 INFO - mozinfo == 0.9 23:19:47 INFO - mozleak == 0.1 23:19:47 INFO - mozlog == 3.2 23:19:47 INFO - moznetwork == 0.27 23:19:47 INFO - mozprocess == 0.22 23:19:47 INFO - mozprofile == 0.28 23:19:47 INFO - mozrunner == 6.11 23:19:47 INFO - mozscreenshot == 0.1 23:19:47 INFO - mozsystemmonitor == 0.3 23:19:47 INFO - moztest == 0.7 23:19:47 INFO - mozversion == 1.4 23:19:47 INFO - psutil == 3.1.1 23:19:47 INFO - requests == 1.2.3 23:19:47 INFO - wsgiref == 0.1.2 23:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:19:47 INFO - Using env: {'DISPLAY': ':0', 23:19:47 INFO - 'HOME': '/home/cltbld', 23:19:47 INFO - 'LANG': 'en_US.UTF-8', 23:19:47 INFO - 'LANGUAGE': 'en_US:en', 23:19:47 INFO - 'LOGNAME': 'cltbld', 23:19:47 INFO - 'MAIL': '/var/mail/cltbld', 23:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:47 INFO - 'MOZ_NO_REMOTE': '1', 23:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:47 INFO - 'NO_EM_RESTART': '1', 23:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:47 INFO - 'PWD': '/builds/slave/test', 23:19:47 INFO - 'SHELL': '/bin/bash', 23:19:47 INFO - 'SHLVL': '1', 23:19:47 INFO - 'TERM': 'linux', 23:19:47 INFO - 'TMOUT': '86400', 23:19:47 INFO - 'USER': 'cltbld', 23:19:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:47 INFO - '_': '/tools/buildbot/bin/python'} 23:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:19:47 INFO - Cleaning up... 23:19:47 INFO - Return code: 0 23:19:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:19:47 INFO - Using env: {'DISPLAY': ':0', 23:19:47 INFO - 'HOME': '/home/cltbld', 23:19:47 INFO - 'LANG': 'en_US.UTF-8', 23:19:47 INFO - 'LANGUAGE': 'en_US:en', 23:19:47 INFO - 'LOGNAME': 'cltbld', 23:19:47 INFO - 'MAIL': '/var/mail/cltbld', 23:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:47 INFO - 'MOZ_NO_REMOTE': '1', 23:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:47 INFO - 'NO_EM_RESTART': '1', 23:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:47 INFO - 'PWD': '/builds/slave/test', 23:19:47 INFO - 'SHELL': '/bin/bash', 23:19:47 INFO - 'SHLVL': '1', 23:19:47 INFO - 'TERM': 'linux', 23:19:47 INFO - 'TMOUT': '86400', 23:19:47 INFO - 'USER': 'cltbld', 23:19:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:47 INFO - '_': '/tools/buildbot/bin/python'} 23:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:47 INFO - Downloading/unpacking jsonschema 23:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:19:49 INFO - Downloading/unpacking functools32 (from jsonschema) 23:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:49 INFO - Downloading functools32-3.2.3-2.tar.gz 23:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:19:49 INFO - warning: no files found matching '*.txt' 23:19:49 INFO - no previously-included directories found matching 'build' 23:19:49 INFO - no previously-included directories found matching 'dist' 23:19:49 INFO - no previously-included directories found matching '.git*' 23:19:49 INFO - Installing collected packages: jsonschema, functools32 23:19:49 INFO - Running setup.py install for functools32 23:19:49 INFO - warning: no files found matching '*.txt' 23:19:49 INFO - no previously-included directories found matching 'build' 23:19:49 INFO - no previously-included directories found matching 'dist' 23:19:49 INFO - no previously-included directories found matching '.git*' 23:19:49 INFO - Successfully installed jsonschema functools32 23:19:49 INFO - Cleaning up... 23:19:50 INFO - Return code: 0 23:19:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:19:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f6372cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, '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': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', '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 23:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:19:50 INFO - Using env: {'DISPLAY': ':0', 23:19:50 INFO - 'HOME': '/home/cltbld', 23:19:50 INFO - 'LANG': 'en_US.UTF-8', 23:19:50 INFO - 'LANGUAGE': 'en_US:en', 23:19:50 INFO - 'LOGNAME': 'cltbld', 23:19:50 INFO - 'MAIL': '/var/mail/cltbld', 23:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:50 INFO - 'MOZ_NO_REMOTE': '1', 23:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:50 INFO - 'NO_EM_RESTART': '1', 23:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:50 INFO - 'PWD': '/builds/slave/test', 23:19:50 INFO - 'SHELL': '/bin/bash', 23:19:50 INFO - 'SHLVL': '1', 23:19:50 INFO - 'TERM': 'linux', 23:19:50 INFO - 'TMOUT': '86400', 23:19:50 INFO - 'USER': 'cltbld', 23:19:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:50 INFO - '_': '/tools/buildbot/bin/python'} 23:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:50 INFO - Downloading/unpacking flake8 23:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:19:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:19:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:19:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:19:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:19:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:19:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:19:52 INFO - no previously-included directories found matching 'docs/_build' 23:19:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:19:52 INFO - Running setup.py install for pep8 23:19:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:19:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:19:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:19:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:19:52 INFO - no previously-included directories found matching 'docs/_build' 23:19:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:19:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:19:53 INFO - Cleaning up... 23:19:53 INFO - Return code: 0 23:19:53 INFO - Running post-action listener: _resource_record_post_action 23:19:53 INFO - Running post-action listener: _start_resource_monitoring 23:19:53 INFO - Starting resource monitoring. 23:19:53 INFO - ##### 23:19:53 INFO - ##### Finished create-virtualenv step (success) 23:19:53 INFO - ##### 23:19:53 INFO - ##### 23:19:53 INFO - ##### Running install step. 23:19:53 INFO - ##### 23:19:53 INFO - Running pre-action listener: _resource_record_pre_action 23:19:53 INFO - Running main action method: install 23:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:19:53 INFO - Reading from file tmpfile_stdout 23:19:53 INFO - Detecting whether we're running mozinstall >=1.0... 23:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:19:53 INFO - Reading from file tmpfile_stdout 23:19:53 INFO - Output received: 23:19:53 INFO - Usage: mozinstall [options] installer 23:19:53 INFO - Options: 23:19:53 INFO - -h, --help show this help message and exit 23:19:53 INFO - -d DEST, --destination=DEST 23:19:53 INFO - Directory to install application into. [default: 23:19:53 INFO - "/builds/slave/test"] 23:19:53 INFO - --app=APP Application being installed. [default: firefox] 23:19:53 INFO - mkdir: /builds/slave/test/build/application 23:19:53 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'] 23:19:53 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 23:20:10 INFO - Reading from file tmpfile_stdout 23:20:10 INFO - Output received: 23:20:10 INFO - /builds/slave/test/build/application/firefox/firefox 23:20:10 INFO - Running post-action listener: _resource_record_post_action 23:20:10 INFO - ##### 23:20:10 INFO - ##### Finished install step (success) 23:20:10 INFO - ##### 23:20:10 INFO - ##### 23:20:10 INFO - ##### Running run-tests step. 23:20:10 INFO - ##### 23:20:10 INFO - Running pre-action listener: _resource_record_pre_action 23:20:10 INFO - Running main action method: run_tests 23:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:20:10 INFO - Python 2.7.3 23:20:10 INFO - Return code: 0 23:20:10 INFO - grabbing minidump binary from tooltool 23:20:10 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')]} 23:20:10 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 0x108c9c0>, '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 0x108d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:20:10 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 23:20:10 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 23:20:10 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 23:20:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:20:10 INFO - Return code: 0 23:20:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:20:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:20:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:20:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:20:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:20:11 INFO - Return code: 0 23:20:11 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/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 23:20:11 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/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 23:20:11 INFO - Using env: {'DISPLAY': ':0', 23:20:11 INFO - 'HOME': '/home/cltbld', 23:20:11 INFO - 'LANG': 'en_US.UTF-8', 23:20:11 INFO - 'LANGUAGE': 'en_US:en', 23:20:11 INFO - 'LOGNAME': 'cltbld', 23:20:11 INFO - 'MAIL': '/var/mail/cltbld', 23:20:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:20:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:11 INFO - 'MOZ_NO_REMOTE': '1', 23:20:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:11 INFO - 'NO_EM_RESTART': '1', 23:20:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:11 INFO - 'PWD': '/builds/slave/test', 23:20:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:20:11 INFO - 'SHELL': '/bin/bash', 23:20:11 INFO - 'SHLVL': '1', 23:20:11 INFO - 'TERM': 'linux', 23:20:11 INFO - 'TMOUT': '86400', 23:20:11 INFO - 'USER': 'cltbld', 23:20:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029', 23:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:11 INFO - '_': '/tools/buildbot/bin/python'} 23:20:11 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/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 23:20:11 INFO - mozversion application_buildid: 20160520203038 23:20:11 INFO - mozversion application_changeset: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 23:20:11 INFO - mozversion application_display_name: Nightly 23:20:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:20:11 INFO - mozversion application_name: Firefox 23:20:11 INFO - mozversion application_remotingname: firefox 23:20:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:20:11 INFO - mozversion application_vendor: Mozilla 23:20:11 INFO - mozversion application_version: 49.0a1 23:20:11 INFO - mozversion platform_buildid: 20160520203038 23:20:11 INFO - mozversion platform_changeset: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 23:20:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:20:11 INFO - mozversion platform_version: 49.0a1 23:20:11 INFO - using testdate: 1463811611 23:20:11 INFO - actual date: 1463811611 23:20:11 INFO - starting webserver on 'localhost:45013' 23:20:11 INFO - SUITE-START | Running 2 tests 23:20:11 INFO - TEST-START | dromaeo_css 23:20:11 INFO - operating with platform_type : linux_ 23:20:11 INFO - Initialising browser for dromaeo_css test... 23:20:11 INFO - TEST-INFO | started process 15361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSUSzr/profile http://localhost:45013/getInfo.html) 23:20:14 INFO - PROCESS | 15361 | 23:20:14 INFO - PROCESS | 15361 | (process:15428): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:20:15 INFO - PROCESS | 15361 | __metrics Screen width/height:1600/1200 23:20:15 INFO - PROCESS | 15361 | colorDepth:24 23:20:15 INFO - PROCESS | 15361 | Browser inner width/height: 1024/697 23:20:15 INFO - PROCESS | 15361 | __metrics 23:20:16 ERROR - PROCESS | 15361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:20:17 INFO - TEST-INFO | 15361: exit 0 23:20:17 INFO - Browser initialized. 23:20:17 INFO - Running cycle 1/1 for dromaeo_css test... 23:20:17 INFO - TEST-INFO | started process 15479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSUSzr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:18 INFO - PROCESS | 15479 | 23:20:18 INFO - PROCESS | 15479 | (process:15539): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:20:28 INFO - PROCESS | 15479 | RSS: Main: 164274176 23:20:28 INFO - PROCESS | 15479 | 23:21:18 INFO - PROCESS | 15479 | 1463811678502 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] 23:23:26 INFO - PROCESS | 15479 | Cycle 1(1): loaded http://localhost:45013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45013/tests/dromaeo/cssquery-ext.html) 23:23:27 INFO - PROCESS | 15479 | RSS: Main: 167325696 23:23:27 INFO - PROCESS | 15479 | 23:26:29 INFO - PROCESS | 15479 | Cycle 1(1): loaded http://localhost:45013/tests/dromaeo/cssquery-ext.html (next: http://localhost:45013/tests/dromaeo/cssquery-jquery.html) 23:26:30 INFO - PROCESS | 15479 | RSS: Main: 167104512 23:26:30 INFO - PROCESS | 15479 | 23:29:32 INFO - PROCESS | 15479 | Cycle 1(1): loaded http://localhost:45013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45013/tests/dromaeo/cssquery-mootools.html) 23:29:32 INFO - PROCESS | 15479 | RSS: Main: 168148992 23:29:32 INFO - PROCESS | 15479 | 23:32:34 INFO - PROCESS | 15479 | Cycle 1(1): loaded http://localhost:45013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45013/tests/dromaeo/cssquery-prototype.html) 23:32:35 INFO - PROCESS | 15479 | RSS: Main: 165482496 23:32:35 INFO - PROCESS | 15479 | 23:35:37 INFO - PROCESS | 15479 | Cycle 1(1): loaded http://localhost:45013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45013/tests/dromaeo/cssquery-yui.html) 23:35:38 INFO - PROCESS | 15479 | RSS: Main: 166797312 23:35:38 INFO - PROCESS | 15479 | 23:38:40 INFO - PROCESS | 15479 | Cycle 1(1): loaded http://localhost:45013/tests/dromaeo/cssquery-yui.html (next: http://localhost:45013/tests/dromaeo/cssquery-dojo.html) 23:38:41 INFO - PROCESS | 15479 | RSS: Main: 169062400 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | __start_tp_report 23:38:41 INFO - PROCESS | 15479 | _x_x_mozilla_page_load 23:38:41 INFO - PROCESS | 15479 | _x_x_mozilla_page_load_details 23:38:41 INFO - PROCESS | 15479 | |i|pagename|runs| 23:38:41 INFO - PROCESS | 15479 | |0;dojo.html;3167.572377729007;3184.729298009669;3191.8084914905094;3210.48632218845;3228.2897762492244;5506.72466376681;5583.022970980082;5583.748731307091;5669.546436285098;5675.716214189284;5487.6158668893195;5534.446555344463;5546.889062218764;5547.278853749017;5628.099504079348;4959.727215003173;4982.227754698028;5116.872078198037;5152.278680984665;5200.349956255468;960.3382417809319;4910.656254062217;4961.603071754269;5041.571466425358;5044.293798868143;4996.3504744383;5009.4239162496415;5021.522955319257;5056.696598204119;5062.215356619711;5056.115179843513;5060.3927528696795;5063.518965698253;5084.211947148198;5087.262346959707;4905.288733133676;4927.384076990376;4963.478834722375;4986.5013498650205;5000.699958002495;5335.839924802262;5406.810761623364;5427.0773968425465;5435.374931882805;5451.781928722847;5677.37548869624;5839.503642190419;5900;5919.437653422918;5920.141579470953;5923.022701254288;5936.22829032223;5940.851478713023;5986.580939334249;6066.8786624267705;5584.553235741171;5589.524890384322;5589.888202235973;5589.972050139723;5595.048841696921;5907.320658124285;5960.5827592068135;6010.849728756816;6078.908816367758;6083.330833608299;5727.854429114193;5728.398518155534;5728.828135155952;5748.5688573357165;5761.625494342854;5858.150568167592;5897.852553686106;5901.17383566301;5905.557083218776;5915.024021036566;5821.767129314865;5840.182374467578;5872.442117998783;5874;5910.763569457259;5871.853203669857;5876.529877609781;5878.118282257696;5894.17481552583;5907.320658124285;4381.496127945264;4420.31485119807;4445.711028783118;4455.710378825366;4500.392447019676;3879.4374815652136;3966.127451960564;3994.2610617035944;4020.0954785173685;4027.859024934113;5492.725363731797;5586.217929489874;5615.8876822464135;5645.350784659735;5661.037623603997;5848.356680765112;5962.25471816023;5962.582619216613;5968.253968253968;5990.460858522754;5648.943510564924;5713.971430142823;5714.828555143353;5734.340550836624;5753.827385178452;5071.112555302807;5110.029094472038;5115.7442127893455;5182.481751824787;5203.505666961632;5975.894459525001;6100.611450805989;6134.786178072973;6198.876022479525;6245.906311405332;6019.247594050831;6092.256723849718;6103.974138059404;6105.490073363355;6110.036353870931;6269.4984401246875;6272.968635156795;6280.403361680633;6280.9685951569945;6292.433680968735;5670.262865827416;5781.797637082682;5839.649621022582;5960.135780311917;5976.521878249817;5927.733252003756;5968.731407086779;6029.125776762433;6033.155358249936;6080.209572755513;5832.941670583409;5855.975204339309;5864.853378665567;5866.50134738552;5896.970515147397;5567.468946039871;5693.658380497183;5753.338366087954;5771.59598828078;5820.82537523875;5687.914681279702;5702.657840529581;5702.8289151325525;5710.743016564182;5726.656400615976;5763.452472015152;5814.709264536841;5818.9127163093435;5843.328017278068;5852.209951656642;5567.610267281251;5700.030994730822;5737.110747834093;5783.450572195635;5797.4782269595935 23:38:41 INFO - PROCESS | 15479 | |1;ext.html;586.4340911020864;633.180031858743;643.5398689936698;655.2955572759284;660;30182.698173018263;43011.78494107529;43854.78072609632;43910;43930.56069439305;42445.151096978116;42915.14169716604;42995.35506967398;46269.76865115669;46351;8740.21338079571;8972.192502674758;9023.142801433853;9026.729198124067;9028.413153145057;8851.690190843321;8952.104789521061;9008.0541543138;9021.729348119567;9034.774130646754;8924.732258032269;9003.144701253403;9036;9078.954605226998;9100.044495327995;8925.285977121846;9011.18899299063;9020.458772473672;9031.683891063814;9040.186383225475;8810.251128654072;8944.463332200088;8962.820743585156;8967.775805604846;8978.057303983052;41582.58417415847;41901.79049104766;42020;42072.78963605193;42161;3396.5075064115813;3522.5244591980013;3537.7877327360443;3543.6102028777073;4191.140816132716;32121;32548.83725581357;33053.504197437054;33060.17349566256;33208.6679133208;4369.410129632491;4442.0893716788305;4455.287154055368;4510.774461276923;4531.410916580823;311276;312726;313691;314569;315625;60245;60862;61132.69433652892;61245.69377153175;61345;64201.67899160568;64296;64422;64520.67739661365;64704.35295646983;17444.91277543604;17576.824231757775;17599.296028158988;17616.823831761518;17694.91152544229;12485.188462749893;12547.560835370718;12574.245545267131;12587;12606.49574017029;17423.78735545874;19442.19465051454;19483.14092811896;19598.118084686223;19615.31346402869;3300.93398132036;3334.4817771919184;7366.7053317866685;7424.925750742424;7535.698572057166;955.8709574207393;984.2322988069318;1040.1159014837328;1071.8017166824163;1072.1851392941421;31919.68080319167;32005;32372.514412283836;32526.83736581302;33114.17214569655;1150.9079273658087;1164.470166074434;1173.8239264110282;1236.202649291202;1238.1147479552164;17347.392841250497;17578.560535986446;17615.911920440314;17638.470845874643;17652.558686032953;493407;493888;496789;496901;497816;57132.42867571354;58756.18084824473;58828.41171588315;58834.11748823771;59035.70482147648;1345.663584103974;1358.1443690474937;1373.9106958047496;1378.8621137886332;1386.4384924105752;30913.536296956012;32151.678483215805;32256.838715806272;32424.02727918166;32771.672283276865;52924;52966;53103;53178.4682153189;53258;428746;428938;430456;433854;436646;26758.331041724112;27549.72450275552;27682.861585691942;28350.432991339647;28820.711792881804;45722.08555828931;46613.766931165126;46637.53362466468;47429.28856067231;47911;38860;39165.804170980104;39957;40462.59537404706;40541.39187912125;37795.62204377921;38203.617963820005;39395;39411.60588394194;40410.797946011255;39057.6094239054;39850.800745996086;39902.60097399105;40134.397984030846;40233.195336092525;34193.48709769405;35426.82286588551;35460.46809297811;35571.466428003085;35674.28651427009;27601.72398276072;27731;27745.167644970683;27888.023919162733;27947.860260698566 23:38:41 INFO - PROCESS | 15479 | |2;jquery.html;389.3867159224222;391.24099247459924;396.68661757211805;398.70495833083515;413.56782162640036;13878;17625.82374176258;18449.90775046123;19208.51978700533;19236.71144932827;10956.890431095686;11552.884471155287;11624.128190385713;18103;18314.908425457856;4941.654084214107;5069.995461640898;5077.771500282496;5098.719570423626;5109.156989096795;5027.597792176635;5170.767315470813;5171.922421163686;5173.741312934357;5176.223566465042;5127.179651255799;5137.845864624067;5147.81982630608;5152.74236288186;5166.974165129169;4955.628327875405;5139.974300128494;5154.690718556899;5184.896302073975;5192.091384007784;5017.34774479319;5029.1450453423;5030.547250747413;5031.547160755549;5041.72270525121;13236.536721214807;15987.92006039974;20300.695489567668;21222.681659775117;21325.466863328387;2067.1421360135528;2081.843861710378;2154.5583155453096;2187.726534183227;2210.0877564124885;9254.907450925471;9568.61725530985;9833.115019648267;9860.689158938285;9916;1867.9906600467048;1918.4436513411233;1929.7105434184843;1955.6186543623858;1962.7644682638174;81955.59022204911;85226.5738671309;86525.56737216336;86799.56600216958;87219.56390218071;10471.895281047093;10757.892421075689;11001.284916480403;11056.613018544313;11123.610673626546;13713.17720936747;14202.573922782332;14613.342399592044;14619.634509137144;14643.780343294859;8044.316233120133;8263.793405164799;8366.958165209257;8506.447080939719;8528.914710852812;7990.12108668046;8094.757157285291;8123.984501937258;8222;8246.546439945741;4566.383538222364;4704.811807527661;4705.317728929286;4867.878303042452;4906.411230652345;1793.3006127610242;1800.612868233336;1828.7622609061002;1877.474307193988;1945.309415157627;424.87678573213424;427.38883396742335;432.1335721877615;433.4148898986343;1014.3862962907482;10849.457527123612;11229.27009744364;11321.603743868925;11454.770904582028;11466.827997580043;442.5309172277396;443.9223135951196;445.36757803918516;449.97405914514957;450.9549045095464;6080.543959203077;6089.969550152309;6207.844803879939;6224.972879474836;6270.968645156745;483258;487657;509828;513281;515285;92326;92526;93184.53407732918;93694.99999999863;94950.52524737333;440.4472387154101;456.5366153354348;457.93131030345717;458.87380970233454;459.1482799407052;10477.580896764044;10628.36229826213;10846.891531084904;10898.618548350769;10930.890691092987;36641.633583663825;37887;38241.235175295784;38941.6105838938;39819;53581.19628205502;54893.1766023502;55848;55939.44060559342;56211.43788562062;7660.808479787827;7998.5600791957;8110.107888132418;8129.715459958873;8263.173682631688;8801.207891289814;12480.313582753035;13250.536231232247;13391.196528208338;13407.262600557064;11424.371659558805;11830.17188796776;11896.22674526153;12004.879951200377;12091.879081209427;11680.357580333164;11883.881161188623;12021.218620789621;12375.938120309702;12387.07096967749;9387.73265609134;11868.58459953932;11965.401729913296;12461.1900226485;12524.37378131108;8549;8597.828043439222;8664.610092545725;8711.346649001476;8754;11724.70688232801;11907.82138267944;11940.940295298467;12144.39278036077;12259.325737084546 23:38:41 INFO - PROCESS | 15479 | |3;mootools.html;1529.3423827754066;1544.5366390082972;1676.7401052836815;1803;1840.9355672551462;7891.565963871984;8459.788505287372;8554.05905350411;9094.86357704635;9130;8537.231649151576;8893.68872089477;8927.107289271069;8928.776780580472;8965.417247878884;2350.435895385108;2371.5138396628736;2397.3407312988893;2405.1461731085474;2405.278416475059;2322.8257880658934;2373.750756170603;2375.6674065630827;2381.880905954704;2382.4877651304964;2314.190033488274;2325.6976593042964;2338.894749736266;2379.726331471877;2380.0836677879056;2311.976880231193;2333.9533209335887;2339.777721116491;2356.658284548731;2358.3750306168877;2297.655351697242;2307.0195167054103;2312.387217387394;2319.1651005637955;2339.087755775249;8778.824423511558;8871.955640221822;8873.911260887438;8878.24534914533;8901.821963560757;5279.313689220377;5316.627836051478;5356.437574054746;5356.839294821161;5378.0857254266475;3298.241404476984;3385.8814941477176;3395.439752440844;3544.2734239480847;3556.6443355664487;1108.9611863584817;1113.582406597526;1115.7154925494028;1119.1326721790597;1142.2289954280827;12437.253764774052;12468.501259949591;12490.375481225903;12512.562060327937;12518.37408129599;4544.2501987171745;4548.863534093983;4657.46439159501;4680.438347398334;4696.459907110658;10429.947850260853;10430.582776689;10527.21045921559;10542.841857372145;10554.261201715806;5278.498542638443;5282.181261904411;5324.068288049576;5347.919781203285;5352.2506849041165;4325.891852703708;4772.570468657837;4898.853034408973;4934.383202099738;4953.18272485036;3994.7403418777685;4013.2174226026227;4086.59134086589;4092.529359123679;4118.711690181718;1257.0886107571937;1272.1794442584667;1272.9872701273055;1276.4894042382934;1282.4229096906242;840.3613253926937;857.9485230886166;903.6520939438363;945.8770359853175;974.541965276319;5819.79630712923;5914.112883067574;5924.881502369928;5977.701114944235;6225.750969961241;953.3564843730454;959.9088086631759;981.2395393569898;988.619381538113;1008.8839783425;3952.9209415811524;4011.538673052636;4056.8985775355263;4094.7543147410656;4182.121754431542;10888.183386245904;11215.383153926448;11260.324380537195;11265.324080555192;11358.60244891425;11203.663890083311;11288.0969522438;11295.774084518263;11353.318800871974;11383.203175777617;7988.680452781824;8110.391720620977;8279.710210142615;8345.248927596545;8357.12250213731;5579.916301255404;5759.1649210865025;5828.125781132864;5900.468957793819;5911.704414779329;10320.12278956297;10325.122364599094;10405.895941040493;10406.635767748396;10413.114885234538;9929.553170107218;10288.588456461657;10626.415547144981;10698.090662293482;10703.785924281627;7272.781816545512;7655.846883062419;7710.575918324322;7921.366290696616;8103.918960810553;8737.301015918583;8758.518281494324;8776.122387761428;8792.736217913473;8871.157240062184;7469.887951680837;7665.540067595962;7721.498102623312;7727.034120734908;8048.436609437284;7252.347288744038;7438.40492760567;7448.664810083667;7629.580373079534;7645.426593005658;6486.254080780771;6556;6559.048937903882;6591.6045037296;6622.10601568782;4832.63755218353;4909.649846292298;5102.948970510248;5105.33630628016;5110.080185566634;5022.0960227158;5099.974500127476;5100.132977393778;5142.51146141116;5148.871278218075 23:38:41 INFO - PROCESS | 15479 | |4;prototype.html;312.7201154966305;313.0733030230519;315.3346439013682;331.93527262183875;332.89513803152005;5522.502974732273;5591.384947655754;5592.552595792337;5611.551075913927;5658.179563963223;5527.917081243774;5545.89256082688;5562.193481945115;5599.524040456566;5620.976448478545;4138.710290279681;4166.83332666693;4287.078278170193;4304.966807966097;4307.138572285539;4285.764282964436;4300.462442194726;4302.505211900624;4318.805653745589;4322.7406355618605;4214.5459816363455;4261.936070958938;4277.101808620194;4280.101178752466;4320.697551171419;4029;4258.6380157686635;4275.551067137968;4294.076773493683;4302.20409224293;3670.9816450917842;3692.907677308062;3693.445983102556;3694.6305369463107;3734.290484807878;5333.493318134771;5365.570754339683;5395.676259424447;5431.266778984866;5455.008921743574;4671.789769460348;4913.287573301851;4915.557599815998;4936.580390666798;5004.624653151028;5768;5823.737931793079;5839.562032847511;5871.091895134098;5875.855312810836;4137.565555616647;4142.399352093959;4143.81352839123;4151.232022075896;4153.937690934638;5873.794417195378;6035.185249991283;6081.6351018939;6135.110408990671;6142.8771424571705;4132.772697501667;4139.91720165595;4182.979085104555;4204.285271503852;4207.326827707552;4237.533871274158;4252.659787217015;4264.722793018444;4271.6369108625495;4274.230638485041;4593.885152871205;4877.439094504178;4882.780274887638;4920.745209971435;4922.138625740481;5777.6822274775295;5786;5806.44838740319;5849.830033993218;5931.377205393458;1461.6126726417294;1470.1620076556474;1485.9182744949132;1489.7262840271628;1489.925503724831;900.7658008917729;925.8194652042787;948.4498990585444;980.9362391444533;1003.4029752297372;5465.562754979592;5478.890422191534;5531.340597820637;5537.667739935617;5607.299087614048;5848.444397782289;5911.408859114054;5912.76348946046;5943.435373639497;5956.195913551615;5413.431589683027;5535.6955367455175;5541.224228607998;5566.777328906798;5575.665460072409;3114.76639252057;3134.2321131322974;3138.356636889432;3149.4173577887705;3167.7782555220915;5834.883302333929;6010.699465026732;6018.759249629966;6051.609614202365;6062.454379105901;5938.28740551128;5953.28560572734;6014.218151640259;6026.819195424145;6107.664078475637;6157.261128664589;6181.320054793969;6191.16419283409;6221.693444376641;6238.500919926486;5775.94224057754;5892.35184129754;5901.085331773582;5921.7631294747725;5935.554833387427;5842.5325973921135;5877.4122587740885;5890.852728681817;5917.260342457193;5930.7924222652;5839.532837373085;6043.8186854394435;6078.574499784972;6116.969415152896;6139.938600613937;4150.79246037703;4159.646430053479;4180.8118634660905;4187.539370669285;4201.836054432031;5888.146218798164;5928.9407105928385;5954.910676339771;5959.880802383841;6000.369961154016;5588.944110558842;5812.73842677089;5816.680082595498;5847.06446968483;5882.970585147047;5761.48146666802;5777.884442311214;5785.82642520725;5787.710614469175;5798.246227990334;5473.781048758005;5572.60991730575;5678.403767604507;5702.429757024264;5753.741081651252;5793.652380857162;5825.077724350869;5883.382244864228;5884.117382392676;5884.764609415575;5553.72231388437;5802.332731735735;5811.418858114154;5824.854378640568;5826.300843898759 23:38:41 INFO - PROCESS | 15479 | |5;yui.html;816.3306089007015;831.2145022953312;841.9213280117549;854.3336197765741;866.670665147244;12704.237745735263;13979.580612581625;14460.92769536152;14681.92659036706;15078.924605376958;14417.567472975801;14990.250487475638;15027.94804363695;15072.095674259552;15115.093094414342;811.736185739634;814.6578437056451;819.4509678515409;821.4947807098621;825.0717942314895;815.339574944297;816.8325493273865;817.5585184000632;819.1521774962914;821.757581513455;860.6041221038298;863.2058506174303;865.8614621660536;867.6139118092451;870.4342177584589;851.0298259983624;855.2260204514862;857.7126662568016;863.809961808398;866.3199388480044;612.3845535237102;620.0203678188451;620.996895015522;622.9439350458435;629.3077614623922;13748.243846588433;13868.861311386858;13871.722565548633;13882.51411200603;13885.097468664504;13821.79267310991;14184.21986790726;14390.424383024667;14554.12675239489;14596.781048284285;11717.414129293502;11827.586034488751;11883.702907427383;11921.523139074427;11996.400179990966;3794.867179648699;3863.16941857502;3895.7662540247393;3913.4325522799318;3959.940600890989;54610.72694636541;54674.72662636701;56075.15887261694;56281.15578266329;56295.155572666445;10690.73273168177;10770.730731731614;10925.562977480811;10949.781004379867;11072.114230861513;20085.196592136443;20107.59784804325;20134.395968120978;20147;20156.89921550383;7695.153533111354;7774.961125194338;7974.561399123104;8036.357091432671;8367.246947774607;4695.694779839299;4735.455422626374;4765.618750500021;4778.402699662543;4803.951960480351;3322.684344987222;3409.232922592397;3419.46998215277;3422.57217847769;3430.622631510532;589.7640943622586;598.4314900844215;614.2536817766346;620.7858288890326;631.9146915166485;655.944244739193;769.103993847173;797.7008621766837;798.1778767869104;808.9878651820227;9638.75903102414;10105.949470252748;10166.339187952908;10318.122959548373;10366.326188797855;534.3371190489219;673.4982438083659;679.6179391233793;684.5071548485083;730.4412124724483;4689.929651055237;4761.547652972962;4809.2305231162845;4824.037990165733;4904.8038078477175;63196.68033196643;63378.68310658417;66666.66666666635;66690.66654666793;67051.66474167598;56826.43173568211;57316;58289.41710582925;58683.70658146682;59211.40788592145;53666.19500707492;53874.46125538773;53947.73026134923;54077;54561.181582276295;9358.532073396167;9585.424874507551;9617.807643847224;9726.562304696165;9736.513174341397;31143.377132457677;35853.462198066525;35930.8203458981;36860.81569592135;38337.808310958266;46569;46602.300965484865;46998.765006176116;47233.763831182;48134.03731925272;12114;12411.255324680547;12493.75012499763;12845.357732113544;12995.675108121994;13620.114692544952;14108.506202282872;14268.928655356656;14460.710785784015;14714.558563242692;13069.281189534286;13400.396982135633;13495.662608434868;13759;13832.446702131801;12564.685882853002;13054.608361749162;13162.14446061003;13190.538331158747;13244.470221191044;13036.348182590642;13053.178879846992;13067.738645227233;13406.195628262336;13770.793438098237;10997.945010274898;11058.447077645924;11112.944435277772;11176;11505.137114716263;11182.66452006441;11607.76784464323;11745.647630571097;11763.470643820878;11863.466144023367 23:38:41 INFO - PROCESS | 15479 | __end_tp_report 23:38:41 INFO - PROCESS | 15479 | __start_cc_report 23:38:41 INFO - PROCESS | 15479 | _x_x_mozilla_cycle_collect,340 23:38:41 INFO - PROCESS | 15479 | __end_cc_report 23:38:41 INFO - PROCESS | 15479 | __startTimestamp1463812721137__endTimestamp 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | ------- Summary: start ------- 23:38:41 INFO - PROCESS | 15479 | Number of tests: 6 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | [#0] dojo.html Cycles:165 Average:5481.16 Median:5726.66 stddev:733.51 (12.8%) stddev-sans-first:712.95 23:38:41 INFO - PROCESS | 15479 | Values: 3167.6 3184.7 3191.8 3210.5 3228.3 5506.7 5583.0 5583.7 5669.5 5675.7 5487.6 5534.4 5546.9 5547.3 5628.1 4959.7 4982.2 5116.9 5152.3 5200.3 960.3 4910.7 4961.6 5041.6 5044.3 4996.4 5009.4 5021.5 5056.7 5062.2 5056.1 5060.4 5063.5 5084.2 5087.3 4905.3 4927.4 4963.5 4986.5 5000.7 5335.8 5406.8 5427.1 5435.4 5451.8 5677.4 5839.5 5900.0 5919.4 5920.1 5923.0 5936.2 5940.9 5986.6 6066.9 5584.6 5589.5 5589.9 5590.0 5595.0 5907.3 5960.6 6010.8 6078.9 6083.3 5727.9 5728.4 5728.8 5748.6 5761.6 5858.2 5897.9 5901.2 5905.6 5915.0 5821.8 5840.2 5872.4 5874.0 5910.8 5871.9 5876.5 5878.1 5894.2 5907.3 4381.5 4420.3 4445.7 4455.7 4500.4 3879.4 3966.1 3994.3 4020.1 4027.9 5492.7 5586.2 5615.9 5645.4 5661.0 5848.4 5962.3 5962.6 5968.3 5990.5 5648.9 5714.0 5714.8 5734.3 5753.8 5071.1 5110.0 5115.7 5182.5 5203.5 5975.9 6100.6 6134.8 6198.9 6245.9 6019.2 6092.3 6104.0 6105.5 6110.0 6269.5 6273.0 6280.4 6281.0 6292.4 5670.3 5781.8 5839.6 5960.1 5976.5 5927.7 5968.7 6029.1 6033.2 6080.2 5832.9 5856.0 5864.9 5866.5 5897.0 5567.5 5693.7 5753.3 5771.6 5820.8 5687.9 5702.7 5702.8 5710.7 5726.7 5763.5 5814.7 5818.9 5843.3 5852.2 5567.6 5700.0 5737.1 5783.5 5797.5 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | [#1] ext.html Cycles:180 Average:58020.36 Median:41742.19 stddev:111280.00 (266.6%) stddev-sans-first:111508.62 23:38:41 INFO - PROCESS | 15479 | Values: 586.4 633.2 643.5 655.3 660.0 30182.7 43011.8 43854.8 43910.0 43930.6 42445.2 42915.1 42995.4 46269.8 46351.0 8740.2 8972.2 9023.1 9026.7 9028.4 8851.7 8952.1 9008.1 9021.7 9034.8 8924.7 9003.1 9036.0 9079.0 9100.0 8925.3 9011.2 9020.5 9031.7 9040.2 8810.3 8944.5 8962.8 8967.8 8978.1 41582.6 41901.8 42020.0 42072.8 42161.0 3396.5 3522.5 3537.8 3543.6 4191.1 32121.0 32548.8 33053.5 33060.2 33208.7 4369.4 4442.1 4455.3 4510.8 4531.4 311276.0 312726.0 313691.0 314569.0 315625.0 60245.0 60862.0 61132.7 61245.7 61345.0 64201.7 64296.0 64422.0 64520.7 64704.4 17444.9 17576.8 17599.3 17616.8 17694.9 12485.2 12547.6 12574.2 12587.0 12606.5 17423.8 19442.2 19483.1 19598.1 19615.3 3300.9 3334.5 7366.7 7424.9 7535.7 955.9 984.2 1040.1 1071.8 1072.2 31919.7 32005.0 32372.5 32526.8 33114.2 1150.9 1164.5 1173.8 1236.2 1238.1 17347.4 17578.6 17615.9 17638.5 17652.6 493407.0 493888.0 496789.0 496901.0 497816.0 57132.4 58756.2 58828.4 58834.1 59035.7 1345.7 1358.1 1373.9 1378.9 1386.4 30913.5 32151.7 32256.8 32424.0 32771.7 52924.0 52966.0 53103.0 53178.5 53258.0 428746.0 428938.0 430456.0 433854.0 436646.0 26758.3 27549.7 27682.9 28350.4 28820.7 45722.1 46613.8 46637.5 47429.3 47911.0 38860.0 39165.8 39957.0 40462.6 40541.4 37795.6 38203.6 39395.0 39411.6 40410.8 39057.6 39850.8 39902.6 40134.4 40233.2 34193.5 35426.8 35460.5 35571.5 35674.3 27601.7 27731.0 27745.2 27888.0 27947.9 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | [#2] jquery.html Cycles:180 Average:28296.59 Median:444.64 stddev:82982.62 (18662.7%) stddev-sans-first:83188.95 23:38:41 INFO - PROCESS | 15479 | Values: 389.4 391.2 396.7 398.7 413.6 13878.0 17625.8 18449.9 19208.5 19236.7 10956.9 11552.9 11624.1 18103.0 18314.9 4941.7 5070.0 5077.8 5098.7 5109.2 5027.6 5170.8 5171.9 5173.7 5176.2 5127.2 5137.8 5147.8 5152.7 5167.0 4955.6 5140.0 5154.7 5184.9 5192.1 5017.3 5029.1 5030.5 5031.5 5041.7 13236.5 15987.9 20300.7 21222.7 21325.5 2067.1 2081.8 2154.6 2187.7 2210.1 9254.9 9568.6 9833.1 9860.7 9916.0 1868.0 1918.4 1929.7 1955.6 1962.8 81955.6 85226.6 86525.6 86799.6 87219.6 10471.9 10757.9 11001.3 11056.6 11123.6 13713.2 14202.6 14613.3 14619.6 14643.8 8044.3 8263.8 8367.0 8506.4 8528.9 7990.1 8094.8 8124.0 8222.0 8246.5 4566.4 4704.8 4705.3 4867.9 4906.4 1793.3 1800.6 1828.8 1877.5 1945.3 424.9 427.4 432.1 433.4 1014.4 10849.5 11229.3 11321.6 11454.8 11466.8 442.5 443.9 445.4 450.0 451.0 6080.5 6090.0 6207.8 6225.0 6271.0 483258.0 487657.0 509828.0 513281.0 515285.0 92326.0 92526.0 93184.5 93695.0 94950.5 440.4 456.5 457.9 458.9 459.1 10477.6 10628.4 10846.9 10898.6 10930.9 36641.6 37887.0 38241.2 38941.6 39819.0 53581.2 54893.2 55848.0 55939.4 56211.4 7660.8 7998.6 8110.1 8129.7 8263.2 8801.2 12480.3 13250.5 13391.2 13407.3 11424.4 11830.2 11896.2 12004.9 12091.9 11680.4 11883.9 12021.2 12375.9 12387.1 9387.7 11868.6 11965.4 12461.2 12524.4 8549.0 8597.8 8664.6 8711.3 8754.0 11724.7 11907.8 11940.9 12144.4 12259.3 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | [#3] mootools.html Cycles:180 Average:5843.37 Median:4734.52 stddev:3356.58 (70.9%) stddev-sans-first:3350.34 23:38:41 INFO - PROCESS | 15479 | Values: 1529.3 1544.5 1676.7 1803.0 1840.9 7891.6 8459.8 8554.1 9094.9 9130.0 8537.2 8893.7 8927.1 8928.8 8965.4 2350.4 2371.5 2397.3 2405.1 2405.3 2322.8 2373.8 2375.7 2381.9 2382.5 2314.2 2325.7 2338.9 2379.7 2380.1 2312.0 2334.0 2339.8 2356.7 2358.4 2297.7 2307.0 2312.4 2319.2 2339.1 8778.8 8872.0 8873.9 8878.2 8901.8 5279.3 5316.6 5356.4 5356.8 5378.1 3298.2 3385.9 3395.4 3544.3 3556.6 1109.0 1113.6 1115.7 1119.1 1142.2 12437.3 12468.5 12490.4 12512.6 12518.4 4544.3 4548.9 4657.5 4680.4 4696.5 10429.9 10430.6 10527.2 10542.8 10554.3 5278.5 5282.2 5324.1 5347.9 5352.3 4325.9 4772.6 4898.9 4934.4 4953.2 3994.7 4013.2 4086.6 4092.5 4118.7 1257.1 1272.2 1273.0 1276.5 1282.4 840.4 857.9 903.7 945.9 974.5 5819.8 5914.1 5924.9 5977.7 6225.8 953.4 959.9 981.2 988.6 1008.9 3952.9 4011.5 4056.9 4094.8 4182.1 10888.2 11215.4 11260.3 11265.3 11358.6 11203.7 11288.1 11295.8 11353.3 11383.2 7988.7 8110.4 8279.7 8345.2 8357.1 5579.9 5759.2 5828.1 5900.5 5911.7 10320.1 10325.1 10405.9 10406.6 10413.1 9929.6 10288.6 10626.4 10698.1 10703.8 7272.8 7655.8 7710.6 7921.4 8103.9 8737.3 8758.5 8776.1 8792.7 8871.2 7469.9 7665.5 7721.5 7727.0 8048.4 7252.3 7438.4 7448.7 7629.6 7645.4 6486.3 6556.0 6559.0 6591.6 6622.1 4832.6 4909.6 5102.9 5105.3 5110.1 5022.1 5100.0 5100.1 5142.5 5148.9 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | [#4] prototype.html Cycles:180 Average:4865.73 Median:5574.14 stddev:1446.01 (25.9%) stddev-sans-first:1409.10 23:38:41 INFO - PROCESS | 15479 | Values: 312.7 313.1 315.3 331.9 332.9 5522.5 5591.4 5592.6 5611.6 5658.2 5527.9 5545.9 5562.2 5599.5 5621.0 4138.7 4166.8 4287.1 4305.0 4307.1 4285.8 4300.5 4302.5 4318.8 4322.7 4214.5 4261.9 4277.1 4280.1 4320.7 4029.0 4258.6 4275.6 4294.1 4302.2 3671.0 3692.9 3693.4 3694.6 3734.3 5333.5 5365.6 5395.7 5431.3 5455.0 4671.8 4913.3 4915.6 4936.6 5004.6 5768.0 5823.7 5839.6 5871.1 5875.9 4137.6 4142.4 4143.8 4151.2 4153.9 5873.8 6035.2 6081.6 6135.1 6142.9 4132.8 4139.9 4183.0 4204.3 4207.3 4237.5 4252.7 4264.7 4271.6 4274.2 4593.9 4877.4 4882.8 4920.7 4922.1 5777.7 5786.0 5806.4 5849.8 5931.4 1461.6 1470.2 1485.9 1489.7 1489.9 900.8 925.8 948.4 980.9 1003.4 5465.6 5478.9 5531.3 5537.7 5607.3 5848.4 5911.4 5912.8 5943.4 5956.2 5413.4 5535.7 5541.2 5566.8 5575.7 3114.8 3134.2 3138.4 3149.4 3167.8 5834.9 6010.7 6018.8 6051.6 6062.5 5938.3 5953.3 6014.2 6026.8 6107.7 6157.3 6181.3 6191.2 6221.7 6238.5 5775.9 5892.4 5901.1 5921.8 5935.6 5842.5 5877.4 5890.9 5917.3 5930.8 5839.5 6043.8 6078.6 6117.0 6139.9 4150.8 4159.6 4180.8 4187.5 4201.8 5888.1 5928.9 5954.9 5959.9 6000.4 5588.9 5812.7 5816.7 5847.1 5883.0 5761.5 5777.9 5785.8 5787.7 5798.2 5473.8 5572.6 5678.4 5702.4 5753.7 5793.7 5825.1 5883.4 5884.1 5884.8 5553.7 5802.3 5811.4 5824.9 5826.3 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | [#5] yui.html Cycles:180 Average:15466.05 Median:25646.12 stddev:17935.62 (69.9%) stddev-sans-first:17952.19 23:38:41 INFO - PROCESS | 15479 | Values: 816.3 831.2 841.9 854.3 866.7 12704.2 13979.6 14460.9 14681.9 15078.9 14417.6 14990.3 15027.9 15072.1 15115.1 811.7 814.7 819.5 821.5 825.1 815.3 816.8 817.6 819.2 821.8 860.6 863.2 865.9 867.6 870.4 851.0 855.2 857.7 863.8 866.3 612.4 620.0 621.0 622.9 629.3 13748.2 13868.9 13871.7 13882.5 13885.1 13821.8 14184.2 14390.4 14554.1 14596.8 11717.4 11827.6 11883.7 11921.5 11996.4 3794.9 3863.2 3895.8 3913.4 3959.9 54610.7 54674.7 56075.2 56281.2 56295.2 10690.7 10770.7 10925.6 10949.8 11072.1 20085.2 20107.6 20134.4 20147.0 20156.9 7695.2 7775.0 7974.6 8036.4 8367.2 4695.7 4735.5 4765.6 4778.4 4804.0 3322.7 3409.2 3419.5 3422.6 3430.6 589.8 598.4 614.3 620.8 631.9 655.9 769.1 797.7 798.2 809.0 9638.8 10105.9 10166.3 10318.1 10366.3 534.3 673.5 679.6 684.5 730.4 4689.9 4761.5 4809.2 4824.0 4904.8 63196.7 63378.7 66666.7 66690.7 67051.7 56826.4 57316.0 58289.4 58683.7 59211.4 53666.2 53874.5 53947.7 54077.0 54561.2 9358.5 9585.4 9617.8 9726.6 9736.5 31143.4 35853.5 35930.8 36860.8 38337.8 46569.0 46602.3 46998.8 47233.8 48134.0 12114.0 12411.3 12493.8 12845.4 12995.7 13620.1 14108.5 14268.9 14460.7 14714.6 13069.3 13400.4 13495.7 13759.0 13832.4 12564.7 13054.6 13162.1 13190.5 13244.5 13036.3 13053.2 13067.7 13406.2 13770.8 10997.9 11058.4 11112.9 11176.0 11505.1 11182.7 11607.8 11745.6 11763.5 11863.5 23:38:41 INFO - PROCESS | 15479 | -------- Summary: end -------- 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - PROCESS | 15479 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 23:38:41 INFO - PROCESS | 15479 | 23:38:41 INFO - TEST-INFO | 15479: exit 0 23:38:41 INFO - TEST-OK | dromaeo_css | took 1110602ms 23:38:41 INFO - TEST-START | kraken 23:38:41 INFO - operating with platform_type : linux_ 23:38:41 INFO - Initialising browser for kraken test... 23:38:41 INFO - TEST-INFO | started process 15710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNV2ds/profile http://localhost:45013/getInfo.html) 23:38:45 INFO - PROCESS | 15710 | 23:38:45 INFO - PROCESS | 15710 | (process:15779): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:38:46 INFO - PROCESS | 15710 | __metrics Screen width/height:1600/1200 23:38:46 INFO - PROCESS | 15710 | colorDepth:24 23:38:46 INFO - PROCESS | 15710 | Browser inner width/height: 1024/697 23:38:46 INFO - PROCESS | 15710 | __metrics 23:38:46 ERROR - PROCESS | 15710 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:38:47 INFO - TEST-INFO | 15710: exit 0 23:38:47 INFO - Browser initialized. 23:38:47 INFO - Running cycle 1/1 for kraken test... 23:38:47 INFO - TEST-INFO | started process 15830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNV2ds/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:38:49 INFO - PROCESS | 15830 | 23:38:49 INFO - PROCESS | 15830 | (process:15889): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:38:59 INFO - PROCESS | 15830 | RSS: Main: 164732928 23:38:59 INFO - PROCESS | 15830 | 23:39:01 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45013/tests/kraken/driver.html?testName=audio-beat-detection) 23:39:02 INFO - PROCESS | 15830 | RSS: Main: 169615360 23:39:02 INFO - PROCESS | 15830 | 23:39:05 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45013/tests/kraken/driver.html?testName=audio-dft) 23:39:06 INFO - PROCESS | 15830 | RSS: Main: 169582592 23:39:06 INFO - PROCESS | 15830 | 23:39:09 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45013/tests/kraken/driver.html?testName=audio-fft) 23:39:09 INFO - PROCESS | 15830 | RSS: Main: 164044800 23:39:09 INFO - PROCESS | 15830 | 23:39:11 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45013/tests/kraken/driver.html?testName=audio-oscillator) 23:39:12 INFO - PROCESS | 15830 | RSS: Main: 164933632 23:39:12 INFO - PROCESS | 15830 | 23:39:14 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:39:15 INFO - PROCESS | 15830 | RSS: Main: 164577280 23:39:15 INFO - PROCESS | 15830 | 23:39:18 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45013/tests/kraken/driver.html?testName=imaging-darkroom) 23:39:19 INFO - PROCESS | 15830 | RSS: Main: 164937728 23:39:19 INFO - PROCESS | 15830 | 23:39:22 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45013/tests/kraken/driver.html?testName=imaging-desaturate) 23:39:23 INFO - PROCESS | 15830 | RSS: Main: 163442688 23:39:23 INFO - PROCESS | 15830 | 23:39:26 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45013/tests/kraken/driver.html?testName=json-parse-financial) 23:39:27 INFO - PROCESS | 15830 | RSS: Main: 164102144 23:39:27 INFO - PROCESS | 15830 | 23:39:28 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:39:29 INFO - PROCESS | 15830 | RSS: Main: 164409344 23:39:29 INFO - PROCESS | 15830 | 23:39:31 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:39:31 INFO - PROCESS | 15830 | RSS: Main: 164667392 23:39:31 INFO - PROCESS | 15830 | 23:39:33 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:39:34 INFO - PROCESS | 15830 | RSS: Main: 164966400 23:39:34 INFO - PROCESS | 15830 | 23:39:37 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:39:37 INFO - PROCESS | 15830 | RSS: Main: 165281792 23:39:37 INFO - PROCESS | 15830 | 23:39:40 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:39:41 INFO - PROCESS | 15830 | RSS: Main: 164880384 23:39:41 INFO - PROCESS | 15830 | 23:39:42 INFO - PROCESS | 15830 | Cycle 1(1): loaded http://localhost:45013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45013/tests/kraken/driver.html?testName=ai-astar) 23:39:43 INFO - PROCESS | 15830 | RSS: Main: 166420480 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | __start_tp_report 23:39:43 INFO - PROCESS | 15830 | _x_x_mozilla_page_load 23:39:43 INFO - PROCESS | 15830 | _x_x_mozilla_page_load_details 23:39:43 INFO - PROCESS | 15830 | |i|pagename|runs| 23:39:43 INFO - PROCESS | 15830 | |0;ai-astar;110;108;110;110;111;114;111;111;111;109 23:39:43 INFO - PROCESS | 15830 | |1;audio-beat-detection;161;134;153;211;126;159;148;125;182;134 23:39:43 INFO - PROCESS | 15830 | |2;audio-dft;163;162;163;163;164;176;162;161;163;163 23:39:43 INFO - PROCESS | 15830 | |3;audio-fft;74;75;75;179;75;73;74;75;170;76 23:39:43 INFO - PROCESS | 15830 | |4;audio-oscillator;93;93;179;92;93;92;140;93;91;150 23:39:43 INFO - PROCESS | 15830 | |5;imaging-gaussian-blur;117;118;116;117;118;117;116;117;118;117 23:39:43 INFO - PROCESS | 15830 | |6;imaging-darkroom;148;149;154;154;149;148;150;150;149;150 23:39:43 INFO - PROCESS | 15830 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 23:39:43 INFO - PROCESS | 15830 | |8;json-parse-financial;56;56;56;55;56;57;57;59;57;55 23:39:43 INFO - PROCESS | 15830 | |9;json-stringify-tinderbox;62;64;62;63;62;69;62;62;63;62 23:39:43 INFO - PROCESS | 15830 | |10;stanford-crypto-aes;79;85;78;78;78;79;80;78;136;78 23:39:43 INFO - PROCESS | 15830 | |11;stanford-crypto-ccm;132;128;127;120;120;128;123;127;145;132 23:39:43 INFO - PROCESS | 15830 | |12;stanford-crypto-pbkdf2;160;163;159;157;158;161;160;158;165;166 23:39:43 INFO - PROCESS | 15830 | |13;stanford-crypto-sha256-iterative;67;63;64;64;63;61;65;63;64;61 23:39:43 INFO - PROCESS | 15830 | __end_tp_report 23:39:43 INFO - PROCESS | 15830 | __start_cc_report 23:39:43 INFO - PROCESS | 15830 | _x_x_mozilla_cycle_collect,859 23:39:43 INFO - PROCESS | 15830 | __end_cc_report 23:39:43 INFO - PROCESS | 15830 | __startTimestamp1463812783235__endTimestamp 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | ------- Summary: start ------- 23:39:43 INFO - PROCESS | 15830 | Number of tests: 14 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 23:39:43 INFO - PROCESS | 15830 | Values: 110.0 108.0 110.0 110.0 111.0 114.0 111.0 111.0 111.0 109.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:156.00 stddev:27.01 (17.3%) stddev-sans-first:28.50 23:39:43 INFO - PROCESS | 15830 | Values: 161.0 134.0 153.0 211.0 126.0 159.0 148.0 125.0 182.0 134.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.29 (2.6%) stddev-sans-first:4.54 23:39:43 INFO - PROCESS | 15830 | Values: 163.0 162.0 163.0 163.0 164.0 176.0 162.0 161.0 163.0 163.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:42.17 (56.2%) stddev-sans-first:44.07 23:39:43 INFO - PROCESS | 15830 | Values: 74.0 75.0 75.0 179.0 75.0 73.0 74.0 75.0 170.0 76.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:92.50 stddev:32.32 (34.9%) stddev-sans-first:33.57 23:39:43 INFO - PROCESS | 15830 | Values: 93.0 93.0 179.0 92.0 93.0 92.0 140.0 93.0 91.0 150.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 23:39:43 INFO - PROCESS | 15830 | Values: 117.0 118.0 116.0 117.0 118.0 117.0 116.0 117.0 118.0 117.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:2.18 (1.5%) stddev-sans-first:2.18 23:39:43 INFO - PROCESS | 15830 | Values: 148.0 149.0 154.0 154.0 149.0 148.0 150.0 150.0 149.0 150.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:39:43 INFO - PROCESS | 15830 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.17 (2.1%) stddev-sans-first:1.24 23:39:43 INFO - PROCESS | 15830 | Values: 56.0 56.0 56.0 55.0 56.0 57.0 57.0 59.0 57.0 55.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:62.50 stddev:2.18 (3.5%) stddev-sans-first:2.28 23:39:43 INFO - PROCESS | 15830 | Values: 62.0 64.0 62.0 63.0 62.0 69.0 62.0 62.0 63.0 62.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:78.50 stddev:18.08 (23.0%) stddev-sans-first:19.05 23:39:43 INFO - PROCESS | 15830 | Values: 79.0 85.0 78.0 78.0 78.0 79.0 80.0 78.0 136.0 78.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.00 stddev:7.27 (5.7%) stddev-sans-first:7.58 23:39:43 INFO - PROCESS | 15830 | Values: 132.0 128.0 127.0 120.0 120.0 128.0 123.0 127.0 145.0 132.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:160.50 stddev:3.06 (1.9%) stddev-sans-first:3.23 23:39:43 INFO - PROCESS | 15830 | Values: 160.0 163.0 159.0 157.0 158.0 161.0 160.0 158.0 165.0 166.0 23:39:43 INFO - PROCESS | 15830 | 23:39:43 INFO - PROCESS | 15830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.78 (2.8%) stddev-sans-first:1.36 23:39:43 INFO - PROCESS | 15830 | Values: 67.0 63.0 64.0 64.0 63.0 61.0 65.0 63.0 64.0 61.0 23:39:43 INFO - PROCESS | 15830 | -------- Summary: end -------- 23:39:43 INFO - PROCESS | 15830 | 23:39:44 INFO - TEST-INFO | 15830: exit 0 23:39:44 INFO - TEST-OK | kraken | took 62351ms 23:39:44 INFO - SUITE-END | took 1172s 23:39:44 INFO - Completed test suite (00:19:33) 23:39:44 INFO - javascript benchmark 23:39:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7060.519611259046, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.572377729007, 3184.729298009669, 3191.8084914905094, 3210.48632218845, 3228.2897762492244, 5506.72466376681, 5583.022970980082, 5583.748731307091, 5669.546436285098, 5675.716214189284, 5487.6158668893195, 5534.446555344463, 5546.889062218764, 5547.278853749017, 5628.099504079348, 4959.727215003173, 4982.227754698028, 5116.872078198037, 5152.278680984665, 5200.349956255468, 960.3382417809319, 4910.656254062217, 4961.603071754269, 5041.571466425358, 5044.293798868143, 4996.3504744383, 5009.4239162496415, 5021.522955319257, 5056.696598204119, 5062.215356619711, 5056.115179843513, 5060.3927528696795, 5063.518965698253, 5084.211947148198, 5087.262346959707, 4905.288733133676, 4927.384076990376, 4963.478834722375, 4986.5013498650205, 5000.699958002495, 5335.839924802262, 5406.810761623364, 5427.0773968425465, 5435.374931882805, 5451.781928722847, 5677.37548869624, 5839.503642190419, 5900.0, 5919.437653422918, 5920.141579470953, 5923.022701254288, 5936.22829032223, 5940.851478713023, 5986.580939334249, 6066.8786624267705, 5584.553235741171, 5589.524890384322, 5589.888202235973, 5589.972050139723, 5595.048841696921, 5907.320658124285, 5960.5827592068135, 6010.849728756816, 6078.908816367758, 6083.330833608299, 5727.854429114193, 5728.398518155534, 5728.828135155952, 5748.5688573357165, 5761.625494342854, 5858.150568167592, 5897.852553686106, 5901.17383566301, 5905.557083218776, 5915.024021036566, 5821.767129314865, 5840.182374467578, 5872.442117998783, 5874.0, 5910.763569457259, 5871.853203669857, 5876.529877609781, 5878.118282257696, 5894.17481552583, 5907.320658124285, 4381.496127945264, 4420.31485119807, 4445.711028783118, 4455.710378825366, 4500.392447019676, 3879.4374815652136, 3966.127451960564, 3994.2610617035944, 4020.0954785173685, 4027.859024934113, 5492.725363731797, 5586.217929489874, 5615.8876822464135, 5645.350784659735, 5661.037623603997, 5848.356680765112, 5962.25471816023, 5962.582619216613, 5968.253968253968, 5990.460858522754, 5648.943510564924, 5713.971430142823, 5714.828555143353, 5734.340550836624, 5753.827385178452, 5071.112555302807, 5110.029094472038, 5115.7442127893455, 5182.481751824787, 5203.505666961632, 5975.894459525001, 6100.611450805989, 6134.786178072973, 6198.876022479525, 6245.906311405332, 6019.247594050831, 6092.256723849718, 6103.974138059404, 6105.490073363355, 6110.036353870931, 6269.4984401246875, 6272.968635156795, 6280.403361680633, 6280.9685951569945, 6292.433680968735, 5670.262865827416, 5781.797637082682, 5839.649621022582, 5960.135780311917, 5976.521878249817, 5927.733252003756, 5968.731407086779, 6029.125776762433, 6033.155358249936, 6080.209572755513, 5832.941670583409, 5855.975204339309, 5864.853378665567, 5866.50134738552, 5896.970515147397, 5567.468946039871, 5693.658380497183, 5753.338366087954, 5771.59598828078, 5820.82537523875, 5687.914681279702, 5702.657840529581, 5702.8289151325525, 5710.743016564182, 5726.656400615976, 5763.452472015152, 5814.709264536841, 5818.9127163093435, 5843.328017278068, 5852.209951656642, 5567.610267281251, 5700.030994730822, 5737.110747834093, 5783.450572195635, 5797.4782269595935], "value": 5431.831257331933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.4340911020864, 633.180031858743, 643.5398689936698, 655.2955572759284, 660.0, 30182.698173018263, 43011.78494107529, 43854.78072609632, 43910.0, 43930.56069439305, 42445.151096978116, 42915.14169716604, 42995.35506967398, 46269.76865115669, 46351.0, 8740.21338079571, 8972.192502674758, 9023.142801433853, 9026.729198124067, 9028.413153145057, 8851.690190843321, 8952.104789521061, 9008.0541543138, 9021.729348119567, 9034.774130646754, 8924.732258032269, 9003.144701253403, 9036.0, 9078.954605226998, 9100.044495327995, 8925.285977121846, 9011.18899299063, 9020.458772473672, 9031.683891063814, 9040.186383225475, 8810.251128654072, 8944.463332200088, 8962.820743585156, 8967.775805604846, 8978.057303983052, 41582.58417415847, 41901.79049104766, 42020.0, 42072.78963605193, 42161.0, 3396.5075064115813, 3522.5244591980013, 3537.7877327360443, 3543.6102028777073, 4191.140816132716, 32121.0, 32548.83725581357, 33053.504197437054, 33060.17349566256, 33208.6679133208, 4369.410129632491, 4442.0893716788305, 4455.287154055368, 4510.774461276923, 4531.410916580823, 311276.0, 312726.0, 313691.0, 314569.0, 315625.0, 60245.0, 60862.0, 61132.69433652892, 61245.69377153175, 61345.0, 64201.67899160568, 64296.0, 64422.0, 64520.67739661365, 64704.35295646983, 17444.91277543604, 17576.824231757775, 17599.296028158988, 17616.823831761518, 17694.91152544229, 12485.188462749893, 12547.560835370718, 12574.245545267131, 12587.0, 12606.49574017029, 17423.78735545874, 19442.19465051454, 19483.14092811896, 19598.118084686223, 19615.31346402869, 3300.93398132036, 3334.4817771919184, 7366.7053317866685, 7424.925750742424, 7535.698572057166, 955.8709574207393, 984.2322988069318, 1040.1159014837328, 1071.8017166824163, 1072.1851392941421, 31919.68080319167, 32005.0, 32372.514412283836, 32526.83736581302, 33114.17214569655, 1150.9079273658087, 1164.470166074434, 1173.8239264110282, 1236.202649291202, 1238.1147479552164, 17347.392841250497, 17578.560535986446, 17615.911920440314, 17638.470845874643, 17652.558686032953, 493407.0, 493888.0, 496789.0, 496901.0, 497816.0, 57132.42867571354, 58756.18084824473, 58828.41171588315, 58834.11748823771, 59035.70482147648, 1345.663584103974, 1358.1443690474937, 1373.9106958047496, 1378.8621137886332, 1386.4384924105752, 30913.536296956012, 32151.678483215805, 32256.838715806272, 32424.02727918166, 32771.672283276865, 52924.0, 52966.0, 53103.0, 53178.4682153189, 53258.0, 428746.0, 428938.0, 430456.0, 433854.0, 436646.0, 26758.331041724112, 27549.72450275552, 27682.861585691942, 28350.432991339647, 28820.711792881804, 45722.08555828931, 46613.766931165126, 46637.53362466468, 47429.28856067231, 47911.0, 38860.0, 39165.804170980104, 39957.0, 40462.59537404706, 40541.39187912125, 37795.62204377921, 38203.617963820005, 39395.0, 39411.60588394194, 40410.797946011255, 39057.6094239054, 39850.800745996086, 39902.60097399105, 40134.397984030846, 40233.195336092525, 34193.48709769405, 35426.82286588551, 35460.46809297811, 35571.466428003085, 35674.28651427009, 27601.72398276072, 27731.0, 27745.167644970683, 27888.023919162733, 27947.860260698566], "value": 20033.40321111351, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3867159224222, 391.24099247459924, 396.68661757211805, 398.70495833083515, 413.56782162640036, 13878.0, 17625.82374176258, 18449.90775046123, 19208.51978700533, 19236.71144932827, 10956.890431095686, 11552.884471155287, 11624.128190385713, 18103.0, 18314.908425457856, 4941.654084214107, 5069.995461640898, 5077.771500282496, 5098.719570423626, 5109.156989096795, 5027.597792176635, 5170.767315470813, 5171.922421163686, 5173.741312934357, 5176.223566465042, 5127.179651255799, 5137.845864624067, 5147.81982630608, 5152.74236288186, 5166.974165129169, 4955.628327875405, 5139.974300128494, 5154.690718556899, 5184.896302073975, 5192.091384007784, 5017.34774479319, 5029.1450453423, 5030.547250747413, 5031.547160755549, 5041.72270525121, 13236.536721214807, 15987.92006039974, 20300.695489567668, 21222.681659775117, 21325.466863328387, 2067.1421360135528, 2081.843861710378, 2154.5583155453096, 2187.726534183227, 2210.0877564124885, 9254.907450925471, 9568.61725530985, 9833.115019648267, 9860.689158938285, 9916.0, 1867.9906600467048, 1918.4436513411233, 1929.7105434184843, 1955.6186543623858, 1962.7644682638174, 81955.59022204911, 85226.5738671309, 86525.56737216336, 86799.56600216958, 87219.56390218071, 10471.895281047093, 10757.892421075689, 11001.284916480403, 11056.613018544313, 11123.610673626546, 13713.17720936747, 14202.573922782332, 14613.342399592044, 14619.634509137144, 14643.780343294859, 8044.316233120133, 8263.793405164799, 8366.958165209257, 8506.447080939719, 8528.914710852812, 7990.12108668046, 8094.757157285291, 8123.984501937258, 8222.0, 8246.546439945741, 4566.383538222364, 4704.811807527661, 4705.317728929286, 4867.878303042452, 4906.411230652345, 1793.3006127610242, 1800.612868233336, 1828.7622609061002, 1877.474307193988, 1945.309415157627, 424.87678573213424, 427.38883396742335, 432.1335721877615, 433.4148898986343, 1014.3862962907482, 10849.457527123612, 11229.27009744364, 11321.603743868925, 11454.770904582028, 11466.827997580043, 442.5309172277396, 443.9223135951196, 445.36757803918516, 449.97405914514957, 450.9549045095464, 6080.543959203077, 6089.969550152309, 6207.844803879939, 6224.972879474836, 6270.968645156745, 483258.0, 487657.0, 509828.0, 513281.0, 515285.0, 92326.0, 92526.0, 93184.53407732918, 93694.99999999863, 94950.52524737333, 440.4472387154101, 456.5366153354348, 457.93131030345717, 458.87380970233454, 459.1482799407052, 10477.580896764044, 10628.36229826213, 10846.891531084904, 10898.618548350769, 10930.890691092987, 36641.633583663825, 37887.0, 38241.235175295784, 38941.6105838938, 39819.0, 53581.19628205502, 54893.1766023502, 55848.0, 55939.44060559342, 56211.43788562062, 7660.808479787827, 7998.5600791957, 8110.107888132418, 8129.715459958873, 8263.173682631688, 8801.207891289814, 12480.313582753035, 13250.536231232247, 13391.196528208338, 13407.262600557064, 11424.371659558805, 11830.17188796776, 11896.22674526153, 12004.879951200377, 12091.879081209427, 11680.357580333164, 11883.881161188623, 12021.218620789621, 12375.938120309702, 12387.07096967749, 9387.73265609134, 11868.58459953932, 11965.401729913296, 12461.1900226485, 12524.37378131108, 8549.0, 8597.828043439222, 8664.610092545725, 8711.346649001476, 8754.0, 11724.70688232801, 11907.82138267944, 11940.940295298467, 12144.39278036077, 12259.325737084546], "value": 7970.625965609032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.3423827754066, 1544.5366390082972, 1676.7401052836815, 1803.0, 1840.9355672551462, 7891.565963871984, 8459.788505287372, 8554.05905350411, 9094.86357704635, 9130.0, 8537.231649151576, 8893.68872089477, 8927.107289271069, 8928.776780580472, 8965.417247878884, 2350.435895385108, 2371.5138396628736, 2397.3407312988893, 2405.1461731085474, 2405.278416475059, 2322.8257880658934, 2373.750756170603, 2375.6674065630827, 2381.880905954704, 2382.4877651304964, 2314.190033488274, 2325.6976593042964, 2338.894749736266, 2379.726331471877, 2380.0836677879056, 2311.976880231193, 2333.9533209335887, 2339.777721116491, 2356.658284548731, 2358.3750306168877, 2297.655351697242, 2307.0195167054103, 2312.387217387394, 2319.1651005637955, 2339.087755775249, 8778.824423511558, 8871.955640221822, 8873.911260887438, 8878.24534914533, 8901.821963560757, 5279.313689220377, 5316.627836051478, 5356.437574054746, 5356.839294821161, 5378.0857254266475, 3298.241404476984, 3385.8814941477176, 3395.439752440844, 3544.2734239480847, 3556.6443355664487, 1108.9611863584817, 1113.582406597526, 1115.7154925494028, 1119.1326721790597, 1142.2289954280827, 12437.253764774052, 12468.501259949591, 12490.375481225903, 12512.562060327937, 12518.37408129599, 4544.2501987171745, 4548.863534093983, 4657.46439159501, 4680.438347398334, 4696.459907110658, 10429.947850260853, 10430.582776689, 10527.21045921559, 10542.841857372145, 10554.261201715806, 5278.498542638443, 5282.181261904411, 5324.068288049576, 5347.919781203285, 5352.2506849041165, 4325.891852703708, 4772.570468657837, 4898.853034408973, 4934.383202099738, 4953.18272485036, 3994.7403418777685, 4013.2174226026227, 4086.59134086589, 4092.529359123679, 4118.711690181718, 1257.0886107571937, 1272.1794442584667, 1272.9872701273055, 1276.4894042382934, 1282.4229096906242, 840.3613253926937, 857.9485230886166, 903.6520939438363, 945.8770359853175, 974.541965276319, 5819.79630712923, 5914.112883067574, 5924.881502369928, 5977.701114944235, 6225.750969961241, 953.3564843730454, 959.9088086631759, 981.2395393569898, 988.619381538113, 1008.8839783425, 3952.9209415811524, 4011.538673052636, 4056.8985775355263, 4094.7543147410656, 4182.121754431542, 10888.183386245904, 11215.383153926448, 11260.324380537195, 11265.324080555192, 11358.60244891425, 11203.663890083311, 11288.0969522438, 11295.774084518263, 11353.318800871974, 11383.203175777617, 7988.680452781824, 8110.391720620977, 8279.710210142615, 8345.248927596545, 8357.12250213731, 5579.916301255404, 5759.1649210865025, 5828.125781132864, 5900.468957793819, 5911.704414779329, 10320.12278956297, 10325.122364599094, 10405.895941040493, 10406.635767748396, 10413.114885234538, 9929.553170107218, 10288.588456461657, 10626.415547144981, 10698.090662293482, 10703.785924281627, 7272.781816545512, 7655.846883062419, 7710.575918324322, 7921.366290696616, 8103.918960810553, 8737.301015918583, 8758.518281494324, 8776.122387761428, 8792.736217913473, 8871.157240062184, 7469.887951680837, 7665.540067595962, 7721.498102623312, 7727.034120734908, 8048.436609437284, 7252.347288744038, 7438.40492760567, 7448.664810083667, 7629.580373079534, 7645.426593005658, 6486.254080780771, 6556.0, 6559.048937903882, 6591.6045037296, 6622.10601568782, 4832.63755218353, 4909.649846292298, 5102.948970510248, 5105.33630628016, 5110.080185566634, 5022.0960227158, 5099.974500127476, 5100.132977393778, 5142.51146141116, 5148.871278218075], "value": 4669.001300497266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.7201154966305, 313.0733030230519, 315.3346439013682, 331.93527262183875, 332.89513803152005, 5522.502974732273, 5591.384947655754, 5592.552595792337, 5611.551075913927, 5658.179563963223, 5527.917081243774, 5545.89256082688, 5562.193481945115, 5599.524040456566, 5620.976448478545, 4138.710290279681, 4166.83332666693, 4287.078278170193, 4304.966807966097, 4307.138572285539, 4285.764282964436, 4300.462442194726, 4302.505211900624, 4318.805653745589, 4322.7406355618605, 4214.5459816363455, 4261.936070958938, 4277.101808620194, 4280.101178752466, 4320.697551171419, 4029.0, 4258.6380157686635, 4275.551067137968, 4294.076773493683, 4302.20409224293, 3670.9816450917842, 3692.907677308062, 3693.445983102556, 3694.6305369463107, 3734.290484807878, 5333.493318134771, 5365.570754339683, 5395.676259424447, 5431.266778984866, 5455.008921743574, 4671.789769460348, 4913.287573301851, 4915.557599815998, 4936.580390666798, 5004.624653151028, 5768.0, 5823.737931793079, 5839.562032847511, 5871.091895134098, 5875.855312810836, 4137.565555616647, 4142.399352093959, 4143.81352839123, 4151.232022075896, 4153.937690934638, 5873.794417195378, 6035.185249991283, 6081.6351018939, 6135.110408990671, 6142.8771424571705, 4132.772697501667, 4139.91720165595, 4182.979085104555, 4204.285271503852, 4207.326827707552, 4237.533871274158, 4252.659787217015, 4264.722793018444, 4271.6369108625495, 4274.230638485041, 4593.885152871205, 4877.439094504178, 4882.780274887638, 4920.745209971435, 4922.138625740481, 5777.6822274775295, 5786.0, 5806.44838740319, 5849.830033993218, 5931.377205393458, 1461.6126726417294, 1470.1620076556474, 1485.9182744949132, 1489.7262840271628, 1489.925503724831, 900.7658008917729, 925.8194652042787, 948.4498990585444, 980.9362391444533, 1003.4029752297372, 5465.562754979592, 5478.890422191534, 5531.340597820637, 5537.667739935617, 5607.299087614048, 5848.444397782289, 5911.408859114054, 5912.76348946046, 5943.435373639497, 5956.195913551615, 5413.431589683027, 5535.6955367455175, 5541.224228607998, 5566.777328906798, 5575.665460072409, 3114.76639252057, 3134.2321131322974, 3138.356636889432, 3149.4173577887705, 3167.7782555220915, 5834.883302333929, 6010.699465026732, 6018.759249629966, 6051.609614202365, 6062.454379105901, 5938.28740551128, 5953.28560572734, 6014.218151640259, 6026.819195424145, 6107.664078475637, 6157.261128664589, 6181.320054793969, 6191.16419283409, 6221.693444376641, 6238.500919926486, 5775.94224057754, 5892.35184129754, 5901.085331773582, 5921.7631294747725, 5935.554833387427, 5842.5325973921135, 5877.4122587740885, 5890.852728681817, 5917.260342457193, 5930.7924222652, 5839.532837373085, 6043.8186854394435, 6078.574499784972, 6116.969415152896, 6139.938600613937, 4150.79246037703, 4159.646430053479, 4180.8118634660905, 4187.539370669285, 4201.836054432031, 5888.146218798164, 5928.9407105928385, 5954.910676339771, 5959.880802383841, 6000.369961154016, 5588.944110558842, 5812.73842677089, 5816.680082595498, 5847.06446968483, 5882.970585147047, 5761.48146666802, 5777.884442311214, 5785.82642520725, 5787.710614469175, 5798.246227990334, 5473.781048758005, 5572.60991730575, 5678.403767604507, 5702.429757024264, 5753.741081651252, 5793.652380857162, 5825.077724350869, 5883.382244864228, 5884.117382392676, 5884.764609415575, 5553.72231388437, 5802.332731735735, 5811.418858114154, 5824.854378640568, 5826.300843898759], "value": 4395.195959350201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.3306089007015, 831.2145022953312, 841.9213280117549, 854.3336197765741, 866.670665147244, 12704.237745735263, 13979.580612581625, 14460.92769536152, 14681.92659036706, 15078.924605376958, 14417.567472975801, 14990.250487475638, 15027.94804363695, 15072.095674259552, 15115.093094414342, 811.736185739634, 814.6578437056451, 819.4509678515409, 821.4947807098621, 825.0717942314895, 815.339574944297, 816.8325493273865, 817.5585184000632, 819.1521774962914, 821.757581513455, 860.6041221038298, 863.2058506174303, 865.8614621660536, 867.6139118092451, 870.4342177584589, 851.0298259983624, 855.2260204514862, 857.7126662568016, 863.809961808398, 866.3199388480044, 612.3845535237102, 620.0203678188451, 620.996895015522, 622.9439350458435, 629.3077614623922, 13748.243846588433, 13868.861311386858, 13871.722565548633, 13882.51411200603, 13885.097468664504, 13821.79267310991, 14184.21986790726, 14390.424383024667, 14554.12675239489, 14596.781048284285, 11717.414129293502, 11827.586034488751, 11883.702907427383, 11921.523139074427, 11996.400179990966, 3794.867179648699, 3863.16941857502, 3895.7662540247393, 3913.4325522799318, 3959.940600890989, 54610.72694636541, 54674.72662636701, 56075.15887261694, 56281.15578266329, 56295.155572666445, 10690.73273168177, 10770.730731731614, 10925.562977480811, 10949.781004379867, 11072.114230861513, 20085.196592136443, 20107.59784804325, 20134.395968120978, 20147.0, 20156.89921550383, 7695.153533111354, 7774.961125194338, 7974.561399123104, 8036.357091432671, 8367.246947774607, 4695.694779839299, 4735.455422626374, 4765.618750500021, 4778.402699662543, 4803.951960480351, 3322.684344987222, 3409.232922592397, 3419.46998215277, 3422.57217847769, 3430.622631510532, 589.7640943622586, 598.4314900844215, 614.2536817766346, 620.7858288890326, 631.9146915166485, 655.944244739193, 769.103993847173, 797.7008621766837, 798.1778767869104, 808.9878651820227, 9638.75903102414, 10105.949470252748, 10166.339187952908, 10318.122959548373, 10366.326188797855, 534.3371190489219, 673.4982438083659, 679.6179391233793, 684.5071548485083, 730.4412124724483, 4689.929651055237, 4761.547652972962, 4809.2305231162845, 4824.037990165733, 4904.8038078477175, 63196.68033196643, 63378.68310658417, 66666.66666666635, 66690.66654666793, 67051.66474167598, 56826.43173568211, 57316.0, 58289.41710582925, 58683.70658146682, 59211.40788592145, 53666.19500707492, 53874.46125538773, 53947.73026134923, 54077.0, 54561.181582276295, 9358.532073396167, 9585.424874507551, 9617.807643847224, 9726.562304696165, 9736.513174341397, 31143.377132457677, 35853.462198066525, 35930.8203458981, 36860.81569592135, 38337.808310958266, 46569.0, 46602.300965484865, 46998.765006176116, 47233.763831182, 48134.03731925272, 12114.0, 12411.255324680547, 12493.75012499763, 12845.357732113544, 12995.675108121994, 13620.114692544952, 14108.506202282872, 14268.928655356656, 14460.710785784015, 14714.558563242692, 13069.281189534286, 13400.396982135633, 13495.662608434868, 13759.0, 13832.446702131801, 12564.685882853002, 13054.608361749162, 13162.14446061003, 13190.538331158747, 13244.470221191044, 13036.348182590642, 13053.178879846992, 13067.738645227233, 13406.195628262336, 13770.793438098237, 10997.945010274898, 11058.447077645924, 11112.944435277772, 11176.0, 11505.137114716263, 11182.66452006441, 11607.76784464323, 11745.647630571097, 11763.470643820878, 11863.466144023367], "value": 6959.580072544942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 110.0, 110.0, 111.0, 114.0, 111.0, 111.0, 111.0, 109.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 134.0, 153.0, 211.0, 126.0, 159.0, 148.0, 125.0, 182.0, 134.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 164.0, 176.0, 162.0, 161.0, 163.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 179.0, 75.0, 73.0, 74.0, 75.0, 170.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 179.0, 92.0, 93.0, 92.0, 140.0, 93.0, 91.0, 150.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 154.0, 154.0, 149.0, 148.0, 150.0, 150.0, 149.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 56.0, 57.0, 57.0, 59.0, 57.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 63.0, 62.0, 69.0, 62.0, 62.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 78.0, 78.0, 78.0, 79.0, 80.0, 78.0, 136.0, 78.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 127.0, 120.0, 120.0, 128.0, 123.0, 127.0, 145.0, 132.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 159.0, 157.0, 158.0, 161.0, 160.0, 158.0, 165.0, 166.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 64.0, 63.0, 61.0, 65.0, 63.0, 64.0, 61.0], "value": 63.5, "unit": "score"}]}]} 23:39:44 INFO - Return code: 0 23:39:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:39:44 ERROR - # TBPL SUCCESS # 23:39:44 INFO - Running post-action listener: _resource_record_post_action 23:39:44 INFO - ##### 23:39:44 INFO - ##### Finished run-tests step (success) 23:39:44 INFO - ##### 23:39:44 INFO - Running post-run listener: _resource_record_post_run 23:39:44 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554532864; Read time: 8; Write time: 472000 23:39:44 INFO - TinderboxPrint: CPU usage
13.4% 23:39:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:39:44 INFO - TinderboxPrint: I/O write bytes / time
554,532,864 / 472,000 23:39:44 INFO - TinderboxPrint: CPU idle
8,234.3 (86.6%) 23:39:44 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 23:39:44 INFO - TinderboxPrint: Swap in / out
0 / 0 23:39:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261197824; Read time: 0; Write time: 248236 23:39:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293335040; Read time: 8; Write time: 223764 23:39:45 INFO - Running post-run listener: _upload_blobber_files 23:39:45 INFO - Blob upload gear active. 23:39:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:39:45 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 23:39:45 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'] 23:39:45 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 23:39:45 INFO - (blobuploader) - INFO - Open directory for files ... 23:39:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:39:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:39:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:46 INFO - (blobuploader) - INFO - Done attempting. 23:39:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:39:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:49 INFO - (blobuploader) - INFO - Done attempting. 23:39:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:39:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:39:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:39:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:39:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:39:50 INFO - (blobuploader) - INFO - Done attempting. 23:39:50 INFO - (blobuploader) - INFO - Iteration through files over. 23:39:50 INFO - Return code: 0 23:39:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:39:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:39:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/146c8a428f601d234e366f1f80946a7b68d0d85901a0b4a8166e64977c1e0dd595c3457dc70c918dcb28eeac81d323e9049159b47d56a7192bb31ad36a43ee71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fc5f2443f07cb242aa540f7a8bf7289fe6ffa8ab0b860c40aa55a84273e65b2c62f4cfd9d399130fc5ab3981b7b0ac40483d14d3ffeaeb5aa8114f7113fff08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d27eee51b3fc5dcbd3e3b258663d583b62c89da620f5045ecb7cb2a30d4229fb1ed75d90fcb6f94d44a625fca1cbcbd4f1a065226170905ed0ccc0517db349d4"} 23:39:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:39:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:39:50 INFO - Contents: 23:39:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/146c8a428f601d234e366f1f80946a7b68d0d85901a0b4a8166e64977c1e0dd595c3457dc70c918dcb28eeac81d323e9049159b47d56a7192bb31ad36a43ee71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fc5f2443f07cb242aa540f7a8bf7289fe6ffa8ab0b860c40aa55a84273e65b2c62f4cfd9d399130fc5ab3981b7b0ac40483d14d3ffeaeb5aa8114f7113fff08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d27eee51b3fc5dcbd3e3b258663d583b62c89da620f5045ecb7cb2a30d4229fb1ed75d90fcb6f94d44a625fca1cbcbd4f1a065226170905ed0ccc0517db349d4"} 23:39:50 INFO - Running post-run listener: copy_logs_to_upload_dir 23:39:50 INFO - Copying logs to upload dir... 23:39:50 INFO - mkdir: /builds/slave/test/build/upload/logs 23:39:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.652924 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-20 23:39:50.167685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 23:39:50.171111) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029 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/146c8a428f601d234e366f1f80946a7b68d0d85901a0b4a8166e64977c1e0dd595c3457dc70c918dcb28eeac81d323e9049159b47d56a7192bb31ad36a43ee71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fc5f2443f07cb242aa540f7a8bf7289fe6ffa8ab0b860c40aa55a84273e65b2c62f4cfd9d399130fc5ab3981b7b0ac40483d14d3ffeaeb5aa8114f7113fff08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d27eee51b3fc5dcbd3e3b258663d583b62c89da620f5045ecb7cb2a30d4229fb1ed75d90fcb6f94d44a625fca1cbcbd4f1a065226170905ed0ccc0517db349d4"} build_url:https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/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/146c8a428f601d234e366f1f80946a7b68d0d85901a0b4a8166e64977c1e0dd595c3457dc70c918dcb28eeac81d323e9049159b47d56a7192bb31ad36a43ee71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3fc5f2443f07cb242aa540f7a8bf7289fe6ffa8ab0b860c40aa55a84273e65b2c62f4cfd9d399130fc5ab3981b7b0ac40483d14d3ffeaeb5aa8114f7113fff08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d27eee51b3fc5dcbd3e3b258663d583b62c89da620f5045ecb7cb2a30d4229fb1ed75d90fcb6f94d44a625fca1cbcbd4f1a065226170905ed0ccc0517db349d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 23:39:50.200489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:39:50.200824) ========= 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=3a3620fb28aea1604ab609ef000001d2-1463809913.890040-1375248029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:39:50.283624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 23:39:50.283951) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 23:39:50.284272) ========= ========= Total master_lag: 0.20 =========