builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1462925726.9 results: success (0) buildid: 20160510162116 builduid: c3404a01b02e4442a7ff3c7e95d92257 revision: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:26.896177) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:26.896554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:26.896820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:26.917374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-05-10 17:15:26.917670) ========= 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=00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 17:15:27-- 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% 222M=0s 2016-05-10 17:15:27 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077012 ========= master_lag: 17.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-05-10 17:15:44.545230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-05-10 17:15:44.545518) ========= 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=00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022853 ========= master_lag: 2.00 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-05-10 17:15:46.570602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 17:15:46.570905) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8df7fcffeb14796b272feb5cb24b1c15dcf67cb --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 d8df7fcffeb14796b272feb5cb24b1c15dcf67cb --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=00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 17:15:46,871 truncating revision to first 12 chars 2016-05-10 17:15:46,871 Setting DEBUG logging. 2016-05-10 17:15:46,871 attempt 1/10 2016-05-10 17:15:46,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8df7fcffeb1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 17:15:48,055 unpacking tar archive at: fx-team-d8df7fcffeb1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.489541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 17:15:48.073237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:48.076573) ========= script_repo_revision: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:48.076982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:48.077245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 17:15:48.092800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-10 17:15:48.093064) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:48 INFO - MultiFileLogger online at 20160510 17:15:48 in /builds/slave/test 17:15:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:15:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:48 INFO - {'append_to_log': False, 17:15:48 INFO - 'base_work_dir': '/builds/slave/test', 17:15:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:15:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:48 INFO - 'branch': 'Fx-Team-Non-PGO', 17:15:48 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:48 INFO - 'config_files': ('talos/linux_config.py',), 17:15:48 INFO - 'default_actions': ('clobber', 17:15:48 INFO - 'read-buildbot-config', 17:15:48 INFO - 'download-and-extract', 17:15:48 INFO - 'populate-webroot', 17:15:48 INFO - 'create-virtualenv', 17:15:48 INFO - 'install', 17:15:48 INFO - 'run-tests'), 17:15:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:48 INFO - 'download_minidump_stackwalk': True, 17:15:48 INFO - 'download_symbols': 'ondemand', 17:15:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:48 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:48 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:48 INFO - 'installer_path': 'installer.exe', 17:15:48 INFO - 'log_level': 'info', 17:15:48 INFO - 'log_name': 'talos', 17:15:48 INFO - 'log_to_console': True, 17:15:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:48 INFO - 'opt_config_files': (), 17:15:48 INFO - 'pip_index': False, 17:15:48 INFO - 'sps_profile': False, 17:15:48 INFO - 'sps_profile_interval': 0, 17:15:48 INFO - 'suite': 'dromaeojs-e10s', 17:15:48 INFO - 'system_bits': '32', 17:15:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:48 INFO - 'title': 'talos-linux64-ix-016', 17:15:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:48 INFO - 'use_talos_json': True, 17:15:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:48 INFO - 'work_dir': 'build'} 17:15:48 INFO - ##### 17:15:48 INFO - ##### Running clobber step. 17:15:48 INFO - ##### 17:15:48 INFO - Running pre-action listener: _resource_record_pre_action 17:15:48 INFO - Running main action method: clobber 17:15:48 INFO - rmtree: /builds/slave/test/build 17:15:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:48 INFO - Running post-action listener: _resource_record_post_action 17:15:48 INFO - ##### 17:15:48 INFO - ##### Finished clobber step (success) 17:15:48 INFO - ##### 17:15:48 INFO - ##### 17:15:48 INFO - ##### Running read-buildbot-config step. 17:15:48 INFO - ##### 17:15:48 INFO - Running pre-action listener: _resource_record_pre_action 17:15:48 INFO - Running main action method: read_buildbot_config 17:15:48 INFO - Using buildbot properties: 17:15:48 INFO - { 17:15:48 INFO - "project": "", 17:15:48 INFO - "product": "firefox", 17:15:48 INFO - "script_repo_revision": "production", 17:15:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:15:48 INFO - "repository": "", 17:15:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:15:48 INFO - "buildid": "20160510162116", 17:15:48 INFO - "pgo_build": "False", 17:15:48 INFO - "basedir": "/builds/slave/test", 17:15:48 INFO - "buildnumber": 1277, 17:15:48 INFO - "slavename": "talos-linux64-ix-016", 17:15:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:15:48 INFO - "platform": "ubuntu64_hw", 17:15:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:15:48 INFO - "branch": "fx-team", 17:15:48 INFO - "repo_path": "integration/fx-team", 17:15:48 INFO - "revision": "d8df7fcffeb14796b272feb5cb24b1c15dcf67cb", 17:15:48 INFO - "stage_platform": "linux64", 17:15:48 INFO - "builduid": "c3404a01b02e4442a7ff3c7e95d92257", 17:15:48 INFO - "slavebuilddir": "test" 17:15:48 INFO - } 17:15:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:15:48 INFO - Running post-action listener: _resource_record_post_action 17:15:48 INFO - ##### 17:15:48 INFO - ##### Finished read-buildbot-config step (success) 17:15:48 INFO - ##### 17:15:48 INFO - ##### 17:15:48 INFO - ##### Running download-and-extract step. 17:15:48 INFO - ##### 17:15:48 INFO - Running pre-action listener: _resource_record_pre_action 17:15:48 INFO - Running main action method: download_and_extract 17:15:48 INFO - mkdir: /builds/slave/test/build/tests 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:48 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:49 INFO - Downloaded 1361 bytes. 17:15:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:15:49 INFO - Using the following test package requirements: 17:15:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'jsshell-linux-x86_64.zip'], 17:15:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:49 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:50 INFO - Downloaded 22329023 bytes. 17:15:50 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'] 17:15:50 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 17:15:51 INFO - Return code: 0 17:15:51 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 17:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:51 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:53 INFO - Downloaded 22329023 bytes. 17:15:53 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'] 17:15:53 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 17:15:54 INFO - Return code: 0 17:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:54 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:55 INFO - Downloaded 10840152 bytes. 17:15:55 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'] 17:15:55 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 17:15:55 INFO - Return code: 0 17:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:55 INFO - https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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 17:15:57 INFO - Downloaded 54681779 bytes. 17:15:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:57 INFO - mkdir: /builds/slave/test/properties 17:15:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:57 INFO - Contents: 17:15:57 INFO - build_url:https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:15:57 INFO - Running post-action listener: _resource_record_post_action 17:15:57 INFO - Running post-action listener: set_extra_try_arguments 17:15:57 INFO - ##### 17:15:57 INFO - ##### Finished download-and-extract step (success) 17:15:57 INFO - ##### 17:15:57 INFO - ##### 17:15:57 INFO - ##### Running populate-webroot step. 17:15:57 INFO - ##### 17:15:57 INFO - Running pre-action listener: _resource_record_pre_action 17:15:57 INFO - Running main action method: populate_webroot 17:15:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:57 INFO - '--tppagecycles', 17:15:57 INFO - '7'], 17:15:57 INFO - 'tests': ['tsvgm']}}, 17:15:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['damp', 'tps']}, 17:15:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'tests': ['damp', 'tps']}, 17:15:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['dromaeo_dom']}, 17:15:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['a11yr', 17:15:57 INFO - 'ts_paint', 17:15:57 INFO - 'tpaint', 17:15:57 INFO - 'sessionrestore', 17:15:57 INFO - 'sessionrestore_no_auto_restore', 17:15:57 INFO - 'tabpaint']}, 17:15:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tsvgx', 17:15:57 INFO - 'tsvgr_opacity', 17:15:57 INFO - 'tart', 17:15:57 INFO - 'tscrollx', 17:15:57 INFO - 'cart']}, 17:15:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:57 INFO - 'tsvgr_opacity', 17:15:57 INFO - 'tart', 17:15:57 INFO - 'tscrollx', 17:15:57 INFO - 'cart']}, 17:15:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s'], 17:15:57 INFO - 'tests': ['tp5o']}, 17:15:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'tests': ['tp5o']}, 17:15:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--disable-e10s', 17:15:57 INFO - '--xperf_path', 17:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:57 INFO - 'tests': ['tp5n']}, 17:15:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:57 INFO - 'talos_options': ['--xperf_path', 17:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:57 INFO - 'tests': ['tp5n']}}, 17:15:57 INFO - 'talos.zip': {'path': '', 17:15:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:57 INFO - Running post-action listener: _resource_record_post_action 17:15:57 INFO - ##### 17:15:57 INFO - ##### Finished populate-webroot step (success) 17:15:57 INFO - ##### 17:15:57 INFO - ##### 17:15:57 INFO - ##### Running create-virtualenv step. 17:15:57 INFO - ##### 17:15:57 INFO - Running pre-action listener: _resource_record_pre_action 17:15:57 INFO - Running main action method: create_virtualenv 17:15:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:15:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:58 INFO - Using real prefix '/usr' 17:15:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:00 INFO - Installing pip.................done. 17:16:00 INFO - Return code: 0 17:16:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 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 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:16:00 INFO - Using env: {'DISPLAY': ':0', 17:16:00 INFO - 'HOME': '/home/cltbld', 17:16:00 INFO - 'LANG': 'en_US.UTF-8', 17:16:00 INFO - 'LANGUAGE': 'en_US:en', 17:16:00 INFO - 'LOGNAME': 'cltbld', 17:16:00 INFO - 'MAIL': '/var/mail/cltbld', 17:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:00 INFO - 'MOZ_NO_REMOTE': '1', 17:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:00 INFO - 'NO_EM_RESTART': '1', 17:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:00 INFO - 'PWD': '/builds/slave/test', 17:16:00 INFO - 'SHELL': '/bin/bash', 17:16:00 INFO - 'SHLVL': '1', 17:16:00 INFO - 'TERM': 'linux', 17:16:00 INFO - 'TMOUT': '86400', 17:16:00 INFO - 'USER': 'cltbld', 17:16:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:00 INFO - '_': '/tools/buildbot/bin/python'} 17:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:16:00 INFO - Cleaning up... 17:16:00 INFO - Return code: 0 17:16:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:16:00 INFO - Using env: {'DISPLAY': ':0', 17:16:00 INFO - 'HOME': '/home/cltbld', 17:16:00 INFO - 'LANG': 'en_US.UTF-8', 17:16:00 INFO - 'LANGUAGE': 'en_US:en', 17:16:00 INFO - 'LOGNAME': 'cltbld', 17:16:00 INFO - 'MAIL': '/var/mail/cltbld', 17:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:00 INFO - 'MOZ_NO_REMOTE': '1', 17:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:00 INFO - 'NO_EM_RESTART': '1', 17:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:00 INFO - 'PWD': '/builds/slave/test', 17:16:00 INFO - 'SHELL': '/bin/bash', 17:16:00 INFO - 'SHLVL': '1', 17:16:00 INFO - 'TERM': 'linux', 17:16:00 INFO - 'TMOUT': '86400', 17:16:00 INFO - 'USER': 'cltbld', 17:16:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:00 INFO - '_': '/tools/buildbot/bin/python'} 17:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:00 INFO - Downloading/unpacking psutil>=0.7.1 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:02 INFO - Installing collected packages: psutil 17:16:02 INFO - Running setup.py install for psutil 17:16:02 INFO - building 'psutil._psutil_linux' extension 17:16:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:16:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:16:03 INFO - building 'psutil._psutil_posix' extension 17:16:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:16:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:16:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:03 INFO - Successfully installed psutil 17:16:03 INFO - Cleaning up... 17:16:03 INFO - Return code: 0 17:16:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:16:03 INFO - Using env: {'DISPLAY': ':0', 17:16:03 INFO - 'HOME': '/home/cltbld', 17:16:03 INFO - 'LANG': 'en_US.UTF-8', 17:16:03 INFO - 'LANGUAGE': 'en_US:en', 17:16:03 INFO - 'LOGNAME': 'cltbld', 17:16:03 INFO - 'MAIL': '/var/mail/cltbld', 17:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:03 INFO - 'MOZ_NO_REMOTE': '1', 17:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:03 INFO - 'NO_EM_RESTART': '1', 17:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:03 INFO - 'PWD': '/builds/slave/test', 17:16:03 INFO - 'SHELL': '/bin/bash', 17:16:03 INFO - 'SHLVL': '1', 17:16:03 INFO - 'TERM': 'linux', 17:16:03 INFO - 'TMOUT': '86400', 17:16:03 INFO - 'USER': 'cltbld', 17:16:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:03 INFO - '_': '/tools/buildbot/bin/python'} 17:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:16:05 INFO - Installing collected packages: mozsystemmonitor 17:16:05 INFO - Running setup.py install for mozsystemmonitor 17:16:05 INFO - Successfully installed mozsystemmonitor 17:16:05 INFO - Cleaning up... 17:16:05 INFO - Return code: 0 17:16:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:05 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 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:16:05 INFO - Using env: {'DISPLAY': ':0', 17:16:05 INFO - 'HOME': '/home/cltbld', 17:16:05 INFO - 'LANG': 'en_US.UTF-8', 17:16:05 INFO - 'LANGUAGE': 'en_US:en', 17:16:05 INFO - 'LOGNAME': 'cltbld', 17:16:05 INFO - 'MAIL': '/var/mail/cltbld', 17:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:05 INFO - 'MOZ_NO_REMOTE': '1', 17:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:05 INFO - 'NO_EM_RESTART': '1', 17:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:05 INFO - 'PWD': '/builds/slave/test', 17:16:05 INFO - 'SHELL': '/bin/bash', 17:16:05 INFO - 'SHLVL': '1', 17:16:05 INFO - 'TERM': 'linux', 17:16:05 INFO - 'TMOUT': '86400', 17:16:05 INFO - 'USER': 'cltbld', 17:16:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:05 INFO - '_': '/tools/buildbot/bin/python'} 17:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:05 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:08 INFO - Downloading docopt-0.6.1.tar.gz 17:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:16:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:16:08 INFO - Running setup.py install for blobuploader 17:16:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:16:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:16:08 INFO - Running setup.py install for requests 17:16:09 INFO - Running setup.py install for docopt 17:16:09 INFO - Successfully installed blobuploader requests docopt 17:16:09 INFO - Cleaning up... 17:16:09 INFO - Return code: 0 17:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:09 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 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:16:09 INFO - Using env: {'DISPLAY': ':0', 17:16:09 INFO - 'HOME': '/home/cltbld', 17:16:09 INFO - 'LANG': 'en_US.UTF-8', 17:16:09 INFO - 'LANGUAGE': 'en_US:en', 17:16:09 INFO - 'LOGNAME': 'cltbld', 17:16:09 INFO - 'MAIL': '/var/mail/cltbld', 17:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:09 INFO - 'MOZ_NO_REMOTE': '1', 17:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:09 INFO - 'NO_EM_RESTART': '1', 17:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:09 INFO - 'PWD': '/builds/slave/test', 17:16:09 INFO - 'SHELL': '/bin/bash', 17:16:09 INFO - 'SHLVL': '1', 17:16:09 INFO - 'TERM': 'linux', 17:16:09 INFO - 'TMOUT': '86400', 17:16:09 INFO - 'USER': 'cltbld', 17:16:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:09 INFO - '_': '/tools/buildbot/bin/python'} 17:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:09 INFO - Running setup.py (path:/tmp/pip-KEcbth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:09 INFO - Running setup.py (path:/tmp/pip-Ap5iz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:09 INFO - Running setup.py (path:/tmp/pip-d32lyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:09 INFO - Running setup.py (path:/tmp/pip-fQljVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:09 INFO - Running setup.py (path:/tmp/pip-b9JOMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:09 INFO - Running setup.py (path:/tmp/pip-C_C7ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:09 INFO - Running setup.py (path:/tmp/pip-Mh65Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:09 INFO - Running setup.py (path:/tmp/pip-TdVE4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:09 INFO - Running setup.py (path:/tmp/pip-EBVdin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:10 INFO - Running setup.py (path:/tmp/pip-OF4Wa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:10 INFO - Running setup.py (path:/tmp/pip-hM_Exm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:10 INFO - Running setup.py (path:/tmp/pip-jvsXQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:10 INFO - Running setup.py (path:/tmp/pip-xPUPYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:10 INFO - Running setup.py (path:/tmp/pip-yvvVi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:10 INFO - Running setup.py (path:/tmp/pip-gGPBE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:10 INFO - Running setup.py (path:/tmp/pip-WdmsaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:10 INFO - Running setup.py (path:/tmp/pip-WWoP1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:16:10 INFO - Running setup.py install for manifestparser 17:16:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:16:10 INFO - Running setup.py install for mozcrash 17:16:10 INFO - Running setup.py install for mozdebug 17:16:10 INFO - Running setup.py install for mozdevice 17:16:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for mozfile 17:16:11 INFO - Running setup.py install for mozhttpd 17:16:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for mozinfo 17:16:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for mozInstall 17:16:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for mozleak 17:16:11 INFO - Running setup.py install for mozlog 17:16:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for moznetwork 17:16:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for mozprocess 17:16:11 INFO - Running setup.py install for mozprofile 17:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:16:11 INFO - Running setup.py install for mozrunner 17:16:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:16:12 INFO - Running setup.py install for mozscreenshot 17:16:12 INFO - Running setup.py install for moztest 17:16:12 INFO - Running setup.py install for mozversion 17:16:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:16:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:16:12 INFO - Cleaning up... 17:16:12 INFO - Return code: 0 17:16:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:12 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 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:16:12 INFO - Using env: {'DISPLAY': ':0', 17:16:12 INFO - 'HOME': '/home/cltbld', 17:16:12 INFO - 'LANG': 'en_US.UTF-8', 17:16:12 INFO - 'LANGUAGE': 'en_US:en', 17:16:12 INFO - 'LOGNAME': 'cltbld', 17:16:12 INFO - 'MAIL': '/var/mail/cltbld', 17:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:12 INFO - 'MOZ_NO_REMOTE': '1', 17:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:12 INFO - 'NO_EM_RESTART': '1', 17:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:12 INFO - 'PWD': '/builds/slave/test', 17:16:12 INFO - 'SHELL': '/bin/bash', 17:16:12 INFO - 'SHLVL': '1', 17:16:12 INFO - 'TERM': 'linux', 17:16:12 INFO - 'TMOUT': '86400', 17:16:12 INFO - 'USER': 'cltbld', 17:16:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:12 INFO - '_': '/tools/buildbot/bin/python'} 17:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:16:12 INFO - Running setup.py (path:/tmp/pip-5AESJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:16:12 INFO - Running setup.py (path:/tmp/pip-Pk9qC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:16:12 INFO - Running setup.py (path:/tmp/pip-zQT7lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:16:12 INFO - Running setup.py (path:/tmp/pip-EBNWDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:16:12 INFO - Running setup.py (path:/tmp/pip-Kq8f6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:16:13 INFO - Running setup.py (path:/tmp/pip-ybptIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:16:13 INFO - Running setup.py (path:/tmp/pip-RzHc8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:16:13 INFO - Running setup.py (path:/tmp/pip-XhJ4U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:16:13 INFO - Running setup.py (path:/tmp/pip-ccc05o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:16:13 INFO - Running setup.py (path:/tmp/pip-atZaDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:16:13 INFO - Running setup.py (path:/tmp/pip-068v5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:16:13 INFO - Running setup.py (path:/tmp/pip-Ecgvtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:16:13 INFO - Running setup.py (path:/tmp/pip-hNdwV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:16:13 INFO - Running setup.py (path:/tmp/pip-JvrESJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:13 INFO - Running setup.py (path:/tmp/pip-YtEQSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:16:13 INFO - Running setup.py (path:/tmp/pip-odFgEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:16:13 INFO - Running setup.py (path:/tmp/pip-S_yCh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:16:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:15 INFO - Downloading blessings-1.6.tar.gz 17:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:15 INFO - Installing collected packages: blessings 17:16:15 INFO - Running setup.py install for blessings 17:16:15 INFO - Successfully installed blessings 17:16:15 INFO - Cleaning up... 17:16:16 INFO - Return code: 0 17:16:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:16 INFO - Reading from file tmpfile_stdout 17:16:16 INFO - Current package versions: 17:16:16 INFO - argparse == 1.2.1 17:16:16 INFO - blessings == 1.6 17:16:16 INFO - blobuploader == 1.2.4 17:16:16 INFO - docopt == 0.6.1 17:16:16 INFO - manifestparser == 1.1 17:16:16 INFO - mozInstall == 1.12 17:16:16 INFO - mozcrash == 0.17 17:16:16 INFO - mozdebug == 0.1 17:16:16 INFO - mozdevice == 0.48 17:16:16 INFO - mozfile == 1.2 17:16:16 INFO - mozhttpd == 0.7 17:16:16 INFO - mozinfo == 0.9 17:16:16 INFO - mozleak == 0.1 17:16:16 INFO - mozlog == 3.1 17:16:16 INFO - moznetwork == 0.27 17:16:16 INFO - mozprocess == 0.22 17:16:16 INFO - mozprofile == 0.28 17:16:16 INFO - mozrunner == 6.11 17:16:16 INFO - mozscreenshot == 0.1 17:16:16 INFO - mozsystemmonitor == 0.0 17:16:16 INFO - moztest == 0.7 17:16:16 INFO - mozversion == 1.4 17:16:16 INFO - psutil == 3.1.1 17:16:16 INFO - requests == 1.2.3 17:16:16 INFO - wsgiref == 0.1.2 17:16:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 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 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:16:16 INFO - Using env: {'DISPLAY': ':0', 17:16:16 INFO - 'HOME': '/home/cltbld', 17:16:16 INFO - 'LANG': 'en_US.UTF-8', 17:16:16 INFO - 'LANGUAGE': 'en_US:en', 17:16:16 INFO - 'LOGNAME': 'cltbld', 17:16:16 INFO - 'MAIL': '/var/mail/cltbld', 17:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:16 INFO - 'MOZ_NO_REMOTE': '1', 17:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:16 INFO - 'NO_EM_RESTART': '1', 17:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:16 INFO - 'PWD': '/builds/slave/test', 17:16:16 INFO - 'SHELL': '/bin/bash', 17:16:16 INFO - 'SHLVL': '1', 17:16:16 INFO - 'TERM': 'linux', 17:16:16 INFO - 'TMOUT': '86400', 17:16:16 INFO - 'USER': 'cltbld', 17:16:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:16 INFO - '_': '/tools/buildbot/bin/python'} 17:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:16:16 INFO - Cleaning up... 17:16:16 INFO - Return code: 0 17:16:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 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 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:16:16 INFO - Using env: {'DISPLAY': ':0', 17:16:16 INFO - 'HOME': '/home/cltbld', 17:16:16 INFO - 'LANG': 'en_US.UTF-8', 17:16:16 INFO - 'LANGUAGE': 'en_US:en', 17:16:16 INFO - 'LOGNAME': 'cltbld', 17:16:16 INFO - 'MAIL': '/var/mail/cltbld', 17:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:16 INFO - 'MOZ_NO_REMOTE': '1', 17:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:16 INFO - 'NO_EM_RESTART': '1', 17:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:16 INFO - 'PWD': '/builds/slave/test', 17:16:16 INFO - 'SHELL': '/bin/bash', 17:16:16 INFO - 'SHLVL': '1', 17:16:16 INFO - 'TERM': 'linux', 17:16:16 INFO - 'TMOUT': '86400', 17:16:16 INFO - 'USER': 'cltbld', 17:16:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:16 INFO - '_': '/tools/buildbot/bin/python'} 17:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:16 INFO - Downloading/unpacking jsonschema 17:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:18 INFO - Downloading/unpacking functools32 (from jsonschema) 17:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:19 INFO - warning: no files found matching '*.txt' 17:16:19 INFO - no previously-included directories found matching 'build' 17:16:19 INFO - no previously-included directories found matching 'dist' 17:16:19 INFO - no previously-included directories found matching '.git*' 17:16:19 INFO - Installing collected packages: jsonschema, functools32 17:16:19 INFO - Running setup.py install for functools32 17:16:19 INFO - warning: no files found matching '*.txt' 17:16:19 INFO - no previously-included directories found matching 'build' 17:16:19 INFO - no previously-included directories found matching 'dist' 17:16:19 INFO - no previously-included directories found matching '.git*' 17:16:19 INFO - Successfully installed jsonschema functools32 17:16:19 INFO - Cleaning up... 17:16:19 INFO - Return code: 0 17:16:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4df54eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2743770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, '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': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:16:19 INFO - Using env: {'DISPLAY': ':0', 17:16:19 INFO - 'HOME': '/home/cltbld', 17:16:19 INFO - 'LANG': 'en_US.UTF-8', 17:16:19 INFO - 'LANGUAGE': 'en_US:en', 17:16:19 INFO - 'LOGNAME': 'cltbld', 17:16:19 INFO - 'MAIL': '/var/mail/cltbld', 17:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:19 INFO - 'MOZ_NO_REMOTE': '1', 17:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:19 INFO - 'NO_EM_RESTART': '1', 17:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:19 INFO - 'PWD': '/builds/slave/test', 17:16:19 INFO - 'SHELL': '/bin/bash', 17:16:19 INFO - 'SHLVL': '1', 17:16:19 INFO - 'TERM': 'linux', 17:16:19 INFO - 'TMOUT': '86400', 17:16:19 INFO - 'USER': 'cltbld', 17:16:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:19 INFO - '_': '/tools/buildbot/bin/python'} 17:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:19 INFO - Downloading/unpacking flake8 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:16:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:16:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:16:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:22 INFO - no previously-included directories found matching 'docs/_build' 17:16:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:16:22 INFO - Running setup.py install for pep8 17:16:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:22 INFO - no previously-included directories found matching 'docs/_build' 17:16:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:16:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:16:22 INFO - Cleaning up... 17:16:22 INFO - Return code: 0 17:16:22 INFO - Running post-action listener: _resource_record_post_action 17:16:22 INFO - Running post-action listener: _start_resource_monitoring 17:16:22 INFO - Starting resource monitoring. 17:16:22 INFO - ##### 17:16:22 INFO - ##### Finished create-virtualenv step (success) 17:16:22 INFO - ##### 17:16:22 INFO - ##### 17:16:22 INFO - ##### Running install step. 17:16:22 INFO - ##### 17:16:22 INFO - Running pre-action listener: _resource_record_pre_action 17:16:22 INFO - Running main action method: install 17:16:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:22 INFO - Reading from file tmpfile_stdout 17:16:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:22 INFO - Reading from file tmpfile_stdout 17:16:22 INFO - Output received: 17:16:22 INFO - Usage: mozinstall [options] installer 17:16:22 INFO - Options: 17:16:22 INFO - -h, --help show this help message and exit 17:16:22 INFO - -d DEST, --destination=DEST 17:16:22 INFO - Directory to install application into. [default: 17:16:22 INFO - "/builds/slave/test"] 17:16:22 INFO - --app=APP Application being installed. [default: firefox] 17:16:22 INFO - mkdir: /builds/slave/test/build/application 17:16:22 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'] 17:16:22 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 17:16:38 INFO - Reading from file tmpfile_stdout 17:16:38 INFO - Output received: 17:16:38 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:38 INFO - Running post-action listener: _resource_record_post_action 17:16:38 INFO - ##### 17:16:38 INFO - ##### Finished install step (success) 17:16:38 INFO - ##### 17:16:38 INFO - ##### 17:16:38 INFO - ##### Running run-tests step. 17:16:38 INFO - ##### 17:16:38 INFO - Running pre-action listener: _resource_record_pre_action 17:16:38 INFO - Running main action method: run_tests 17:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:38 INFO - Python 2.7.3 17:16:38 INFO - Return code: 0 17:16:38 INFO - grabbing minidump binary from tooltool 17:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:38 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 0x27d29c0>, '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 0x27d38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:16:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:16:38 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 17:16:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:38 INFO - Return code: 0 17:16:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:16:39 INFO - Return code: 0 17:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 17:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 17:16:39 INFO - Using env: {'DISPLAY': ':0', 17:16:39 INFO - 'HOME': '/home/cltbld', 17:16:39 INFO - 'LANG': 'en_US.UTF-8', 17:16:39 INFO - 'LANGUAGE': 'en_US:en', 17:16:39 INFO - 'LOGNAME': 'cltbld', 17:16:39 INFO - 'MAIL': '/var/mail/cltbld', 17:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:39 INFO - 'MOZ_NO_REMOTE': '1', 17:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:39 INFO - 'NO_EM_RESTART': '1', 17:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:39 INFO - 'PWD': '/builds/slave/test', 17:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:39 INFO - 'SHELL': '/bin/bash', 17:16:39 INFO - 'SHLVL': '1', 17:16:39 INFO - 'TERM': 'linux', 17:16:39 INFO - 'TMOUT': '86400', 17:16:39 INFO - 'USER': 'cltbld', 17:16:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606', 17:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:39 INFO - '_': '/tools/buildbot/bin/python'} 17:16:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 17:16:39 INFO - mozversion application_buildid: 20160510162116 17:16:39 INFO - mozversion application_changeset: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb 17:16:39 INFO - mozversion application_display_name: Nightly 17:16:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:39 INFO - mozversion application_name: Firefox 17:16:39 INFO - mozversion application_remotingname: firefox 17:16:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:39 INFO - mozversion application_vendor: Mozilla 17:16:39 INFO - mozversion application_version: 49.0a1 17:16:39 INFO - mozversion platform_buildid: 20160510162116 17:16:39 INFO - mozversion platform_changeset: d8df7fcffeb14796b272feb5cb24b1c15dcf67cb 17:16:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:39 INFO - mozversion platform_version: 49.0a1 17:16:39 INFO - using testdate: 1462925799 17:16:39 INFO - actual date: 1462925799 17:16:39 INFO - starting webserver on 'localhost:60155' 17:16:39 INFO - SUITE-START | Running 2 tests 17:16:39 INFO - TEST-START | dromaeo_css 17:16:39 INFO - operating with platform_type : linux_ 17:16:39 INFO - Initialising browser for dromaeo_css test... 17:16:39 INFO - TEST-INFO | started process 1735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbdinw/profile http://localhost:60155/getInfo.html) 17:16:43 INFO - PROCESS | 1735 | 17:16:43 INFO - PROCESS | 1735 | (process:1806): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:16:44 INFO - PROCESS | 1735 | __metrics Screen width/height:1600/1200 17:16:44 INFO - PROCESS | 1735 | colorDepth:24 17:16:44 INFO - PROCESS | 1735 | Browser inner width/height: 1024/697 17:16:44 INFO - PROCESS | 1735 | __metrics 17:16:45 ERROR - PROCESS | 1735 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:16:45 INFO - TEST-INFO | 1735: exit 0 17:16:45 INFO - Browser initialized. 17:16:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:45 INFO - TEST-INFO | started process 1857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbdinw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:48 INFO - PROCESS | 1857 | 17:16:48 INFO - PROCESS | 1857 | (process:1919): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:16:58 INFO - PROCESS | 1857 | RSS: Main: 164159488 17:16:58 INFO - PROCESS | 1857 | 17:17:47 INFO - PROCESS | 1857 | 1462925867628 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:19:59 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:60155/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60155/tests/dromaeo/cssquery-ext.html) 17:20:00 INFO - PROCESS | 1857 | RSS: Main: 165711872 17:20:00 INFO - PROCESS | 1857 | 17:23:02 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:60155/tests/dromaeo/cssquery-ext.html (next: http://localhost:60155/tests/dromaeo/cssquery-jquery.html) 17:23:02 INFO - PROCESS | 1857 | RSS: Main: 166428672 17:23:02 INFO - PROCESS | 1857 | 17:26:04 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:60155/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60155/tests/dromaeo/cssquery-mootools.html) 17:26:05 INFO - PROCESS | 1857 | RSS: Main: 167452672 17:26:05 INFO - PROCESS | 1857 | 17:29:07 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:60155/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60155/tests/dromaeo/cssquery-prototype.html) 17:29:08 INFO - PROCESS | 1857 | RSS: Main: 165044224 17:29:08 INFO - PROCESS | 1857 | 17:32:10 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:60155/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60155/tests/dromaeo/cssquery-yui.html) 17:32:11 INFO - PROCESS | 1857 | RSS: Main: 166400000 17:32:11 INFO - PROCESS | 1857 | 17:35:13 INFO - PROCESS | 1857 | Cycle 1(1): loaded http://localhost:60155/tests/dromaeo/cssquery-yui.html (next: http://localhost:60155/tests/dromaeo/cssquery-dojo.html) 17:35:14 INFO - PROCESS | 1857 | RSS: Main: 168394752 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | __start_tp_report 17:35:14 INFO - PROCESS | 1857 | _x_x_mozilla_page_load 17:35:14 INFO - PROCESS | 1857 | _x_x_mozilla_page_load_details 17:35:14 INFO - PROCESS | 1857 | |i|pagename|runs| 17:35:14 INFO - PROCESS | 1857 | |0;dojo.html;2621.0433191884968;2626.9474610507777;2644.6297518347433;2675.8929642814287;2688.811783175178;4671.112488627163;4689.085628302478;4719.787609557569;4769.260764581487;4826.9758651206785;4770.475247722757;4794.1610218211845;4835.588974937125;4886.877828054292;4892.584130348924;4459.732416055039;4491.169133710274;4608.884777880563;4615.238485649864;4628.028114096044;454.3953861882305;4375.7374557526655;4401.097774956126;4459.219636563605;4461.843835465759;4464.8883777905485;4489.865304040868;4506.4817545982305;4509.278515437531;4560.475545312265;4495.887602809923;4506.684532082755;4511.233090374644;4530.841420550265;4540.27355623102;4350.956490435086;4434.979954610458;4437.2900335946415;4476.709013914117;4494.146112238697;4735.242361222222;4747.264174053027;4765.189917713997;4776.8566942991765;4833.709977401367;5110.156824124015;5227.032998895179;5239.607029472767;5245.370555533361;5301.761420736076;5103.030424219423;5128.974355128238;5181.145111056671;5186.92219616706;5196.272521846944;4826.517348265145;4838.104950584118;4843.370361852972;4874.0495603357;4904.386951631046;5121.0014047261175;5310.893782124336;5367.329083864517;5400.081986062379;5402;5115.258287548285;5121.103806833789;5126.615503837227;5133.307003554547;5180.9740951295;5221.164613661796;5237.633365664443;5240.213967904845;5244.056069907377;5306.09796334624;4975.502449755068;5158.148905430562;5166.354205724285;5184;5198.844034678966;4991.650584459053;4999.900001999939;5005.799768009311;5027.497250274943;5041.0422019816115;4370.453693288339;4376.671749618791;4379.846705365297;4415.492218394926;4425.137098265807;3732.5147730794824;3817.9236415272094;3861.613838616172;3868.7485313454536;3895.02624343914;4434.490033646108;4444.599986001275;4448.288273876165;4463.24124898768;4523.411956445641;5243.370795504487;5293.417724050351;5299.311089558333;5304.522592966574;5316.362036555638;4307.935380969288;4361.520232774392;4362.585554372329;4403.867883963486;4407.845725399596;4579.107074120515;4607.815687372535;4622.699524530894;4629.768511574408;4657.883552911204;4738.218193997952;4815.277708343707;4839.177339852163;4846.176150054499;4866.562009419098;5134.998675258289;5269.920951185659;5306.761195746278;5323.2547443358735;5334.973325133349;4937.8271760488215;4952.702837829742;4970.055689418999;4975.800967961241;5030.522100400456;4936.75316234194;5199.142141546602;5225.059489291812;5230.895382092261;5236.816711415082;5228.790848366023;5272.55183309423;5295.7087360195555;5296.152615581488;5302.3637163540625;5112.74436278192;5129.230615407719;5129.589632829439;5133.948660513347;5186.962607478595;4848.200046992207;5076.162433198629;5134.7175905324075;5155.53600175986;5162;5032.899342013213;5062.898742025212;5067.41724701664;5088.262201980766;5139.280500729826;5175.171972484384;5185.185185185306;5188.610854186027;5200.947990520046;5251.975864706345;4826.710397376169;4965.155923492943;5012.974935125301;5070.645054846273;5086.720230387365 17:35:14 INFO - PROCESS | 1857 | |1;ext.html;567.3135506037694;603.5141710922707;612.4640939178219;623.5230049012504;659.6734616364894;37701.43447848281;38937.61062389375;41894.99999999996;41962.16075678485;42120.36819447711;42280;42668.57331426685;42773.358399624034;43068.13863722724;43179;7855.332296754783;8014;8022.19778022199;8026.638801253928;8028.478148920331;7721.498102623312;7726.381889448859;7792.259735325135;7810.882836757453;7816.101148367954;7740.993670822785;7782.299593036626;7785.299323060924;7787.221277872196;7799.688012479494;7711.267429594208;7764.961175194117;7768.145503994556;7786.7663970080985;7801.414893882981;7839.608019598997;7871.409644276645;7902.723404680809;7902.802429939297;7906.44654874159;39426.408603870965;39844;39847.80076099601;39904.600953990375;39917.60082399168;3083.583716198307;3186.8725250989933;3232.7575431842706;3299.3236386540702;3625.854965801365;30000.849995749883;30241.546376804366;30753.69246307553;30773.538396924065;31360.529592056137;3181.8568164432654;3196.6963138502038;3215.5819743433203;3218.5815843940372;3238.8542515586855;231512;232599;233206;234746;234767.82616086982;33888.15279618029;34973.82513087418;55254.17118743222;56012.719936400055;56026.43973560294;36271.63728362735;36378.818105909304;36504.26991460156;36567;36573.81713091471;13293.800592991112;13311.201327920357;13482.19106853592;13496.39266233022;13570.525031624044;10053.396796192106;10103.7474063149;10143.442110683836;10206.23453240995;10246.129079028216;8377.916220837835;8478.957605211934;8492.278156356655;8493.702720404755;8590;3313.784604000732;3325.467925131967;3342.665733426638;3343.9164020899184;3362.2266878618057;902.4946030223097;950.339514037751;1048.0410424461531;1063.6170978447753;1090.9727256818485;29256.707432925825;29764;29833.40333193324;30268;30338.84830575833;984.3011461862158;1021.7547788530699;1057.3444464432102;1067.4075887882145;1081.561967403203;15699.764503532457;15852.365905363888;15903.59523560219;15962.122083285298;16068.839311606967;344428;347465;348971;349491;350139;53348.46651533512;53405.1989220162;53417.1987420189;53930.73034634802;54089.459105408445;1273.8662440443804;1281.5130250504935;1295.617792751122;1299.5516546791341;1306.7255876265901;27082;28463;29018.7098129016;29261.41477170402;29299;45587;45644;45839.54160458353;46109.077818444115;46243;299294;299909;300128;300243;300454;26850.194494165207;27093.322666933484;28238.294042649097;28291.57562636521;29354.853225733736;42997.57002430061;43368.56631433645;43774;44120.33819492646;44738.55261447344;37435.202727359596;38001.42997854979;38819.80590097144;39027.41458878176;39642.40536391899;37183.07042323964;37659.81170094132;38365;38688.6131138685;39255.41116883192;37011;37442.43836342402;37491.62508374881;37541;38025.4296185563;32846.67153328436;34496.655033449344;34690.47964280487;35124;35203.29593408169;25169.119080832083;25559.87220063962;25565.616515751906;25888;25946.091886783874 17:35:14 INFO - PROCESS | 1857 | |2;jquery.html;387.53302270763714;393.8739603326935;394.8657456464802;399.06220382102043;406.6238729175512;13142.802857957138;16140.91929540352;16281.185940702948;17575.472735817915;17613.55966100848;16915.1542422879;16978.660426791455;17201.82798172018;18029.7295540567;18081;4962.0820148272505;5109.335786347779;5245.816396426126;5249.632525723201;5259.132243179871;5215.061288967984;5240.161574148137;5240.44975277596;5249.028929648009;5257.421683614799;5162.6902385856965;5407.621466497347;5410.404855465896;5413.377461591928;5427.213054107152;5233.476652334774;5342.759575819078;5351.759170837302;5370.892582148354;5398.838034858961;5383.973080134574;5394.730263486849;5401.162819762943;5403.297571315743;5407.188921661743;12065.517379304818;12278.140530162893;12581.182223155558;12672.936635316764;12701.110922235448;1954.8729332593336;2020.111151093514;2039.7246371739923;2063.556335387899;2119.3218170185546;9273.119053689956;9691.563879625433;9714.125728684381;12458.875411245952;12826.781455761688;1792.865535084874;1827.3330234464458;1857.907104644776;1865.9626807463774;1884.8397886179555;67872;68341;68581.314186858;70672.64663676648;71359.64320178417;9459.905400945903;9525.618975240914;9551.952240238754;9688;9865.654702085392;12170.574029909088;13086.607401777961;13098.607041788762;13132.080754347295;13356.73286534264;7132.643367831588;7161.785146445615;7252.601106939063;7270.600116993511;7390.371818395389;6894.448444124559;6913.585184888922;6992;7057.329553692391;7111.075560177143;4323.4379530661445;4329.155814616182;4389.582989615981;4490.259107247268;4552.772361381918;1850.7223916412377;1881.9435416937513;1931.671615825313;1940.223910435837;1941.5825597496605;393.0311781458718;398.2095540352398;441.1375760388433;816.6570040582969;920.4155361345594;10344.275900687031;10726.946365268124;10749.570017199225;10836.86212947629;10913.23607347494;427.0753817984092;428.594977746027;434.15556742136874;445.45654301751813;451.4266881061034;5687.573431992617;5724.971375143181;5735.1392099206;5757.704516483841;5879.265091863517;420437;427115;446274;447435;453135;83090.58454707809;84425.15574844296;84519;84868;85306;436.2300539547701;442.7697597249348;444.83096423358916;445.100896189695;446.18793795292254;9806.460644664612;9886.703398898044;10044.49777511107;10124.746881328027;10220.97790220972;34476;34634.48048279328;34742.82628586841;34838.65161348354;35554;51308.48691513037;52801.735991319794;53437.93124137573;53859;54097.72951135219;7402.592857392679;7480.476366654282;7578.962105189439;7579.5073320234005;7638.388928885564;10256.17950563968;11541.307521548733;11594.188406811441;12233.3271670059;12303.75392492163;10197.9490102549;10542.103921166787;10669.839952400875;10935.23453358289;11026.062784663394;10847.837282440612;10968.23222374458;10998.505067272152;11123;11131.83302250483;10731.946340268249;11068.391238481961;11114.888851111386;11163.49764260594;11386.601468948547;7952.522848629101;7998.920010799818;8152;8163.959180204061;8275.917240827755;8142.8778568322705;10025.749356266151;10631.8936810634;10643;10918.672439826818 17:35:14 INFO - PROCESS | 1857 | |3;mootools.html;1506.7739839024146;1522.4899658614363;1745.6595963787058;1847.5104097414196;1883.5667796406826;6724.495662825296;7517.774466766005;7593.2027137150635;8159.796005099868;8173.1418201088845;7746.496477728943;7942.086660034098;7958.92041079589;8021;8024.91975080249;2221.44463884029;2254.0983606557343;2254.7068881045443;2256.616375216209;2259.536794957038;2202.0751284460484;2203.3500117465305;2247.550489902018;2248.6402175651897;2260.2654137405325;2174.1194816099505;2182.0726191368685;2185.1914791527156;2205.691203231549;2239.428945618865;2153.698482212476;2195.681626164205;2197.7802219777973;2203.537257175995;2204.2285200179967;2168.6313326734494;2173.478365192358;2173.5544213436365;2173.9565208695894;2194.6049711052165;7942.28519433248;7970.322522585587;7985.560794156319;7990.800229994296;8006.599670016534;4741.217699079648;4861.17360048789;4884;4888.388951381077;4907.288443175756;2793.9301517462022;2958.733713965732;2975.7024297570288;2988.8505574721175;2991.641003079623;881.180502133016;885.7431344910033;901.441106513959;937.3906960475678;937.5031233446284;10022.54898529568;10248.282620216587;10271;10275.691729248134;10675.145988320994;4295.548967358445;4376.234159022159;4393.956060439355;4441.555844415532;4457.888552786141;9123.863142052875;9157.45055296671;9182.449053056838;9203.309751768644;9206.033366496555;4730.834420795256;4752.334673145693;4767.380240568704;4772.069446457907;4792.9281060784115;3753.0617345663586;4249.745015299092;4347.804348804311;4363.192809330284;4399.296112621965;3686.8156592170285;3717.5910649828497;3823.8661646842784;3829.5978922213326;3949.30887094763;1227.1777908801125;1235.3020543392954;1239.3803098450774;1262.81689155072;1270.6658009090418;919.5264438814016;943.5376665433888;950.7765675066354;958.6884262614539;959.4003747657714;5492.642978206404;5554.444555544494;5667.614903507819;5708.628939118944;5813.680247586423;400.50337581398855;410.046641558378;410.30453381518635;418.4852631263502;420.5038055095017;3734.533183352081;3881.922361552753;3884.5532763731967;3938.5667576566557;3962;9428.245740340757;9667.468289244018;9681.467519286507;9777.608895644236;9796.755081123029;8995.77510562228;9424.858627120599;9646;9681.273904457054;9780.31537792362;7238.855222895512;7411.0736157980255;7425.517341372685;7450.329470347695;7452.925470745223;5527.778888844401;5700.686462244616;5766.077427611562;5782.13268009785;5857.882842343044;8852.55737213124;9120.77198070027;9123.361364704673;9216.769580760534;9224.769380765267;9096.135867092615;9241.58412871409;9273.165415112673;9360.20438262728;9387.249020078241;6810.114685090906;7083.0791997042115;7112.537685050455;7129.5365801224825;7177.102862142232;7290.708371665286;7317.195108538163;7322.670479828527;7371.668274927534;7379.298966598165;6358.554901156875;6431.485481161402;6527.738890444329;6571.145751052332;6659.067730517828;6792.083068785848;6805.251422343439;6876.656167191721;6982.79051628452;7096.396806271525;6420.357964203542;6644.136262285871;6658.267590564937;6724.991251312146;6788.660566971533;4839.395075615548;4918.188498897642;4948.529889660476;4958.231474121517;4981.701097934136;4824.059308434821;4850.466448690711;4933.136701077226;4948.653594248368;4960.528749768766 17:35:14 INFO - PROCESS | 1857 | |4;prototype.html;315.1946775987352;322.44861287198887;323.3694296122561;330.8544240534163;335.17379659140215;4968.999999999995;5006.474320196382;5007.399112106543;5026.3214466047075;5027.597792176626;4943.431505376882;4953;4956.776945037473;4970.353853998975;4995.875103122424;3730.2725968436234;3799.164183879556;3888.202918401721;3896.941545876814;3904.609539046087;3902.8829135125993;3904.4338570907203;3926.803659816998;3937.1535119949203;3944.329463991114;3909.7654140751647;3919.666828319582;3920.627540383659;3923.646871781539;3948.5261768587666;3841.2317536492533;3888.8833334999995;3896.5908579599018;3948.4077388391684;3957.2085582883537;3435.1927297085167;3462.774919630216;3483.6936148944146;3489.4068008438626;3503.929921401583;4672.672912896099;4677.74272415017;4678.602318802906;4679.321498382749;4710.034442939189;4333.4832808517085;4469.284914413711;4472.396226509412;4480.342273358878;4488.371627972087;5091.287219789232;5108.361454818148;5124.590032797368;5132.743362831843;5159.509846564571;3785.9242815143816;3805.1818858945185;3816.1985982943615;3818.6754125899333;3825.7895815730126;5354.179578943178;5368.651037682577;5377.354717433933;5399.811006614789;5413.323334583177;3792.6017768133947;3864.787436691009;3876.302265592164;3891.2217556488818;3897.142628621699;3911;3927.116398810245;3935.2129574085297;3947.7631342119566;3951.6838652908273;4374.796930844043;4407;4415.690901636919;4422.977885110554;4425.09285596452;4967.4784147664695;5127.435982041972;5144.819931302386;5163.7676304566385;5183.118869792144;1354.106289848695;1354.966125846842;1355.654308151415;1359.3135466589308;1368.9726205475836;851.9233269005696;879.4723166100416;901.7339884733888;915.56053094515;928.0209379104974;4428.914915845574;4506.369108324837;4551.6813823032735;4557.772111394417;4590.862274131781;5345.973270133624;5355.544778693777;5390.110631745796;5392.946070539323;5398.217258497496;4459.900369243344;4525.253333200051;4540.72755634663;4541.5231400703115;4552.476465206543;2843.2039029071893;2859.2994716294224;2882.827030378184;2891.85540722963;2898.942021159565;5043.520865517843;5044.344235249468;5075.492450754895;5075.792030466759;5125.846224613268;5228.732042473454;5493.533049690741;5506.834794956158;5538.280023596906;5578.246936663499;5071.949280507221;5085.618578606619;5090.541851233407;5100.974495127501;5118.8976220476125;5395.487428694268;5438.347398312069;5446.727663616883;5449.700266485382;5458.454154584669;5198.141022437569;5285.207218917193;5293.438435661412;5338.572914166935;5346.919796202982;5044.54599086084;5057.494250574913;5084;5114.411842638145;5133.743312834269;3948.763074215556;3959.92080158401;3961.5642279349827;3964.4251583520804;3986.32232520478;5314.707691076873;5382.650127741685;5393.487618676219;5399.352077750695;5437.972810135924;5153.4073581538605;5178.404483484447;5252.107141785982;5260.237265596544;5261.237120617412;5182.53357197854;5182.766775495187;5196.298499702491;5204.271402003798;5246.501582349671;4942.505749425172;5112.463191365002;5125.386053113014;5150.768215430239;5155.381354237516;5113.92329115071;5157.458466861076;5265.289185959847;5292.073887069824;5292.550133238564;5176.456472070378;5182.663126896739;5187.610929180402;5190.714510701948;5206.97396513015 17:35:14 INFO - PROCESS | 1857 | |5;yui.html;629.3769168523163;657.0997733105646;700.1668015062075;706.8550947055851;717.8707832590134;9543.47510886901;11889.76220475591;12663.873361266385;12668.746625067493;13005;14227.288635568231;14396.28018599071;14397.280135993211;14408.423663053465;14420.206888621122;878.5080355001204;890.1676932068505;890.8262888736699;891.3092353426082;892.018779342721;865.4634126841368;869.4131461263622;871.6861929705333;875.2560323724847;877.5129802959354;922.9861552076724;925.7870689741363;927.1053433436732;929.0802105915163;929.8419268724299;885.7608445719684;907.4283201583027;915.6474757218452;916.0244339778116;916.724982505249;661.52039771166;665.866826634675;666.8799616069106;669.5112567825514;669.9531032827704;12062.457189426497;12091;12093;12100.576479823252;12119.272843629411;12428.875711242863;12835;12914.610797002584;13030.283334416603;13104.934475327658;9600.519974001272;9663.468509231989;9774;9796.804063918682;9904.653337133166;3170.6036745406823;3235.8705651773903;3240.287136829894;3273.0017344709854;3273.8690452381875;49344.50655493435;49504.50495495071;50590.7470462649;50831.49168508305;50832.237516437286;10308.845367319496;10385.532651030722;10464.00591943764;10536.420496872746;10624.521896514676;17890.373836915645;18194.90902545479;18217.63564728698;18250;18608.16263268156;6970.372666460043;6978.197507286727;7039.54242974205;7041.436685065182;7043.225245223021;3959.1883663848844;3961.168154687548;3965.1871366369824;3985.1830374773103;4047.0489434982755;2798.398344355973;2877.798554101235;2888.8411137387225;2889.1621429785546;2908.0548821633056;475.3535192138689;488.34561687339135;490.8920037591724;500.812195426715;504.2813990064144;613.1752792494177;632.1781683811028;637.2575949019433;640.5804198250154;647.9125318082093;7739.458237923292;8016.559089250147;8180.14108518597;8238.546879921541;8385.95807020961;574.6236215278999;605.4218221598451;618.8143556932993;625.7121724006917;642.6915080761167;3971.9801400993388;3998.28030954431;4052.1490486997473;4052.959470405317;4129.112240868228;51322;51835.74082129565;51917;51931;53526.46473535293;45117.774411127735;46024;46131.53868461272;46489.767551162025;47019.29471057937;42360.1527969445;42856;43098.56901431008;43281.56718432775;43384.78307608505;8151.633176506953;8153.388495862952;8225.424220304521;8286.295664868554;8564;25482;26739.598906016814;26872.193834185007;29243.26891827636;29815.85092074526;36655.81672091623;37125.443118352705;37218.44172337363;37541.81229093837;38160.23679526449;10978.12175026012;10993.670189894316;11019.206645109403;11644.301341919512;11757.176997610086;11704.94147529291;11880.168388212742;11898;12265.325407102338;12891.935540322613;11128.44357782124;11312.095032397225;11364.54541818351;11573.537058517903;11958.940205298917;11243;11567.88432115668;11647.12646551529;11673.416329183678;11689.473973671034;11132.955399493414;11223.214374993999;11302.321860688386;11317.264377815745;11426.314421134759;9525.237980961369;9576.664816731382;9597.58302171819;9742.610295588098;9865.26010549226;9531.38046027006;9697.854532181882;9717.80564388694;9996.700098997042;10002.44986525748 17:35:14 INFO - PROCESS | 1857 | __end_tp_report 17:35:14 INFO - PROCESS | 1857 | __start_cc_report 17:35:14 INFO - PROCESS | 1857 | _x_x_mozilla_cycle_collect,383 17:35:14 INFO - PROCESS | 1857 | __end_cc_report 17:35:14 INFO - PROCESS | 1857 | __startTimestamp1462926914236__endTimestamp 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | ------- Summary: start ------- 17:35:14 INFO - PROCESS | 1857 | Number of tests: 6 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | [#0] dojo.html Cycles:165 Average:4779.19 Median:4936.75 stddev:623.72 (12.6%) stddev-sans-first:602.22 17:35:14 INFO - PROCESS | 1857 | Values: 2621.0 2626.9 2644.6 2675.9 2688.8 4671.1 4689.1 4719.8 4769.3 4827.0 4770.5 4794.2 4835.6 4886.9 4892.6 4459.7 4491.2 4608.9 4615.2 4628.0 454.4 4375.7 4401.1 4459.2 4461.8 4464.9 4489.9 4506.5 4509.3 4560.5 4495.9 4506.7 4511.2 4530.8 4540.3 4351.0 4435.0 4437.3 4476.7 4494.1 4735.2 4747.3 4765.2 4776.9 4833.7 5110.2 5227.0 5239.6 5245.4 5301.8 5103.0 5129.0 5181.1 5186.9 5196.3 4826.5 4838.1 4843.4 4874.0 4904.4 5121.0 5310.9 5367.3 5400.1 5402.0 5115.3 5121.1 5126.6 5133.3 5181.0 5221.2 5237.6 5240.2 5244.1 5306.1 4975.5 5158.1 5166.4 5184.0 5198.8 4991.7 4999.9 5005.8 5027.5 5041.0 4370.5 4376.7 4379.8 4415.5 4425.1 3732.5 3817.9 3861.6 3868.7 3895.0 4434.5 4444.6 4448.3 4463.2 4523.4 5243.4 5293.4 5299.3 5304.5 5316.4 4307.9 4361.5 4362.6 4403.9 4407.8 4579.1 4607.8 4622.7 4629.8 4657.9 4738.2 4815.3 4839.2 4846.2 4866.6 5135.0 5269.9 5306.8 5323.3 5335.0 4937.8 4952.7 4970.1 4975.8 5030.5 4936.8 5199.1 5225.1 5230.9 5236.8 5228.8 5272.6 5295.7 5296.2 5302.4 5112.7 5129.2 5129.6 5133.9 5187.0 4848.2 5076.2 5134.7 5155.5 5162.0 5032.9 5062.9 5067.4 5088.3 5139.3 5175.2 5185.2 5188.6 5200.9 5252.0 4826.7 4965.2 5013.0 5070.6 5086.7 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | [#1] ext.html Cycles:180 Average:45112.87 Median:36441.54 stddev:78141.33 (214.4%) stddev-sans-first:78288.96 17:35:14 INFO - PROCESS | 1857 | Values: 567.3 603.5 612.5 623.5 659.7 37701.4 38937.6 41895.0 41962.2 42120.4 42280.0 42668.6 42773.4 43068.1 43179.0 7855.3 8014.0 8022.2 8026.6 8028.5 7721.5 7726.4 7792.3 7810.9 7816.1 7741.0 7782.3 7785.3 7787.2 7799.7 7711.3 7765.0 7768.1 7786.8 7801.4 7839.6 7871.4 7902.7 7902.8 7906.4 39426.4 39844.0 39847.8 39904.6 39917.6 3083.6 3186.9 3232.8 3299.3 3625.9 30000.8 30241.5 30753.7 30773.5 31360.5 3181.9 3196.7 3215.6 3218.6 3238.9 231512.0 232599.0 233206.0 234746.0 234767.8 33888.2 34973.8 55254.2 56012.7 56026.4 36271.6 36378.8 36504.3 36567.0 36573.8 13293.8 13311.2 13482.2 13496.4 13570.5 10053.4 10103.7 10143.4 10206.2 10246.1 8377.9 8479.0 8492.3 8493.7 8590.0 3313.8 3325.5 3342.7 3343.9 3362.2 902.5 950.3 1048.0 1063.6 1091.0 29256.7 29764.0 29833.4 30268.0 30338.8 984.3 1021.8 1057.3 1067.4 1081.6 15699.8 15852.4 15903.6 15962.1 16068.8 344428.0 347465.0 348971.0 349491.0 350139.0 53348.5 53405.2 53417.2 53930.7 54089.5 1273.9 1281.5 1295.6 1299.6 1306.7 27082.0 28463.0 29018.7 29261.4 29299.0 45587.0 45644.0 45839.5 46109.1 46243.0 299294.0 299909.0 300128.0 300243.0 300454.0 26850.2 27093.3 28238.3 28291.6 29354.9 42997.6 43368.6 43774.0 44120.3 44738.6 37435.2 38001.4 38819.8 39027.4 39642.4 37183.1 37659.8 38365.0 38688.6 39255.4 37011.0 37442.4 37491.6 37541.0 38025.4 32846.7 34496.7 34690.5 35124.0 35203.3 25169.1 25559.9 25565.6 25888.0 25946.1 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | [#2] jquery.html Cycles:180 Average:25262.92 Median:441.95 stddev:72490.43 (16402.3%) stddev-sans-first:72669.72 17:35:14 INFO - PROCESS | 1857 | Values: 387.5 393.9 394.9 399.1 406.6 13142.8 16140.9 16281.2 17575.5 17613.6 16915.2 16978.7 17201.8 18029.7 18081.0 4962.1 5109.3 5245.8 5249.6 5259.1 5215.1 5240.2 5240.4 5249.0 5257.4 5162.7 5407.6 5410.4 5413.4 5427.2 5233.5 5342.8 5351.8 5370.9 5398.8 5384.0 5394.7 5401.2 5403.3 5407.2 12065.5 12278.1 12581.2 12672.9 12701.1 1954.9 2020.1 2039.7 2063.6 2119.3 9273.1 9691.6 9714.1 12458.9 12826.8 1792.9 1827.3 1857.9 1866.0 1884.8 67872.0 68341.0 68581.3 70672.6 71359.6 9459.9 9525.6 9552.0 9688.0 9865.7 12170.6 13086.6 13098.6 13132.1 13356.7 7132.6 7161.8 7252.6 7270.6 7390.4 6894.4 6913.6 6992.0 7057.3 7111.1 4323.4 4329.2 4389.6 4490.3 4552.8 1850.7 1881.9 1931.7 1940.2 1941.6 393.0 398.2 441.1 816.7 920.4 10344.3 10726.9 10749.6 10836.9 10913.2 427.1 428.6 434.2 445.5 451.4 5687.6 5725.0 5735.1 5757.7 5879.3 420437.0 427115.0 446274.0 447435.0 453135.0 83090.6 84425.2 84519.0 84868.0 85306.0 436.2 442.8 444.8 445.1 446.2 9806.5 9886.7 10044.5 10124.7 10221.0 34476.0 34634.5 34742.8 34838.7 35554.0 51308.5 52801.7 53437.9 53859.0 54097.7 7402.6 7480.5 7579.0 7579.5 7638.4 10256.2 11541.3 11594.2 12233.3 12303.8 10197.9 10542.1 10669.8 10935.2 11026.1 10847.8 10968.2 10998.5 11123.0 11131.8 10731.9 11068.4 11114.9 11163.5 11386.6 7952.5 7998.9 8152.0 8164.0 8275.9 8142.9 10025.7 10631.9 10643.0 10918.7 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | [#3] mootools.html Cycles:180 Average:5243.60 Median:5510.21 stddev:2879.71 (52.3%) stddev-sans-first:2874.09 17:35:14 INFO - PROCESS | 1857 | Values: 1506.8 1522.5 1745.7 1847.5 1883.6 6724.5 7517.8 7593.2 8159.8 8173.1 7746.5 7942.1 7958.9 8021.0 8024.9 2221.4 2254.1 2254.7 2256.6 2259.5 2202.1 2203.4 2247.6 2248.6 2260.3 2174.1 2182.1 2185.2 2205.7 2239.4 2153.7 2195.7 2197.8 2203.5 2204.2 2168.6 2173.5 2173.6 2174.0 2194.6 7942.3 7970.3 7985.6 7990.8 8006.6 4741.2 4861.2 4884.0 4888.4 4907.3 2793.9 2958.7 2975.7 2988.9 2991.6 881.2 885.7 901.4 937.4 937.5 10022.5 10248.3 10271.0 10275.7 10675.1 4295.5 4376.2 4394.0 4441.6 4457.9 9123.9 9157.5 9182.4 9203.3 9206.0 4730.8 4752.3 4767.4 4772.1 4792.9 3753.1 4249.7 4347.8 4363.2 4399.3 3686.8 3717.6 3823.9 3829.6 3949.3 1227.2 1235.3 1239.4 1262.8 1270.7 919.5 943.5 950.8 958.7 959.4 5492.6 5554.4 5667.6 5708.6 5813.7 400.5 410.0 410.3 418.5 420.5 3734.5 3881.9 3884.6 3938.6 3962.0 9428.2 9667.5 9681.5 9777.6 9796.8 8995.8 9424.9 9646.0 9681.3 9780.3 7238.9 7411.1 7425.5 7450.3 7452.9 5527.8 5700.7 5766.1 5782.1 5857.9 8852.6 9120.8 9123.4 9216.8 9224.8 9096.1 9241.6 9273.2 9360.2 9387.2 6810.1 7083.1 7112.5 7129.5 7177.1 7290.7 7317.2 7322.7 7371.7 7379.3 6358.6 6431.5 6527.7 6571.1 6659.1 6792.1 6805.3 6876.7 6982.8 7096.4 6420.4 6644.1 6658.3 6725.0 6788.7 4839.4 4918.2 4948.5 4958.2 4981.7 4824.1 4850.5 4933.1 4948.7 4960.5 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | [#4] prototype.html Cycles:180 Average:4345.48 Median:4969.68 stddev:1245.98 (25.1%) stddev-sans-first:1212.20 17:35:14 INFO - PROCESS | 1857 | Values: 315.2 322.4 323.4 330.9 335.2 4969.0 5006.5 5007.4 5026.3 5027.6 4943.4 4953.0 4956.8 4970.4 4995.9 3730.3 3799.2 3888.2 3896.9 3904.6 3902.9 3904.4 3926.8 3937.2 3944.3 3909.8 3919.7 3920.6 3923.6 3948.5 3841.2 3888.9 3896.6 3948.4 3957.2 3435.2 3462.8 3483.7 3489.4 3503.9 4672.7 4677.7 4678.6 4679.3 4710.0 4333.5 4469.3 4472.4 4480.3 4488.4 5091.3 5108.4 5124.6 5132.7 5159.5 3785.9 3805.2 3816.2 3818.7 3825.8 5354.2 5368.7 5377.4 5399.8 5413.3 3792.6 3864.8 3876.3 3891.2 3897.1 3911.0 3927.1 3935.2 3947.8 3951.7 4374.8 4407.0 4415.7 4423.0 4425.1 4967.5 5127.4 5144.8 5163.8 5183.1 1354.1 1355.0 1355.7 1359.3 1369.0 851.9 879.5 901.7 915.6 928.0 4428.9 4506.4 4551.7 4557.8 4590.9 5346.0 5355.5 5390.1 5392.9 5398.2 4459.9 4525.3 4540.7 4541.5 4552.5 2843.2 2859.3 2882.8 2891.9 2898.9 5043.5 5044.3 5075.5 5075.8 5125.8 5228.7 5493.5 5506.8 5538.3 5578.2 5071.9 5085.6 5090.5 5101.0 5118.9 5395.5 5438.3 5446.7 5449.7 5458.5 5198.1 5285.2 5293.4 5338.6 5346.9 5044.5 5057.5 5084.0 5114.4 5133.7 3948.8 3959.9 3961.6 3964.4 3986.3 5314.7 5382.7 5393.5 5399.4 5438.0 5153.4 5178.4 5252.1 5260.2 5261.2 5182.5 5182.8 5196.3 5204.3 5246.5 4942.5 5112.5 5125.4 5150.8 5155.4 5113.9 5157.5 5265.3 5292.1 5292.6 5176.5 5182.7 5187.6 5190.7 5207.0 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - PROCESS | 1857 | [#5] yui.html Cycles:180 Average:12987.97 Median:45570.89 stddev:14571.71 (32.0%) stddev-sans-first:14583.03 17:35:14 INFO - PROCESS | 1857 | Values: 629.4 657.1 700.2 706.9 717.9 9543.5 11889.8 12663.9 12668.7 13005.0 14227.3 14396.3 14397.3 14408.4 14420.2 878.5 890.2 890.8 891.3 892.0 865.5 869.4 871.7 875.3 877.5 923.0 925.8 927.1 929.1 929.8 885.8 907.4 915.6 916.0 916.7 661.5 665.9 666.9 669.5 670.0 12062.5 12091.0 12093.0 12100.6 12119.3 12428.9 12835.0 12914.6 13030.3 13104.9 9600.5 9663.5 9774.0 9796.8 9904.7 3170.6 3235.9 3240.3 3273.0 3273.9 49344.5 49504.5 50590.7 50831.5 50832.2 10308.8 10385.5 10464.0 10536.4 10624.5 17890.4 18194.9 18217.6 18250.0 18608.2 6970.4 6978.2 7039.5 7041.4 7043.2 3959.2 3961.2 3965.2 3985.2 4047.0 2798.4 2877.8 2888.8 2889.2 2908.1 475.4 488.3 490.9 500.8 504.3 613.2 632.2 637.3 640.6 647.9 7739.5 8016.6 8180.1 8238.5 8386.0 574.6 605.4 618.8 625.7 642.7 3972.0 3998.3 4052.1 4053.0 4129.1 51322.0 51835.7 51917.0 51931.0 53526.5 45117.8 46024.0 46131.5 46489.8 47019.3 42360.2 42856.0 43098.6 43281.6 43384.8 8151.6 8153.4 8225.4 8286.3 8564.0 25482.0 26739.6 26872.2 29243.3 29815.9 36655.8 37125.4 37218.4 37541.8 38160.2 10978.1 10993.7 11019.2 11644.3 11757.2 11704.9 11880.2 11898.0 12265.3 12891.9 11128.4 11312.1 11364.5 11573.5 11958.9 11243.0 11567.9 11647.1 11673.4 11689.5 11133.0 11223.2 11302.3 11317.3 11426.3 9525.2 9576.7 9597.6 9742.6 9865.3 9531.4 9697.9 9717.8 9996.7 10002.4 17:35:14 INFO - PROCESS | 1857 | -------- Summary: end -------- 17:35:14 INFO - PROCESS | 1857 | 17:35:14 INFO - TEST-INFO | 1857: exit 0 17:35:14 INFO - TEST-OK | dromaeo_css | took 1115437ms 17:35:14 INFO - TEST-START | kraken 17:35:14 INFO - operating with platform_type : linux_ 17:35:14 INFO - Initialising browser for kraken test... 17:35:14 INFO - TEST-INFO | started process 2098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLk8r4b/profile http://localhost:60155/getInfo.html) 17:35:18 INFO - PROCESS | 2098 | 17:35:18 INFO - PROCESS | 2098 | (process:2166): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:35:19 INFO - PROCESS | 2098 | __metrics Screen width/height:1600/1200 17:35:19 INFO - PROCESS | 2098 | colorDepth:24 17:35:19 INFO - PROCESS | 2098 | Browser inner width/height: 1024/697 17:35:19 INFO - PROCESS | 2098 | __metrics 17:35:20 ERROR - PROCESS | 2098 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:35:21 INFO - TEST-INFO | 2098: exit 0 17:35:21 INFO - Browser initialized. 17:35:21 INFO - Running cycle 1/1 for kraken test... 17:35:21 INFO - TEST-INFO | started process 2217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLk8r4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:23 INFO - PROCESS | 2217 | 17:35:23 INFO - PROCESS | 2217 | (process:2278): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:35:33 INFO - PROCESS | 2217 | RSS: Main: 164691968 17:35:33 INFO - PROCESS | 2217 | 17:35:35 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60155/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:36 INFO - PROCESS | 2217 | RSS: Main: 167514112 17:35:36 INFO - PROCESS | 2217 | 17:35:39 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60155/tests/kraken/driver.html?testName=audio-dft) 17:35:40 INFO - PROCESS | 2217 | RSS: Main: 167862272 17:35:40 INFO - PROCESS | 2217 | 17:35:43 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60155/tests/kraken/driver.html?testName=audio-fft) 17:35:44 INFO - PROCESS | 2217 | RSS: Main: 163799040 17:35:44 INFO - PROCESS | 2217 | 17:35:46 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60155/tests/kraken/driver.html?testName=audio-oscillator) 17:35:46 INFO - PROCESS | 2217 | RSS: Main: 164147200 17:35:46 INFO - PROCESS | 2217 | 17:35:49 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60155/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:49 INFO - PROCESS | 2217 | RSS: Main: 164401152 17:35:49 INFO - PROCESS | 2217 | 17:35:53 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60155/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:53 INFO - PROCESS | 2217 | RSS: Main: 164364288 17:35:53 INFO - PROCESS | 2217 | 17:35:57 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60155/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:57 INFO - PROCESS | 2217 | RSS: Main: 163123200 17:35:57 INFO - PROCESS | 2217 | 17:36:01 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60155/tests/kraken/driver.html?testName=json-parse-financial) 17:36:01 INFO - PROCESS | 2217 | RSS: Main: 163643392 17:36:01 INFO - PROCESS | 2217 | 17:36:03 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60155/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:36:04 INFO - PROCESS | 2217 | RSS: Main: 164016128 17:36:04 INFO - PROCESS | 2217 | 17:36:05 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:36:06 INFO - PROCESS | 2217 | RSS: Main: 164085760 17:36:06 INFO - PROCESS | 2217 | 17:36:08 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:36:09 INFO - PROCESS | 2217 | RSS: Main: 164720640 17:36:09 INFO - PROCESS | 2217 | 17:36:12 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:13 INFO - PROCESS | 2217 | RSS: Main: 164556800 17:36:13 INFO - PROCESS | 2217 | 17:36:16 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:16 INFO - PROCESS | 2217 | RSS: Main: 164519936 17:36:16 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:60155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60155/tests/kraken/driver.html?testName=ai-astar) 17:36:18 INFO - PROCESS | 2217 | RSS: Main: 167055360 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | __start_tp_report 17:36:18 INFO - PROCESS | 2217 | _x_x_mozilla_page_load 17:36:18 INFO - PROCESS | 2217 | _x_x_mozilla_page_load_details 17:36:18 INFO - PROCESS | 2217 | |i|pagename|runs| 17:36:18 INFO - PROCESS | 2217 | |0;ai-astar;109;115;108;115;117;115;109;113;115;114 17:36:18 INFO - PROCESS | 2217 | |1;audio-beat-detection;160;135;162;208;136;157;169;132;199;142 17:36:18 INFO - PROCESS | 2217 | |2;audio-dft;164;164;165;167;164;162;163;162;162;162 17:36:18 INFO - PROCESS | 2217 | |3;audio-fft;76;76;77;171;78;77;76;77;164;77 17:36:18 INFO - PROCESS | 2217 | |4;audio-oscillator;94;99;191;93;93;93;138;93;94;138 17:36:18 INFO - PROCESS | 2217 | |5;imaging-gaussian-blur;118;117;118;117;117;118;118;117;117;118 17:36:18 INFO - PROCESS | 2217 | |6;imaging-darkroom;149;148;147;148;148;148;148;148;148;148 17:36:18 INFO - PROCESS | 2217 | |7;imaging-desaturate;95;95;95;96;97;96;95;95;96;95 17:36:18 INFO - PROCESS | 2217 | |8;json-parse-financial;67;68;70;68;69;68;66;68;67;67 17:36:18 INFO - PROCESS | 2217 | |9;json-stringify-tinderbox;64;69;64;65;65;64;65;64;64;64 17:36:18 INFO - PROCESS | 2217 | |10;stanford-crypto-aes;83;88;86;82;84;84;83;83;135;82 17:36:18 INFO - PROCESS | 2217 | |11;stanford-crypto-ccm;135;134;144;153;136;141;144;144;150;144 17:36:18 INFO - PROCESS | 2217 | |12;stanford-crypto-pbkdf2;180;185;176;174;174;175;174;176;181;176 17:36:18 INFO - PROCESS | 2217 | |13;stanford-crypto-sha256-iterative;71;71;68;68;68;67;68;68;73;69 17:36:18 INFO - PROCESS | 2217 | __end_tp_report 17:36:18 INFO - PROCESS | 2217 | __start_cc_report 17:36:18 INFO - PROCESS | 2217 | _x_x_mozilla_cycle_collect,942 17:36:18 INFO - PROCESS | 2217 | __end_cc_report 17:36:18 INFO - PROCESS | 2217 | __startTimestamp1462926978822__endTimestamp 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | ------- Summary: start ------- 17:36:18 INFO - PROCESS | 2217 | Number of tests: 14 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#0] ai-astar Cycles:10 Average:113.00 Median:115.00 stddev:3.16 (2.7%) stddev-sans-first:3.00 17:36:18 INFO - PROCESS | 2217 | Values: 109.0 115.0 108.0 115.0 117.0 115.0 109.0 113.0 115.0 114.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#1] audio-beat-detection Cycles:10 Average:160.00 Median:161.00 stddev:26.31 (16.3%) stddev-sans-first:27.90 17:36:18 INFO - PROCESS | 2217 | Values: 160.0 135.0 162.0 208.0 136.0 157.0 169.0 132.0 199.0 142.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 17:36:18 INFO - PROCESS | 2217 | Values: 164.0 164.0 165.0 167.0 164.0 162.0 163.0 162.0 162.0 162.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.00 stddev:38.30 (49.7%) stddev-sans-first:40.01 17:36:18 INFO - PROCESS | 2217 | Values: 76.0 76.0 77.0 171.0 78.0 77.0 76.0 77.0 164.0 77.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:93.00 stddev:33.08 (35.6%) stddev-sans-first:34.40 17:36:18 INFO - PROCESS | 2217 | Values: 94.0 99.0 191.0 93.0 93.0 93.0 138.0 93.0 94.0 138.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:36:18 INFO - PROCESS | 2217 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 17:36:18 INFO - PROCESS | 2217 | Values: 149.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 17:36:18 INFO - PROCESS | 2217 | Values: 95.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 96.0 95.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 17:36:18 INFO - PROCESS | 2217 | Values: 67.0 68.0 70.0 68.0 69.0 68.0 66.0 68.0 67.0 67.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 17:36:18 INFO - PROCESS | 2217 | Values: 64.0 69.0 64.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:83.50 stddev:16.27 (19.5%) stddev-sans-first:17.11 17:36:18 INFO - PROCESS | 2217 | Values: 83.0 88.0 86.0 82.0 84.0 84.0 83.0 83.0 135.0 82.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:144.00 stddev:6.22 (4.3%) stddev-sans-first:5.98 17:36:18 INFO - PROCESS | 2217 | Values: 135.0 134.0 144.0 153.0 136.0 141.0 144.0 144.0 150.0 144.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:176.00 stddev:3.70 (2.1%) stddev-sans-first:3.77 17:36:18 INFO - PROCESS | 2217 | Values: 180.0 185.0 176.0 174.0 174.0 175.0 174.0 176.0 181.0 176.0 17:36:18 INFO - PROCESS | 2217 | 17:36:18 INFO - PROCESS | 2217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.50 stddev:1.91 (2.8%) stddev-sans-first:1.90 17:36:18 INFO - PROCESS | 2217 | Values: 71.0 71.0 68.0 68.0 68.0 67.0 68.0 68.0 73.0 69.0 17:36:18 INFO - PROCESS | 2217 | -------- Summary: end -------- 17:36:18 INFO - PROCESS | 2217 | 17:36:19 INFO - TEST-INFO | 2217: exit 0 17:36:19 INFO - TEST-OK | kraken | took 64864ms 17:36:19 INFO - SUITE-END | took 1180s 17:36:19 INFO - Completed test suite (00:19:40) 17:36:19 INFO - javascript benchmark 17:36:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.0433191884968, 2626.9474610507777, 2644.6297518347433, 2675.8929642814287, 2688.811783175178, 4671.112488627163, 4689.085628302478, 4719.787609557569, 4769.260764581487, 4826.9758651206785, 4770.475247722757, 4794.1610218211845, 4835.588974937125, 4886.877828054292, 4892.584130348924, 4459.732416055039, 4491.169133710274, 4608.884777880563, 4615.238485649864, 4628.028114096044, 454.3953861882305, 4375.7374557526655, 4401.097774956126, 4459.219636563605, 4461.843835465759, 4464.8883777905485, 4489.865304040868, 4506.4817545982305, 4509.278515437531, 4560.475545312265, 4495.887602809923, 4506.684532082755, 4511.233090374644, 4530.841420550265, 4540.27355623102, 4350.956490435086, 4434.979954610458, 4437.2900335946415, 4476.709013914117, 4494.146112238697, 4735.242361222222, 4747.264174053027, 4765.189917713997, 4776.8566942991765, 4833.709977401367, 5110.156824124015, 5227.032998895179, 5239.607029472767, 5245.370555533361, 5301.761420736076, 5103.030424219423, 5128.974355128238, 5181.145111056671, 5186.92219616706, 5196.272521846944, 4826.517348265145, 4838.104950584118, 4843.370361852972, 4874.0495603357, 4904.386951631046, 5121.0014047261175, 5310.893782124336, 5367.329083864517, 5400.081986062379, 5402.0, 5115.258287548285, 5121.103806833789, 5126.615503837227, 5133.307003554547, 5180.9740951295, 5221.164613661796, 5237.633365664443, 5240.213967904845, 5244.056069907377, 5306.09796334624, 4975.502449755068, 5158.148905430562, 5166.354205724285, 5184.0, 5198.844034678966, 4991.650584459053, 4999.900001999939, 5005.799768009311, 5027.497250274943, 5041.0422019816115, 4370.453693288339, 4376.671749618791, 4379.846705365297, 4415.492218394926, 4425.137098265807, 3732.5147730794824, 3817.9236415272094, 3861.613838616172, 3868.7485313454536, 3895.02624343914, 4434.490033646108, 4444.599986001275, 4448.288273876165, 4463.24124898768, 4523.411956445641, 5243.370795504487, 5293.417724050351, 5299.311089558333, 5304.522592966574, 5316.362036555638, 4307.935380969288, 4361.520232774392, 4362.585554372329, 4403.867883963486, 4407.845725399596, 4579.107074120515, 4607.815687372535, 4622.699524530894, 4629.768511574408, 4657.883552911204, 4738.218193997952, 4815.277708343707, 4839.177339852163, 4846.176150054499, 4866.562009419098, 5134.998675258289, 5269.920951185659, 5306.761195746278, 5323.2547443358735, 5334.973325133349, 4937.8271760488215, 4952.702837829742, 4970.055689418999, 4975.800967961241, 5030.522100400456, 4936.75316234194, 5199.142141546602, 5225.059489291812, 5230.895382092261, 5236.816711415082, 5228.790848366023, 5272.55183309423, 5295.7087360195555, 5296.152615581488, 5302.3637163540625, 5112.74436278192, 5129.230615407719, 5129.589632829439, 5133.948660513347, 5186.962607478595, 4848.200046992207, 5076.162433198629, 5134.7175905324075, 5155.53600175986, 5162.0, 5032.899342013213, 5062.898742025212, 5067.41724701664, 5088.262201980766, 5139.280500729826, 5175.171972484384, 5185.185185185306, 5188.610854186027, 5200.947990520046, 5251.975864706345, 4826.710397376169, 4965.155923492943, 5012.974935125301, 5070.645054846273, 5086.720230387365], "value": 4739.8124305895635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3135506037694, 603.5141710922707, 612.4640939178219, 623.5230049012504, 659.6734616364894, 37701.43447848281, 38937.61062389375, 41894.99999999996, 41962.16075678485, 42120.36819447711, 42280.0, 42668.57331426685, 42773.358399624034, 43068.13863722724, 43179.0, 7855.332296754783, 8014.0, 8022.19778022199, 8026.638801253928, 8028.478148920331, 7721.498102623312, 7726.381889448859, 7792.259735325135, 7810.882836757453, 7816.101148367954, 7740.993670822785, 7782.299593036626, 7785.299323060924, 7787.221277872196, 7799.688012479494, 7711.267429594208, 7764.961175194117, 7768.145503994556, 7786.7663970080985, 7801.414893882981, 7839.608019598997, 7871.409644276645, 7902.723404680809, 7902.802429939297, 7906.44654874159, 39426.408603870965, 39844.0, 39847.80076099601, 39904.600953990375, 39917.60082399168, 3083.583716198307, 3186.8725250989933, 3232.7575431842706, 3299.3236386540702, 3625.854965801365, 30000.849995749883, 30241.546376804366, 30753.69246307553, 30773.538396924065, 31360.529592056137, 3181.8568164432654, 3196.6963138502038, 3215.5819743433203, 3218.5815843940372, 3238.8542515586855, 231512.0, 232599.0, 233206.0, 234746.0, 234767.82616086982, 33888.15279618029, 34973.82513087418, 55254.17118743222, 56012.719936400055, 56026.43973560294, 36271.63728362735, 36378.818105909304, 36504.26991460156, 36567.0, 36573.81713091471, 13293.800592991112, 13311.201327920357, 13482.19106853592, 13496.39266233022, 13570.525031624044, 10053.396796192106, 10103.7474063149, 10143.442110683836, 10206.23453240995, 10246.129079028216, 8377.916220837835, 8478.957605211934, 8492.278156356655, 8493.702720404755, 8590.0, 3313.784604000732, 3325.467925131967, 3342.665733426638, 3343.9164020899184, 3362.2266878618057, 902.4946030223097, 950.339514037751, 1048.0410424461531, 1063.6170978447753, 1090.9727256818485, 29256.707432925825, 29764.0, 29833.40333193324, 30268.0, 30338.84830575833, 984.3011461862158, 1021.7547788530699, 1057.3444464432102, 1067.4075887882145, 1081.561967403203, 15699.764503532457, 15852.365905363888, 15903.59523560219, 15962.122083285298, 16068.839311606967, 344428.0, 347465.0, 348971.0, 349491.0, 350139.0, 53348.46651533512, 53405.1989220162, 53417.1987420189, 53930.73034634802, 54089.459105408445, 1273.8662440443804, 1281.5130250504935, 1295.617792751122, 1299.5516546791341, 1306.7255876265901, 27082.0, 28463.0, 29018.7098129016, 29261.41477170402, 29299.0, 45587.0, 45644.0, 45839.54160458353, 46109.077818444115, 46243.0, 299294.0, 299909.0, 300128.0, 300243.0, 300454.0, 26850.194494165207, 27093.322666933484, 28238.294042649097, 28291.57562636521, 29354.853225733736, 42997.57002430061, 43368.56631433645, 43774.0, 44120.33819492646, 44738.55261447344, 37435.202727359596, 38001.42997854979, 38819.80590097144, 39027.41458878176, 39642.40536391899, 37183.07042323964, 37659.81170094132, 38365.0, 38688.6131138685, 39255.41116883192, 37011.0, 37442.43836342402, 37491.62508374881, 37541.0, 38025.4296185563, 32846.67153328436, 34496.655033449344, 34690.47964280487, 35124.0, 35203.29593408169, 25169.119080832083, 25559.87220063962, 25565.616515751906, 25888.0, 25946.091886783874], "value": 16954.57855815873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.53302270763714, 393.8739603326935, 394.8657456464802, 399.06220382102043, 406.6238729175512, 13142.802857957138, 16140.91929540352, 16281.185940702948, 17575.472735817915, 17613.55966100848, 16915.1542422879, 16978.660426791455, 17201.82798172018, 18029.7295540567, 18081.0, 4962.0820148272505, 5109.335786347779, 5245.816396426126, 5249.632525723201, 5259.132243179871, 5215.061288967984, 5240.161574148137, 5240.44975277596, 5249.028929648009, 5257.421683614799, 5162.6902385856965, 5407.621466497347, 5410.404855465896, 5413.377461591928, 5427.213054107152, 5233.476652334774, 5342.759575819078, 5351.759170837302, 5370.892582148354, 5398.838034858961, 5383.973080134574, 5394.730263486849, 5401.162819762943, 5403.297571315743, 5407.188921661743, 12065.517379304818, 12278.140530162893, 12581.182223155558, 12672.936635316764, 12701.110922235448, 1954.8729332593336, 2020.111151093514, 2039.7246371739923, 2063.556335387899, 2119.3218170185546, 9273.119053689956, 9691.563879625433, 9714.125728684381, 12458.875411245952, 12826.781455761688, 1792.865535084874, 1827.3330234464458, 1857.907104644776, 1865.9626807463774, 1884.8397886179555, 67872.0, 68341.0, 68581.314186858, 70672.64663676648, 71359.64320178417, 9459.905400945903, 9525.618975240914, 9551.952240238754, 9688.0, 9865.654702085392, 12170.574029909088, 13086.607401777961, 13098.607041788762, 13132.080754347295, 13356.73286534264, 7132.643367831588, 7161.785146445615, 7252.601106939063, 7270.600116993511, 7390.371818395389, 6894.448444124559, 6913.585184888922, 6992.0, 7057.329553692391, 7111.075560177143, 4323.4379530661445, 4329.155814616182, 4389.582989615981, 4490.259107247268, 4552.772361381918, 1850.7223916412377, 1881.9435416937513, 1931.671615825313, 1940.223910435837, 1941.5825597496605, 393.0311781458718, 398.2095540352398, 441.1375760388433, 816.6570040582969, 920.4155361345594, 10344.275900687031, 10726.946365268124, 10749.570017199225, 10836.86212947629, 10913.23607347494, 427.0753817984092, 428.594977746027, 434.15556742136874, 445.45654301751813, 451.4266881061034, 5687.573431992617, 5724.971375143181, 5735.1392099206, 5757.704516483841, 5879.265091863517, 420437.0, 427115.0, 446274.0, 447435.0, 453135.0, 83090.58454707809, 84425.15574844296, 84519.0, 84868.0, 85306.0, 436.2300539547701, 442.7697597249348, 444.83096423358916, 445.100896189695, 446.18793795292254, 9806.460644664612, 9886.703398898044, 10044.49777511107, 10124.746881328027, 10220.97790220972, 34476.0, 34634.48048279328, 34742.82628586841, 34838.65161348354, 35554.0, 51308.48691513037, 52801.735991319794, 53437.93124137573, 53859.0, 54097.72951135219, 7402.592857392679, 7480.476366654282, 7578.962105189439, 7579.5073320234005, 7638.388928885564, 10256.17950563968, 11541.307521548733, 11594.188406811441, 12233.3271670059, 12303.75392492163, 10197.9490102549, 10542.103921166787, 10669.839952400875, 10935.23453358289, 11026.062784663394, 10847.837282440612, 10968.23222374458, 10998.505067272152, 11123.0, 11131.83302250483, 10731.946340268249, 11068.391238481961, 11114.888851111386, 11163.49764260594, 11386.601468948547, 7952.522848629101, 7998.920010799818, 8152.0, 8163.959180204061, 8275.917240827755, 8142.8778568322705, 10025.749356266151, 10631.8936810634, 10643.0, 10918.672439826818], "value": 7547.963197639578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.7739839024146, 1522.4899658614363, 1745.6595963787058, 1847.5104097414196, 1883.5667796406826, 6724.495662825296, 7517.774466766005, 7593.2027137150635, 8159.796005099868, 8173.1418201088845, 7746.496477728943, 7942.086660034098, 7958.92041079589, 8021.0, 8024.91975080249, 2221.44463884029, 2254.0983606557343, 2254.7068881045443, 2256.616375216209, 2259.536794957038, 2202.0751284460484, 2203.3500117465305, 2247.550489902018, 2248.6402175651897, 2260.2654137405325, 2174.1194816099505, 2182.0726191368685, 2185.1914791527156, 2205.691203231549, 2239.428945618865, 2153.698482212476, 2195.681626164205, 2197.7802219777973, 2203.537257175995, 2204.2285200179967, 2168.6313326734494, 2173.478365192358, 2173.5544213436365, 2173.9565208695894, 2194.6049711052165, 7942.28519433248, 7970.322522585587, 7985.560794156319, 7990.800229994296, 8006.599670016534, 4741.217699079648, 4861.17360048789, 4884.0, 4888.388951381077, 4907.288443175756, 2793.9301517462022, 2958.733713965732, 2975.7024297570288, 2988.8505574721175, 2991.641003079623, 881.180502133016, 885.7431344910033, 901.441106513959, 937.3906960475678, 937.5031233446284, 10022.54898529568, 10248.282620216587, 10271.0, 10275.691729248134, 10675.145988320994, 4295.548967358445, 4376.234159022159, 4393.956060439355, 4441.555844415532, 4457.888552786141, 9123.863142052875, 9157.45055296671, 9182.449053056838, 9203.309751768644, 9206.033366496555, 4730.834420795256, 4752.334673145693, 4767.380240568704, 4772.069446457907, 4792.9281060784115, 3753.0617345663586, 4249.745015299092, 4347.804348804311, 4363.192809330284, 4399.296112621965, 3686.8156592170285, 3717.5910649828497, 3823.8661646842784, 3829.5978922213326, 3949.30887094763, 1227.1777908801125, 1235.3020543392954, 1239.3803098450774, 1262.81689155072, 1270.6658009090418, 919.5264438814016, 943.5376665433888, 950.7765675066354, 958.6884262614539, 959.4003747657714, 5492.642978206404, 5554.444555544494, 5667.614903507819, 5708.628939118944, 5813.680247586423, 400.50337581398855, 410.046641558378, 410.30453381518635, 418.4852631263502, 420.5038055095017, 3734.533183352081, 3881.922361552753, 3884.5532763731967, 3938.5667576566557, 3962.0, 9428.245740340757, 9667.468289244018, 9681.467519286507, 9777.608895644236, 9796.755081123029, 8995.77510562228, 9424.858627120599, 9646.0, 9681.273904457054, 9780.31537792362, 7238.855222895512, 7411.0736157980255, 7425.517341372685, 7450.329470347695, 7452.925470745223, 5527.778888844401, 5700.686462244616, 5766.077427611562, 5782.13268009785, 5857.882842343044, 8852.55737213124, 9120.77198070027, 9123.361364704673, 9216.769580760534, 9224.769380765267, 9096.135867092615, 9241.58412871409, 9273.165415112673, 9360.20438262728, 9387.249020078241, 6810.114685090906, 7083.0791997042115, 7112.537685050455, 7129.5365801224825, 7177.102862142232, 7290.708371665286, 7317.195108538163, 7322.670479828527, 7371.668274927534, 7379.298966598165, 6358.554901156875, 6431.485481161402, 6527.738890444329, 6571.145751052332, 6659.067730517828, 6792.083068785848, 6805.251422343439, 6876.656167191721, 6982.79051628452, 7096.396806271525, 6420.357964203542, 6644.136262285871, 6658.267590564937, 6724.991251312146, 6788.660566971533, 4839.395075615548, 4918.188498897642, 4948.529889660476, 4958.231474121517, 4981.701097934136, 4824.059308434821, 4850.466448690711, 4933.136701077226, 4948.653594248368, 4960.528749768766], "value": 4182.265597249539, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.1946775987352, 322.44861287198887, 323.3694296122561, 330.8544240534163, 335.17379659140215, 4968.999999999995, 5006.474320196382, 5007.399112106543, 5026.3214466047075, 5027.597792176626, 4943.431505376882, 4953.0, 4956.776945037473, 4970.353853998975, 4995.875103122424, 3730.2725968436234, 3799.164183879556, 3888.202918401721, 3896.941545876814, 3904.609539046087, 3902.8829135125993, 3904.4338570907203, 3926.803659816998, 3937.1535119949203, 3944.329463991114, 3909.7654140751647, 3919.666828319582, 3920.627540383659, 3923.646871781539, 3948.5261768587666, 3841.2317536492533, 3888.8833334999995, 3896.5908579599018, 3948.4077388391684, 3957.2085582883537, 3435.1927297085167, 3462.774919630216, 3483.6936148944146, 3489.4068008438626, 3503.929921401583, 4672.672912896099, 4677.74272415017, 4678.602318802906, 4679.321498382749, 4710.034442939189, 4333.4832808517085, 4469.284914413711, 4472.396226509412, 4480.342273358878, 4488.371627972087, 5091.287219789232, 5108.361454818148, 5124.590032797368, 5132.743362831843, 5159.509846564571, 3785.9242815143816, 3805.1818858945185, 3816.1985982943615, 3818.6754125899333, 3825.7895815730126, 5354.179578943178, 5368.651037682577, 5377.354717433933, 5399.811006614789, 5413.323334583177, 3792.6017768133947, 3864.787436691009, 3876.302265592164, 3891.2217556488818, 3897.142628621699, 3911.0, 3927.116398810245, 3935.2129574085297, 3947.7631342119566, 3951.6838652908273, 4374.796930844043, 4407.0, 4415.690901636919, 4422.977885110554, 4425.09285596452, 4967.4784147664695, 5127.435982041972, 5144.819931302386, 5163.7676304566385, 5183.118869792144, 1354.106289848695, 1354.966125846842, 1355.654308151415, 1359.3135466589308, 1368.9726205475836, 851.9233269005696, 879.4723166100416, 901.7339884733888, 915.56053094515, 928.0209379104974, 4428.914915845574, 4506.369108324837, 4551.6813823032735, 4557.772111394417, 4590.862274131781, 5345.973270133624, 5355.544778693777, 5390.110631745796, 5392.946070539323, 5398.217258497496, 4459.900369243344, 4525.253333200051, 4540.72755634663, 4541.5231400703115, 4552.476465206543, 2843.2039029071893, 2859.2994716294224, 2882.827030378184, 2891.85540722963, 2898.942021159565, 5043.520865517843, 5044.344235249468, 5075.492450754895, 5075.792030466759, 5125.846224613268, 5228.732042473454, 5493.533049690741, 5506.834794956158, 5538.280023596906, 5578.246936663499, 5071.949280507221, 5085.618578606619, 5090.541851233407, 5100.974495127501, 5118.8976220476125, 5395.487428694268, 5438.347398312069, 5446.727663616883, 5449.700266485382, 5458.454154584669, 5198.141022437569, 5285.207218917193, 5293.438435661412, 5338.572914166935, 5346.919796202982, 5044.54599086084, 5057.494250574913, 5084.0, 5114.411842638145, 5133.743312834269, 3948.763074215556, 3959.92080158401, 3961.5642279349827, 3964.4251583520804, 3986.32232520478, 5314.707691076873, 5382.650127741685, 5393.487618676219, 5399.352077750695, 5437.972810135924, 5153.4073581538605, 5178.404483484447, 5252.107141785982, 5260.237265596544, 5261.237120617412, 5182.53357197854, 5182.766775495187, 5196.298499702491, 5204.271402003798, 5246.501582349671, 4942.505749425172, 5112.463191365002, 5125.386053113014, 5150.768215430239, 5155.381354237516, 5113.92329115071, 5157.458466861076, 5265.289185959847, 5292.073887069824, 5292.550133238564, 5176.456472070378, 5182.663126896739, 5187.610929180402, 5190.714510701948, 5206.97396513015], "value": 3954.4128286721493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.3769168523163, 657.0997733105646, 700.1668015062075, 706.8550947055851, 717.8707832590134, 9543.47510886901, 11889.76220475591, 12663.873361266385, 12668.746625067493, 13005.0, 14227.288635568231, 14396.28018599071, 14397.280135993211, 14408.423663053465, 14420.206888621122, 878.5080355001204, 890.1676932068505, 890.8262888736699, 891.3092353426082, 892.018779342721, 865.4634126841368, 869.4131461263622, 871.6861929705333, 875.2560323724847, 877.5129802959354, 922.9861552076724, 925.7870689741363, 927.1053433436732, 929.0802105915163, 929.8419268724299, 885.7608445719684, 907.4283201583027, 915.6474757218452, 916.0244339778116, 916.724982505249, 661.52039771166, 665.866826634675, 666.8799616069106, 669.5112567825514, 669.9531032827704, 12062.457189426497, 12091.0, 12093.0, 12100.576479823252, 12119.272843629411, 12428.875711242863, 12835.0, 12914.610797002584, 13030.283334416603, 13104.934475327658, 9600.519974001272, 9663.468509231989, 9774.0, 9796.804063918682, 9904.653337133166, 3170.6036745406823, 3235.8705651773903, 3240.287136829894, 3273.0017344709854, 3273.8690452381875, 49344.50655493435, 49504.50495495071, 50590.7470462649, 50831.49168508305, 50832.237516437286, 10308.845367319496, 10385.532651030722, 10464.00591943764, 10536.420496872746, 10624.521896514676, 17890.373836915645, 18194.90902545479, 18217.63564728698, 18250.0, 18608.16263268156, 6970.372666460043, 6978.197507286727, 7039.54242974205, 7041.436685065182, 7043.225245223021, 3959.1883663848844, 3961.168154687548, 3965.1871366369824, 3985.1830374773103, 4047.0489434982755, 2798.398344355973, 2877.798554101235, 2888.8411137387225, 2889.1621429785546, 2908.0548821633056, 475.3535192138689, 488.34561687339135, 490.8920037591724, 500.812195426715, 504.2813990064144, 613.1752792494177, 632.1781683811028, 637.2575949019433, 640.5804198250154, 647.9125318082093, 7739.458237923292, 8016.559089250147, 8180.14108518597, 8238.546879921541, 8385.95807020961, 574.6236215278999, 605.4218221598451, 618.8143556932993, 625.7121724006917, 642.6915080761167, 3971.9801400993388, 3998.28030954431, 4052.1490486997473, 4052.959470405317, 4129.112240868228, 51322.0, 51835.74082129565, 51917.0, 51931.0, 53526.46473535293, 45117.774411127735, 46024.0, 46131.53868461272, 46489.767551162025, 47019.29471057937, 42360.1527969445, 42856.0, 43098.56901431008, 43281.56718432775, 43384.78307608505, 8151.633176506953, 8153.388495862952, 8225.424220304521, 8286.295664868554, 8564.0, 25482.0, 26739.598906016814, 26872.193834185007, 29243.26891827636, 29815.85092074526, 36655.81672091623, 37125.443118352705, 37218.44172337363, 37541.81229093837, 38160.23679526449, 10978.12175026012, 10993.670189894316, 11019.206645109403, 11644.301341919512, 11757.176997610086, 11704.94147529291, 11880.168388212742, 11898.0, 12265.325407102338, 12891.935540322613, 11128.44357782124, 11312.095032397225, 11364.54541818351, 11573.537058517903, 11958.940205298917, 11243.0, 11567.88432115668, 11647.12646551529, 11673.416329183678, 11689.473973671034, 11132.955399493414, 11223.214374993999, 11302.321860688386, 11317.264377815745, 11426.314421134759, 9525.237980961369, 9576.664816731382, 9597.58302171819, 9742.610295588098, 9865.26010549226, 9531.38046027006, 9697.854532181882, 9717.80564388694, 9996.700098997042, 10002.44986525748], "value": 6118.361292918538, "unit": "score"}], "name": "dromaeo_css", "value": 6280.706982569737, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 108.0, 115.0, 117.0, 115.0, 109.0, 113.0, 115.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 135.0, 162.0, 208.0, 136.0, 157.0, 169.0, 132.0, 199.0, 142.0], "value": 160.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 167.0, 164.0, 162.0, 163.0, 162.0, 162.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 171.0, 78.0, 77.0, 76.0, 77.0, 164.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 191.0, 93.0, 93.0, 93.0, 138.0, 93.0, 94.0, 138.0], "value": 112.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 68.0, 69.0, 68.0, 66.0, 68.0, 67.0, 67.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 86.0, 82.0, 84.0, 84.0, 83.0, 83.0, 135.0, 82.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 144.0, 153.0, 136.0, 141.0, 144.0, 144.0, 150.0, 144.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 185.0, 176.0, 174.0, 174.0, 175.0, 174.0, 176.0, 181.0, 176.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 73.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1615.2999999999997, "alertThreshold": 2.0}]} 17:36:20 INFO - Return code: 0 17:36:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:36:20 ERROR - # TBPL SUCCESS # 17:36:20 INFO - Running post-action listener: _resource_record_post_action 17:36:20 INFO - ##### 17:36:20 INFO - ##### Finished run-tests step (success) 17:36:20 INFO - ##### 17:36:20 INFO - Running post-run listener: _resource_record_post_run 17:36:21 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 537055232; Read time: 0; Write time: 497824 17:36:21 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 246480896; Read time: 0; Write time: 343184 17:36:21 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 290574336; Read time: 0; Write time: 154640 17:36:21 INFO - Running post-run listener: _upload_blobber_files 17:36:21 INFO - Blob upload gear active. 17:36:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:36:21 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:22 INFO - (blobuploader) - INFO - Done attempting. 17:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:36:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:23 INFO - (blobuploader) - INFO - Done attempting. 17:36:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:23 INFO - Return code: 0 17:36:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b8248f25ce66ace9c204c075c9eb8e55036145ac2994f81eb1b5b81d0f12748504903c50abaaa975469e42affc3a798833900d83f72b6d38e8876377fe36621", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ed2d9f075802d89d324f9995f60cb27c8fa796d55cf01c2a685fa29ba37c727afb49d98fe10fd8690d8418ef22d5fd2f6312607272a00d501a02aed8512ed69"} 17:36:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:23 INFO - Contents: 17:36:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b8248f25ce66ace9c204c075c9eb8e55036145ac2994f81eb1b5b81d0f12748504903c50abaaa975469e42affc3a798833900d83f72b6d38e8876377fe36621", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ed2d9f075802d89d324f9995f60cb27c8fa796d55cf01c2a685fa29ba37c727afb49d98fe10fd8690d8418ef22d5fd2f6312607272a00d501a02aed8512ed69"} 17:36:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:23 INFO - Copying logs to upload dir... 17:36:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.059078 ========= master_lag: 1.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-10 17:36:24.167362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:36:24.171835) ========= 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=00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606 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-Non-PGO/sha512/0b8248f25ce66ace9c204c075c9eb8e55036145ac2994f81eb1b5b81d0f12748504903c50abaaa975469e42affc3a798833900d83f72b6d38e8876377fe36621", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ed2d9f075802d89d324f9995f60cb27c8fa796d55cf01c2a685fa29ba37c727afb49d98fe10fd8690d8418ef22d5fd2f6312607272a00d501a02aed8512ed69"} build_url:https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/SaS-PAYrS9qHyL0A2DmcKg/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-Non-PGO/sha512/0b8248f25ce66ace9c204c075c9eb8e55036145ac2994f81eb1b5b81d0f12748504903c50abaaa975469e42affc3a798833900d83f72b6d38e8876377fe36621", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ed2d9f075802d89d324f9995f60cb27c8fa796d55cf01c2a685fa29ba37c727afb49d98fe10fd8690d8418ef22d5fd2f6312607272a00d501a02aed8512ed69"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 17:36:24.204962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:36:24.205262) ========= 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=00204705a9daa57ed339a427000001b9-1462925718.481767-1672890606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004218 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 17:36:24.254129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:36:24.254423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 17:36:24.254698) ========= ========= Total master_lag: 20.65 =========