builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1462793021.4 results: success (0) buildid: 20160509024751 builduid: 991189a231734b41ad920f1637f0b2f5 revision: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.402149) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.402604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.402877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.419676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.420041) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 04:23:42-- 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% 217M=0s 2016-05-09 04:23:42 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164669 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.704107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.704417) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015277 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.730756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:41.731109) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce --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=337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 04:23:42,682 truncating revision to first 12 chars 2016-05-09 04:23:42,682 Setting DEBUG logging. 2016-05-09 04:23:42,682 attempt 1/10 2016-05-09 04:23:42,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7adbdf0fce9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 04:23:42,957 unpacking tar archive at: mozilla-central-7adbdf0fce9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:42.316116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:42.316448) ========= script_repo_revision: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:42.316848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:42.317112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:23:42.326741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-09 04:23:42.327010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:43 INFO - MultiFileLogger online at 20160509 04:23:43 in /builds/slave/test 04:23:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:23:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:43 INFO - {'append_to_log': False, 04:23:43 INFO - 'base_work_dir': '/builds/slave/test', 04:23:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:23:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:43 INFO - 'branch': 'Firefox-Non-PGO', 04:23:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:43 INFO - 'config_files': ('talos/linux_config.py',), 04:23:43 INFO - 'default_actions': ('clobber', 04:23:43 INFO - 'read-buildbot-config', 04:23:43 INFO - 'download-and-extract', 04:23:43 INFO - 'populate-webroot', 04:23:43 INFO - 'create-virtualenv', 04:23:43 INFO - 'install', 04:23:43 INFO - 'run-tests'), 04:23:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:43 INFO - 'download_minidump_stackwalk': True, 04:23:43 INFO - 'download_symbols': 'ondemand', 04:23:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:43 INFO - 'installer_path': 'installer.exe', 04:23:43 INFO - 'log_level': 'info', 04:23:43 INFO - 'log_name': 'talos', 04:23:43 INFO - 'log_to_console': True, 04:23:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:43 INFO - 'opt_config_files': (), 04:23:43 INFO - 'pip_index': False, 04:23:43 INFO - 'sps_profile': False, 04:23:43 INFO - 'sps_profile_interval': 0, 04:23:43 INFO - 'suite': 'dromaeojs-e10s', 04:23:43 INFO - 'system_bits': '32', 04:23:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:43 INFO - 'title': 'talos-linux64-ix-060', 04:23:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:43 INFO - 'use_talos_json': True, 04:23:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:43 INFO - 'work_dir': 'build'} 04:23:43 INFO - ##### 04:23:43 INFO - ##### Running clobber step. 04:23:43 INFO - ##### 04:23:43 INFO - Running pre-action listener: _resource_record_pre_action 04:23:43 INFO - Running main action method: clobber 04:23:43 INFO - rmtree: /builds/slave/test/build 04:23:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:44 INFO - Running post-action listener: _resource_record_post_action 04:23:44 INFO - ##### 04:23:44 INFO - ##### Finished clobber step (success) 04:23:44 INFO - ##### 04:23:44 INFO - ##### 04:23:44 INFO - ##### Running read-buildbot-config step. 04:23:44 INFO - ##### 04:23:44 INFO - Running pre-action listener: _resource_record_pre_action 04:23:44 INFO - Running main action method: read_buildbot_config 04:23:44 INFO - Using buildbot properties: 04:23:44 INFO - { 04:23:44 INFO - "project": "", 04:23:44 INFO - "product": "firefox", 04:23:44 INFO - "script_repo_revision": "production", 04:23:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:23:44 INFO - "repository": "", 04:23:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:23:44 INFO - "buildid": "20160509024751", 04:23:44 INFO - "pgo_build": "False", 04:23:44 INFO - "basedir": "/builds/slave/test", 04:23:44 INFO - "buildnumber": 305, 04:23:44 INFO - "slavename": "talos-linux64-ix-060", 04:23:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:23:44 INFO - "platform": "ubuntu64_hw", 04:23:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:23:44 INFO - "branch": "mozilla-central", 04:23:44 INFO - "repo_path": "mozilla-central", 04:23:44 INFO - "revision": "7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce", 04:23:44 INFO - "stage_platform": "linux64", 04:23:44 INFO - "builduid": "991189a231734b41ad920f1637f0b2f5", 04:23:44 INFO - "slavebuilddir": "test" 04:23:44 INFO - } 04:23:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:23:44 INFO - Running post-action listener: _resource_record_post_action 04:23:44 INFO - ##### 04:23:44 INFO - ##### Finished read-buildbot-config step (success) 04:23:44 INFO - ##### 04:23:44 INFO - ##### 04:23:44 INFO - ##### Running download-and-extract step. 04:23:44 INFO - ##### 04:23:44 INFO - Running pre-action listener: _resource_record_pre_action 04:23:44 INFO - Running main action method: download_and_extract 04:23:44 INFO - mkdir: /builds/slave/test/build/tests 04:23:44 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')]} 04:23:44 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:23:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:23:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:46 INFO - Downloaded 1361 bytes. 04:23:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:23:46 INFO - Using the following test package requirements: 04:23:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:23:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'jsshell-linux-x86_64.zip'], 04:23:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:46 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:54 INFO - Downloaded 22322613 bytes. 04:23:54 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'] 04:23:54 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 04:23:55 INFO - Return code: 0 04:23:55 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 04:23: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')]} 04:23:55 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:23:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:56 INFO - Downloaded 22322613 bytes. 04:23:56 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'] 04:23:56 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 04:23:57 INFO - Return code: 0 04:23:57 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')]} 04:23:57 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:58 INFO - Downloaded 10840152 bytes. 04:23:58 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'] 04:23:58 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 04:23:58 INFO - Return code: 0 04:23:58 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')]} 04:23:58 INFO - https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4wkJiVKQDa5z1MyGphD2A/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 04:24:00 INFO - Downloaded 54853767 bytes. 04:24:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:24:00 INFO - mkdir: /builds/slave/test/properties 04:24:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:00 INFO - Contents: 04:24:00 INFO - build_url:https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:24:01 INFO - Running post-action listener: _resource_record_post_action 04:24:01 INFO - Running post-action listener: set_extra_try_arguments 04:24:01 INFO - ##### 04:24:01 INFO - ##### Finished download-and-extract step (success) 04:24:01 INFO - ##### 04:24:01 INFO - ##### 04:24:01 INFO - ##### Running populate-webroot step. 04:24:01 INFO - ##### 04:24:01 INFO - Running pre-action listener: _resource_record_pre_action 04:24:01 INFO - Running main action method: populate_webroot 04:24:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:01 INFO - '--tppagecycles', 04:24:01 INFO - '7'], 04:24:01 INFO - 'tests': ['tsvgm']}}, 04:24:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:24:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:24:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:24:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['damp', 'tps']}, 04:24:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'tests': ['damp', 'tps']}, 04:24:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['dromaeo_dom']}, 04:24:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['a11yr', 04:24:01 INFO - 'ts_paint', 04:24:01 INFO - 'tpaint', 04:24:01 INFO - 'sessionrestore', 04:24:01 INFO - 'sessionrestore_no_auto_restore', 04:24:01 INFO - 'tabpaint']}, 04:24:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:24:01 INFO - 'ts_paint', 04:24:01 INFO - 'tpaint', 04:24:01 INFO - 'sessionrestore', 04:24:01 INFO - 'sessionrestore_no_auto_restore', 04:24:01 INFO - 'tabpaint']}, 04:24:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:24:01 INFO - 'ts_paint', 04:24:01 INFO - 'tpaint', 04:24:01 INFO - 'sessionrestore', 04:24:01 INFO - 'sessionrestore_no_auto_restore', 04:24:01 INFO - 'tabpaint']}, 04:24:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:24:01 INFO - 'ts_paint', 04:24:01 INFO - 'tpaint', 04:24:01 INFO - 'sessionrestore', 04:24:01 INFO - 'sessionrestore_no_auto_restore', 04:24:01 INFO - 'tabpaint']}, 04:24:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['a11yr', 04:24:01 INFO - 'ts_paint', 04:24:01 INFO - 'tpaint', 04:24:01 INFO - 'sessionrestore', 04:24:01 INFO - 'sessionrestore_no_auto_restore', 04:24:01 INFO - 'tabpaint']}, 04:24:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['a11yr', 04:24:01 INFO - 'ts_paint', 04:24:01 INFO - 'tpaint', 04:24:01 INFO - 'sessionrestore', 04:24:01 INFO - 'sessionrestore_no_auto_restore', 04:24:01 INFO - 'tabpaint']}, 04:24:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['tsvgx', 04:24:01 INFO - 'tsvgr_opacity', 04:24:01 INFO - 'tart', 04:24:01 INFO - 'tscrollx', 04:24:01 INFO - 'cart']}, 04:24:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:24:01 INFO - 'tsvgr_opacity', 04:24:01 INFO - 'tart', 04:24:01 INFO - 'tscrollx', 04:24:01 INFO - 'cart']}, 04:24:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'talos_options': ['--disable-e10s'], 04:24:01 INFO - 'tests': ['tp5o']}, 04:24:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'tests': ['tp5o']}, 04:24:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'talos_options': ['--disable-e10s', 04:24:01 INFO - '--xperf_path', 04:24:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:01 INFO - 'tests': ['tp5n']}, 04:24:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:01 INFO - 'talos_options': ['--xperf_path', 04:24:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:01 INFO - 'tests': ['tp5n']}}, 04:24:01 INFO - 'talos.zip': {'path': '', 04:24:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:01 INFO - Running post-action listener: _resource_record_post_action 04:24:01 INFO - ##### 04:24:01 INFO - ##### Finished populate-webroot step (success) 04:24:01 INFO - ##### 04:24:01 INFO - ##### 04:24:01 INFO - ##### Running create-virtualenv step. 04:24:01 INFO - ##### 04:24:01 INFO - Running pre-action listener: _resource_record_pre_action 04:24:01 INFO - Running main action method: create_virtualenv 04:24:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:01 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 04:24:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:01 INFO - Using real prefix '/usr' 04:24:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:03 INFO - Installing pip.................done. 04:24:03 INFO - Return code: 0 04:24:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24: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', 'pip>=1.5'] in /builds/slave/test/build 04:24: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 pip>=1.5 04:24:03 INFO - Using env: {'DISPLAY': ':0', 04:24:03 INFO - 'HOME': '/home/cltbld', 04:24:03 INFO - 'LANG': 'en_US.UTF-8', 04:24:03 INFO - 'LANGUAGE': 'en_US:en', 04:24:03 INFO - 'LOGNAME': 'cltbld', 04:24:03 INFO - 'MAIL': '/var/mail/cltbld', 04:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:03 INFO - 'MOZ_NO_REMOTE': '1', 04:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:03 INFO - 'NO_EM_RESTART': '1', 04:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:03 INFO - 'PWD': '/builds/slave/test', 04:24:03 INFO - 'SHELL': '/bin/bash', 04:24:03 INFO - 'SHLVL': '1', 04:24:03 INFO - 'TERM': 'linux', 04:24:03 INFO - 'TMOUT': '86400', 04:24:03 INFO - 'USER': 'cltbld', 04:24:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:03 INFO - '_': '/tools/buildbot/bin/python'} 04:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:03 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 04:24:03 INFO - Cleaning up... 04:24:03 INFO - Return code: 0 04:24:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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', '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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:24: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 psutil>=0.7.1 04:24:03 INFO - Using env: {'DISPLAY': ':0', 04:24:03 INFO - 'HOME': '/home/cltbld', 04:24:03 INFO - 'LANG': 'en_US.UTF-8', 04:24:03 INFO - 'LANGUAGE': 'en_US:en', 04:24:03 INFO - 'LOGNAME': 'cltbld', 04:24:03 INFO - 'MAIL': '/var/mail/cltbld', 04:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:03 INFO - 'MOZ_NO_REMOTE': '1', 04:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:03 INFO - 'NO_EM_RESTART': '1', 04:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:03 INFO - 'PWD': '/builds/slave/test', 04:24:03 INFO - 'SHELL': '/bin/bash', 04:24:03 INFO - 'SHLVL': '1', 04:24:03 INFO - 'TERM': 'linux', 04:24:03 INFO - 'TMOUT': '86400', 04:24:03 INFO - 'USER': 'cltbld', 04:24:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:03 INFO - '_': '/tools/buildbot/bin/python'} 04:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:04 INFO - Downloading/unpacking psutil>=0.7.1 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:06 INFO - Installing collected packages: psutil 04:24:06 INFO - Running setup.py install for psutil 04:24:06 INFO - building 'psutil._psutil_linux' extension 04:24:06 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 04:24:06 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 04:24:06 INFO - building 'psutil._psutil_posix' extension 04:24:06 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 04:24:06 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 04:24:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:06 INFO - Successfully installed psutil 04:24:06 INFO - Cleaning up... 04:24:06 INFO - Return code: 0 04:24:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:06 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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24:06 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 04:24:06 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 04:24:06 INFO - Using env: {'DISPLAY': ':0', 04:24:06 INFO - 'HOME': '/home/cltbld', 04:24:06 INFO - 'LANG': 'en_US.UTF-8', 04:24:06 INFO - 'LANGUAGE': 'en_US:en', 04:24:06 INFO - 'LOGNAME': 'cltbld', 04:24:06 INFO - 'MAIL': '/var/mail/cltbld', 04:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:06 INFO - 'MOZ_NO_REMOTE': '1', 04:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:06 INFO - 'NO_EM_RESTART': '1', 04:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:06 INFO - 'PWD': '/builds/slave/test', 04:24:06 INFO - 'SHELL': '/bin/bash', 04:24:06 INFO - 'SHLVL': '1', 04:24:06 INFO - 'TERM': 'linux', 04:24:06 INFO - 'TMOUT': '86400', 04:24:06 INFO - 'USER': 'cltbld', 04:24:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:06 INFO - '_': '/tools/buildbot/bin/python'} 04:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:24:06 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 04:24:06 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 04:24:06 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 04:24:06 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 04:24:06 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 04:24:06 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 04:24:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:24:08 INFO - Installing collected packages: mozsystemmonitor 04:24:08 INFO - Running setup.py install for mozsystemmonitor 04:24:08 INFO - Successfully installed mozsystemmonitor 04:24:08 INFO - Cleaning up... 04:24:08 INFO - Return code: 0 04:24:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:08 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')]} 04:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:08 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')]} 04:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:08 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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24:08 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 04:24:08 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 04:24:08 INFO - Using env: {'DISPLAY': ':0', 04:24:08 INFO - 'HOME': '/home/cltbld', 04:24:08 INFO - 'LANG': 'en_US.UTF-8', 04:24:08 INFO - 'LANGUAGE': 'en_US:en', 04:24:08 INFO - 'LOGNAME': 'cltbld', 04:24:08 INFO - 'MAIL': '/var/mail/cltbld', 04:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:08 INFO - 'MOZ_NO_REMOTE': '1', 04:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:08 INFO - 'NO_EM_RESTART': '1', 04:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:08 INFO - 'PWD': '/builds/slave/test', 04:24:08 INFO - 'SHELL': '/bin/bash', 04:24:08 INFO - 'SHLVL': '1', 04:24:08 INFO - 'TERM': 'linux', 04:24:08 INFO - 'TMOUT': '86400', 04:24:08 INFO - 'USER': 'cltbld', 04:24:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:08 INFO - '_': '/tools/buildbot/bin/python'} 04:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:11 INFO - Downloading docopt-0.6.1.tar.gz 04:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:11 INFO - Running setup.py install for blobuploader 04:24:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:11 INFO - Running setup.py install for requests 04:24:12 INFO - Running setup.py install for docopt 04:24:12 INFO - Successfully installed blobuploader requests docopt 04:24:12 INFO - Cleaning up... 04:24:12 INFO - Return code: 0 04:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:12 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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24:12 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 04:24:12 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 04:24:12 INFO - Using env: {'DISPLAY': ':0', 04:24:12 INFO - 'HOME': '/home/cltbld', 04:24:12 INFO - 'LANG': 'en_US.UTF-8', 04:24:12 INFO - 'LANGUAGE': 'en_US:en', 04:24:12 INFO - 'LOGNAME': 'cltbld', 04:24:12 INFO - 'MAIL': '/var/mail/cltbld', 04:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:12 INFO - 'MOZ_NO_REMOTE': '1', 04:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:12 INFO - 'NO_EM_RESTART': '1', 04:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:12 INFO - 'PWD': '/builds/slave/test', 04:24:12 INFO - 'SHELL': '/bin/bash', 04:24:12 INFO - 'SHLVL': '1', 04:24:12 INFO - 'TERM': 'linux', 04:24:12 INFO - 'TMOUT': '86400', 04:24:12 INFO - 'USER': 'cltbld', 04:24:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:12 INFO - '_': '/tools/buildbot/bin/python'} 04:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:12 INFO - Running setup.py (path:/tmp/pip-LEwdzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:12 INFO - Running setup.py (path:/tmp/pip-YnBv65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:12 INFO - Running setup.py (path:/tmp/pip-_jrwqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:12 INFO - Running setup.py (path:/tmp/pip-Lm2Gpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:12 INFO - Running setup.py (path:/tmp/pip-bKgS1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:12 INFO - Running setup.py (path:/tmp/pip-D8GFQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:13 INFO - Running setup.py (path:/tmp/pip-erZuF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:13 INFO - Running setup.py (path:/tmp/pip-wtCnaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:13 INFO - Running setup.py (path:/tmp/pip-CKQ3IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:13 INFO - Running setup.py (path:/tmp/pip-0Hk0Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:13 INFO - Running setup.py (path:/tmp/pip-ukbuNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:13 INFO - Running setup.py (path:/tmp/pip-m8XdaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:13 INFO - Running setup.py (path:/tmp/pip-Nsyr98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:13 INFO - Running setup.py (path:/tmp/pip-zRhYOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:13 INFO - Running setup.py (path:/tmp/pip-snnqD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:13 INFO - Running setup.py (path:/tmp/pip-YRHiNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:13 INFO - Running setup.py (path:/tmp/pip-VikqQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:13 INFO - Running setup.py install for manifestparser 04:24:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:13 INFO - Running setup.py install for mozcrash 04:24:14 INFO - Running setup.py install for mozdebug 04:24:14 INFO - Running setup.py install for mozdevice 04:24:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Running setup.py install for mozfile 04:24:14 INFO - Running setup.py install for mozhttpd 04:24:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Running setup.py install for mozinfo 04:24:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Running setup.py install for mozInstall 04:24:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Running setup.py install for mozleak 04:24:14 INFO - Running setup.py install for mozlog 04:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Running setup.py install for moznetwork 04:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Running setup.py install for mozprocess 04:24:15 INFO - Running setup.py install for mozprofile 04:24:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:15 INFO - Running setup.py install for mozrunner 04:24:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:15 INFO - Running setup.py install for mozscreenshot 04:24:15 INFO - Running setup.py install for moztest 04:24:15 INFO - Running setup.py install for mozversion 04:24:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:15 INFO - Cleaning up... 04:24:15 INFO - Return code: 0 04:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:15 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')]} 04:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:15 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')]} 04:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:15 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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24:15 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 04:24:15 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 04:24:15 INFO - Using env: {'DISPLAY': ':0', 04:24:15 INFO - 'HOME': '/home/cltbld', 04:24:15 INFO - 'LANG': 'en_US.UTF-8', 04:24:15 INFO - 'LANGUAGE': 'en_US:en', 04:24:15 INFO - 'LOGNAME': 'cltbld', 04:24:15 INFO - 'MAIL': '/var/mail/cltbld', 04:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:15 INFO - 'MOZ_NO_REMOTE': '1', 04:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:15 INFO - 'NO_EM_RESTART': '1', 04:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:15 INFO - 'PWD': '/builds/slave/test', 04:24:15 INFO - 'SHELL': '/bin/bash', 04:24:15 INFO - 'SHLVL': '1', 04:24:15 INFO - 'TERM': 'linux', 04:24:15 INFO - 'TMOUT': '86400', 04:24:15 INFO - 'USER': 'cltbld', 04:24:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:15 INFO - '_': '/tools/buildbot/bin/python'} 04:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:15 INFO - Running setup.py (path:/tmp/pip-OSnTsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:15 INFO - Running setup.py (path:/tmp/pip-Ur9xcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:16 INFO - Running setup.py (path:/tmp/pip-kF5Vgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:16 INFO - Running setup.py (path:/tmp/pip-VCYQIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:16 INFO - Running setup.py (path:/tmp/pip-SCHxoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:16 INFO - Running setup.py (path:/tmp/pip-lqWz7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:16 INFO - Running setup.py (path:/tmp/pip-aeXSBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:16 INFO - Running setup.py (path:/tmp/pip-1a00zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:16 INFO - Running setup.py (path:/tmp/pip-1XOJ5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:16 INFO - Running setup.py (path:/tmp/pip-tZDbdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:16 INFO - Running setup.py (path:/tmp/pip-5vnnWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:16 INFO - Running setup.py (path:/tmp/pip-qVTW2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:16 INFO - Running setup.py (path:/tmp/pip-8oFgrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:16 INFO - Running setup.py (path:/tmp/pip-LhNP1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:16 INFO - Running setup.py (path:/tmp/pip-lBkBRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:16 INFO - Running setup.py (path:/tmp/pip-5J2UjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:17 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)) 04:24:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:17 INFO - Running setup.py (path:/tmp/pip-66BO2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:17 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)) 04:24:17 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)) 04:24:17 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)) 04:24:17 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)) 04:24:17 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)) 04:24:17 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)) 04:24:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:19 INFO - Downloading blessings-1.6.tar.gz 04:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:19 INFO - Installing collected packages: blessings 04:24:19 INFO - Running setup.py install for blessings 04:24:19 INFO - Successfully installed blessings 04:24:19 INFO - Cleaning up... 04:24:19 INFO - Return code: 0 04:24:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:19 INFO - Reading from file tmpfile_stdout 04:24:19 INFO - Current package versions: 04:24:19 INFO - argparse == 1.2.1 04:24:19 INFO - blessings == 1.6 04:24:19 INFO - blobuploader == 1.2.4 04:24:19 INFO - docopt == 0.6.1 04:24:19 INFO - manifestparser == 1.1 04:24:19 INFO - mozInstall == 1.12 04:24:19 INFO - mozcrash == 0.17 04:24:19 INFO - mozdebug == 0.1 04:24:19 INFO - mozdevice == 0.48 04:24:19 INFO - mozfile == 1.2 04:24:19 INFO - mozhttpd == 0.7 04:24:19 INFO - mozinfo == 0.9 04:24:19 INFO - mozleak == 0.1 04:24:19 INFO - mozlog == 3.1 04:24:19 INFO - moznetwork == 0.27 04:24:19 INFO - mozprocess == 0.22 04:24:19 INFO - mozprofile == 0.28 04:24:19 INFO - mozrunner == 6.11 04:24:19 INFO - mozscreenshot == 0.1 04:24:19 INFO - mozsystemmonitor == 0.0 04:24:19 INFO - moztest == 0.7 04:24:19 INFO - mozversion == 1.4 04:24:19 INFO - psutil == 3.1.1 04:24:19 INFO - requests == 1.2.3 04:24:19 INFO - wsgiref == 0.1.2 04:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:19 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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24:19 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 04:24:19 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 04:24:19 INFO - Using env: {'DISPLAY': ':0', 04:24:19 INFO - 'HOME': '/home/cltbld', 04:24:19 INFO - 'LANG': 'en_US.UTF-8', 04:24:19 INFO - 'LANGUAGE': 'en_US:en', 04:24:19 INFO - 'LOGNAME': 'cltbld', 04:24:19 INFO - 'MAIL': '/var/mail/cltbld', 04:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:19 INFO - 'MOZ_NO_REMOTE': '1', 04:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:19 INFO - 'NO_EM_RESTART': '1', 04:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:19 INFO - 'PWD': '/builds/slave/test', 04:24:19 INFO - 'SHELL': '/bin/bash', 04:24:19 INFO - 'SHLVL': '1', 04:24:19 INFO - 'TERM': 'linux', 04:24:19 INFO - 'TMOUT': '86400', 04:24:19 INFO - 'USER': 'cltbld', 04:24:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:19 INFO - '_': '/tools/buildbot/bin/python'} 04:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 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)) 04:24:19 INFO - Cleaning up... 04:24:19 INFO - Return code: 0 04:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24: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', 'jsonschema'] in /builds/slave/test/build 04:24: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 jsonschema 04:24:19 INFO - Using env: {'DISPLAY': ':0', 04:24:19 INFO - 'HOME': '/home/cltbld', 04:24:19 INFO - 'LANG': 'en_US.UTF-8', 04:24:19 INFO - 'LANGUAGE': 'en_US:en', 04:24:19 INFO - 'LOGNAME': 'cltbld', 04:24:19 INFO - 'MAIL': '/var/mail/cltbld', 04:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:19 INFO - 'MOZ_NO_REMOTE': '1', 04:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:19 INFO - 'NO_EM_RESTART': '1', 04:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:19 INFO - 'PWD': '/builds/slave/test', 04:24:19 INFO - 'SHELL': '/bin/bash', 04:24:19 INFO - 'SHLVL': '1', 04:24:19 INFO - 'TERM': 'linux', 04:24:19 INFO - 'TMOUT': '86400', 04:24:19 INFO - 'USER': 'cltbld', 04:24:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:19 INFO - '_': '/tools/buildbot/bin/python'} 04:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:19 INFO - Downloading/unpacking jsonschema 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:21 INFO - Downloading/unpacking functools32 (from jsonschema) 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24: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 04:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:22 INFO - warning: no files found matching '*.txt' 04:24:22 INFO - no previously-included directories found matching 'build' 04:24:22 INFO - no previously-included directories found matching 'dist' 04:24:22 INFO - no previously-included directories found matching '.git*' 04:24:22 INFO - Installing collected packages: jsonschema, functools32 04:24:22 INFO - Running setup.py install for functools32 04:24:22 INFO - warning: no files found matching '*.txt' 04:24:22 INFO - no previously-included directories found matching 'build' 04:24:22 INFO - no previously-included directories found matching 'dist' 04:24:22 INFO - no previously-included directories found matching '.git*' 04:24:22 INFO - Successfully installed jsonschema functools32 04:24:22 INFO - Cleaning up... 04:24:22 INFO - Return code: 0 04:24:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:22 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 0x7fb6a3e51f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, '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': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', '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 04:24:22 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 04:24:22 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 04:24:22 INFO - Using env: {'DISPLAY': ':0', 04:24:22 INFO - 'HOME': '/home/cltbld', 04:24:22 INFO - 'LANG': 'en_US.UTF-8', 04:24:22 INFO - 'LANGUAGE': 'en_US:en', 04:24:22 INFO - 'LOGNAME': 'cltbld', 04:24:22 INFO - 'MAIL': '/var/mail/cltbld', 04:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:22 INFO - 'MOZ_NO_REMOTE': '1', 04:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:22 INFO - 'NO_EM_RESTART': '1', 04:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:22 INFO - 'PWD': '/builds/slave/test', 04:24:22 INFO - 'SHELL': '/bin/bash', 04:24:22 INFO - 'SHLVL': '1', 04:24:22 INFO - 'TERM': 'linux', 04:24:22 INFO - 'TMOUT': '86400', 04:24:22 INFO - 'USER': 'cltbld', 04:24:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:22 INFO - '_': '/tools/buildbot/bin/python'} 04:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:22 INFO - Downloading/unpacking flake8 04:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:24:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:24:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:24 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 04:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:25 INFO - no previously-included directories found matching 'docs/_build' 04:24:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:24:25 INFO - Running setup.py install for pep8 04:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:25 INFO - no previously-included directories found matching 'docs/_build' 04:24:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:24:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:24:25 INFO - Cleaning up... 04:24:25 INFO - Return code: 0 04:24:25 INFO - Running post-action listener: _resource_record_post_action 04:24:25 INFO - Running post-action listener: _start_resource_monitoring 04:24:25 INFO - Starting resource monitoring. 04:24:25 INFO - ##### 04:24:25 INFO - ##### Finished create-virtualenv step (success) 04:24:25 INFO - ##### 04:24:25 INFO - ##### 04:24:25 INFO - ##### Running install step. 04:24:25 INFO - ##### 04:24:25 INFO - Running pre-action listener: _resource_record_pre_action 04:24:25 INFO - Running main action method: install 04:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:25 INFO - Reading from file tmpfile_stdout 04:24:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:25 INFO - Reading from file tmpfile_stdout 04:24:25 INFO - Output received: 04:24:25 INFO - Usage: mozinstall [options] installer 04:24:25 INFO - Options: 04:24:25 INFO - -h, --help show this help message and exit 04:24:25 INFO - -d DEST, --destination=DEST 04:24:25 INFO - Directory to install application into. [default: 04:24:25 INFO - "/builds/slave/test"] 04:24:25 INFO - --app=APP Application being installed. [default: firefox] 04:24:25 INFO - mkdir: /builds/slave/test/build/application 04:24:25 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'] 04:24:25 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 04:24:41 INFO - Reading from file tmpfile_stdout 04:24:41 INFO - Output received: 04:24:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:41 INFO - Running post-action listener: _resource_record_post_action 04:24:41 INFO - ##### 04:24:41 INFO - ##### Finished install step (success) 04:24:41 INFO - ##### 04:24:41 INFO - ##### 04:24:41 INFO - ##### Running run-tests step. 04:24:41 INFO - ##### 04:24:41 INFO - Running pre-action listener: _resource_record_pre_action 04:24:41 INFO - Running main action method: run_tests 04:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:41 INFO - Python 2.7.3 04:24:41 INFO - Return code: 0 04:24:41 INFO - grabbing minidump binary from tooltool 04:24:41 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')]} 04:24:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13eb9c0>, '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 0x13ec8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ecd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:41 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 04:24:41 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 04:24:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:41 INFO - Return code: 0 04:24:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:42 INFO - Return code: 0 04:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 04:24:42 INFO - Using env: {'DISPLAY': ':0', 04:24:42 INFO - 'HOME': '/home/cltbld', 04:24:42 INFO - 'LANG': 'en_US.UTF-8', 04:24:42 INFO - 'LANGUAGE': 'en_US:en', 04:24:42 INFO - 'LOGNAME': 'cltbld', 04:24:42 INFO - 'MAIL': '/var/mail/cltbld', 04:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:42 INFO - 'MOZ_NO_REMOTE': '1', 04:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:42 INFO - 'NO_EM_RESTART': '1', 04:24:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:42 INFO - 'PWD': '/builds/slave/test', 04:24:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:42 INFO - 'SHELL': '/bin/bash', 04:24:42 INFO - 'SHLVL': '1', 04:24:42 INFO - 'TERM': 'linux', 04:24:42 INFO - 'TMOUT': '86400', 04:24:42 INFO - 'USER': 'cltbld', 04:24:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577', 04:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:42 INFO - '_': '/tools/buildbot/bin/python'} 04:24:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:24:42 INFO - mozversion application_buildid: 20160509024751 04:24:42 INFO - mozversion application_changeset: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce 04:24:42 INFO - mozversion application_display_name: Nightly 04:24:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:42 INFO - mozversion application_name: Firefox 04:24:42 INFO - mozversion application_remotingname: firefox 04:24:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:24:42 INFO - mozversion application_vendor: Mozilla 04:24:42 INFO - mozversion application_version: 49.0a1 04:24:42 INFO - mozversion platform_buildid: 20160509024751 04:24:42 INFO - mozversion platform_changeset: 7adbdf0fce9ac43118938d8e3dc6c0f500a2ffce 04:24:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:24:42 INFO - mozversion platform_version: 49.0a1 04:24:42 INFO - using testdate: 1462793082 04:24:42 INFO - actual date: 1462793082 04:24:42 INFO - starting webserver on 'localhost:38360' 04:24:42 INFO - SUITE-START | Running 2 tests 04:24:42 INFO - TEST-START | dromaeo_css 04:24:42 INFO - operating with platform_type : linux_ 04:24:42 INFO - Initialising browser for dromaeo_css test... 04:24:42 INFO - TEST-INFO | started process 16164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRsimbl/profile http://localhost:38360/getInfo.html) 04:24:46 INFO - PROCESS | 16164 | 04:24:46 INFO - PROCESS | 16164 | (process:16230): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:24:47 INFO - PROCESS | 16164 | __metrics Screen width/height:1600/1200 04:24:47 INFO - PROCESS | 16164 | colorDepth:24 04:24:47 INFO - PROCESS | 16164 | Browser inner width/height: 1024/697 04:24:47 INFO - PROCESS | 16164 | __metrics 04:24:48 ERROR - PROCESS | 16164 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:24:49 INFO - TEST-INFO | 16164: exit 0 04:24:49 INFO - Browser initialized. 04:24:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:49 INFO - TEST-INFO | started process 16281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRsimbl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:51 INFO - PROCESS | 16281 | 04:24:51 INFO - PROCESS | 16281 | (process:16341): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:01 INFO - PROCESS | 16281 | RSS: Main: 164315136 04:25:01 INFO - PROCESS | 16281 | 04:25:50 INFO - PROCESS | 16281 | 1462793150621 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] 04:28:01 INFO - PROCESS | 16281 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38360/tests/dromaeo/cssquery-ext.html) 04:28:03 INFO - PROCESS | 16281 | RSS: Main: 167141376 04:28:03 INFO - PROCESS | 16281 | 04:31:05 INFO - PROCESS | 16281 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-ext.html (next: http://localhost:38360/tests/dromaeo/cssquery-jquery.html) 04:31:06 INFO - PROCESS | 16281 | RSS: Main: 166645760 04:31:06 INFO - PROCESS | 16281 | 04:34:08 INFO - PROCESS | 16281 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38360/tests/dromaeo/cssquery-mootools.html) 04:34:08 INFO - PROCESS | 16281 | RSS: Main: 167981056 04:34:08 INFO - PROCESS | 16281 | 04:37:10 INFO - PROCESS | 16281 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38360/tests/dromaeo/cssquery-prototype.html) 04:37:11 INFO - PROCESS | 16281 | RSS: Main: 165761024 04:37:11 INFO - PROCESS | 16281 | 04:40:14 INFO - PROCESS | 16281 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38360/tests/dromaeo/cssquery-yui.html) 04:40:14 INFO - PROCESS | 16281 | RSS: Main: 166912000 04:40:14 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-yui.html (next: http://localhost:38360/tests/dromaeo/cssquery-dojo.html) 04:43:17 INFO - PROCESS | 16281 | RSS: Main: 168390656 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | __start_tp_report 04:43:17 INFO - PROCESS | 16281 | _x_x_mozilla_page_load 04:43:17 INFO - PROCESS | 16281 | _x_x_mozilla_page_load_details 04:43:17 INFO - PROCESS | 16281 | |i|pagename|runs| 04:43:17 INFO - PROCESS | 16281 | |0;dojo.html;2654.6018097285405;2709.9322516937073;2725.8773355199014;2730.140005898143;2738.4249307645396;4776.665633405659;4785.832495862645;4837.854864354066;4891.4374846892615;4911.336969509115;4695.6947798393085;4802.807887684488;4834;4850.660453768238;4868.56182943535;4380.860976146201;4436.822527098912;4547.272436410175;4550.408446901898;4577.404937358138;526.2934976477583;4348.695591308609;4453.242948698729;4467.977660111695;4477.082198149372;4472.284434490466;4477.350784136282;4483.170613436525;4491.258942274537;4522.072975040125;4413.624841888443;4491.23648979671;4503.369528266046;4509.774511274423;4539.001419687696;4405.074934263808;4411.1618792429335;4432.113577284556;4475.9481521842345;4482.574155455227;4711.175544279738;4744.14605371033;4752.5247475252545;4800.516077808661;4830.058138662962;5012.223105418666;5164.044651739403;5192.92210616841;5197.298364720752;5204.271402003723;5282;5283.418823929364;5311.389190243133;5311.521963023308;5349.43830897754;4887.828925987574;4913.975430122898;4915.336429581961;4947.183714687072;4949.727764972961;5157.922631160535;5309.840704778786;5317.680939143586;5347.331583552056;5431.321084864392;5128.538431541179;5145.639805213599;5148.845534633892;5152.227165925141;5184.248283998799;5227.634065615446;5248.107821670325;5251.684898906078;5256.5269125778095;5295.894082118413;5004.42449118356;5131.1277082895995;5158.071547121554;5183.896322073613;5198.246254293106;4929.679570827956;5148.613853960968;5209.557187639093;5214.426413094557;5214.869628259324;4427.667924905645;4432.49026361966;4447.043885564619;4459.710118842265;4502.122086193161;3743.8689645862264;3811.313963486599;3815.790131542736;3859.459675645412;3922.5292964844402;4518.8418405356315;4523.095380923828;4541.296099104644;4553.704009239389;4569.725816451024;5266.499682530153;5310.548603368679;5322.201669749568;5340.065488539568;5341.866453338697;4336.002719374498;4455.910881782411;4479.664025198123;4508.256137737237;4576.222042252825;4707.83522576715;4724.88187795301;4726.314684370747;4729.787159577827;4767.903382222108;4924.285978533164;4941.75291235444;4955.520982926434;4974.253861920669;5004.199328107486;5065.113605119163;5138.820141295037;5139.8458046258675;5179.559737422362;5205.531502164823;4843.782029808737;4849.709017458964;4858.489858564941;4868.269759536098;4906.656534042583;4935.876603084952;5111.3355263815465;5138.820141295037;5141.28022076902;5162.9483705162465;5166.819161329336;5213.530782229617;5235.031519168966;5249.212618107162;5270.60470464709;5053.74731263428;5059.848204553869;5068.239764035424;5105.8723531912;5122.436531981553;4916.975415122902;4981.726005069756;5081.263216833465;5083.5678967288195;5089.05852417304;4800;4856.028794241237;4878.609711223165;4923.852284431473;5023.874403139951;5079.92380114306;5081.695098294114;5087.592992560661;5090.440051594248;5091.159958606789;5006.224035274538;5012.749362531932;5044.54599086084;5045.571126454146;5048.772805223847 04:43:17 INFO - PROCESS | 16281 | |1;ext.html;544.1837244133799;618.1839971237968;621.2234706616731;626.4612433307354;643.4112786800079;35359;40309.596904030914;40322.39516407253;40354.385824567056;40565.79717101418;40892.59107408925;41549.376759348634;41612.16775664485;41659.58340416595;41720.58279417205;7855.921440785591;7952.165022672622;7953.363730901514;7987.201279872024;8010.279074883259;7846.607669616496;7903.565303908283;7909.24862138096;7927.207279272085;7958.204179582024;7909.683612655487;7924.484908480959;7952.761417157466;7965.44241903067;7987.522308372941;7911.8417631647335;7939.126696063428;7939.523628582304;7951.165127661599;7983.920160798376;7885.053793544754;7902.604869756489;7913.406494512935;7946.960265198637;7962.243586859239;30729.385412291853;38150.42774358387;38519.22961540754;38568.42147367792;38641.613583864084;3100.0544833825675;3274.4269752793166;3285.0801775502896;3825.3879379299456;3910.296146693594;29309.26726831825;29410.264743381373;29535;30570;30713.539296910563;3335.266241426882;3379.729621630264;3410.5736782902136;3417.3677869593957;3437.1750779812664;218361;219075.42773716655;220559;221972;222113;33160.33679326448;33491.66508334885;33621.49567756485;33623;33760.662393376246;33704.49443258353;35711.4643280351;36210.27579448396;36245;36301.636983629825;11781.823272650918;11874.584389546497;11886.940565297291;11889.227200231957;11937.224080434744;10297.845532317022;10330.070293673605;10374.377537347633;10375.896241037493;10386.221033422373;8336.208060234268;8436.28291595209;8444.662213511514;8504.744857654281;8508.319334453228;3248.447763880146;3297.38998285318;3310.2551925816497;3335.483000134983;3359.512870633793;934.8223837470858;965.3532133470592;990.4799980010553;993.339429279521;1038.5430410619304;29235.56146657802;29731.40537189244;29790.10629681113;30083.849580751958;30200.24499387489;983.8032393521181;1054.514923135351;1060.5015642647943;1076.983845242322;1140.8288756686563;15492.767608485881;15783.842161578466;15943.20283985796;16036.358545658277;16217.108059056865;395523;402149;402193;402612;403136;50157;51675.22487162695;51702.741486292325;51812.74093629508;51841;1294.3786982248573;1296.5786119511197;1301.3103055380664;1311.6196303072193;1315.9013074019488;27393.178204653894;28675.713242867303;28826;29319.560206596492;29506.704932951256;44075;44341.77829110834;44666.3300050506;44766.55233447624;44796.77601611971;303220;305183;305298;305424;305890;26009.609855852555;26492.205233843015;26612;26619.33451663724;26744.866275669276;41423;44650;44798;45457.54542454533;45736;36688.44967325439;37671.246575067795;37763.62236377601;38200.04499887525;38242.80878595701;37058;37068.629313706515;37694;38059.2388152241;38169.85490435291;37654;38527.61472385353;38676.80661596674;38838.4174237381;41824.79087604542;31467.52798708067;34990.12524686903;35103.47344789779;35243.82378088093;35346;26575.33561660974;26587.867060664572;26634.200973970812;27812.58281125744;29255 04:43:17 INFO - PROCESS | 16281 | |2;jquery.html;371.82338389265084;377.70727686043324;378.3511278157959;378.52684144818977;384.2123646524624;15789.210539473024;16613.83386166138;17280.395186168487;17282.82717172828;17296.913515432436;15891.920540397281;16297.185140742975;17217.741733874;17244.22400991955;17246.655066898686;5017.64876458649;5150.33045704058;5153.716545589991;5171.0692075426405;5178.741062946857;3664.468652045452;5085.872853178663;5648.350439699426;5931.703414829263;5935.732892019848;5998.130271110686;6013.458788709016;6016.8495787605225;6041.335453100155;6044.939550604504;5043.319151914499;5380.784768609271;5382.407935127152;5421.593380496439;5443.945560544384;5067.885065285668;5181.611379146579;5367.46325367464;5367.570594352443;5386.569074474032;12055.21641093326;12117.454714537867;12304.446299916524;12313.384330783425;18595.721064184047;1919.376202734117;1927.171316333976;1977.8813271203774;2002.7596688397487;2020.1919232307196;8905.955470222672;9342.719718408458;9404.482753448558;9432.386894851812;9682;1715.4939292908623;1758.5515693498205;1765.479183640829;1776.165202354891;1790.7672002639704;69305;72639;72951;73203;73505.63247183729;9420.481873496887;9425.38734982224;9467.526623668928;9614.278929080347;9632.325737198329;12826.011968144952;12847;12903.870961290455;12914.870851291555;12937.870621293667;6574.652196299747;6860.995635259986;6963.373296403348;7007.439404847702;7098.68055937484;6465.741370345228;6521.9673901630185;6597.835054123685;6612.239592446834;6689.431398331197;3844.9231015379537;3951.565327813938;3991.980040099781;4040.212158629039;4346.521882592912;1584.5721655153045;1590.530793415945;1705.7441383792282;1722.2422134260885;1756.9912150439422;858.3819649852096;900.7658008917598;916.8945571259258;944.8393773058459;1006.1347241372414;16159.272832722556;16516.339346426248;16748.330066797193;16894.66210675804;17059.91470042642;897.8473659477904;918.0956757593765;919.4804935211585;926.6108234541508;941.077743811069;9213.723588292361;9287.442753434816;9288.34981551285;9432.481213533321;9494.620215191453;398546;402942.7792915543;407081;410447;412747;77160;78078;78593;82072;82790.58604707058;957.1051067252141;984.640606178754;990.3166814897842;993.8509223616516;1005.6982905128432;9750.561224745046;9846.458444785605;14750.893682973605;14770.77843832322;15263.08421494714;33064.66935330712;35648;36112;36727;39304;46844.29733554068;50776.49223507865;51387.22919156141;51782.48217517776;51864.48135518596;6011;9325.580348884181;9971.351862128939;11422.31466112036;11841.052715782544;6523.9347606525225;6647.434968027578;8202.917970820215;8418.747437576883;10720;7565.621718914143;7713.112992005991;7784.571848548384;7841.451098423284;7911.446198766032;7327.340539351484;7481.663325150273;7508.174100848793;7815.29662330393;7883.251091146332;7934.2859142677435;7936.246056624612;7977.7207797726805;8076.555789431638;8160.26557609818;11587.884121159017;11687.415629218334;11701.239419437708;11711.121665874924;11921.642350729491;10940.507677154388;11092.611758588411;11202.887971120184;11289.943550282196;11313.151513636674 04:43:17 INFO - PROCESS | 16281 | |3;mootools.html;1492.9552113436598;1509.3886975774813;1690.467502736638;1804.458662401281;1823.4438496258635;6484.319146489622;6931.2375638679705;6966.895496567556;7408.481406301561;7416;7080.822979425504;7260;7289.6719647615855;7301.89047164293;7311.4150867930575;2192.8465007449486;2210.3258506155616;2214.3356992902145;2216.5788500184913;2225.2211725895886;2175.923842665507;2177.1073859717517;2226.810721088709;2232.854864433815;2238.3956331790487;2170.522485053286;2177.4882902517897;2182.552576721768;2207.315732123047;2246.9887650561723;2171.0772921508456;2173.6848157017303;2175.5431359414542;2176.064292354295;2185.562887422514;2117.947051323714;2135.1032566322183;2143.0998980428103;2161.7622061573215;2174.8260139188983;7280.2719728027305;7307.707691692326;7322.0847394075745;7342.045534080536;7350.779476615657;4432.556744325574;4542.04617030424;4546.363509108727;4549.977250113761;4559.6580256480565;2925.9268518287;2928.824270543774;3090.9381812363627;3091.8608662610236;3095.9535606965915;963.937344072633;968.9757756056155;982.003266684316;986.3243678080538;1007.2546315726383;9745.610175592969;9860.852087218698;9862.211023118205;9878.407295562289;9910.15763660097;4145.461090058273;4236.237477254123;4284.764337961442;4291.592298731615;4298.20483210607;8534;8588.141185881486;8595.140485951355;8599.183077607617;8619.870701939475;4365.759883206454;4418.5802348776815;4443.289073748185;4555.612772914273;4557.6581756368405;3540.1149712571855;3935.704822138351;4120.855770048034;4149.6265336119895;4174.937375939363;3510.982445087758;3545.4859045438266;3582.0865679252147;3606.891793246207;3625.274945011008;1152.504423098059;1154.7748189103213;1159.3913195572393;1170.267425561307;1176.153439100621;856.3448961544424;862.5600943518725;874.2394117118148;879.7976465412991;889.4085433186988;4926.9014619707405;4994.126027945095;5054.49455054499;5218.582513398919;5351.57187425005;834.7036801935348;850.8340873529602;860.642833224205;870.4951128345544;914.7164379042385;3327.966720332814;3386.5428167197115;3394.0835974286806;3452.3267962747022;3474.3919814032442;8814.823703525894;9071.637134514678;9120.361574689841;9147.58835852375;9162.267018638493;9060.728178154666;9129.771755706028;9137.314701397421;9177.541122943827;9181.357304988587;6569.540132190797;6655.401013908771;7085.114360704912;7141.500094993301;7159.856802863914;5041.974790126026;5042.747862606781;5059.696418214919;5071.036503064406;5077.136886729191;8384.706535271236;8417;8594.054653988182;8675.609597568251;8680.91319086801;8481.321494280319;8679.305655547667;8681.08848570891;8735;8771.649134034567;5657.094864821609;5849.210356601804;5947.167396564398;6208.9689551551955;6308.179936608395;7034.788956331318;7069.39910107626;7092.6099064551945;7115.039469671528;7123.572585644878;6336.683165841598;6525.771597994048;6590.736370545124;6632.303608121078;6639.435647969976;6233.127362169391;6294;6331.018692102732;6380.202474690664;6510.967445162744;6137.539684523589;6184;6184.6598437086395;6218.129461875251;6219.284782250099;4335.634275203301;4517.277235642281;4525.253333200117;4572.4055872736335;4588.770561471846;4567.2920697291975;4593.839215627437;4622.976885115553;4681.227597446519;4686.390769199982 04:43:17 INFO - PROCESS | 16281 | |4;prototype.html;313.54379378005;314.10010320431957;318.4681581758463;321.7201035099464;323.38233973111363;4936.259561065842;4987.152184128698;5017.849464516065;5053;5073.315102461167;4989.925151122736;4995.800167993285;4997.575206107476;5012.749362531877;5046.192609182532;3716.5540135183746;3816.370298900678;3889.9416508752392;3915.2169566086895;3917.6278253565865;3908.2769687607743;3913.456253435276;3915.706322025845;3919.4708714323488;3928.2536318099615;3859.899928520372;3878.146807702301;3885.164689591737;3889.533256009283;3943.6450719435247;3830.5211848518934;3889.4554762333296;3896.2597106549665;3897.902552436183;3935.48838650975;3433.725301975836;3444.793312401239;3452.154222215573;3457.4640930655787;3458.2564748579175;4688.203005489041;4693.737852192728;4702.3416721659;4721.622270218409;4750.904981900378;4463.375127482155;4467.821287148543;4493.955250361078;4516.616087632555;4527.547245275446;4950.257461380822;5214.634975551713;5224.76488558012;5228.764705588258;5255.76349064293;3672.6143754905884;3697.8335974881193;3703.9073473325166;3705.555333359987;3722.664960153599;5452.68260989078;5457.781688732446;5489.149181876775;5491.643043202179;5532.917006244869;3677.9264414712093;3773.7735735855936;3774.9433758493647;3778.205352457616;3788.6400791924725;3841.9423708644395;3852.5184351956004;3856.325143099946;3862.8025312153322;3878.332317103616;4399.5820397062225;4408.258737798552;4412.271975124133;4439.711418757771;4440.2461027893805;5151.25306830515;5233.2935053768015;5239.397469291081;5253.605979551549;5261.684298942076;1275.0628288208159;1286.9420876060599;1295.3393769177787;1297.7080156964607;1297.772889744291;820.5445977482435;843.8734189871568;867.757028032152;886.5611522296505;888.5246393179618;4399.73601583906;4528.233988744392;4530.864074077783;4572.7713614319155;4575.267957126844;5330.573554115662;5344.225087362311;5377.892442151135;5436.293281873332;5454.236406903036;4464.17412778637;4593.2191527439745;4617.845538615346;4628.120657075145;4636.211843986531;2807.5367564352064;2839.4605025045175;2846.4022555263214;2849.059810262608;2856.571514272876;5029.1953287473825;5041.092603331363;5047.369078865142;5051;5062.848114556569;5128.282040514331;5205.583553315726;5350.5184533392185;5414.402751188409;5463.890722185613;4885.117780509517;4887.7556122194455;4916.852494425173;4924.8030078797165;4930.6055515557955;5248.606354523502;5287.762050707651;5305.708186049805;5319.829637479748;5320.228566857862;4938.950610493993;5159.277701121771;5230.947690523199;5316.946830531645;5317.57459403239;5078.669886457368;5091.541761241358;5096.770645320896;5111.693298402108;5129.410117836496;3768.812823960444;3787.772733635991;3795.411711184771;3803.6576708096404;3806.8286927088902;5183.585313175013;5420.509359926052;5448.45515448452;5463.060613482156;5479.698616576126;5231.189165679326;5242.580593552583;5257.947420525746;5271.288376069181;5285.973570132125;5267.236250743544;5272.288241087557;5275.208718692227;5303.867403314948;5309.203619457112;5005.199168133081;5174.7930082796265;5182.170852663556;5261.4738526147075;5267.709411194129;5118.846434606968;5123.948760512496;5243.606729495227;5256.237845512455;5323.813666521653;5123.257127716534;5124.180131178993;5126.2054381570915;5137.409197942285;5141.820036298712 04:43:17 INFO - PROCESS | 16281 | |5;yui.html;698.0715648187911;721.1166321256458;728.7813655903228;784.1648644193934;836.9539675317859;11077.556897724091;11480.885191148096;11481.540738370477;11520.135989800778;11532.769344613103;11510.884891151087;11710.414479276045;11717.414129293544;11755.941220293907;11769.882301176985;857.2070834478114;871.5772850167664;872.655301156043;873.0789017586444;873.6112429968666;675.8479342148001;844.8014716541608;869.9130086991313;875.6409871952501;875.8554838451648;917.9954100229489;919.3932004876783;921.2583869984693;923.1968187676731;928.109015345266;914.2229105260542;915.839728047589;916.3036092569629;917.6971599372191;918.453520155513;678.2302087131093;678.3149019490351;678.5860625018735;678.8031470873441;680.8876535371658;11057.612983545618;11069.778604427947;11069.889301107047;11096.167787415976;11100.55597776088;11988.70028249292;12130.211536250205;12142.575009874701;12268.877311226863;12440.937795311056;10418.635347762793;10438.425886576235;10535.683929482127;10540.472976351228;10601.363918164934;4116.629503344683;4127;4220.07158425149;4283.571642835723;4331.133773245332;42507;42809.57190428087;42825.785871070446;42921.78539107316;43029.99999999969;9912.437810945274;10143.847842282372;10162.39025658463;10241.180705543538;10306.072453479223;17220.483385498454;17394.391196308068;17426.390076347267;17459.127043647768;17561.736573951403;6508.153939987771;6581.308962558958;6595.472362211011;6677.399034086956;6778.4916131289365;3282.163048422637;3406.7615266931075;3530.5763308403157;3575.910602234965;3585.15748799032;2784.832910025405;2869.512182928907;2888.2923683697627;2914;3119.953200701991;593.7239183779564;595.9821205363846;609.823151286131;615.9445649891532;625.5558553427027;626.3454689849119;647.5790736021623;669.7220653428773;673.2325149329768;685.917689877208;7806.687732490636;7902.604869756489;7942.563159026309;8097.838043239102;8155.469894456842;489.42003725585295;540.4109520622462;558.2324304081887;584.9795257165979;606.7451670298485;3829.659619133281;3884.892805550405;3980.5024371953505;4012.598740125964;4033.4554835097474;53039.73480132652;54535.72732136314;54599.45400546023;54799.178012329845;54943.45056549463;48291;48614.5138548617;49202.753986229836;49515.25727114096;49760.25359619609;46137.7693111539;46187.3071903915;46297.53702462999;46417.53582464132;47159;7643.541387516767;7644.273793989562;7738.806529836799;7783.883241751491;8082.878756818534;30480.695193048672;31255.53116703206;31429.528557071204;31999;32153.517697235027;39919.40120898247;39977.20045599013;40184.19631607293;40206.79896600615;40290.798546007085;10142.594296228363;10270.608198624821;10300.639477618248;10581.259311848096;10647.361158330525;10216.284860060021;10850.620228291971;10883.78232435331;10929.617463388744;11002.614908478165;9895.356801807859;10095.646652367132;10206.846897296695;10515;10691.198160138176;9441.858372124287;9483.762905927408;9576.281778866753;9583.089606487372;10045.095941365313;9007.189352958265;9099.590518426554;9155.313351498531;9474.810503789748;9579.664711735057;8263.504189748634;8586.91413085886;8724.302055835391;8748.825023499621;8925.464472131693;8701.699310043436;9245.907540924774;9273.489958052372;9297.535123243946;9320.207782338577 04:43:17 INFO - PROCESS | 16281 | __end_tp_report 04:43:17 INFO - PROCESS | 16281 | __start_cc_report 04:43:17 INFO - PROCESS | 16281 | _x_x_mozilla_cycle_collect,362 04:43:17 INFO - PROCESS | 16281 | __end_cc_report 04:43:17 INFO - PROCESS | 16281 | __startTimestamp1462794197413__endTimestamp 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | ------- Summary: start ------- 04:43:17 INFO - PROCESS | 16281 | Number of tests: 6 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | [#0] dojo.html Cycles:165 Average:4783.54 Median:4924.29 stddev:605.83 (12.3%) stddev-sans-first:584.22 04:43:17 INFO - PROCESS | 16281 | Values: 2654.6 2709.9 2725.9 2730.1 2738.4 4776.7 4785.8 4837.9 4891.4 4911.3 4695.7 4802.8 4834.0 4850.7 4868.6 4380.9 4436.8 4547.3 4550.4 4577.4 526.3 4348.7 4453.2 4468.0 4477.1 4472.3 4477.4 4483.2 4491.3 4522.1 4413.6 4491.2 4503.4 4509.8 4539.0 4405.1 4411.2 4432.1 4475.9 4482.6 4711.2 4744.1 4752.5 4800.5 4830.1 5012.2 5164.0 5192.9 5197.3 5204.3 5282.0 5283.4 5311.4 5311.5 5349.4 4887.8 4914.0 4915.3 4947.2 4949.7 5157.9 5309.8 5317.7 5347.3 5431.3 5128.5 5145.6 5148.8 5152.2 5184.2 5227.6 5248.1 5251.7 5256.5 5295.9 5004.4 5131.1 5158.1 5183.9 5198.2 4929.7 5148.6 5209.6 5214.4 5214.9 4427.7 4432.5 4447.0 4459.7 4502.1 3743.9 3811.3 3815.8 3859.5 3922.5 4518.8 4523.1 4541.3 4553.7 4569.7 5266.5 5310.5 5322.2 5340.1 5341.9 4336.0 4455.9 4479.7 4508.3 4576.2 4707.8 4724.9 4726.3 4729.8 4767.9 4924.3 4941.8 4955.5 4974.3 5004.2 5065.1 5138.8 5139.8 5179.6 5205.5 4843.8 4849.7 4858.5 4868.3 4906.7 4935.9 5111.3 5138.8 5141.3 5162.9 5166.8 5213.5 5235.0 5249.2 5270.6 5053.7 5059.8 5068.2 5105.9 5122.4 4917.0 4981.7 5081.3 5083.6 5089.1 4800.0 4856.0 4878.6 4923.9 5023.9 5079.9 5081.7 5087.6 5090.4 5091.2 5006.2 5012.7 5044.5 5045.6 5048.8 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | [#1] ext.html Cycles:180 Average:45707.11 Median:36873.22 stddev:83816.88 (227.3%) stddev-sans-first:83983.42 04:43:17 INFO - PROCESS | 16281 | Values: 544.2 618.2 621.2 626.5 643.4 35359.0 40309.6 40322.4 40354.4 40565.8 40892.6 41549.4 41612.2 41659.6 41720.6 7855.9 7952.2 7953.4 7987.2 8010.3 7846.6 7903.6 7909.2 7927.2 7958.2 7909.7 7924.5 7952.8 7965.4 7987.5 7911.8 7939.1 7939.5 7951.2 7983.9 7885.1 7902.6 7913.4 7947.0 7962.2 30729.4 38150.4 38519.2 38568.4 38641.6 3100.1 3274.4 3285.1 3825.4 3910.3 29309.3 29410.3 29535.0 30570.0 30713.5 3335.3 3379.7 3410.6 3417.4 3437.2 218361.0 219075.4 220559.0 221972.0 222113.0 33160.3 33491.7 33621.5 33623.0 33760.7 33704.5 35711.5 36210.3 36245.0 36301.6 11781.8 11874.6 11886.9 11889.2 11937.2 10297.8 10330.1 10374.4 10375.9 10386.2 8336.2 8436.3 8444.7 8504.7 8508.3 3248.4 3297.4 3310.3 3335.5 3359.5 934.8 965.4 990.5 993.3 1038.5 29235.6 29731.4 29790.1 30083.8 30200.2 983.8 1054.5 1060.5 1077.0 1140.8 15492.8 15783.8 15943.2 16036.4 16217.1 395523.0 402149.0 402193.0 402612.0 403136.0 50157.0 51675.2 51702.7 51812.7 51841.0 1294.4 1296.6 1301.3 1311.6 1315.9 27393.2 28675.7 28826.0 29319.6 29506.7 44075.0 44341.8 44666.3 44766.6 44796.8 303220.0 305183.0 305298.0 305424.0 305890.0 26009.6 26492.2 26612.0 26619.3 26744.9 41423.0 44650.0 44798.0 45457.5 45736.0 36688.4 37671.2 37763.6 38200.0 38242.8 37058.0 37068.6 37694.0 38059.2 38169.9 37654.0 38527.6 38676.8 38838.4 41824.8 31467.5 34990.1 35103.5 35243.8 35346.0 26575.3 26587.9 26634.2 27812.6 29255.0 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | [#2] jquery.html Cycles:180 Average:24447.40 Median:28482.05 stddev:67188.58 (235.9%) stddev-sans-first:67352.75 04:43:17 INFO - PROCESS | 16281 | Values: 371.8 377.7 378.4 378.5 384.2 15789.2 16613.8 17280.4 17282.8 17296.9 15891.9 16297.2 17217.7 17244.2 17246.7 5017.6 5150.3 5153.7 5171.1 5178.7 3664.5 5085.9 5648.4 5931.7 5935.7 5998.1 6013.5 6016.8 6041.3 6044.9 5043.3 5380.8 5382.4 5421.6 5443.9 5067.9 5181.6 5367.5 5367.6 5386.6 12055.2 12117.5 12304.4 12313.4 18595.7 1919.4 1927.2 1977.9 2002.8 2020.2 8906.0 9342.7 9404.5 9432.4 9682.0 1715.5 1758.6 1765.5 1776.2 1790.8 69305.0 72639.0 72951.0 73203.0 73505.6 9420.5 9425.4 9467.5 9614.3 9632.3 12826.0 12847.0 12903.9 12914.9 12937.9 6574.7 6861.0 6963.4 7007.4 7098.7 6465.7 6522.0 6597.8 6612.2 6689.4 3844.9 3951.6 3992.0 4040.2 4346.5 1584.6 1590.5 1705.7 1722.2 1757.0 858.4 900.8 916.9 944.8 1006.1 16159.3 16516.3 16748.3 16894.7 17059.9 897.8 918.1 919.5 926.6 941.1 9213.7 9287.4 9288.3 9432.5 9494.6 398546.0 402942.8 407081.0 410447.0 412747.0 77160.0 78078.0 78593.0 82072.0 82790.6 957.1 984.6 990.3 993.9 1005.7 9750.6 9846.5 14750.9 14770.8 15263.1 33064.7 35648.0 36112.0 36727.0 39304.0 46844.3 50776.5 51387.2 51782.5 51864.5 6011.0 9325.6 9971.4 11422.3 11841.1 6523.9 6647.4 8202.9 8418.7 10720.0 7565.6 7713.1 7784.6 7841.5 7911.4 7327.3 7481.7 7508.2 7815.3 7883.3 7934.3 7936.2 7977.7 8076.6 8160.3 11587.9 11687.4 11701.2 11711.1 11921.6 10940.5 11092.6 11202.9 11289.9 11313.2 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | [#3] mootools.html Cycles:180 Average:4933.06 Median:5504.33 stddev:2654.63 (48.2%) stddev-sans-first:2649.49 04:43:17 INFO - PROCESS | 16281 | Values: 1493.0 1509.4 1690.5 1804.5 1823.4 6484.3 6931.2 6966.9 7408.5 7416.0 7080.8 7260.0 7289.7 7301.9 7311.4 2192.8 2210.3 2214.3 2216.6 2225.2 2175.9 2177.1 2226.8 2232.9 2238.4 2170.5 2177.5 2182.6 2207.3 2247.0 2171.1 2173.7 2175.5 2176.1 2185.6 2117.9 2135.1 2143.1 2161.8 2174.8 7280.3 7307.7 7322.1 7342.0 7350.8 4432.6 4542.0 4546.4 4550.0 4559.7 2925.9 2928.8 3090.9 3091.9 3096.0 963.9 969.0 982.0 986.3 1007.3 9745.6 9860.9 9862.2 9878.4 9910.2 4145.5 4236.2 4284.8 4291.6 4298.2 8534.0 8588.1 8595.1 8599.2 8619.9 4365.8 4418.6 4443.3 4555.6 4557.7 3540.1 3935.7 4120.9 4149.6 4174.9 3511.0 3545.5 3582.1 3606.9 3625.3 1152.5 1154.8 1159.4 1170.3 1176.2 856.3 862.6 874.2 879.8 889.4 4926.9 4994.1 5054.5 5218.6 5351.6 834.7 850.8 860.6 870.5 914.7 3328.0 3386.5 3394.1 3452.3 3474.4 8814.8 9071.6 9120.4 9147.6 9162.3 9060.7 9129.8 9137.3 9177.5 9181.4 6569.5 6655.4 7085.1 7141.5 7159.9 5042.0 5042.7 5059.7 5071.0 5077.1 8384.7 8417.0 8594.1 8675.6 8680.9 8481.3 8679.3 8681.1 8735.0 8771.6 5657.1 5849.2 5947.2 6209.0 6308.2 7034.8 7069.4 7092.6 7115.0 7123.6 6336.7 6525.8 6590.7 6632.3 6639.4 6233.1 6294.0 6331.0 6380.2 6511.0 6137.5 6184.0 6184.7 6218.1 6219.3 4335.6 4517.3 4525.3 4572.4 4588.8 4567.3 4593.8 4623.0 4681.2 4686.4 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | [#4] prototype.html Cycles:180 Average:4327.07 Median:4937.61 stddev:1259.77 (25.5%) stddev-sans-first:1226.76 04:43:17 INFO - PROCESS | 16281 | Values: 313.5 314.1 318.5 321.7 323.4 4936.3 4987.2 5017.8 5053.0 5073.3 4989.9 4995.8 4997.6 5012.7 5046.2 3716.6 3816.4 3889.9 3915.2 3917.6 3908.3 3913.5 3915.7 3919.5 3928.3 3859.9 3878.1 3885.2 3889.5 3943.6 3830.5 3889.5 3896.3 3897.9 3935.5 3433.7 3444.8 3452.2 3457.5 3458.3 4688.2 4693.7 4702.3 4721.6 4750.9 4463.4 4467.8 4494.0 4516.6 4527.5 4950.3 5214.6 5224.8 5228.8 5255.8 3672.6 3697.8 3703.9 3705.6 3722.7 5452.7 5457.8 5489.1 5491.6 5532.9 3677.9 3773.8 3774.9 3778.2 3788.6 3841.9 3852.5 3856.3 3862.8 3878.3 4399.6 4408.3 4412.3 4439.7 4440.2 5151.3 5233.3 5239.4 5253.6 5261.7 1275.1 1286.9 1295.3 1297.7 1297.8 820.5 843.9 867.8 886.6 888.5 4399.7 4528.2 4530.9 4572.8 4575.3 5330.6 5344.2 5377.9 5436.3 5454.2 4464.2 4593.2 4617.8 4628.1 4636.2 2807.5 2839.5 2846.4 2849.1 2856.6 5029.2 5041.1 5047.4 5051.0 5062.8 5128.3 5205.6 5350.5 5414.4 5463.9 4885.1 4887.8 4916.9 4924.8 4930.6 5248.6 5287.8 5305.7 5319.8 5320.2 4939.0 5159.3 5230.9 5316.9 5317.6 5078.7 5091.5 5096.8 5111.7 5129.4 3768.8 3787.8 3795.4 3803.7 3806.8 5183.6 5420.5 5448.5 5463.1 5479.7 5231.2 5242.6 5257.9 5271.3 5286.0 5267.2 5272.3 5275.2 5303.9 5309.2 5005.2 5174.8 5182.2 5261.5 5267.7 5118.8 5123.9 5243.6 5256.2 5323.8 5123.3 5124.2 5126.2 5137.4 5141.8 04:43:17 INFO - PROCESS | 16281 | 04:43:17 INFO - PROCESS | 16281 | [#5] yui.html Cycles:180 Average:12795.70 Median:24551.97 stddev:14960.59 (60.9%) stddev-sans-first:14974.98 04:43:17 INFO - PROCESS | 16281 | Values: 698.1 721.1 728.8 784.2 837.0 11077.6 11480.9 11481.5 11520.1 11532.8 11510.9 11710.4 11717.4 11755.9 11769.9 857.2 871.6 872.7 873.1 873.6 675.8 844.8 869.9 875.6 875.9 918.0 919.4 921.3 923.2 928.1 914.2 915.8 916.3 917.7 918.5 678.2 678.3 678.6 678.8 680.9 11057.6 11069.8 11069.9 11096.2 11100.6 11988.7 12130.2 12142.6 12268.9 12440.9 10418.6 10438.4 10535.7 10540.5 10601.4 4116.6 4127.0 4220.1 4283.6 4331.1 42507.0 42809.6 42825.8 42921.8 43030.0 9912.4 10143.8 10162.4 10241.2 10306.1 17220.5 17394.4 17426.4 17459.1 17561.7 6508.2 6581.3 6595.5 6677.4 6778.5 3282.2 3406.8 3530.6 3575.9 3585.2 2784.8 2869.5 2888.3 2914.0 3120.0 593.7 596.0 609.8 615.9 625.6 626.3 647.6 669.7 673.2 685.9 7806.7 7902.6 7942.6 8097.8 8155.5 489.4 540.4 558.2 585.0 606.7 3829.7 3884.9 3980.5 4012.6 4033.5 53039.7 54535.7 54599.5 54799.2 54943.5 48291.0 48614.5 49202.8 49515.3 49760.3 46137.8 46187.3 46297.5 46417.5 47159.0 7643.5 7644.3 7738.8 7783.9 8082.9 30480.7 31255.5 31429.5 31999.0 32153.5 39919.4 39977.2 40184.2 40206.8 40290.8 10142.6 10270.6 10300.6 10581.3 10647.4 10216.3 10850.6 10883.8 10929.6 11002.6 9895.4 10095.6 10206.8 10515.0 10691.2 9441.9 9483.8 9576.3 9583.1 10045.1 9007.2 9099.6 9155.3 9474.8 9579.7 8263.5 8586.9 8724.3 8748.8 8925.5 8701.7 9245.9 9273.5 9297.5 9320.2 04:43:17 INFO - PROCESS | 16281 | -------- Summary: end -------- 04:43:17 INFO - PROCESS | 16281 | 04:43:18 INFO - TEST-INFO | 16281: exit 0 04:43:18 INFO - TEST-OK | dromaeo_css | took 1115545ms 04:43:18 INFO - TEST-START | kraken 04:43:18 INFO - operating with platform_type : linux_ 04:43:18 INFO - Initialising browser for kraken test... 04:43:18 INFO - TEST-INFO | started process 16509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_C9zYi/profile http://localhost:38360/getInfo.html) 04:43:22 INFO - PROCESS | 16509 | 04:43:22 INFO - PROCESS | 16509 | (process:16578): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:43:22 INFO - PROCESS | 16509 | __metrics Screen width/height:1600/1200 04:43:22 INFO - PROCESS | 16509 | colorDepth:24 04:43:22 INFO - PROCESS | 16509 | Browser inner width/height: 1024/697 04:43:22 INFO - PROCESS | 16509 | __metrics 04:43:23 ERROR - PROCESS | 16509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:43:24 INFO - TEST-INFO | 16509: exit 0 04:43:24 INFO - Browser initialized. 04:43:24 INFO - Running cycle 1/1 for kraken test... 04:43:24 INFO - TEST-INFO | started process 16629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_C9zYi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:26 INFO - PROCESS | 16629 | 04:43:26 INFO - PROCESS | 16629 | (process:16689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:43:36 INFO - PROCESS | 16629 | RSS: Main: 164323328 04:43:36 INFO - PROCESS | 16629 | 04:43:39 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:40 INFO - PROCESS | 16629 | RSS: Main: 167198720 04:43:40 INFO - PROCESS | 16629 | 04:43:43 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-dft) 04:43:43 INFO - PROCESS | 16629 | RSS: Main: 167669760 04:43:43 INFO - PROCESS | 16629 | 04:43:46 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-fft) 04:43:47 INFO - PROCESS | 16629 | RSS: Main: 163540992 04:43:47 INFO - PROCESS | 16629 | 04:43:49 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-oscillator) 04:43:49 INFO - PROCESS | 16629 | RSS: Main: 164057088 04:43:49 INFO - PROCESS | 16629 | 04:43:52 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38360/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:52 INFO - PROCESS | 16629 | RSS: Main: 164376576 04:43:52 INFO - PROCESS | 16629 | 04:43:56 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38360/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:56 INFO - PROCESS | 16629 | RSS: Main: 164225024 04:43:56 INFO - PROCESS | 16629 | 04:44:00 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38360/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:01 INFO - PROCESS | 16629 | RSS: Main: 162639872 04:44:01 INFO - PROCESS | 16629 | 04:44:04 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38360/tests/kraken/driver.html?testName=json-parse-financial) 04:44:04 INFO - PROCESS | 16629 | RSS: Main: 163680256 04:44:04 INFO - PROCESS | 16629 | 04:44:06 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38360/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:07 INFO - PROCESS | 16629 | RSS: Main: 163721216 04:44:07 INFO - PROCESS | 16629 | 04:44:09 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:09 INFO - PROCESS | 16629 | RSS: Main: 164220928 04:44:09 INFO - PROCESS | 16629 | 04:44:11 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:12 INFO - PROCESS | 16629 | RSS: Main: 164429824 04:44:12 INFO - PROCESS | 16629 | 04:44:15 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:16 INFO - PROCESS | 16629 | RSS: Main: 164179968 04:44:16 INFO - PROCESS | 16629 | 04:44:19 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:19 INFO - PROCESS | 16629 | RSS: Main: 164007936 04:44:19 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38360/tests/kraken/driver.html?testName=ai-astar) 04:44:21 INFO - PROCESS | 16629 | RSS: Main: 165724160 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | __start_tp_report 04:44:21 INFO - PROCESS | 16629 | _x_x_mozilla_page_load 04:44:21 INFO - PROCESS | 16629 | _x_x_mozilla_page_load_details 04:44:21 INFO - PROCESS | 16629 | |i|pagename|runs| 04:44:21 INFO - PROCESS | 16629 | |0;ai-astar;113;115;109;116;119;117;109;117;115;117 04:44:21 INFO - PROCESS | 16629 | |1;audio-beat-detection;165;132;160;221;137;154;163;134;199;135 04:44:21 INFO - PROCESS | 16629 | |2;audio-dft;163;161;169;167;163;164;164;163;161;165 04:44:21 INFO - PROCESS | 16629 | |3;audio-fft;76;77;76;165;77;76;77;76;169;77 04:44:21 INFO - PROCESS | 16629 | |4;audio-oscillator;94;95;170;94;95;93;137;94;92;138 04:44:21 INFO - PROCESS | 16629 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;118;118;119 04:44:21 INFO - PROCESS | 16629 | |6;imaging-darkroom;149;148;147;149;148;147;148;147;147;147 04:44:21 INFO - PROCESS | 16629 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;95;95 04:44:21 INFO - PROCESS | 16629 | |8;json-parse-financial;67;68;67;67;68;67;68;67;66;67 04:44:21 INFO - PROCESS | 16629 | |9;json-stringify-tinderbox;65;66;66;65;65;65;66;65;65;66 04:44:21 INFO - PROCESS | 16629 | |10;stanford-crypto-aes;82;81;82;81;82;84;88;89;146;83 04:44:21 INFO - PROCESS | 16629 | |11;stanford-crypto-ccm;152;131;134;132;134;155;142;136;160;138 04:44:21 INFO - PROCESS | 16629 | |12;stanford-crypto-pbkdf2;175;174;175;171;174;174;173;171;172;173 04:44:21 INFO - PROCESS | 16629 | |13;stanford-crypto-sha256-iterative;70;71;69;69;69;68;67;68;67;66 04:44:21 INFO - PROCESS | 16629 | __end_tp_report 04:44:21 INFO - PROCESS | 16629 | __start_cc_report 04:44:21 INFO - PROCESS | 16629 | _x_x_mozilla_cycle_collect,922 04:44:21 INFO - PROCESS | 16629 | __end_cc_report 04:44:21 INFO - PROCESS | 16629 | __startTimestamp1462794261860__endTimestamp 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | ------- Summary: start ------- 04:44:21 INFO - PROCESS | 16629 | Number of tests: 14 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#0] ai-astar Cycles:10 Average:114.70 Median:116.50 stddev:3.40 (2.9%) stddev-sans-first:3.55 04:44:21 INFO - PROCESS | 16629 | Values: 113.0 115.0 109.0 116.0 119.0 117.0 109.0 117.0 115.0 117.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#1] audio-beat-detection Cycles:10 Average:160.00 Median:161.50 stddev:29.68 (18.4%) stddev-sans-first:31.42 04:44:21 INFO - PROCESS | 16629 | Values: 165.0 132.0 160.0 221.0 137.0 154.0 163.0 134.0 199.0 135.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.49 (1.5%) stddev-sans-first:2.62 04:44:21 INFO - PROCESS | 16629 | Values: 163.0 161.0 169.0 167.0 163.0 164.0 164.0 163.0 161.0 165.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:38.17 (49.9%) stddev-sans-first:39.89 04:44:21 INFO - PROCESS | 16629 | Values: 76.0 77.0 76.0 165.0 77.0 76.0 77.0 76.0 169.0 77.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:94.00 stddev:27.78 (29.5%) stddev-sans-first:28.84 04:44:21 INFO - PROCESS | 16629 | Values: 94.0 95.0 170.0 94.0 95.0 93.0 137.0 94.0 92.0 138.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:44:21 INFO - PROCESS | 16629 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 119.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 04:44:21 INFO - PROCESS | 16629 | Values: 149.0 148.0 147.0 149.0 148.0 147.0 148.0 147.0 147.0 147.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:44:21 INFO - PROCESS | 16629 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 04:44:21 INFO - PROCESS | 16629 | Values: 67.0 68.0 67.0 67.0 68.0 67.0 68.0 67.0 66.0 67.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:44:21 INFO - PROCESS | 16629 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:82.50 stddev:19.94 (24.2%) stddev-sans-first:20.95 04:44:21 INFO - PROCESS | 16629 | Values: 82.0 81.0 82.0 81.0 82.0 84.0 88.0 89.0 146.0 83.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:140.00 stddev:10.49 (7.5%) stddev-sans-first:10.40 04:44:21 INFO - PROCESS | 16629 | Values: 152.0 131.0 134.0 132.0 134.0 155.0 142.0 136.0 160.0 138.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.00 stddev:1.48 (0.8%) stddev-sans-first:1.41 04:44:21 INFO - PROCESS | 16629 | Values: 175.0 174.0 175.0 171.0 174.0 174.0 173.0 171.0 172.0 173.0 04:44:21 INFO - PROCESS | 16629 | 04:44:21 INFO - PROCESS | 16629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.48 04:44:21 INFO - PROCESS | 16629 | Values: 70.0 71.0 69.0 69.0 69.0 68.0 67.0 68.0 67.0 66.0 04:44:21 INFO - PROCESS | 16629 | -------- Summary: end -------- 04:44:21 INFO - PROCESS | 16629 | 04:44:23 INFO - TEST-INFO | 16629: exit 0 04:44:23 INFO - TEST-OK | kraken | took 64951ms 04:44:23 INFO - SUITE-END | took 1180s 04:44:23 INFO - Completed test suite (00:19:40) 04:44:23 INFO - javascript benchmark 04:44:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.6018097285405, 2709.9322516937073, 2725.8773355199014, 2730.140005898143, 2738.4249307645396, 4776.665633405659, 4785.832495862645, 4837.854864354066, 4891.4374846892615, 4911.336969509115, 4695.6947798393085, 4802.807887684488, 4834.0, 4850.660453768238, 4868.56182943535, 4380.860976146201, 4436.822527098912, 4547.272436410175, 4550.408446901898, 4577.404937358138, 526.2934976477583, 4348.695591308609, 4453.242948698729, 4467.977660111695, 4477.082198149372, 4472.284434490466, 4477.350784136282, 4483.170613436525, 4491.258942274537, 4522.072975040125, 4413.624841888443, 4491.23648979671, 4503.369528266046, 4509.774511274423, 4539.001419687696, 4405.074934263808, 4411.1618792429335, 4432.113577284556, 4475.9481521842345, 4482.574155455227, 4711.175544279738, 4744.14605371033, 4752.5247475252545, 4800.516077808661, 4830.058138662962, 5012.223105418666, 5164.044651739403, 5192.92210616841, 5197.298364720752, 5204.271402003723, 5282.0, 5283.418823929364, 5311.389190243133, 5311.521963023308, 5349.43830897754, 4887.828925987574, 4913.975430122898, 4915.336429581961, 4947.183714687072, 4949.727764972961, 5157.922631160535, 5309.840704778786, 5317.680939143586, 5347.331583552056, 5431.321084864392, 5128.538431541179, 5145.639805213599, 5148.845534633892, 5152.227165925141, 5184.248283998799, 5227.634065615446, 5248.107821670325, 5251.684898906078, 5256.5269125778095, 5295.894082118413, 5004.42449118356, 5131.1277082895995, 5158.071547121554, 5183.896322073613, 5198.246254293106, 4929.679570827956, 5148.613853960968, 5209.557187639093, 5214.426413094557, 5214.869628259324, 4427.667924905645, 4432.49026361966, 4447.043885564619, 4459.710118842265, 4502.122086193161, 3743.8689645862264, 3811.313963486599, 3815.790131542736, 3859.459675645412, 3922.5292964844402, 4518.8418405356315, 4523.095380923828, 4541.296099104644, 4553.704009239389, 4569.725816451024, 5266.499682530153, 5310.548603368679, 5322.201669749568, 5340.065488539568, 5341.866453338697, 4336.002719374498, 4455.910881782411, 4479.664025198123, 4508.256137737237, 4576.222042252825, 4707.83522576715, 4724.88187795301, 4726.314684370747, 4729.787159577827, 4767.903382222108, 4924.285978533164, 4941.75291235444, 4955.520982926434, 4974.253861920669, 5004.199328107486, 5065.113605119163, 5138.820141295037, 5139.8458046258675, 5179.559737422362, 5205.531502164823, 4843.782029808737, 4849.709017458964, 4858.489858564941, 4868.269759536098, 4906.656534042583, 4935.876603084952, 5111.3355263815465, 5138.820141295037, 5141.28022076902, 5162.9483705162465, 5166.819161329336, 5213.530782229617, 5235.031519168966, 5249.212618107162, 5270.60470464709, 5053.74731263428, 5059.848204553869, 5068.239764035424, 5105.8723531912, 5122.436531981553, 4916.975415122902, 4981.726005069756, 5081.263216833465, 5083.5678967288195, 5089.05852417304, 4800.0, 4856.028794241237, 4878.609711223165, 4923.852284431473, 5023.874403139951, 5079.92380114306, 5081.695098294114, 5087.592992560661, 5090.440051594248, 5091.159958606789, 5006.224035274538, 5012.749362531932, 5044.54599086084, 5045.571126454146, 5048.772805223847], "value": 4746.793016805569, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1837244133799, 618.1839971237968, 621.2234706616731, 626.4612433307354, 643.4112786800079, 35359.0, 40309.596904030914, 40322.39516407253, 40354.385824567056, 40565.79717101418, 40892.59107408925, 41549.376759348634, 41612.16775664485, 41659.58340416595, 41720.58279417205, 7855.921440785591, 7952.165022672622, 7953.363730901514, 7987.201279872024, 8010.279074883259, 7846.607669616496, 7903.565303908283, 7909.24862138096, 7927.207279272085, 7958.204179582024, 7909.683612655487, 7924.484908480959, 7952.761417157466, 7965.44241903067, 7987.522308372941, 7911.8417631647335, 7939.126696063428, 7939.523628582304, 7951.165127661599, 7983.920160798376, 7885.053793544754, 7902.604869756489, 7913.406494512935, 7946.960265198637, 7962.243586859239, 30729.385412291853, 38150.42774358387, 38519.22961540754, 38568.42147367792, 38641.613583864084, 3100.0544833825675, 3274.4269752793166, 3285.0801775502896, 3825.3879379299456, 3910.296146693594, 29309.26726831825, 29410.264743381373, 29535.0, 30570.0, 30713.539296910563, 3335.266241426882, 3379.729621630264, 3410.5736782902136, 3417.3677869593957, 3437.1750779812664, 218361.0, 219075.42773716655, 220559.0, 221972.0, 222113.0, 33160.33679326448, 33491.66508334885, 33621.49567756485, 33623.0, 33760.662393376246, 33704.49443258353, 35711.4643280351, 36210.27579448396, 36245.0, 36301.636983629825, 11781.823272650918, 11874.584389546497, 11886.940565297291, 11889.227200231957, 11937.224080434744, 10297.845532317022, 10330.070293673605, 10374.377537347633, 10375.896241037493, 10386.221033422373, 8336.208060234268, 8436.28291595209, 8444.662213511514, 8504.744857654281, 8508.319334453228, 3248.447763880146, 3297.38998285318, 3310.2551925816497, 3335.483000134983, 3359.512870633793, 934.8223837470858, 965.3532133470592, 990.4799980010553, 993.339429279521, 1038.5430410619304, 29235.56146657802, 29731.40537189244, 29790.10629681113, 30083.849580751958, 30200.24499387489, 983.8032393521181, 1054.514923135351, 1060.5015642647943, 1076.983845242322, 1140.8288756686563, 15492.767608485881, 15783.842161578466, 15943.20283985796, 16036.358545658277, 16217.108059056865, 395523.0, 402149.0, 402193.0, 402612.0, 403136.0, 50157.0, 51675.22487162695, 51702.741486292325, 51812.74093629508, 51841.0, 1294.3786982248573, 1296.5786119511197, 1301.3103055380664, 1311.6196303072193, 1315.9013074019488, 27393.178204653894, 28675.713242867303, 28826.0, 29319.560206596492, 29506.704932951256, 44075.0, 44341.77829110834, 44666.3300050506, 44766.55233447624, 44796.77601611971, 303220.0, 305183.0, 305298.0, 305424.0, 305890.0, 26009.609855852555, 26492.205233843015, 26612.0, 26619.33451663724, 26744.866275669276, 41423.0, 44650.0, 44798.0, 45457.54542454533, 45736.0, 36688.44967325439, 37671.246575067795, 37763.62236377601, 38200.04499887525, 38242.80878595701, 37058.0, 37068.629313706515, 37694.0, 38059.2388152241, 38169.85490435291, 37654.0, 38527.61472385353, 38676.80661596674, 38838.4174237381, 41824.79087604542, 31467.52798708067, 34990.12524686903, 35103.47344789779, 35243.82378088093, 35346.0, 26575.33561660974, 26587.867060664572, 26634.200973970812, 27812.58281125744, 29255.0], "value": 16763.14014971417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.82338389265084, 377.70727686043324, 378.3511278157959, 378.52684144818977, 384.2123646524624, 15789.210539473024, 16613.83386166138, 17280.395186168487, 17282.82717172828, 17296.913515432436, 15891.920540397281, 16297.185140742975, 17217.741733874, 17244.22400991955, 17246.655066898686, 5017.64876458649, 5150.33045704058, 5153.716545589991, 5171.0692075426405, 5178.741062946857, 3664.468652045452, 5085.872853178663, 5648.350439699426, 5931.703414829263, 5935.732892019848, 5998.130271110686, 6013.458788709016, 6016.8495787605225, 6041.335453100155, 6044.939550604504, 5043.319151914499, 5380.784768609271, 5382.407935127152, 5421.593380496439, 5443.945560544384, 5067.885065285668, 5181.611379146579, 5367.46325367464, 5367.570594352443, 5386.569074474032, 12055.21641093326, 12117.454714537867, 12304.446299916524, 12313.384330783425, 18595.721064184047, 1919.376202734117, 1927.171316333976, 1977.8813271203774, 2002.7596688397487, 2020.1919232307196, 8905.955470222672, 9342.719718408458, 9404.482753448558, 9432.386894851812, 9682.0, 1715.4939292908623, 1758.5515693498205, 1765.479183640829, 1776.165202354891, 1790.7672002639704, 69305.0, 72639.0, 72951.0, 73203.0, 73505.63247183729, 9420.481873496887, 9425.38734982224, 9467.526623668928, 9614.278929080347, 9632.325737198329, 12826.011968144952, 12847.0, 12903.870961290455, 12914.870851291555, 12937.870621293667, 6574.652196299747, 6860.995635259986, 6963.373296403348, 7007.439404847702, 7098.68055937484, 6465.741370345228, 6521.9673901630185, 6597.835054123685, 6612.239592446834, 6689.431398331197, 3844.9231015379537, 3951.565327813938, 3991.980040099781, 4040.212158629039, 4346.521882592912, 1584.5721655153045, 1590.530793415945, 1705.7441383792282, 1722.2422134260885, 1756.9912150439422, 858.3819649852096, 900.7658008917598, 916.8945571259258, 944.8393773058459, 1006.1347241372414, 16159.272832722556, 16516.339346426248, 16748.330066797193, 16894.66210675804, 17059.91470042642, 897.8473659477904, 918.0956757593765, 919.4804935211585, 926.6108234541508, 941.077743811069, 9213.723588292361, 9287.442753434816, 9288.34981551285, 9432.481213533321, 9494.620215191453, 398546.0, 402942.7792915543, 407081.0, 410447.0, 412747.0, 77160.0, 78078.0, 78593.0, 82072.0, 82790.58604707058, 957.1051067252141, 984.640606178754, 990.3166814897842, 993.8509223616516, 1005.6982905128432, 9750.561224745046, 9846.458444785605, 14750.893682973605, 14770.77843832322, 15263.08421494714, 33064.66935330712, 35648.0, 36112.0, 36727.0, 39304.0, 46844.29733554068, 50776.49223507865, 51387.22919156141, 51782.48217517776, 51864.48135518596, 6011.0, 9325.580348884181, 9971.351862128939, 11422.31466112036, 11841.052715782544, 6523.9347606525225, 6647.434968027578, 8202.917970820215, 8418.747437576883, 10720.0, 7565.621718914143, 7713.112992005991, 7784.571848548384, 7841.451098423284, 7911.446198766032, 7327.340539351484, 7481.663325150273, 7508.174100848793, 7815.29662330393, 7883.251091146332, 7934.2859142677435, 7936.246056624612, 7977.7207797726805, 8076.555789431638, 8160.26557609818, 11587.884121159017, 11687.415629218334, 11701.239419437708, 11711.121665874924, 11921.642350729491, 10940.507677154388, 11092.611758588411, 11202.887971120184, 11289.943550282196, 11313.151513636674], "value": 7970.501965514486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.9552113436598, 1509.3886975774813, 1690.467502736638, 1804.458662401281, 1823.4438496258635, 6484.319146489622, 6931.2375638679705, 6966.895496567556, 7408.481406301561, 7416.0, 7080.822979425504, 7260.0, 7289.6719647615855, 7301.89047164293, 7311.4150867930575, 2192.8465007449486, 2210.3258506155616, 2214.3356992902145, 2216.5788500184913, 2225.2211725895886, 2175.923842665507, 2177.1073859717517, 2226.810721088709, 2232.854864433815, 2238.3956331790487, 2170.522485053286, 2177.4882902517897, 2182.552576721768, 2207.315732123047, 2246.9887650561723, 2171.0772921508456, 2173.6848157017303, 2175.5431359414542, 2176.064292354295, 2185.562887422514, 2117.947051323714, 2135.1032566322183, 2143.0998980428103, 2161.7622061573215, 2174.8260139188983, 7280.2719728027305, 7307.707691692326, 7322.0847394075745, 7342.045534080536, 7350.779476615657, 4432.556744325574, 4542.04617030424, 4546.363509108727, 4549.977250113761, 4559.6580256480565, 2925.9268518287, 2928.824270543774, 3090.9381812363627, 3091.8608662610236, 3095.9535606965915, 963.937344072633, 968.9757756056155, 982.003266684316, 986.3243678080538, 1007.2546315726383, 9745.610175592969, 9860.852087218698, 9862.211023118205, 9878.407295562289, 9910.15763660097, 4145.461090058273, 4236.237477254123, 4284.764337961442, 4291.592298731615, 4298.20483210607, 8534.0, 8588.141185881486, 8595.140485951355, 8599.183077607617, 8619.870701939475, 4365.759883206454, 4418.5802348776815, 4443.289073748185, 4555.612772914273, 4557.6581756368405, 3540.1149712571855, 3935.704822138351, 4120.855770048034, 4149.6265336119895, 4174.937375939363, 3510.982445087758, 3545.4859045438266, 3582.0865679252147, 3606.891793246207, 3625.274945011008, 1152.504423098059, 1154.7748189103213, 1159.3913195572393, 1170.267425561307, 1176.153439100621, 856.3448961544424, 862.5600943518725, 874.2394117118148, 879.7976465412991, 889.4085433186988, 4926.9014619707405, 4994.126027945095, 5054.49455054499, 5218.582513398919, 5351.57187425005, 834.7036801935348, 850.8340873529602, 860.642833224205, 870.4951128345544, 914.7164379042385, 3327.966720332814, 3386.5428167197115, 3394.0835974286806, 3452.3267962747022, 3474.3919814032442, 8814.823703525894, 9071.637134514678, 9120.361574689841, 9147.58835852375, 9162.267018638493, 9060.728178154666, 9129.771755706028, 9137.314701397421, 9177.541122943827, 9181.357304988587, 6569.540132190797, 6655.401013908771, 7085.114360704912, 7141.500094993301, 7159.856802863914, 5041.974790126026, 5042.747862606781, 5059.696418214919, 5071.036503064406, 5077.136886729191, 8384.706535271236, 8417.0, 8594.054653988182, 8675.609597568251, 8680.91319086801, 8481.321494280319, 8679.305655547667, 8681.08848570891, 8735.0, 8771.649134034567, 5657.094864821609, 5849.210356601804, 5947.167396564398, 6208.9689551551955, 6308.179936608395, 7034.788956331318, 7069.39910107626, 7092.6099064551945, 7115.039469671528, 7123.572585644878, 6336.683165841598, 6525.771597994048, 6590.736370545124, 6632.303608121078, 6639.435647969976, 6233.127362169391, 6294.0, 6331.018692102732, 6380.202474690664, 6510.967445162744, 6137.539684523589, 6184.0, 6184.6598437086395, 6218.129461875251, 6219.284782250099, 4335.634275203301, 4517.277235642281, 4525.253333200117, 4572.4055872736335, 4588.770561471846, 4567.2920697291975, 4593.839215627437, 4622.976885115553, 4681.227597446519, 4686.390769199982], "value": 4047.4620614539394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.54379378005, 314.10010320431957, 318.4681581758463, 321.7201035099464, 323.38233973111363, 4936.259561065842, 4987.152184128698, 5017.849464516065, 5053.0, 5073.315102461167, 4989.925151122736, 4995.800167993285, 4997.575206107476, 5012.749362531877, 5046.192609182532, 3716.5540135183746, 3816.370298900678, 3889.9416508752392, 3915.2169566086895, 3917.6278253565865, 3908.2769687607743, 3913.456253435276, 3915.706322025845, 3919.4708714323488, 3928.2536318099615, 3859.899928520372, 3878.146807702301, 3885.164689591737, 3889.533256009283, 3943.6450719435247, 3830.5211848518934, 3889.4554762333296, 3896.2597106549665, 3897.902552436183, 3935.48838650975, 3433.725301975836, 3444.793312401239, 3452.154222215573, 3457.4640930655787, 3458.2564748579175, 4688.203005489041, 4693.737852192728, 4702.3416721659, 4721.622270218409, 4750.904981900378, 4463.375127482155, 4467.821287148543, 4493.955250361078, 4516.616087632555, 4527.547245275446, 4950.257461380822, 5214.634975551713, 5224.76488558012, 5228.764705588258, 5255.76349064293, 3672.6143754905884, 3697.8335974881193, 3703.9073473325166, 3705.555333359987, 3722.664960153599, 5452.68260989078, 5457.781688732446, 5489.149181876775, 5491.643043202179, 5532.917006244869, 3677.9264414712093, 3773.7735735855936, 3774.9433758493647, 3778.205352457616, 3788.6400791924725, 3841.9423708644395, 3852.5184351956004, 3856.325143099946, 3862.8025312153322, 3878.332317103616, 4399.5820397062225, 4408.258737798552, 4412.271975124133, 4439.711418757771, 4440.2461027893805, 5151.25306830515, 5233.2935053768015, 5239.397469291081, 5253.605979551549, 5261.684298942076, 1275.0628288208159, 1286.9420876060599, 1295.3393769177787, 1297.7080156964607, 1297.772889744291, 820.5445977482435, 843.8734189871568, 867.757028032152, 886.5611522296505, 888.5246393179618, 4399.73601583906, 4528.233988744392, 4530.864074077783, 4572.7713614319155, 4575.267957126844, 5330.573554115662, 5344.225087362311, 5377.892442151135, 5436.293281873332, 5454.236406903036, 4464.17412778637, 4593.2191527439745, 4617.845538615346, 4628.120657075145, 4636.211843986531, 2807.5367564352064, 2839.4605025045175, 2846.4022555263214, 2849.059810262608, 2856.571514272876, 5029.1953287473825, 5041.092603331363, 5047.369078865142, 5051.0, 5062.848114556569, 5128.282040514331, 5205.583553315726, 5350.5184533392185, 5414.402751188409, 5463.890722185613, 4885.117780509517, 4887.7556122194455, 4916.852494425173, 4924.8030078797165, 4930.6055515557955, 5248.606354523502, 5287.762050707651, 5305.708186049805, 5319.829637479748, 5320.228566857862, 4938.950610493993, 5159.277701121771, 5230.947690523199, 5316.946830531645, 5317.57459403239, 5078.669886457368, 5091.541761241358, 5096.770645320896, 5111.693298402108, 5129.410117836496, 3768.812823960444, 3787.772733635991, 3795.411711184771, 3803.6576708096404, 3806.8286927088902, 5183.585313175013, 5420.509359926052, 5448.45515448452, 5463.060613482156, 5479.698616576126, 5231.189165679326, 5242.580593552583, 5257.947420525746, 5271.288376069181, 5285.973570132125, 5267.236250743544, 5272.288241087557, 5275.208718692227, 5303.867403314948, 5309.203619457112, 5005.199168133081, 5174.7930082796265, 5182.170852663556, 5261.4738526147075, 5267.709411194129, 5118.846434606968, 5123.948760512496, 5243.606729495227, 5256.237845512455, 5323.813666521653, 5123.257127716534, 5124.180131178993, 5126.2054381570915, 5137.409197942285, 5141.820036298712], "value": 3926.24924752134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.0715648187911, 721.1166321256458, 728.7813655903228, 784.1648644193934, 836.9539675317859, 11077.556897724091, 11480.885191148096, 11481.540738370477, 11520.135989800778, 11532.769344613103, 11510.884891151087, 11710.414479276045, 11717.414129293544, 11755.941220293907, 11769.882301176985, 857.2070834478114, 871.5772850167664, 872.655301156043, 873.0789017586444, 873.6112429968666, 675.8479342148001, 844.8014716541608, 869.9130086991313, 875.6409871952501, 875.8554838451648, 917.9954100229489, 919.3932004876783, 921.2583869984693, 923.1968187676731, 928.109015345266, 914.2229105260542, 915.839728047589, 916.3036092569629, 917.6971599372191, 918.453520155513, 678.2302087131093, 678.3149019490351, 678.5860625018735, 678.8031470873441, 680.8876535371658, 11057.612983545618, 11069.778604427947, 11069.889301107047, 11096.167787415976, 11100.55597776088, 11988.70028249292, 12130.211536250205, 12142.575009874701, 12268.877311226863, 12440.937795311056, 10418.635347762793, 10438.425886576235, 10535.683929482127, 10540.472976351228, 10601.363918164934, 4116.629503344683, 4127.0, 4220.07158425149, 4283.571642835723, 4331.133773245332, 42507.0, 42809.57190428087, 42825.785871070446, 42921.78539107316, 43029.99999999969, 9912.437810945274, 10143.847842282372, 10162.39025658463, 10241.180705543538, 10306.072453479223, 17220.483385498454, 17394.391196308068, 17426.390076347267, 17459.127043647768, 17561.736573951403, 6508.153939987771, 6581.308962558958, 6595.472362211011, 6677.399034086956, 6778.4916131289365, 3282.163048422637, 3406.7615266931075, 3530.5763308403157, 3575.910602234965, 3585.15748799032, 2784.832910025405, 2869.512182928907, 2888.2923683697627, 2914.0, 3119.953200701991, 593.7239183779564, 595.9821205363846, 609.823151286131, 615.9445649891532, 625.5558553427027, 626.3454689849119, 647.5790736021623, 669.7220653428773, 673.2325149329768, 685.917689877208, 7806.687732490636, 7902.604869756489, 7942.563159026309, 8097.838043239102, 8155.469894456842, 489.42003725585295, 540.4109520622462, 558.2324304081887, 584.9795257165979, 606.7451670298485, 3829.659619133281, 3884.892805550405, 3980.5024371953505, 4012.598740125964, 4033.4554835097474, 53039.73480132652, 54535.72732136314, 54599.45400546023, 54799.178012329845, 54943.45056549463, 48291.0, 48614.5138548617, 49202.753986229836, 49515.25727114096, 49760.25359619609, 46137.7693111539, 46187.3071903915, 46297.53702462999, 46417.53582464132, 47159.0, 7643.541387516767, 7644.273793989562, 7738.806529836799, 7783.883241751491, 8082.878756818534, 30480.695193048672, 31255.53116703206, 31429.528557071204, 31999.0, 32153.517697235027, 39919.40120898247, 39977.20045599013, 40184.19631607293, 40206.79896600615, 40290.798546007085, 10142.594296228363, 10270.608198624821, 10300.639477618248, 10581.259311848096, 10647.361158330525, 10216.284860060021, 10850.620228291971, 10883.78232435331, 10929.617463388744, 11002.614908478165, 9895.356801807859, 10095.646652367132, 10206.846897296695, 10515.0, 10691.198160138176, 9441.858372124287, 9483.762905927408, 9576.281778866753, 9583.089606487372, 10045.095941365313, 9007.189352958265, 9099.590518426554, 9155.313351498531, 9474.810503789748, 9579.664711735057, 8263.504189748634, 8586.91413085886, 8724.302055835391, 8748.825023499621, 8925.464472131693, 8701.699310043436, 9245.907540924774, 9273.489958052372, 9297.535123243946, 9320.207782338577], "value": 5975.561127434951, "unit": "score"}], "name": "dromaeo_css", "value": 6260.915272954948, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 109.0, 116.0, 119.0, 117.0, 109.0, 117.0, 115.0, 117.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 160.0, 221.0, 137.0, 154.0, 163.0, 134.0, 199.0, 135.0], "value": 160.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 169.0, 167.0, 163.0, 164.0, 164.0, 163.0, 161.0, 165.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 165.0, 77.0, 76.0, 77.0, 76.0, 169.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 170.0, 94.0, 95.0, 93.0, 137.0, 94.0, 92.0, 138.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 81.0, 82.0, 84.0, 88.0, 89.0, 146.0, 83.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 134.0, 132.0, 134.0, 155.0, 142.0, 136.0, 160.0, 138.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 175.0, 171.0, 174.0, 174.0, 173.0, 171.0, 172.0, 173.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 69.0, 69.0, 68.0, 67.0, 68.0, 67.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1609.8000000000004, "alertThreshold": 2.0}]} 04:44:23 INFO - Return code: 0 04:44:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:44:23 ERROR - # TBPL SUCCESS # 04:44:23 INFO - Running post-action listener: _resource_record_post_action 04:44:23 INFO - ##### 04:44:23 INFO - ##### Finished run-tests step (success) 04:44:23 INFO - ##### 04:44:23 INFO - Running post-run listener: _resource_record_post_run 04:44:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 531464192; Read time: 0; Write time: 403768 04:44:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234803200; Read time: 0; Write time: 209764 04:44:24 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 296660992; Read time: 0; Write time: 194004 04:44:24 INFO - Running post-run listener: _upload_blobber_files 04:44:24 INFO - Blob upload gear active. 04:44:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:24 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 04:44:24 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:44:24 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:26 INFO - (blobuploader) - INFO - Done attempting. 04:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:26 INFO - (blobuploader) - INFO - Done attempting. 04:44:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:26 INFO - Return code: 0 04:44:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00338872dcc76923c585ecd21662e8038b8c492869eb3e1bf0b6261ce29861bfe4f4308d6bc6d0629d573840b2d00642d8ffcc24449d99ca3547b8f1f8fcd26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23335dd31ec93fd6c05874d9055524e085bcf1318899b1f0978e1f332a63857eab0e974e3c03371b3f8f7fbc7cabde7fdc73451627a83e90495d1e91f535898e"} 04:44:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:26 INFO - Contents: 04:44:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00338872dcc76923c585ecd21662e8038b8c492869eb3e1bf0b6261ce29861bfe4f4308d6bc6d0629d573840b2d00642d8ffcc24449d99ca3547b8f1f8fcd26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23335dd31ec93fd6c05874d9055524e085bcf1318899b1f0978e1f332a63857eab0e974e3c03371b3f8f7fbc7cabde7fdc73451627a83e90495d1e91f535898e"} 04:44:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:26 INFO - Copying logs to upload dir... 04:44:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.517680 ========= master_lag: 0.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-09 04:44:26.442183) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:26.449935) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577 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/Firefox-Non-PGO/sha512/00338872dcc76923c585ecd21662e8038b8c492869eb3e1bf0b6261ce29861bfe4f4308d6bc6d0629d573840b2d00642d8ffcc24449d99ca3547b8f1f8fcd26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23335dd31ec93fd6c05874d9055524e085bcf1318899b1f0978e1f332a63857eab0e974e3c03371b3f8f7fbc7cabde7fdc73451627a83e90495d1e91f535898e"} build_url:https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/M4wkJiVKQDa5z1MyGphD2A/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/Firefox-Non-PGO/sha512/00338872dcc76923c585ecd21662e8038b8c492869eb3e1bf0b6261ce29861bfe4f4308d6bc6d0629d573840b2d00642d8ffcc24449d99ca3547b8f1f8fcd26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23335dd31ec93fd6c05874d9055524e085bcf1318899b1f0978e1f332a63857eab0e974e3c03371b3f8f7fbc7cabde7fdc73451627a83e90495d1e91f535898e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:26.480184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:26.480526) ========= 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=337fe3f4b1febe37b85fccc40000019e-1462793020.914436-1527991577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:44:26.761462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:44:26.761810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:44:26.762162) ========= ========= Total master_lag: 1.04 =========