builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1462880477.5 results: success (0) buildid: 20160510030710 builduid: 2365e4bf703b425484e5d911e00d7883 revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.499665) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.500096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.500375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.583281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.583911) ========= 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-1462880476.860697-1553045626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 04:41:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.2M=0s 2016-05-10 04:41:17 (81.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168076 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.774117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.774429) ========= 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-1462880476.860697-1553045626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018955 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:17.841642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 04:41:17.842013) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --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 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --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-1462880476.860697-1553045626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 04:41:18,120 truncating revision to first 12 chars 2016-05-10 04:41:18,120 Setting DEBUG logging. 2016-05-10 04:41:18,120 attempt 1/10 2016-05-10 04:41:18,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1579b9e2e50f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 04:41:18,893 unpacking tar archive at: mozilla-central-1579b9e2e50f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.070925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 04:41:18.932698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:18.932974) ========= script_repo_revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:18.933339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:18.933619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 04:41:19.026666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-10 04:41:19.026938) ========= /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-1462880476.860697-1553045626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:19 INFO - MultiFileLogger online at 20160510 04:41:19 in /builds/slave/test 04:41:19 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:41:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:19 INFO - {'append_to_log': False, 04:41:19 INFO - 'base_work_dir': '/builds/slave/test', 04:41:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:41:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:19 INFO - 'branch': 'Firefox-Non-PGO', 04:41:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:19 INFO - 'config_files': ('talos/linux_config.py',), 04:41:19 INFO - 'default_actions': ('clobber', 04:41:19 INFO - 'read-buildbot-config', 04:41:19 INFO - 'download-and-extract', 04:41:19 INFO - 'populate-webroot', 04:41:19 INFO - 'create-virtualenv', 04:41:19 INFO - 'install', 04:41:19 INFO - 'run-tests'), 04:41:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:19 INFO - 'download_minidump_stackwalk': True, 04:41:19 INFO - 'download_symbols': 'ondemand', 04:41:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:19 INFO - 'installer_path': 'installer.exe', 04:41:19 INFO - 'log_level': 'info', 04:41:19 INFO - 'log_name': 'talos', 04:41:19 INFO - 'log_to_console': True, 04:41:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:19 INFO - 'opt_config_files': (), 04:41:19 INFO - 'pip_index': False, 04:41:19 INFO - 'sps_profile': False, 04:41:19 INFO - 'sps_profile_interval': 0, 04:41:19 INFO - 'suite': 'dromaeojs-e10s', 04:41:19 INFO - 'system_bits': '32', 04:41:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:19 INFO - 'title': 'talos-linux64-ix-060', 04:41:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:19 INFO - 'use_talos_json': True, 04:41:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:19 INFO - 'work_dir': 'build'} 04:41:19 INFO - ##### 04:41:19 INFO - ##### Running clobber step. 04:41:19 INFO - ##### 04:41:19 INFO - Running pre-action listener: _resource_record_pre_action 04:41:19 INFO - Running main action method: clobber 04:41:19 INFO - rmtree: /builds/slave/test/build 04:41:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:19 INFO - Running post-action listener: _resource_record_post_action 04:41:19 INFO - ##### 04:41:19 INFO - ##### Finished clobber step (success) 04:41:19 INFO - ##### 04:41:19 INFO - ##### 04:41:19 INFO - ##### Running read-buildbot-config step. 04:41:19 INFO - ##### 04:41:19 INFO - Running pre-action listener: _resource_record_pre_action 04:41:19 INFO - Running main action method: read_buildbot_config 04:41:19 INFO - Using buildbot properties: 04:41:19 INFO - { 04:41:19 INFO - "project": "", 04:41:19 INFO - "product": "firefox", 04:41:19 INFO - "script_repo_revision": "production", 04:41:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:41:19 INFO - "repository": "", 04:41:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:41:19 INFO - "buildid": "20160510030710", 04:41:19 INFO - "pgo_build": "False", 04:41:19 INFO - "basedir": "/builds/slave/test", 04:41:19 INFO - "buildnumber": 309, 04:41:19 INFO - "slavename": "talos-linux64-ix-060", 04:41:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:41:19 INFO - "platform": "ubuntu64_hw", 04:41:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:41:19 INFO - "branch": "mozilla-central", 04:41:19 INFO - "repo_path": "mozilla-central", 04:41:19 INFO - "revision": "1579b9e2e50f3a27ad02d58cc9170c91e0973fec", 04:41:19 INFO - "stage_platform": "linux64", 04:41:19 INFO - "builduid": "2365e4bf703b425484e5d911e00d7883", 04:41:19 INFO - "slavebuilddir": "test" 04:41:19 INFO - } 04:41:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:41:19 INFO - Running post-action listener: _resource_record_post_action 04:41:19 INFO - ##### 04:41:19 INFO - ##### Finished read-buildbot-config step (success) 04:41:19 INFO - ##### 04:41:19 INFO - ##### 04:41:19 INFO - ##### Running download-and-extract step. 04:41:19 INFO - ##### 04:41:19 INFO - Running pre-action listener: _resource_record_pre_action 04:41:19 INFO - Running main action method: download_and_extract 04:41:19 INFO - mkdir: /builds/slave/test/build/tests 04:41: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:41:19 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:41:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:20 INFO - Downloaded 1361 bytes. 04:41:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:41:20 INFO - Using the following test package requirements: 04:41:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:41:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:41:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'jsshell-linux-x86_64.zip'], 04:41:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:41:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:41:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:41:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:41:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:41:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:41:20 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:41:20 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:22 INFO - Downloaded 22325729 bytes. 04:41:22 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:41:22 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:41:23 INFO - Return code: 0 04:41:23 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:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:23 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:41:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:24 INFO - Downloaded 22325729 bytes. 04:41:24 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:41:24 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:41:26 INFO - Return code: 0 04:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:26 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:41:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:27 INFO - Downloaded 10840152 bytes. 04:41:27 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:41:27 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:41:27 INFO - Return code: 0 04:41:27 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:41:27 INFO - https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:41:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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:41:28 INFO - Downloaded 54673617 bytes. 04:41:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:28 INFO - mkdir: /builds/slave/test/properties 04:41:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:28 INFO - Contents: 04:41:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:41:29 INFO - Running post-action listener: _resource_record_post_action 04:41:29 INFO - Running post-action listener: set_extra_try_arguments 04:41:29 INFO - ##### 04:41:29 INFO - ##### Finished download-and-extract step (success) 04:41:29 INFO - ##### 04:41:29 INFO - ##### 04:41:29 INFO - ##### Running populate-webroot step. 04:41:29 INFO - ##### 04:41:29 INFO - Running pre-action listener: _resource_record_pre_action 04:41:29 INFO - Running main action method: populate_webroot 04:41:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:41:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:41:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:41:29 INFO - '--tppagecycles', 04:41:29 INFO - '7'], 04:41:29 INFO - 'tests': ['tsvgm']}}, 04:41:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:41:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:41:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:41:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:41:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['damp', 'tps']}, 04:41:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'tests': ['damp', 'tps']}, 04:41:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['dromaeo_dom']}, 04:41:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:41:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['a11yr', 04:41:29 INFO - 'ts_paint', 04:41:29 INFO - 'tpaint', 04:41:29 INFO - 'sessionrestore', 04:41:29 INFO - 'sessionrestore_no_auto_restore', 04:41:29 INFO - 'tabpaint']}, 04:41:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:41:29 INFO - 'ts_paint', 04:41:29 INFO - 'tpaint', 04:41:29 INFO - 'sessionrestore', 04:41:29 INFO - 'sessionrestore_no_auto_restore', 04:41:29 INFO - 'tabpaint']}, 04:41:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:41:29 INFO - 'ts_paint', 04:41:29 INFO - 'tpaint', 04:41:29 INFO - 'sessionrestore', 04:41:29 INFO - 'sessionrestore_no_auto_restore', 04:41:29 INFO - 'tabpaint']}, 04:41:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:41:29 INFO - 'ts_paint', 04:41:29 INFO - 'tpaint', 04:41:29 INFO - 'sessionrestore', 04:41:29 INFO - 'sessionrestore_no_auto_restore', 04:41:29 INFO - 'tabpaint']}, 04:41:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['a11yr', 04:41:29 INFO - 'ts_paint', 04:41:29 INFO - 'tpaint', 04:41:29 INFO - 'sessionrestore', 04:41:29 INFO - 'sessionrestore_no_auto_restore', 04:41:29 INFO - 'tabpaint']}, 04:41:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['a11yr', 04:41:29 INFO - 'ts_paint', 04:41:29 INFO - 'tpaint', 04:41:29 INFO - 'sessionrestore', 04:41:29 INFO - 'sessionrestore_no_auto_restore', 04:41:29 INFO - 'tabpaint']}, 04:41:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['tsvgx', 04:41:29 INFO - 'tsvgr_opacity', 04:41:29 INFO - 'tart', 04:41:29 INFO - 'tscrollx', 04:41:29 INFO - 'cart']}, 04:41:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:41:29 INFO - 'tsvgr_opacity', 04:41:29 INFO - 'tart', 04:41:29 INFO - 'tscrollx', 04:41:29 INFO - 'cart']}, 04:41:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'talos_options': ['--disable-e10s'], 04:41:29 INFO - 'tests': ['tp5o']}, 04:41:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'tests': ['tp5o']}, 04:41:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'talos_options': ['--disable-e10s', 04:41:29 INFO - '--xperf_path', 04:41:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:29 INFO - 'tests': ['tp5n']}, 04:41:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:29 INFO - 'talos_options': ['--xperf_path', 04:41:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:29 INFO - 'tests': ['tp5n']}}, 04:41:29 INFO - 'talos.zip': {'path': '', 04:41:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:41:29 INFO - Running post-action listener: _resource_record_post_action 04:41:29 INFO - ##### 04:41:29 INFO - ##### Finished populate-webroot step (success) 04:41:29 INFO - ##### 04:41:29 INFO - ##### 04:41:29 INFO - ##### Running create-virtualenv step. 04:41:29 INFO - ##### 04:41:29 INFO - Running pre-action listener: _resource_record_pre_action 04:41:29 INFO - Running main action method: create_virtualenv 04:41:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:41:29 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:41:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:41:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:41:29 INFO - Using real prefix '/usr' 04:41:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:41:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:41:32 INFO - Installing pip.................done. 04:41:32 INFO - Return code: 0 04:41:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:41:32 INFO - Using env: {'DISPLAY': ':0', 04:41:32 INFO - 'HOME': '/home/cltbld', 04:41:32 INFO - 'LANG': 'en_US.UTF-8', 04:41:32 INFO - 'LANGUAGE': 'en_US:en', 04:41:32 INFO - 'LOGNAME': 'cltbld', 04:41:32 INFO - 'MAIL': '/var/mail/cltbld', 04:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:32 INFO - 'MOZ_NO_REMOTE': '1', 04:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:32 INFO - 'NO_EM_RESTART': '1', 04:41:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:32 INFO - 'PWD': '/builds/slave/test', 04:41:32 INFO - 'SHELL': '/bin/bash', 04:41:32 INFO - 'SHLVL': '1', 04:41:32 INFO - 'TERM': 'linux', 04:41:32 INFO - 'TMOUT': '86400', 04:41:32 INFO - 'USER': 'cltbld', 04:41:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:32 INFO - '_': '/tools/buildbot/bin/python'} 04:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:32 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:41:32 INFO - Cleaning up... 04:41:32 INFO - Return code: 0 04:41:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:41:32 INFO - Using env: {'DISPLAY': ':0', 04:41:32 INFO - 'HOME': '/home/cltbld', 04:41:32 INFO - 'LANG': 'en_US.UTF-8', 04:41:32 INFO - 'LANGUAGE': 'en_US:en', 04:41:32 INFO - 'LOGNAME': 'cltbld', 04:41:32 INFO - 'MAIL': '/var/mail/cltbld', 04:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:32 INFO - 'MOZ_NO_REMOTE': '1', 04:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:32 INFO - 'NO_EM_RESTART': '1', 04:41:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:32 INFO - 'PWD': '/builds/slave/test', 04:41:32 INFO - 'SHELL': '/bin/bash', 04:41:32 INFO - 'SHLVL': '1', 04:41:32 INFO - 'TERM': 'linux', 04:41:32 INFO - 'TMOUT': '86400', 04:41:32 INFO - 'USER': 'cltbld', 04:41:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:32 INFO - '_': '/tools/buildbot/bin/python'} 04:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:32 INFO - Downloading/unpacking psutil>=0.7.1 04:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:34 INFO - Installing collected packages: psutil 04:41:34 INFO - Running setup.py install for psutil 04:41:34 INFO - building 'psutil._psutil_linux' extension 04:41:34 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:41:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:41:34 INFO - building 'psutil._psutil_posix' extension 04:41:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:41:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:35 INFO - Successfully installed psutil 04:41:35 INFO - Cleaning up... 04:41:35 INFO - Return code: 0 04:41:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:41:35 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:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:35 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:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:35 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 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:35 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:41:35 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:41:35 INFO - Using env: {'DISPLAY': ':0', 04:41:35 INFO - 'HOME': '/home/cltbld', 04:41:35 INFO - 'LANG': 'en_US.UTF-8', 04:41:35 INFO - 'LANGUAGE': 'en_US:en', 04:41:35 INFO - 'LOGNAME': 'cltbld', 04:41:35 INFO - 'MAIL': '/var/mail/cltbld', 04:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:35 INFO - 'MOZ_NO_REMOTE': '1', 04:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:35 INFO - 'NO_EM_RESTART': '1', 04:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:35 INFO - 'PWD': '/builds/slave/test', 04:41:35 INFO - 'SHELL': '/bin/bash', 04:41:35 INFO - 'SHLVL': '1', 04:41:35 INFO - 'TERM': 'linux', 04:41:35 INFO - 'TMOUT': '86400', 04:41:35 INFO - 'USER': 'cltbld', 04:41:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:35 INFO - '_': '/tools/buildbot/bin/python'} 04:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:41:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:41:37 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:41:37 INFO - Installing collected packages: mozsystemmonitor 04:41:37 INFO - Running setup.py install for mozsystemmonitor 04:41:37 INFO - Successfully installed mozsystemmonitor 04:41:37 INFO - Cleaning up... 04:41:37 INFO - Return code: 0 04:41:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41:37 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:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:37 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:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:37 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 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:37 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:41:37 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:41:37 INFO - Using env: {'DISPLAY': ':0', 04:41:37 INFO - 'HOME': '/home/cltbld', 04:41:37 INFO - 'LANG': 'en_US.UTF-8', 04:41:37 INFO - 'LANGUAGE': 'en_US:en', 04:41:37 INFO - 'LOGNAME': 'cltbld', 04:41:37 INFO - 'MAIL': '/var/mail/cltbld', 04:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:37 INFO - 'MOZ_NO_REMOTE': '1', 04:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:37 INFO - 'NO_EM_RESTART': '1', 04:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:37 INFO - 'PWD': '/builds/slave/test', 04:41:37 INFO - 'SHELL': '/bin/bash', 04:41:37 INFO - 'SHLVL': '1', 04:41:37 INFO - 'TERM': 'linux', 04:41:37 INFO - 'TMOUT': '86400', 04:41:37 INFO - 'USER': 'cltbld', 04:41:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:37 INFO - '_': '/tools/buildbot/bin/python'} 04:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:41:37 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:41:37 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:41:37 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:41:37 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:41:37 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:41:37 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:41:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:40 INFO - Downloading docopt-0.6.1.tar.gz 04:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:40 INFO - Running setup.py install for blobuploader 04:41:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:40 INFO - Running setup.py install for requests 04:41:40 INFO - Running setup.py install for docopt 04:41:40 INFO - Successfully installed blobuploader requests docopt 04:41:40 INFO - Cleaning up... 04:41:40 INFO - Return code: 0 04:41:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:41:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:41:40 INFO - Using env: {'DISPLAY': ':0', 04:41:40 INFO - 'HOME': '/home/cltbld', 04:41:40 INFO - 'LANG': 'en_US.UTF-8', 04:41:40 INFO - 'LANGUAGE': 'en_US:en', 04:41:40 INFO - 'LOGNAME': 'cltbld', 04:41:40 INFO - 'MAIL': '/var/mail/cltbld', 04:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:40 INFO - 'MOZ_NO_REMOTE': '1', 04:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:40 INFO - 'NO_EM_RESTART': '1', 04:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:40 INFO - 'PWD': '/builds/slave/test', 04:41:40 INFO - 'SHELL': '/bin/bash', 04:41:40 INFO - 'SHLVL': '1', 04:41:40 INFO - 'TERM': 'linux', 04:41:40 INFO - 'TMOUT': '86400', 04:41:40 INFO - 'USER': 'cltbld', 04:41:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:40 INFO - '_': '/tools/buildbot/bin/python'} 04:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:41 INFO - Running setup.py (path:/tmp/pip-lohkWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:41 INFO - Running setup.py (path:/tmp/pip-7T0CMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:41 INFO - Running setup.py (path:/tmp/pip-lY8t7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:41 INFO - Running setup.py (path:/tmp/pip-RMd8Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:41 INFO - Running setup.py (path:/tmp/pip-uSeuFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:41 INFO - Running setup.py (path:/tmp/pip-B69Yzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:41 INFO - Running setup.py (path:/tmp/pip-R8AS8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:41 INFO - Running setup.py (path:/tmp/pip-b_3drn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:41 INFO - Running setup.py (path:/tmp/pip-5pfhhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:41 INFO - Running setup.py (path:/tmp/pip-0Pff_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:41 INFO - Running setup.py (path:/tmp/pip-mfjZ4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:41 INFO - Running setup.py (path:/tmp/pip-kqUsRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:41 INFO - Running setup.py (path:/tmp/pip-mZoaqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:41 INFO - Running setup.py (path:/tmp/pip-T9of8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:42 INFO - Running setup.py (path:/tmp/pip-kJCDpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:42 INFO - Running setup.py (path:/tmp/pip-ZYPz7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:42 INFO - Running setup.py (path:/tmp/pip-50f_2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:42 INFO - Running setup.py install for manifestparser 04:41:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:42 INFO - Running setup.py install for mozcrash 04:41:42 INFO - Running setup.py install for mozdebug 04:41:42 INFO - Running setup.py install for mozdevice 04:41:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:41:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:42 INFO - Running setup.py install for mozfile 04:41:42 INFO - Running setup.py install for mozhttpd 04:41:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:42 INFO - Running setup.py install for mozinfo 04:41:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:42 INFO - Running setup.py install for mozInstall 04:41:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Running setup.py install for mozleak 04:41:43 INFO - Running setup.py install for mozlog 04:41:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Running setup.py install for moznetwork 04:41:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Running setup.py install for mozprocess 04:41:43 INFO - Running setup.py install for mozprofile 04:41:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Running setup.py install for mozrunner 04:41:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:43 INFO - Running setup.py install for mozscreenshot 04:41:43 INFO - Running setup.py install for moztest 04:41:43 INFO - Running setup.py install for mozversion 04:41:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:44 INFO - Cleaning up... 04:41:44 INFO - Return code: 0 04:41:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41: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:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:44 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 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:44 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:41:44 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:41:44 INFO - Using env: {'DISPLAY': ':0', 04:41:44 INFO - 'HOME': '/home/cltbld', 04:41:44 INFO - 'LANG': 'en_US.UTF-8', 04:41:44 INFO - 'LANGUAGE': 'en_US:en', 04:41:44 INFO - 'LOGNAME': 'cltbld', 04:41:44 INFO - 'MAIL': '/var/mail/cltbld', 04:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:44 INFO - 'MOZ_NO_REMOTE': '1', 04:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:44 INFO - 'NO_EM_RESTART': '1', 04:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:44 INFO - 'PWD': '/builds/slave/test', 04:41:44 INFO - 'SHELL': '/bin/bash', 04:41:44 INFO - 'SHLVL': '1', 04:41:44 INFO - 'TERM': 'linux', 04:41:44 INFO - 'TMOUT': '86400', 04:41:44 INFO - 'USER': 'cltbld', 04:41:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:44 INFO - '_': '/tools/buildbot/bin/python'} 04:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:44 INFO - Running setup.py (path:/tmp/pip-2SHSt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:44 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:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:44 INFO - Running setup.py (path:/tmp/pip-3rGw5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:44 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:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:44 INFO - Running setup.py (path:/tmp/pip-dx6en5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:44 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:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:44 INFO - Running setup.py (path:/tmp/pip-MbHBQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:44 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:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:44 INFO - Running setup.py (path:/tmp/pip-ifbnp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:44 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:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:44 INFO - Running setup.py (path:/tmp/pip-mJNCDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:44 INFO - Running setup.py (path:/tmp/pip-YanEZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:44 INFO - Running setup.py (path:/tmp/pip-beD88M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:44 INFO - Running setup.py (path:/tmp/pip-0Y2SnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:44 INFO - Running setup.py (path:/tmp/pip-Dg7mua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:44 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:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:44 INFO - Running setup.py (path:/tmp/pip-tWMUy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:45 INFO - Running setup.py (path:/tmp/pip-tDCKaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:45 INFO - Running setup.py (path:/tmp/pip-WMOuXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:45 INFO - Running setup.py (path:/tmp/pip-WqFn6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:45 INFO - Running setup.py (path:/tmp/pip-u6mCnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:45 INFO - Running setup.py (path:/tmp/pip-WMuARi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:45 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:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:45 INFO - Running setup.py (path:/tmp/pip-zDIyaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:45 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:41:45 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:41:45 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:41:45 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:41:45 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:41:45 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:41:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:45 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:41:45 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:41:45 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:41:45 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:41:45 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:41:45 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:41:47 INFO - Downloading blessings-1.6.tar.gz 04:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:47 INFO - Installing collected packages: blessings 04:41:47 INFO - Running setup.py install for blessings 04:41:47 INFO - Successfully installed blessings 04:41:47 INFO - Cleaning up... 04:41:47 INFO - Return code: 0 04:41:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:47 INFO - Reading from file tmpfile_stdout 04:41:47 INFO - Current package versions: 04:41:47 INFO - argparse == 1.2.1 04:41:47 INFO - blessings == 1.6 04:41:47 INFO - blobuploader == 1.2.4 04:41:47 INFO - docopt == 0.6.1 04:41:47 INFO - manifestparser == 1.1 04:41:47 INFO - mozInstall == 1.12 04:41:47 INFO - mozcrash == 0.17 04:41:47 INFO - mozdebug == 0.1 04:41:47 INFO - mozdevice == 0.48 04:41:47 INFO - mozfile == 1.2 04:41:47 INFO - mozhttpd == 0.7 04:41:47 INFO - mozinfo == 0.9 04:41:47 INFO - mozleak == 0.1 04:41:47 INFO - mozlog == 3.1 04:41:47 INFO - moznetwork == 0.27 04:41:47 INFO - mozprocess == 0.22 04:41:47 INFO - mozprofile == 0.28 04:41:47 INFO - mozrunner == 6.11 04:41:47 INFO - mozscreenshot == 0.1 04:41:47 INFO - mozsystemmonitor == 0.0 04:41:47 INFO - moztest == 0.7 04:41:47 INFO - mozversion == 1.4 04:41:47 INFO - psutil == 3.1.1 04:41:47 INFO - requests == 1.2.3 04:41:47 INFO - wsgiref == 0.1.2 04:41:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:41:47 INFO - Using env: {'DISPLAY': ':0', 04:41:47 INFO - 'HOME': '/home/cltbld', 04:41:47 INFO - 'LANG': 'en_US.UTF-8', 04:41:47 INFO - 'LANGUAGE': 'en_US:en', 04:41:47 INFO - 'LOGNAME': 'cltbld', 04:41:47 INFO - 'MAIL': '/var/mail/cltbld', 04:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:47 INFO - 'MOZ_NO_REMOTE': '1', 04:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:47 INFO - 'NO_EM_RESTART': '1', 04:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:47 INFO - 'PWD': '/builds/slave/test', 04:41:47 INFO - 'SHELL': '/bin/bash', 04:41:47 INFO - 'SHLVL': '1', 04:41:47 INFO - 'TERM': 'linux', 04:41:47 INFO - 'TMOUT': '86400', 04:41:47 INFO - 'USER': 'cltbld', 04:41:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:47 INFO - '_': '/tools/buildbot/bin/python'} 04:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 INFO - Cleaning up... 04:41:48 INFO - Return code: 0 04:41:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:48 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 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:48 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:41:48 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:41:48 INFO - Using env: {'DISPLAY': ':0', 04:41:48 INFO - 'HOME': '/home/cltbld', 04:41:48 INFO - 'LANG': 'en_US.UTF-8', 04:41:48 INFO - 'LANGUAGE': 'en_US:en', 04:41:48 INFO - 'LOGNAME': 'cltbld', 04:41:48 INFO - 'MAIL': '/var/mail/cltbld', 04:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:48 INFO - 'MOZ_NO_REMOTE': '1', 04:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:48 INFO - 'NO_EM_RESTART': '1', 04:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:48 INFO - 'PWD': '/builds/slave/test', 04:41:48 INFO - 'SHELL': '/bin/bash', 04:41:48 INFO - 'SHLVL': '1', 04:41:48 INFO - 'TERM': 'linux', 04:41:48 INFO - 'TMOUT': '86400', 04:41:48 INFO - 'USER': 'cltbld', 04:41:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:48 INFO - '_': '/tools/buildbot/bin/python'} 04:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:48 INFO - Downloading/unpacking jsonschema 04:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:48 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:41:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:50 INFO - Downloading/unpacking functools32 (from jsonschema) 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:50 INFO - warning: no files found matching '*.txt' 04:41:50 INFO - no previously-included directories found matching 'build' 04:41:50 INFO - no previously-included directories found matching 'dist' 04:41:50 INFO - no previously-included directories found matching '.git*' 04:41:50 INFO - Installing collected packages: jsonschema, functools32 04:41:50 INFO - Running setup.py install for functools32 04:41:50 INFO - warning: no files found matching '*.txt' 04:41:50 INFO - no previously-included directories found matching 'build' 04:41:50 INFO - no previously-included directories found matching 'dist' 04:41:50 INFO - no previously-included directories found matching '.git*' 04:41:50 INFO - Successfully installed jsonschema functools32 04:41:50 INFO - Cleaning up... 04:41:50 INFO - Return code: 0 04:41:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5951294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, '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-1462880476.860697-1553045626', '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:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:41:50 INFO - Using env: {'DISPLAY': ':0', 04:41:50 INFO - 'HOME': '/home/cltbld', 04:41:50 INFO - 'LANG': 'en_US.UTF-8', 04:41:50 INFO - 'LANGUAGE': 'en_US:en', 04:41:50 INFO - 'LOGNAME': 'cltbld', 04:41:50 INFO - 'MAIL': '/var/mail/cltbld', 04:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:50 INFO - 'MOZ_NO_REMOTE': '1', 04:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:50 INFO - 'NO_EM_RESTART': '1', 04:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:50 INFO - 'PWD': '/builds/slave/test', 04:41:50 INFO - 'SHELL': '/bin/bash', 04:41:50 INFO - 'SHLVL': '1', 04:41:50 INFO - 'TERM': 'linux', 04:41:50 INFO - 'TMOUT': '86400', 04:41:50 INFO - 'USER': 'cltbld', 04:41:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:50 INFO - '_': '/tools/buildbot/bin/python'} 04:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:50 INFO - Downloading/unpacking flake8 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:41:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:41:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:41:53 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:41:53 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:41:53 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:41:53 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:41:53 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:41:53 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:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:41:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:53 INFO - no previously-included directories found matching 'docs/_build' 04:41:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:41:53 INFO - Running setup.py install for pep8 04:41:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:53 INFO - no previously-included directories found matching 'docs/_build' 04:41:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:41:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:41:53 INFO - Cleaning up... 04:41:53 INFO - Return code: 0 04:41:53 INFO - Running post-action listener: _resource_record_post_action 04:41:53 INFO - Running post-action listener: _start_resource_monitoring 04:41:53 INFO - Starting resource monitoring. 04:41:53 INFO - ##### 04:41:53 INFO - ##### Finished create-virtualenv step (success) 04:41:53 INFO - ##### 04:41:53 INFO - ##### 04:41:53 INFO - ##### Running install step. 04:41:53 INFO - ##### 04:41:53 INFO - Running pre-action listener: _resource_record_pre_action 04:41:53 INFO - Running main action method: install 04:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:53 INFO - Reading from file tmpfile_stdout 04:41:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:53 INFO - Reading from file tmpfile_stdout 04:41:53 INFO - Output received: 04:41:53 INFO - Usage: mozinstall [options] installer 04:41:53 INFO - Options: 04:41:53 INFO - -h, --help show this help message and exit 04:41:53 INFO - -d DEST, --destination=DEST 04:41:53 INFO - Directory to install application into. [default: 04:41:53 INFO - "/builds/slave/test"] 04:41:53 INFO - --app=APP Application being installed. [default: firefox] 04:41:53 INFO - mkdir: /builds/slave/test/build/application 04:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:42:09 INFO - Reading from file tmpfile_stdout 04:42:09 INFO - Output received: 04:42:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:09 INFO - Running post-action listener: _resource_record_post_action 04:42:09 INFO - ##### 04:42:09 INFO - ##### Finished install step (success) 04:42:09 INFO - ##### 04:42:09 INFO - ##### 04:42:09 INFO - ##### Running run-tests step. 04:42:09 INFO - ##### 04:42:09 INFO - Running pre-action listener: _resource_record_pre_action 04:42:09 INFO - Running main action method: run_tests 04:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:09 INFO - Python 2.7.3 04:42:09 INFO - Return code: 0 04:42:09 INFO - grabbing minidump binary from tooltool 04:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:09 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 0x1f599c0>, '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 0x1f5a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:09 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:42:09 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:42:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:09 INFO - Return code: 0 04:42:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:42:10 INFO - Return code: 0 04:42:10 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/Ij_2TJ77QLenFrJJZ321dQ/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:42:10 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/Ij_2TJ77QLenFrJJZ321dQ/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:42:10 INFO - Using env: {'DISPLAY': ':0', 04:42:10 INFO - 'HOME': '/home/cltbld', 04:42:10 INFO - 'LANG': 'en_US.UTF-8', 04:42:10 INFO - 'LANGUAGE': 'en_US:en', 04:42:10 INFO - 'LOGNAME': 'cltbld', 04:42:10 INFO - 'MAIL': '/var/mail/cltbld', 04:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:10 INFO - 'MOZ_NO_REMOTE': '1', 04:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:10 INFO - 'NO_EM_RESTART': '1', 04:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:10 INFO - 'PWD': '/builds/slave/test', 04:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:10 INFO - 'SHELL': '/bin/bash', 04:42:10 INFO - 'SHLVL': '1', 04:42:10 INFO - 'TERM': 'linux', 04:42:10 INFO - 'TMOUT': '86400', 04:42:10 INFO - 'USER': 'cltbld', 04:42:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1462880476.860697-1553045626', 04:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:10 INFO - '_': '/tools/buildbot/bin/python'} 04:42:10 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/Ij_2TJ77QLenFrJJZ321dQ/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:42:10 INFO - mozversion application_buildid: 20160510030710 04:42:10 INFO - mozversion application_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 04:42:10 INFO - mozversion application_display_name: Nightly 04:42:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:10 INFO - mozversion application_name: Firefox 04:42:10 INFO - mozversion application_remotingname: firefox 04:42:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:42:10 INFO - mozversion application_vendor: Mozilla 04:42:10 INFO - mozversion application_version: 49.0a1 04:42:10 INFO - mozversion platform_buildid: 20160510030710 04:42:10 INFO - mozversion platform_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 04:42:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:42:10 INFO - mozversion platform_version: 49.0a1 04:42:10 INFO - using testdate: 1462880530 04:42:10 INFO - actual date: 1462880530 04:42:10 INFO - starting webserver on 'localhost:36430' 04:42:10 INFO - SUITE-START | Running 2 tests 04:42:10 INFO - TEST-START | dromaeo_css 04:42:10 INFO - operating with platform_type : linux_ 04:42:10 INFO - Initialising browser for dromaeo_css test... 04:42:10 INFO - TEST-INFO | started process 25672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCDrXyk/profile http://localhost:36430/getInfo.html) 04:42:14 INFO - PROCESS | 25672 | 04:42:14 INFO - PROCESS | 25672 | (process:25738): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:42:15 INFO - PROCESS | 25672 | __metrics Screen width/height:1600/1200 04:42:15 INFO - PROCESS | 25672 | colorDepth:24 04:42:15 INFO - PROCESS | 25672 | Browser inner width/height: 1024/697 04:42:15 INFO - PROCESS | 25672 | __metrics 04:42:16 ERROR - PROCESS | 25672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:42:17 INFO - TEST-INFO | 25672: exit 0 04:42:17 INFO - Browser initialized. 04:42:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:17 INFO - TEST-INFO | started process 25789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCDrXyk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:19 INFO - PROCESS | 25789 | 04:42:19 INFO - PROCESS | 25789 | (process:25849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:42:29 INFO - PROCESS | 25789 | RSS: Main: 164458496 04:42:29 INFO - PROCESS | 25789 | 04:43:18 INFO - PROCESS | 25789 | 1462880598947 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:45:30 INFO - PROCESS | 25789 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36430/tests/dromaeo/cssquery-ext.html) 04:45:31 INFO - PROCESS | 25789 | RSS: Main: 165793792 04:45:31 INFO - PROCESS | 25789 | 04:48:33 INFO - PROCESS | 25789 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-ext.html (next: http://localhost:36430/tests/dromaeo/cssquery-jquery.html) 04:48:34 INFO - PROCESS | 25789 | RSS: Main: 166592512 04:48:34 INFO - PROCESS | 25789 | 04:51:36 INFO - PROCESS | 25789 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36430/tests/dromaeo/cssquery-mootools.html) 04:51:37 INFO - PROCESS | 25789 | RSS: Main: 167743488 04:51:37 INFO - PROCESS | 25789 | 04:54:38 INFO - PROCESS | 25789 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36430/tests/dromaeo/cssquery-prototype.html) 04:54:39 INFO - PROCESS | 25789 | RSS: Main: 165310464 04:54:39 INFO - PROCESS | 25789 | 04:57:42 INFO - PROCESS | 25789 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36430/tests/dromaeo/cssquery-yui.html) 04:57:42 INFO - PROCESS | 25789 | RSS: Main: 166453248 04:57:42 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | Cycle 1(1): loaded http://localhost:36430/tests/dromaeo/cssquery-yui.html (next: http://localhost:36430/tests/dromaeo/cssquery-dojo.html) 05:00:45 INFO - PROCESS | 25789 | RSS: Main: 168353792 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | __start_tp_report 05:00:45 INFO - PROCESS | 25789 | _x_x_mozilla_page_load 05:00:45 INFO - PROCESS | 25789 | _x_x_mozilla_page_load_details 05:00:45 INFO - PROCESS | 25789 | |i|pagename|runs| 05:00:45 INFO - PROCESS | 25789 | |0;dojo.html;2653.5488966875632;2708.3906121122745;2709.878055487503;2711.159540542433;2718.7553120219177;4679.485256621769;4709.08172906283;4737.26572381281;4861.124997500448;4865.294532292815;4673.228917228653;4769.117713223048;4807;4820.8071677132875;4851.102546028978;4363.78181090945;4407.449068866392;4495.3931219285305;4526.343680166374;4530.501644819067;4459.353393757903;4495.100979804036;4509.977450112761;4523.36672865799;4546.727196368212;4291.592298731615;4370.169667763115;4394.362817391492;4398.472183337988;4466.754328511931;4360.869173924787;4414.470263568361;4414.955850441486;4416.933745993812;4447.444069491314;4415.161119387339;4437.711548749321;4445.599896009375;4450.688451808374;4488.147252022105;4646.395968524071;4687.086018226447;4690.624750019991;4707.646926480527;4776.0925424169645;5095.464976177485;5102.719350435725;5119.257707632372;5125.897482050375;5135.4094279158;5077.086124497589;5119.436861945183;5142.742862856842;5147.253648221024;5149.124648809711;4748.07412554552;4782.832600858953;4784.928226076611;4785.59322457595;4835.419749630032;5241.947580524222;5244.292020577173;5248.8425347239645;5250.107481728039;5272.92090618641;5036.597072234285;5056.342675452168;5101.795928162906;5148.2020286855595;5167.431582525919;5222.8955420892125;5241.947580524222;5243.4232234454175;5246.63273570854;5262.105442074857;5062.164742817394;5069.847904562869;5081.72050537224;5123.257127716534;5131.204663277198;4962.751862406865;5082.161443361804;5109.029284435946;5120.436751957282;5126.846194614168;4429.180601588717;4457.64338852891;4458.353538736865;4491.191585514639;4501.324801279834;3825.598312177237;3840.4815349927962;3851.1912498375095;3885.436611691289;3925.391564307537;4295.957040429618;4461.553844615512;4475.283954567253;4491.1915855145735;4503.211937910853;5169.431362550116;5214.817481388133;5225.163973764255;5250.422453530108;5258.053550360895;4438.245498265303;4485.9775701121935;4486.775661216926;4487.596116349544;4529.6376289896725;4538.659600529973;4654.348391225231;4670.392848929618;4707.693999889996;4718.882027949328;4847.248676455155;4868.415790105139;4871.902561948812;4878.707277563358;4922.655414120977;5074.5940324774665;5215.843524694265;5227.268182454535;5229.241759944711;5267.367915850123;4785.114753770564;4817.229243321051;4827.227643577011;4830.8792280193275;4833.081714474239;5093.439721630543;5094.617903657167;5105.132127538253;5118.436971933159;5176.378834539729;5106.897862042812;5154.819581314636;5177.792888284577;5189.974050129726;5193.948060519498;4867.5132486751045;5016.799328026838;5050.974745126251;5084.440711521655;5161.019406312788;5056.595472362275;5083.517065878736;5096.541311282002;5100.18397056484;5134.512221338967;4768.308595253599;4843.200871856105;4989.850304490871;4997.450280469218;5033.723145227048;4929.827456039022;4967.180415231446;4986.052649996489;4992.80028798844;5045.2936588876855;4865.95134048655;4881.68269062524;4886.144924638245;4888.5111488850835;4893.7063776173545 05:00:45 INFO - PROCESS | 25789 | |1;ext.html;553.1150159744409;600;603.4822421609655;611.446640790085;618.6040933802365;41598.37602435962;42403.78798106009;42681.35977960329;42716.78641606787;47828.521714782844;43714.34428483567;43827.561724382744;44099.77950110245;44162;44398.55601443985;7973.760787176365;8072.596370181497;8075.353971682281;8090.312323452514;8109.878351824727;7833.060032796073;7884.250996155385;7936.404769642271;7973.960130199341;7975.561344126071;7967.760967170965;7989.960050199741;8012.198780121999;8022.879656805153;8038.758837234892;7871.370290376756;7933.920660793405;7966.920330796705;7984.401169912251;8003.719869804587;7876.448648594601;7954.840903181904;7960.562169080698;7966.362690984707;7988.560629165394;40348.596514035075;40438.393424098664;40494.1901161978;40505.59494405077;40599.18801623951;3010.3979204159255;3090.6136732908385;3113.159446949311;3122.98438507806;3167.889123880653;29911.70088299111;30201;30253;30759.38481230385;31377.52933705996;3158.8262645554487;3161.146490447566;3196.121066706651;3204.3911656785367;3259.071164718068;249667;251094;252848;252918;253079.73460132765;33694;35007.64992350044;56563;57112;57121.428785712444;36094.63905360965;36301.455478167845;36504.26991460156;36546.451803222975;36779;14699.485518006819;14750.852491475163;14790.926045369704;14804.481843135438;14949.402023918921;11242.437878106062;11244.212905096565;11250.831237531444;11277.154213434025;11339.546418143347;8330.375221858385;8349.624266908004;8409.831803363899;8466.957665211634;8493.320534357237;3291.7037466628117;3303.884364047295;3322.2691007978688;3378.543896573931;3428.4000299947907;995.3679413572289;1002.6914876086777;1013.543905242629;1029.8815636201932;1072.624581396505;29435.85282073576;29747.256318592208;29878.850605746833;30175.698243017727;30194.69805301919;1001.3341128149699;1115;1126.1947707389256;1185.407296351824;1200.2138599217526;15946.68106637884;16009.919950400406;16031.278592463366;16181.919090404472;16535;368831;369623;370588;370965;372188;54214.728926355114;54518.72740636271;54746.452535474935;54879.451205487436;54936.725316373166;1223.2904915149193;1269.904757143218;1271.7774389481988;1287.0668765145383;1306.3272414706435;28099.859500702365;29090.418191636472;29213.39326337072;29593.26016849596;29701.702982969895;46399.76800115978;46727.53272467232;46954.53045469638;46962;46977.29534056924;310974;316081;319913;320525;320909;26653.60019599669;26953.86523067372;27057;27187.1843844685;27231.727682722918;44287.778561106985;45371.77314113409;45628.315575267065;46251.3062304059;46397;38033;38088;38949.8052509747;38984.80507597444;39923.40114898337;37501.4374784373;38537.229255414175;38799.61200388073;38874;38908.41637375385;37717;38085.4287185698;38120.61879381281;38430;38932.80533597314;32928;34991.475127872596;35076.64923350734;35200.471992919614;35432.64567354293;26536.601950971137;26606.467870642868;26745.86627066852;26801.597976029985;27144.72855271422 05:00:45 INFO - PROCESS | 25789 | |2;jquery.html;383.1565537143022;384.450236162288;384.45215567815853;393.53955871630194;406.78846999560227;15834.4457943972;16423.01461912283;17133.65732685347;17173.484795456126;17189.140542972833;9541.570629321679;10701.83947240792;11173.944130279358;11213.495392707327;11647.708807279821;4571.108633816407;4613.700109492881;4707.293905914106;4750.667453278272;4771.594414474756;4733.290006499018;4733.621310295168;4747.525247475242;4754.6434017448655;4769.093872164295;4582.381378513908;4712.670113092085;4729.196036673774;4738.265568836819;4739.028499157682;4688.507706690816;4701.858944231679;4723.149833030053;4730.763461826895;4740.976295118519;4471.3293006049025;4584.243599806028;4615.238485649864;4628.3288923105965;4644.535546445362;20200.797992020038;20759.481012974644;21039.5792084159;21052.789472105236;21158.894205529028;1846.8984205868671;1927.267638297452;2060.402483279847;2064.6386882295687;2068.503559145809;9370.250379969655;9385.671501497414;9512.952435237848;9539.809203815954;9707.126358627758;1804.359452394394;1859.8419134373594;1862.608852141052;1865.4683415226596;1871.840893524052;61723.691381542805;64222.67888660573;65268.020979685345;71911;73768.63115684495;10041.292980193384;10359.430231337348;10377.221708371751;10708.143348532254;10711.892881071246;14649.560513184622;14691.191984440744;14746.04150730199;14810.925945370203;14886.330115144845;6578.901316480256;6767.593944363255;7392.963035184897;7843.137254901956;7891.6054197289905;6743.055972163901;7252.818679533054;7540.434467414966;7557.3751643395835;7714.228577142353;4508.549145085531;4515;4550.522195169526;4623.630109591225;4661.3707149534375;1889.7070954002152;1924.5765931495048;1939.5054261163596;1945.7762357328804;1976.8517361197967;925.564984457304;967.6274634265858;993.5330394714473;1025.374521541859;1031.6131450705984;16003.599910002344;16168.029918204946;16863.241154148094;17017.744733829004;17268.395606153725;893.8480458322101;931.7204838548408;937.7139972308375;959.2709540749081;1036.9637062702768;9537.332386733;9560.808783824285;9690.370125941932;9733.610655573697;9765.751897924425;363374;364981;366129;367129;384285;80158;80307.19692803115;81208.18791812124;81732;83150.58424707838;955.245356168633;961.9134277915022;972.3436680240809;977.5942983661843;980.8626792249091;14997.625059373602;15198;15211.391544338545;15240.390384384944;15527.689446210787;35344.82327588346;35487.82256088703;36454;36756.81621591875;36996.81501592582;38661.22677546489;44124.33813492864;44528.332075018254;48207;49722.25416618826;7770.961145194238;7776.766696998873;7885.921140788748;7903.802404939923;8039.276465118168;10989.670309890716;11901.76196476083;12062.095342849498;12213.572524961584;12281.815772763237;10135.543900524346;10703.19726020536;10825.458727063458;10876.564937402416;10922.836157457803;10688.519016644424;10694.14446844235;10727.946360268148;10746.892531074902;10831.079358254636;10796.352218866894;10970.341779493256;10975.890241097486;11193.384363860067;11402.429878506207;7761.7671469855995;7913.208679132041;8090.312323452573;8203.220694034057;8221;9897.851532227167;10385.948070259601;10518.368897866152;10639;10732.839007415052 05:00:45 INFO - PROCESS | 25789 | |3;mootools.html;1516.3707061569446;1545.6058705030218;1750.6236159225764;1843.8985855777926;1871.4666320098775;6813.931860681391;7541.434392420563;7555.395568354532;8108.675652973881;8115.26962573369;7665.348445382136;7878.133405325424;7933.087694915086;7947.523148611087;7983.640736166872;2208.149862303013;2252.4368907773055;2253.2339004738387;2254.301166638339;2254.695616091831;2101.8843963582;2160.1791319298645;2167.2306331252416;2172.3265787605815;2174.325958952722;2181.1275489804048;2186.431527802767;2199.186301068607;2202.680611311359;2203.1958335207696;2155.2779818760655;2163.3401812447196;2167.1331467413;2171.337741988693;2171.69596256525;2158.082814803702;2168.533765240481;2187.2344679362254;2200.4938864061196;2207.724034495688;7802.063752349698;7834.255745704149;7852.450328477009;7878.645460954213;7892.4869883457395;4719.646026548023;4812.061647978646;4832.154372984749;4846.248831431134;4858.489858564871;2853.671827739816;2993.565932939733;3000.639923209229;3001.7448516876093;3011.6988301169927;948;950.8003319302954;959.7216807125925;999.3204620857814;1010.4493051287067;10595.576176952913;10667.786644267071;10673.466326683634;10682.359058456517;10757;4302.247106756367;4326.199653064194;4397.329014974289;4444.444444444444;4458.910821783611;9177.082291770903;9186;9193.172614464731;9195.402298850688;9210.631574736935;4704.811807527661;4761.333413322138;4768.690035147704;4814.494478079751;4846.80612775485;3819.2934307153264;4256.638185754246;4401.933970990438;4411.360352748833;4415.2935530315;3607.152319204985;3634.127809325743;3680.3375392429084;3762.4920635714375;3774.8867533974026;1196.5393323570313;1263.1536870296923;1266.2718936611302;1276.5532063777603;1284.383495921944;866.332923648787;868.3357231717741;874.8469017921839;882.4925667741074;898.874157617934;5028.421731500925;5050.924236136461;5067.391912970394;5215.348081489814;5285.68285902847;900.1358695652248;903.13299232736;914.5884352041608;930.7207837648814;955.8757361542955;3512.121969507623;3536.0806190390686;3537.663921927413;3557.1462848916076;3588.6949609282983;9275.304352173614;9626.759331016641;9646;9737.07497787709;9770.169535589412;9622.085901839315;9665.806683866283;9816.803663926681;9822.116009559173;9823.26325525574;7167.641617919083;7171.820704482429;7232.566046037149;7455.179930207672;7553.433492488085;5147.897042059063;5150.4592017837585;5194.948050519446;5214.0354034502225;5235;8773.517456539952;8824.867626985471;8856.778580535538;9016.774580635536;9099.272058235192;8952.14954579314;8999.19007289347;9035.819283614159;9275;9287.535623218677;5549.334079910275;6053.092036194606;6225.159603453476;6278.121063051085;6359.618422894641;7327.963360183165;7350.926490735238;7390.889136663062;7391.889121663287;7430.591317477591;6493.772717954849;6562.868742625216;6590.670466476561;6602.900956485752;6605.273419923708;6278.46633036197;6424.13274207976;6425.710843011982;6448.806535803933;6531.706073226811;5863.413658634103;5969.597144670912;5971.0744834550715;5976.342602313829;5989.041753319448;4234.301340278943;4299.097189590096;4304.16068866568;4425.291953287458;4433.024734558392;4316.611504964569;4394.1870753910625;4419.602235798665;4427.955720442883;4463.642908567242 05:00:45 INFO - PROCESS | 25789 | |4;prototype.html;315.3550988229071;320.415242183016;325.24705307213804;327.9918002049947;328.09377516628393;4808.595702148926;4880.389471474414;4982.153033984222;5010.524000219983;5041.269015992679;4894.143524883149;4919.532644398785;4941.308216849644;4951.529604687549;4952.281919121734;3918.921621567567;3925.2934471795065;3932.3315036443732;3934.488516492852;3938.3304838177437;3676.1544844685736;3944;3959.128991621853;3971.7616942983514;3981.402789581557;3807.9619203807883;3817.3701339278987;3846.8653597124107;3857.5756666766633;3865.323568375537;3855.961440385602;3857.4792403025513;3864.555576108727;3874.8062596870186;3884.3202439573242;3348.280119774236;3403.8298085095894;3404.438267685829;3404.5360494987144;3411.300683359905;4667.649926255544;4732.337472753818;4743.430788305391;4761.6904901181315;4765.475797662254;4384.912301753979;4398.692091553593;4410.867673969754;4415.536368681274;4426.7122637028815;5132.9743351283005;5173.1722924331925;5178.741062946838;5208.453112423179;5239.16173412256;3598.892033239007;3699.130704284491;3699.352613292663;3701.555813302394;3713.628637136265;5404.891902161935;5408.296921400193;5422;5423.2136340230445;5438.564914806806;3775.5846856845724;3785.734998550075;3790.886273411747;3794.506714127201;3805.5052843130215;3839.8080095995088;3839.9232015359535;3864.652181303696;3867.6712479439;3876.2441323942126;4227.260229459832;4358.346248062816;4374.234508960919;4378.824847006084;4416.447944006999;5134.8973020540125;5162.845114646567;5218;5221.399539052982;5231.9476805232225;1249.775040492702;1298.8571257161705;1324.1723922548408;1330.6939403936956;1334.2261488336935;842.5955541340192;842.6208206307186;847.8685803700437;860.6514361683528;879.9868001979976;4010.498687664042;4067.6745860331102;4078.5105787305715;4084.2852500812237;4084.7957602119777;4687.578117969331;4703.905921881612;4724.314974328703;4726.858194254178;4731.060265291214;4053.493313335833;4065.6137666921595;4101.015756218486;4135.441715368387;4148.7303325284365;2529.5446819572285;2644.955242679131;2875.511163102278;2879.1650421377567;2896.174590241771;5042.168042273057;5064.721440320818;5066.46802085783;5067.797288108434;5093;5345.33183352081;5517.2551705520045;5527.585431092684;5556.305461817273;5563.610547261734;4975.776090075955;4995.25071239317;4998.250262460515;5017.8243761468175;5021.748912554431;5346.304980352529;5363.302770639948;5386.757595908115;5388.757505912322;5404.702741349263;5076.670016448919;5221.608379371638;5271.288376069181;5287.75270510024;5306.495882891119;5013.222950442687;5013.774380152829;5026.271190677405;5033.219850923113;5042.9243561345875;3794.146317078635;3795.0132965428634;3822.3119838429348;3822.8279727411777;3837.788921609338;5183.5593974512585;5314.8937021260135;5333.679979201261;5364.892702145858;5374.946250537445;5118.513741194581;5120.411152717336;5122.641415100908;5145.279660847559;5224.615476898549;5098.694078355311;5150.433452320317;5155.922661160011;5170.482951704799;5219.895602087861;4913.72243216759;4998.925016124688;5093.821716239914;5099.719515426687;5209.968112436077;5222.582193424593;5229.660072095302;5260.237265596544;5280.785419353493;5360.865978350573;5133.717645529382;5153.149730294459;5200.6879587224885;5216.582673386196;5220.738963051756 05:00:45 INFO - PROCESS | 25789 | |5;yui.html;733.4462480826978;738.0368618952268;752.1643404365542;758.757197696737;773.1186447449904;10047.14599259063;12173.573924912629;12441.315727634976;12499.437525311349;12508.186967847083;11132.666020019393;11229.270097443681;11294.09647228222;11446.542138314479;11525.250858694179;677.6442367756943;847.1443841719846;864.7103220421167;882.9558522073903;883.5052370672412;871.1897934920521;872.5637181409295;874.3573473497006;874.6719980007497;874.8862647855769;892.3485855325616;892.9017808041143;900.3832374823266;901.292485398962;901.2969883490888;890.381185076369;891.3715830339628;894.6466145872344;894.9105089491064;898.5148020069155;664.2261765043718;664.7241394821192;664.9534532582721;665.527475492401;665.9800205993828;13112.606621801362;13128.2123072615;13132.737345253137;13150.408231629599;13150.934245328808;10909.618163364323;10950.178736594788;10969.616063437821;11030.117590592734;11451.599194028253;8884.422512536728;8985;9109.089091090904;9132.634694612274;9346.065393460667;3342.565466489365;3393.0669066007044;3393.134750638596;3421.298633780094;3442.6041005284465;45725.54274457246;46384.7680761594;46395.30407043897;46442.53557464416;47698.5230147701;10247.7438064049;10450.529726162189;10568.841467377995;10639.627613033661;10645.254832161829;16645.583860403345;17106.65786684284;17143.142842857807;17348.739768903477;17572.29710811579;6889.965550172317;6912.861742765116;6987.301269873074;7044.929550704427;7057.92942070583;3496.7202623790035;3553.8400771964807;3571.339302229044;3576.8211589420944;3608.693261072786;2888.9855550722114;2938.3241854373186;2950.8377039263046;2955.674875763664;2976.627921509811;520.1132069820947;520.3495630461923;522.0733198572564;533.8531903726506;535.9249705041298;547.8493414311017;589.5813972079872;596.4155127974609;604.1360853978853;606.9635821850703;7383.889241661379;7431.2197219292275;7637.045369328834;7714.5756983366455;7777.300042996158;477.3508029080448;522.3261992030239;578.5805291163872;586.5659412035149;587.2014060877203;3737.140457694691;3760.8871733848027;3761.134938963999;3817.2365526894732;3879.0302424393903;51505.48494515007;51713.09462737293;52071.73964130155;52654;52670.946581068165;44981.775091124335;46401.535984640395;46669.29996050062;46685.29972050422;47299;43579;43617.90955226081;43631.12737745227;43985.56014439878;44260.77869610631;6961.6171110587375;7004.498347292374;7016;7029.121359830021;7169.139703235645;28424.57363139513;28432.445944256968;28973.275668108465;29549;29668.25829354197;37488;38041.239175215786;38775.22449550937;38781.80609096937;38875.80562097171;8935.776605584912;9158.40470369424;9181.449113053239;9222.354435189472;9251.444913305224;10083.495825208563;10320.741981450525;10398.116160126474;10402.947985260025;10495.895041049796;9261.72214833556;9359.554627972564;9370.39092458988;9389.10803473669;9543.236541076836;9678.854817177607;9788.99173882768;9885.406875587487;10139.594416223268;10181.694549163536;9796.559154837907;9847.083855316283;9862.457564834003;9959.302848800804;9997.500124993867;8477.618507167315;8555.187257210555;8665.090165532529;8719.738407847775;8950.14973577509;8764.561771911507;9026.90973090287;9051.185393314634;9083.500407477652;9165.816683666422 05:00:45 INFO - PROCESS | 25789 | __end_tp_report 05:00:45 INFO - PROCESS | 25789 | __start_cc_report 05:00:45 INFO - PROCESS | 25789 | _x_x_mozilla_cycle_collect,351 05:00:45 INFO - PROCESS | 25789 | __end_cc_report 05:00:45 INFO - PROCESS | 25789 | __startTimestamp1462881645560__endTimestamp 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | ------- Summary: start ------- 05:00:45 INFO - PROCESS | 25789 | Number of tests: 6 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | [#0] dojo.html Cycles:165 Average:4764.36 Median:4865.29 stddev:492.98 (10.1%) stddev-sans-first:465.85 05:00:45 INFO - PROCESS | 25789 | Values: 2653.5 2708.4 2709.9 2711.2 2718.8 4679.5 4709.1 4737.3 4861.1 4865.3 4673.2 4769.1 4807.0 4820.8 4851.1 4363.8 4407.4 4495.4 4526.3 4530.5 4459.4 4495.1 4510.0 4523.4 4546.7 4291.6 4370.2 4394.4 4398.5 4466.8 4360.9 4414.5 4415.0 4416.9 4447.4 4415.2 4437.7 4445.6 4450.7 4488.1 4646.4 4687.1 4690.6 4707.6 4776.1 5095.5 5102.7 5119.3 5125.9 5135.4 5077.1 5119.4 5142.7 5147.3 5149.1 4748.1 4782.8 4784.9 4785.6 4835.4 5241.9 5244.3 5248.8 5250.1 5272.9 5036.6 5056.3 5101.8 5148.2 5167.4 5222.9 5241.9 5243.4 5246.6 5262.1 5062.2 5069.8 5081.7 5123.3 5131.2 4962.8 5082.2 5109.0 5120.4 5126.8 4429.2 4457.6 4458.4 4491.2 4501.3 3825.6 3840.5 3851.2 3885.4 3925.4 4296.0 4461.6 4475.3 4491.2 4503.2 5169.4 5214.8 5225.2 5250.4 5258.1 4438.2 4486.0 4486.8 4487.6 4529.6 4538.7 4654.3 4670.4 4707.7 4718.9 4847.2 4868.4 4871.9 4878.7 4922.7 5074.6 5215.8 5227.3 5229.2 5267.4 4785.1 4817.2 4827.2 4830.9 4833.1 5093.4 5094.6 5105.1 5118.4 5176.4 5106.9 5154.8 5177.8 5190.0 5193.9 4867.5 5016.8 5051.0 5084.4 5161.0 5056.6 5083.5 5096.5 5100.2 5134.5 4768.3 4843.2 4989.9 4997.5 5033.7 4929.8 4967.2 4986.1 4992.8 5045.3 4866.0 4881.7 4886.1 4888.5 4893.7 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | [#1] ext.html Cycles:180 Average:47144.05 Median:202805.00 stddev:83381.65 (41.1%) stddev-sans-first:83542.18 05:00:45 INFO - PROCESS | 25789 | Values: 553.1 600.0 603.5 611.4 618.6 41598.4 42403.8 42681.4 42716.8 47828.5 43714.3 43827.6 44099.8 44162.0 44398.6 7973.8 8072.6 8075.4 8090.3 8109.9 7833.1 7884.3 7936.4 7974.0 7975.6 7967.8 7990.0 8012.2 8022.9 8038.8 7871.4 7933.9 7966.9 7984.4 8003.7 7876.4 7954.8 7960.6 7966.4 7988.6 40348.6 40438.4 40494.2 40505.6 40599.2 3010.4 3090.6 3113.2 3123.0 3167.9 29911.7 30201.0 30253.0 30759.4 31377.5 3158.8 3161.1 3196.1 3204.4 3259.1 249667.0 251094.0 252848.0 252918.0 253079.7 33694.0 35007.6 56563.0 57112.0 57121.4 36094.6 36301.5 36504.3 36546.5 36779.0 14699.5 14750.9 14790.9 14804.5 14949.4 11242.4 11244.2 11250.8 11277.2 11339.5 8330.4 8349.6 8409.8 8467.0 8493.3 3291.7 3303.9 3322.3 3378.5 3428.4 995.4 1002.7 1013.5 1029.9 1072.6 29435.9 29747.3 29878.9 30175.7 30194.7 1001.3 1115.0 1126.2 1185.4 1200.2 15946.7 16009.9 16031.3 16181.9 16535.0 368831.0 369623.0 370588.0 370965.0 372188.0 54214.7 54518.7 54746.5 54879.5 54936.7 1223.3 1269.9 1271.8 1287.1 1306.3 28099.9 29090.4 29213.4 29593.3 29701.7 46399.8 46727.5 46954.5 46962.0 46977.3 310974.0 316081.0 319913.0 320525.0 320909.0 26653.6 26953.9 27057.0 27187.2 27231.7 44287.8 45371.8 45628.3 46251.3 46397.0 38033.0 38088.0 38949.8 38984.8 39923.4 37501.4 38537.2 38799.6 38874.0 38908.4 37717.0 38085.4 38120.6 38430.0 38932.8 32928.0 34991.5 35076.6 35200.5 35432.6 26536.6 26606.5 26745.9 26801.6 27144.7 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | [#2] jquery.html Cycles:180 Average:23508.74 Median:400.16 stddev:61139.70 (15278.7%) stddev-sans-first:61286.55 05:00:45 INFO - PROCESS | 25789 | Values: 383.2 384.5 384.5 393.5 406.8 15834.4 16423.0 17133.7 17173.5 17189.1 9541.6 10701.8 11173.9 11213.5 11647.7 4571.1 4613.7 4707.3 4750.7 4771.6 4733.3 4733.6 4747.5 4754.6 4769.1 4582.4 4712.7 4729.2 4738.3 4739.0 4688.5 4701.9 4723.1 4730.8 4741.0 4471.3 4584.2 4615.2 4628.3 4644.5 20200.8 20759.5 21039.6 21052.8 21158.9 1846.9 1927.3 2060.4 2064.6 2068.5 9370.3 9385.7 9513.0 9539.8 9707.1 1804.4 1859.8 1862.6 1865.5 1871.8 61723.7 64222.7 65268.0 71911.0 73768.6 10041.3 10359.4 10377.2 10708.1 10711.9 14649.6 14691.2 14746.0 14810.9 14886.3 6578.9 6767.6 7393.0 7843.1 7891.6 6743.1 7252.8 7540.4 7557.4 7714.2 4508.5 4515.0 4550.5 4623.6 4661.4 1889.7 1924.6 1939.5 1945.8 1976.9 925.6 967.6 993.5 1025.4 1031.6 16003.6 16168.0 16863.2 17017.7 17268.4 893.8 931.7 937.7 959.3 1037.0 9537.3 9560.8 9690.4 9733.6 9765.8 363374.0 364981.0 366129.0 367129.0 384285.0 80158.0 80307.2 81208.2 81732.0 83150.6 955.2 961.9 972.3 977.6 980.9 14997.6 15198.0 15211.4 15240.4 15527.7 35344.8 35487.8 36454.0 36756.8 36996.8 38661.2 44124.3 44528.3 48207.0 49722.3 7771.0 7776.8 7885.9 7903.8 8039.3 10989.7 11901.8 12062.1 12213.6 12281.8 10135.5 10703.2 10825.5 10876.6 10922.8 10688.5 10694.1 10727.9 10746.9 10831.1 10796.4 10970.3 10975.9 11193.4 11402.4 7761.8 7913.2 8090.3 8203.2 8221.0 9897.9 10385.9 10518.4 10639.0 10732.8 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | [#3] mootools.html Cycles:180 Average:5126.10 Median:5172.70 stddev:2849.89 (55.1%) stddev-sans-first:2844.98 05:00:45 INFO - PROCESS | 25789 | Values: 1516.4 1545.6 1750.6 1843.9 1871.5 6813.9 7541.4 7555.4 8108.7 8115.3 7665.3 7878.1 7933.1 7947.5 7983.6 2208.1 2252.4 2253.2 2254.3 2254.7 2101.9 2160.2 2167.2 2172.3 2174.3 2181.1 2186.4 2199.2 2202.7 2203.2 2155.3 2163.3 2167.1 2171.3 2171.7 2158.1 2168.5 2187.2 2200.5 2207.7 7802.1 7834.3 7852.5 7878.6 7892.5 4719.6 4812.1 4832.2 4846.2 4858.5 2853.7 2993.6 3000.6 3001.7 3011.7 948.0 950.8 959.7 999.3 1010.4 10595.6 10667.8 10673.5 10682.4 10757.0 4302.2 4326.2 4397.3 4444.4 4458.9 9177.1 9186.0 9193.2 9195.4 9210.6 4704.8 4761.3 4768.7 4814.5 4846.8 3819.3 4256.6 4401.9 4411.4 4415.3 3607.2 3634.1 3680.3 3762.5 3774.9 1196.5 1263.2 1266.3 1276.6 1284.4 866.3 868.3 874.8 882.5 898.9 5028.4 5050.9 5067.4 5215.3 5285.7 900.1 903.1 914.6 930.7 955.9 3512.1 3536.1 3537.7 3557.1 3588.7 9275.3 9626.8 9646.0 9737.1 9770.2 9622.1 9665.8 9816.8 9822.1 9823.3 7167.6 7171.8 7232.6 7455.2 7553.4 5147.9 5150.5 5194.9 5214.0 5235.0 8773.5 8824.9 8856.8 9016.8 9099.3 8952.1 8999.2 9035.8 9275.0 9287.5 5549.3 6053.1 6225.2 6278.1 6359.6 7328.0 7350.9 7390.9 7391.9 7430.6 6493.8 6562.9 6590.7 6602.9 6605.3 6278.5 6424.1 6425.7 6448.8 6531.7 5863.4 5969.6 5971.1 5976.3 5989.0 4234.3 4299.1 4304.2 4425.3 4433.0 4316.6 4394.2 4419.6 4428.0 4463.6 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | [#4] prototype.html Cycles:180 Average:4270.23 Median:4844.49 stddev:1246.66 (25.7%) stddev-sans-first:1214.30 05:00:45 INFO - PROCESS | 25789 | Values: 315.4 320.4 325.2 328.0 328.1 4808.6 4880.4 4982.2 5010.5 5041.3 4894.1 4919.5 4941.3 4951.5 4952.3 3918.9 3925.3 3932.3 3934.5 3938.3 3676.2 3944.0 3959.1 3971.8 3981.4 3808.0 3817.4 3846.9 3857.6 3865.3 3856.0 3857.5 3864.6 3874.8 3884.3 3348.3 3403.8 3404.4 3404.5 3411.3 4667.6 4732.3 4743.4 4761.7 4765.5 4384.9 4398.7 4410.9 4415.5 4426.7 5133.0 5173.2 5178.7 5208.5 5239.2 3598.9 3699.1 3699.4 3701.6 3713.6 5404.9 5408.3 5422.0 5423.2 5438.6 3775.6 3785.7 3790.9 3794.5 3805.5 3839.8 3839.9 3864.7 3867.7 3876.2 4227.3 4358.3 4374.2 4378.8 4416.4 5134.9 5162.8 5218.0 5221.4 5231.9 1249.8 1298.9 1324.2 1330.7 1334.2 842.6 842.6 847.9 860.7 880.0 4010.5 4067.7 4078.5 4084.3 4084.8 4687.6 4703.9 4724.3 4726.9 4731.1 4053.5 4065.6 4101.0 4135.4 4148.7 2529.5 2645.0 2875.5 2879.2 2896.2 5042.2 5064.7 5066.5 5067.8 5093.0 5345.3 5517.3 5527.6 5556.3 5563.6 4975.8 4995.3 4998.3 5017.8 5021.7 5346.3 5363.3 5386.8 5388.8 5404.7 5076.7 5221.6 5271.3 5287.8 5306.5 5013.2 5013.8 5026.3 5033.2 5042.9 3794.1 3795.0 3822.3 3822.8 3837.8 5183.6 5314.9 5333.7 5364.9 5374.9 5118.5 5120.4 5122.6 5145.3 5224.6 5098.7 5150.4 5155.9 5170.5 5219.9 4913.7 4998.9 5093.8 5099.7 5210.0 5222.6 5229.7 5260.2 5280.8 5360.9 5133.7 5153.1 5200.7 5216.6 5220.7 05:00:45 INFO - PROCESS | 25789 | 05:00:45 INFO - PROCESS | 25789 | [#5] yui.html Cycles:180 Average:12465.77 Median:52662.47 stddev:14544.11 (27.6%) stddev-sans-first:14558.23 05:00:45 INFO - PROCESS | 25789 | Values: 733.4 738.0 752.2 758.8 773.1 10047.1 12173.6 12441.3 12499.4 12508.2 11132.7 11229.3 11294.1 11446.5 11525.3 677.6 847.1 864.7 883.0 883.5 871.2 872.6 874.4 874.7 874.9 892.3 892.9 900.4 901.3 901.3 890.4 891.4 894.6 894.9 898.5 664.2 664.7 665.0 665.5 666.0 13112.6 13128.2 13132.7 13150.4 13150.9 10909.6 10950.2 10969.6 11030.1 11451.6 8884.4 8985.0 9109.1 9132.6 9346.1 3342.6 3393.1 3393.1 3421.3 3442.6 45725.5 46384.8 46395.3 46442.5 47698.5 10247.7 10450.5 10568.8 10639.6 10645.3 16645.6 17106.7 17143.1 17348.7 17572.3 6890.0 6912.9 6987.3 7044.9 7057.9 3496.7 3553.8 3571.3 3576.8 3608.7 2889.0 2938.3 2950.8 2955.7 2976.6 520.1 520.3 522.1 533.9 535.9 547.8 589.6 596.4 604.1 607.0 7383.9 7431.2 7637.0 7714.6 7777.3 477.4 522.3 578.6 586.6 587.2 3737.1 3760.9 3761.1 3817.2 3879.0 51505.5 51713.1 52071.7 52654.0 52670.9 44981.8 46401.5 46669.3 46685.3 47299.0 43579.0 43617.9 43631.1 43985.6 44260.8 6961.6 7004.5 7016.0 7029.1 7169.1 28424.6 28432.4 28973.3 29549.0 29668.3 37488.0 38041.2 38775.2 38781.8 38875.8 8935.8 9158.4 9181.4 9222.4 9251.4 10083.5 10320.7 10398.1 10402.9 10495.9 9261.7 9359.6 9370.4 9389.1 9543.2 9678.9 9789.0 9885.4 10139.6 10181.7 9796.6 9847.1 9862.5 9959.3 9997.5 8477.6 8555.2 8665.1 8719.7 8950.1 8764.6 9026.9 9051.2 9083.5 9165.8 05:00:45 INFO - PROCESS | 25789 | -------- Summary: end -------- 05:00:45 INFO - PROCESS | 25789 | 05:00:46 INFO - TEST-INFO | 25789: exit 0 05:00:46 INFO - TEST-OK | dromaeo_css | took 1115456ms 05:00:46 INFO - TEST-START | kraken 05:00:46 INFO - operating with platform_type : linux_ 05:00:46 INFO - Initialising browser for kraken test... 05:00:46 INFO - TEST-INFO | started process 26026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzZCCC/profile http://localhost:36430/getInfo.html) 05:00:50 INFO - PROCESS | 26026 | 05:00:50 INFO - PROCESS | 26026 | (process:26093): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:51 INFO - PROCESS | 26026 | __metrics Screen width/height:1600/1200 05:00:51 INFO - PROCESS | 26026 | colorDepth:24 05:00:51 INFO - PROCESS | 26026 | Browser inner width/height: 1024/697 05:00:51 INFO - PROCESS | 26026 | __metrics 05:00:51 ERROR - PROCESS | 26026 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 05:00:52 INFO - TEST-INFO | 26026: exit 0 05:00:52 INFO - Browser initialized. 05:00:52 INFO - Running cycle 1/1 for kraken test... 05:00:52 INFO - TEST-INFO | started process 26144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzZCCC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:54 INFO - PROCESS | 26144 | 05:00:54 INFO - PROCESS | 26144 | (process:26203): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:01:04 INFO - PROCESS | 26144 | RSS: Main: 164077568 05:01:04 INFO - PROCESS | 26144 | 05:01:07 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:08 INFO - PROCESS | 26144 | RSS: Main: 168685568 05:01:08 INFO - PROCESS | 26144 | 05:01:11 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-dft) 05:01:11 INFO - PROCESS | 26144 | RSS: Main: 168554496 05:01:11 INFO - PROCESS | 26144 | 05:01:14 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-fft) 05:01:15 INFO - PROCESS | 26144 | RSS: Main: 163672064 05:01:15 INFO - PROCESS | 26144 | 05:01:17 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36430/tests/kraken/driver.html?testName=audio-oscillator) 05:01:18 INFO - PROCESS | 26144 | RSS: Main: 164253696 05:01:18 INFO - PROCESS | 26144 | 05:01:20 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:21 INFO - PROCESS | 26144 | RSS: Main: 164089856 05:01:21 INFO - PROCESS | 26144 | 05:01:24 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36430/tests/kraken/driver.html?testName=imaging-darkroom) 05:01:25 INFO - PROCESS | 26144 | RSS: Main: 164265984 05:01:25 INFO - PROCESS | 26144 | 05:01:28 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36430/tests/kraken/driver.html?testName=imaging-desaturate) 05:01:29 INFO - PROCESS | 26144 | RSS: Main: 162713600 05:01:29 INFO - PROCESS | 26144 | 05:01:32 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36430/tests/kraken/driver.html?testName=json-parse-financial) 05:01:32 INFO - PROCESS | 26144 | RSS: Main: 163782656 05:01:32 INFO - PROCESS | 26144 | 05:01:34 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:35 INFO - PROCESS | 26144 | RSS: Main: 163999744 05:01:35 INFO - PROCESS | 26144 | 05:01:37 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:37 INFO - PROCESS | 26144 | RSS: Main: 164204544 05:01:37 INFO - PROCESS | 26144 | 05:01:40 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:40 INFO - PROCESS | 26144 | RSS: Main: 164597760 05:01:40 INFO - PROCESS | 26144 | 05:01:43 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:44 INFO - PROCESS | 26144 | RSS: Main: 164204544 05:01:44 INFO - PROCESS | 26144 | 05:01:47 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:01:48 INFO - PROCESS | 26144 | RSS: Main: 164478976 05:01:48 INFO - PROCESS | 26144 | 05:01:49 INFO - PROCESS | 26144 | Cycle 1(1): loaded http://localhost:36430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36430/tests/kraken/driver.html?testName=ai-astar) 05:01:50 INFO - PROCESS | 26144 | RSS: Main: 166961152 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | __start_tp_report 05:01:50 INFO - PROCESS | 26144 | _x_x_mozilla_page_load 05:01:50 INFO - PROCESS | 26144 | _x_x_mozilla_page_load_details 05:01:50 INFO - PROCESS | 26144 | |i|pagename|runs| 05:01:50 INFO - PROCESS | 26144 | |0;ai-astar;112;116;105;115;114;116;107;115;114;113 05:01:50 INFO - PROCESS | 26144 | |1;audio-beat-detection;158;132;162;214;131;173;178;133;197;132 05:01:50 INFO - PROCESS | 26144 | |2;audio-dft;161;165;169;169;163;161;162;164;160;162 05:01:50 INFO - PROCESS | 26144 | |3;audio-fft;77;77;76;161;78;79;77;77;172;76 05:01:50 INFO - PROCESS | 26144 | |4;audio-oscillator;95;95;183;93;94;94;135;93;93;149 05:01:50 INFO - PROCESS | 26144 | |5;imaging-gaussian-blur;117;117;117;117;118;117;119;118;118;118 05:01:50 INFO - PROCESS | 26144 | |6;imaging-darkroom;150;147;147;147;148;147;148;146;147;147 05:01:50 INFO - PROCESS | 26144 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;95 05:01:50 INFO - PROCESS | 26144 | |8;json-parse-financial;67;67;67;77;66;66;69;67;66;68 05:01:50 INFO - PROCESS | 26144 | |9;json-stringify-tinderbox;64;64;64;65;64;64;65;63;64;66 05:01:50 INFO - PROCESS | 26144 | |10;stanford-crypto-aes;84;83;85;84;84;84;86;91;144;91 05:01:50 INFO - PROCESS | 26144 | |11;stanford-crypto-ccm;141;137;135;133;140;132;140;143;155;136 05:01:50 INFO - PROCESS | 26144 | |12;stanford-crypto-pbkdf2;181;184;182;179;182;181;186;180;180;177 05:01:50 INFO - PROCESS | 26144 | |13;stanford-crypto-sha256-iterative;69;71;72;69;68;68;70;68;69;69 05:01:50 INFO - PROCESS | 26144 | __end_tp_report 05:01:50 INFO - PROCESS | 26144 | __start_cc_report 05:01:50 INFO - PROCESS | 26144 | _x_x_mozilla_cycle_collect,925 05:01:50 INFO - PROCESS | 26144 | __end_cc_report 05:01:50 INFO - PROCESS | 26144 | __startTimestamp1462881710133__endTimestamp 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | ------- Summary: start ------- 05:01:50 INFO - PROCESS | 26144 | Number of tests: 14 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.50 stddev:3.77 (3.3%) stddev-sans-first:3.99 05:01:50 INFO - PROCESS | 26144 | Values: 112.0 116.0 105.0 115.0 114.0 116.0 107.0 115.0 114.0 113.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#1] audio-beat-detection Cycles:10 Average:161.00 Median:167.50 stddev:29.65 (17.7%) stddev-sans-first:31.43 05:01:50 INFO - PROCESS | 26144 | Values: 158.0 132.0 162.0 214.0 131.0 173.0 178.0 133.0 197.0 132.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.20 (2.0%) stddev-sans-first:3.26 05:01:50 INFO - PROCESS | 26144 | Values: 161.0 165.0 169.0 169.0 163.0 161.0 162.0 164.0 160.0 162.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#3] audio-fft Cycles:10 Average:95.00 Median:77.00 stddev:37.78 (49.1%) stddev-sans-first:39.51 05:01:50 INFO - PROCESS | 26144 | Values: 77.0 77.0 76.0 161.0 78.0 79.0 77.0 77.0 172.0 76.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:93.50 stddev:32.05 (34.3%) stddev-sans-first:33.37 05:01:50 INFO - PROCESS | 26144 | Values: 95.0 95.0 183.0 93.0 94.0 94.0 135.0 93.0 93.0 149.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:01:50 INFO - PROCESS | 26144 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 119.0 118.0 118.0 118.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:0.60 05:01:50 INFO - PROCESS | 26144 | Values: 150.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 147.0 147.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:01:50 INFO - PROCESS | 26144 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.00 stddev:3.30 (4.9%) stddev-sans-first:3.48 05:01:50 INFO - PROCESS | 26144 | Values: 67.0 67.0 67.0 77.0 66.0 66.0 69.0 67.0 66.0 68.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 05:01:50 INFO - PROCESS | 26144 | Values: 64.0 64.0 64.0 65.0 64.0 64.0 65.0 63.0 64.0 66.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:84.50 stddev:18.64 (22.1%) stddev-sans-first:19.56 05:01:50 INFO - PROCESS | 26144 | Values: 84.0 83.0 85.0 84.0 84.0 84.0 86.0 91.0 144.0 91.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:140.00 stddev:6.60 (4.7%) stddev-sans-first:6.96 05:01:50 INFO - PROCESS | 26144 | Values: 141.0 137.0 135.0 133.0 140.0 132.0 140.0 143.0 155.0 136.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:181.50 stddev:2.53 (1.4%) stddev-sans-first:2.68 05:01:50 INFO - PROCESS | 26144 | Values: 181.0 184.0 182.0 179.0 182.0 181.0 186.0 180.0 180.0 177.0 05:01:50 INFO - PROCESS | 26144 | 05:01:50 INFO - PROCESS | 26144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 05:01:50 INFO - PROCESS | 26144 | Values: 69.0 71.0 72.0 69.0 68.0 68.0 70.0 68.0 69.0 69.0 05:01:50 INFO - PROCESS | 26144 | -------- Summary: end -------- 05:01:50 INFO - PROCESS | 26144 | 05:01:51 INFO - TEST-INFO | 26144: exit 0 05:01:51 INFO - TEST-OK | kraken | took 64939ms 05:01:51 INFO - SUITE-END | took 1180s 05:01:51 INFO - Completed test suite (00:19:40) 05:01:51 INFO - javascript benchmark 05:01:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.5488966875632, 2708.3906121122745, 2709.878055487503, 2711.159540542433, 2718.7553120219177, 4679.485256621769, 4709.08172906283, 4737.26572381281, 4861.124997500448, 4865.294532292815, 4673.228917228653, 4769.117713223048, 4807.0, 4820.8071677132875, 4851.102546028978, 4363.78181090945, 4407.449068866392, 4495.3931219285305, 4526.343680166374, 4530.501644819067, 4459.353393757903, 4495.100979804036, 4509.977450112761, 4523.36672865799, 4546.727196368212, 4291.592298731615, 4370.169667763115, 4394.362817391492, 4398.472183337988, 4466.754328511931, 4360.869173924787, 4414.470263568361, 4414.955850441486, 4416.933745993812, 4447.444069491314, 4415.161119387339, 4437.711548749321, 4445.599896009375, 4450.688451808374, 4488.147252022105, 4646.395968524071, 4687.086018226447, 4690.624750019991, 4707.646926480527, 4776.0925424169645, 5095.464976177485, 5102.719350435725, 5119.257707632372, 5125.897482050375, 5135.4094279158, 5077.086124497589, 5119.436861945183, 5142.742862856842, 5147.253648221024, 5149.124648809711, 4748.07412554552, 4782.832600858953, 4784.928226076611, 4785.59322457595, 4835.419749630032, 5241.947580524222, 5244.292020577173, 5248.8425347239645, 5250.107481728039, 5272.92090618641, 5036.597072234285, 5056.342675452168, 5101.795928162906, 5148.2020286855595, 5167.431582525919, 5222.8955420892125, 5241.947580524222, 5243.4232234454175, 5246.63273570854, 5262.105442074857, 5062.164742817394, 5069.847904562869, 5081.72050537224, 5123.257127716534, 5131.204663277198, 4962.751862406865, 5082.161443361804, 5109.029284435946, 5120.436751957282, 5126.846194614168, 4429.180601588717, 4457.64338852891, 4458.353538736865, 4491.191585514639, 4501.324801279834, 3825.598312177237, 3840.4815349927962, 3851.1912498375095, 3885.436611691289, 3925.391564307537, 4295.957040429618, 4461.553844615512, 4475.283954567253, 4491.1915855145735, 4503.211937910853, 5169.431362550116, 5214.817481388133, 5225.163973764255, 5250.422453530108, 5258.053550360895, 4438.245498265303, 4485.9775701121935, 4486.775661216926, 4487.596116349544, 4529.6376289896725, 4538.659600529973, 4654.348391225231, 4670.392848929618, 4707.693999889996, 4718.882027949328, 4847.248676455155, 4868.415790105139, 4871.902561948812, 4878.707277563358, 4922.655414120977, 5074.5940324774665, 5215.843524694265, 5227.268182454535, 5229.241759944711, 5267.367915850123, 4785.114753770564, 4817.229243321051, 4827.227643577011, 4830.8792280193275, 4833.081714474239, 5093.439721630543, 5094.617903657167, 5105.132127538253, 5118.436971933159, 5176.378834539729, 5106.897862042812, 5154.819581314636, 5177.792888284577, 5189.974050129726, 5193.948060519498, 4867.5132486751045, 5016.799328026838, 5050.974745126251, 5084.440711521655, 5161.019406312788, 5056.595472362275, 5083.517065878736, 5096.541311282002, 5100.18397056484, 5134.512221338967, 4768.308595253599, 4843.200871856105, 4989.850304490871, 4997.450280469218, 5033.723145227048, 4929.827456039022, 4967.180415231446, 4986.052649996489, 4992.80028798844, 5045.2936588876855, 4865.95134048655, 4881.68269062524, 4886.144924638245, 4888.5111488850835, 4893.7063776173545], "value": 4733.309093898093, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1150159744409, 600.0, 603.4822421609655, 611.446640790085, 618.6040933802365, 41598.37602435962, 42403.78798106009, 42681.35977960329, 42716.78641606787, 47828.521714782844, 43714.34428483567, 43827.561724382744, 44099.77950110245, 44162.0, 44398.55601443985, 7973.760787176365, 8072.596370181497, 8075.353971682281, 8090.312323452514, 8109.878351824727, 7833.060032796073, 7884.250996155385, 7936.404769642271, 7973.960130199341, 7975.561344126071, 7967.760967170965, 7989.960050199741, 8012.198780121999, 8022.879656805153, 8038.758837234892, 7871.370290376756, 7933.920660793405, 7966.920330796705, 7984.401169912251, 8003.719869804587, 7876.448648594601, 7954.840903181904, 7960.562169080698, 7966.362690984707, 7988.560629165394, 40348.596514035075, 40438.393424098664, 40494.1901161978, 40505.59494405077, 40599.18801623951, 3010.3979204159255, 3090.6136732908385, 3113.159446949311, 3122.98438507806, 3167.889123880653, 29911.70088299111, 30201.0, 30253.0, 30759.38481230385, 31377.52933705996, 3158.8262645554487, 3161.146490447566, 3196.121066706651, 3204.3911656785367, 3259.071164718068, 249667.0, 251094.0, 252848.0, 252918.0, 253079.73460132765, 33694.0, 35007.64992350044, 56563.0, 57112.0, 57121.428785712444, 36094.63905360965, 36301.455478167845, 36504.26991460156, 36546.451803222975, 36779.0, 14699.485518006819, 14750.852491475163, 14790.926045369704, 14804.481843135438, 14949.402023918921, 11242.437878106062, 11244.212905096565, 11250.831237531444, 11277.154213434025, 11339.546418143347, 8330.375221858385, 8349.624266908004, 8409.831803363899, 8466.957665211634, 8493.320534357237, 3291.7037466628117, 3303.884364047295, 3322.2691007978688, 3378.543896573931, 3428.4000299947907, 995.3679413572289, 1002.6914876086777, 1013.543905242629, 1029.8815636201932, 1072.624581396505, 29435.85282073576, 29747.256318592208, 29878.850605746833, 30175.698243017727, 30194.69805301919, 1001.3341128149699, 1115.0, 1126.1947707389256, 1185.407296351824, 1200.2138599217526, 15946.68106637884, 16009.919950400406, 16031.278592463366, 16181.919090404472, 16535.0, 368831.0, 369623.0, 370588.0, 370965.0, 372188.0, 54214.728926355114, 54518.72740636271, 54746.452535474935, 54879.451205487436, 54936.725316373166, 1223.2904915149193, 1269.904757143218, 1271.7774389481988, 1287.0668765145383, 1306.3272414706435, 28099.859500702365, 29090.418191636472, 29213.39326337072, 29593.26016849596, 29701.702982969895, 46399.76800115978, 46727.53272467232, 46954.53045469638, 46962.0, 46977.29534056924, 310974.0, 316081.0, 319913.0, 320525.0, 320909.0, 26653.60019599669, 26953.86523067372, 27057.0, 27187.1843844685, 27231.727682722918, 44287.778561106985, 45371.77314113409, 45628.315575267065, 46251.3062304059, 46397.0, 38033.0, 38088.0, 38949.8052509747, 38984.80507597444, 39923.40114898337, 37501.4374784373, 38537.229255414175, 38799.61200388073, 38874.0, 38908.41637375385, 37717.0, 38085.4287185698, 38120.61879381281, 38430.0, 38932.80533597314, 32928.0, 34991.475127872596, 35076.64923350734, 35200.471992919614, 35432.64567354293, 26536.601950971137, 26606.467870642868, 26745.86627066852, 26801.597976029985, 27144.72855271422], "value": 17311.33303824235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.1565537143022, 384.450236162288, 384.45215567815853, 393.53955871630194, 406.78846999560227, 15834.4457943972, 16423.01461912283, 17133.65732685347, 17173.484795456126, 17189.140542972833, 9541.570629321679, 10701.83947240792, 11173.944130279358, 11213.495392707327, 11647.708807279821, 4571.108633816407, 4613.700109492881, 4707.293905914106, 4750.667453278272, 4771.594414474756, 4733.290006499018, 4733.621310295168, 4747.525247475242, 4754.6434017448655, 4769.093872164295, 4582.381378513908, 4712.670113092085, 4729.196036673774, 4738.265568836819, 4739.028499157682, 4688.507706690816, 4701.858944231679, 4723.149833030053, 4730.763461826895, 4740.976295118519, 4471.3293006049025, 4584.243599806028, 4615.238485649864, 4628.3288923105965, 4644.535546445362, 20200.797992020038, 20759.481012974644, 21039.5792084159, 21052.789472105236, 21158.894205529028, 1846.8984205868671, 1927.267638297452, 2060.402483279847, 2064.6386882295687, 2068.503559145809, 9370.250379969655, 9385.671501497414, 9512.952435237848, 9539.809203815954, 9707.126358627758, 1804.359452394394, 1859.8419134373594, 1862.608852141052, 1865.4683415226596, 1871.840893524052, 61723.691381542805, 64222.67888660573, 65268.020979685345, 71911.0, 73768.63115684495, 10041.292980193384, 10359.430231337348, 10377.221708371751, 10708.143348532254, 10711.892881071246, 14649.560513184622, 14691.191984440744, 14746.04150730199, 14810.925945370203, 14886.330115144845, 6578.901316480256, 6767.593944363255, 7392.963035184897, 7843.137254901956, 7891.6054197289905, 6743.055972163901, 7252.818679533054, 7540.434467414966, 7557.3751643395835, 7714.228577142353, 4508.549145085531, 4515.0, 4550.522195169526, 4623.630109591225, 4661.3707149534375, 1889.7070954002152, 1924.5765931495048, 1939.5054261163596, 1945.7762357328804, 1976.8517361197967, 925.564984457304, 967.6274634265858, 993.5330394714473, 1025.374521541859, 1031.6131450705984, 16003.599910002344, 16168.029918204946, 16863.241154148094, 17017.744733829004, 17268.395606153725, 893.8480458322101, 931.7204838548408, 937.7139972308375, 959.2709540749081, 1036.9637062702768, 9537.332386733, 9560.808783824285, 9690.370125941932, 9733.610655573697, 9765.751897924425, 363374.0, 364981.0, 366129.0, 367129.0, 384285.0, 80158.0, 80307.19692803115, 81208.18791812124, 81732.0, 83150.58424707838, 955.245356168633, 961.9134277915022, 972.3436680240809, 977.5942983661843, 980.8626792249091, 14997.625059373602, 15198.0, 15211.391544338545, 15240.390384384944, 15527.689446210787, 35344.82327588346, 35487.82256088703, 36454.0, 36756.81621591875, 36996.81501592582, 38661.22677546489, 44124.33813492864, 44528.332075018254, 48207.0, 49722.25416618826, 7770.961145194238, 7776.766696998873, 7885.921140788748, 7903.802404939923, 8039.276465118168, 10989.670309890716, 11901.76196476083, 12062.095342849498, 12213.572524961584, 12281.815772763237, 10135.543900524346, 10703.19726020536, 10825.458727063458, 10876.564937402416, 10922.836157457803, 10688.519016644424, 10694.14446844235, 10727.946360268148, 10746.892531074902, 10831.079358254636, 10796.352218866894, 10970.341779493256, 10975.890241097486, 11193.384363860067, 11402.429878506207, 7761.7671469855995, 7913.208679132041, 8090.312323452573, 8203.220694034057, 8221.0, 9897.851532227167, 10385.948070259601, 10518.368897866152, 10639.0, 10732.839007415052], "value": 8151.399261556436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.3707061569446, 1545.6058705030218, 1750.6236159225764, 1843.8985855777926, 1871.4666320098775, 6813.931860681391, 7541.434392420563, 7555.395568354532, 8108.675652973881, 8115.26962573369, 7665.348445382136, 7878.133405325424, 7933.087694915086, 7947.523148611087, 7983.640736166872, 2208.149862303013, 2252.4368907773055, 2253.2339004738387, 2254.301166638339, 2254.695616091831, 2101.8843963582, 2160.1791319298645, 2167.2306331252416, 2172.3265787605815, 2174.325958952722, 2181.1275489804048, 2186.431527802767, 2199.186301068607, 2202.680611311359, 2203.1958335207696, 2155.2779818760655, 2163.3401812447196, 2167.1331467413, 2171.337741988693, 2171.69596256525, 2158.082814803702, 2168.533765240481, 2187.2344679362254, 2200.4938864061196, 2207.724034495688, 7802.063752349698, 7834.255745704149, 7852.450328477009, 7878.645460954213, 7892.4869883457395, 4719.646026548023, 4812.061647978646, 4832.154372984749, 4846.248831431134, 4858.489858564871, 2853.671827739816, 2993.565932939733, 3000.639923209229, 3001.7448516876093, 3011.6988301169927, 948.0, 950.8003319302954, 959.7216807125925, 999.3204620857814, 1010.4493051287067, 10595.576176952913, 10667.786644267071, 10673.466326683634, 10682.359058456517, 10757.0, 4302.247106756367, 4326.199653064194, 4397.329014974289, 4444.444444444444, 4458.910821783611, 9177.082291770903, 9186.0, 9193.172614464731, 9195.402298850688, 9210.631574736935, 4704.811807527661, 4761.333413322138, 4768.690035147704, 4814.494478079751, 4846.80612775485, 3819.2934307153264, 4256.638185754246, 4401.933970990438, 4411.360352748833, 4415.2935530315, 3607.152319204985, 3634.127809325743, 3680.3375392429084, 3762.4920635714375, 3774.8867533974026, 1196.5393323570313, 1263.1536870296923, 1266.2718936611302, 1276.5532063777603, 1284.383495921944, 866.332923648787, 868.3357231717741, 874.8469017921839, 882.4925667741074, 898.874157617934, 5028.421731500925, 5050.924236136461, 5067.391912970394, 5215.348081489814, 5285.68285902847, 900.1358695652248, 903.13299232736, 914.5884352041608, 930.7207837648814, 955.8757361542955, 3512.121969507623, 3536.0806190390686, 3537.663921927413, 3557.1462848916076, 3588.6949609282983, 9275.304352173614, 9626.759331016641, 9646.0, 9737.07497787709, 9770.169535589412, 9622.085901839315, 9665.806683866283, 9816.803663926681, 9822.116009559173, 9823.26325525574, 7167.641617919083, 7171.820704482429, 7232.566046037149, 7455.179930207672, 7553.433492488085, 5147.897042059063, 5150.4592017837585, 5194.948050519446, 5214.0354034502225, 5235.0, 8773.517456539952, 8824.867626985471, 8856.778580535538, 9016.774580635536, 9099.272058235192, 8952.14954579314, 8999.19007289347, 9035.819283614159, 9275.0, 9287.535623218677, 5549.334079910275, 6053.092036194606, 6225.159603453476, 6278.121063051085, 6359.618422894641, 7327.963360183165, 7350.926490735238, 7390.889136663062, 7391.889121663287, 7430.591317477591, 6493.772717954849, 6562.868742625216, 6590.670466476561, 6602.900956485752, 6605.273419923708, 6278.46633036197, 6424.13274207976, 6425.710843011982, 6448.806535803933, 6531.706073226811, 5863.413658634103, 5969.597144670912, 5971.0744834550715, 5976.342602313829, 5989.041753319448, 4234.301340278943, 4299.097189590096, 4304.16068866568, 4425.291953287458, 4433.024734558392, 4316.611504964569, 4394.1870753910625, 4419.602235798665, 4427.955720442883, 4463.642908567242], "value": 4169.728691207065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.3550988229071, 320.415242183016, 325.24705307213804, 327.9918002049947, 328.09377516628393, 4808.595702148926, 4880.389471474414, 4982.153033984222, 5010.524000219983, 5041.269015992679, 4894.143524883149, 4919.532644398785, 4941.308216849644, 4951.529604687549, 4952.281919121734, 3918.921621567567, 3925.2934471795065, 3932.3315036443732, 3934.488516492852, 3938.3304838177437, 3676.1544844685736, 3944.0, 3959.128991621853, 3971.7616942983514, 3981.402789581557, 3807.9619203807883, 3817.3701339278987, 3846.8653597124107, 3857.5756666766633, 3865.323568375537, 3855.961440385602, 3857.4792403025513, 3864.555576108727, 3874.8062596870186, 3884.3202439573242, 3348.280119774236, 3403.8298085095894, 3404.438267685829, 3404.5360494987144, 3411.300683359905, 4667.649926255544, 4732.337472753818, 4743.430788305391, 4761.6904901181315, 4765.475797662254, 4384.912301753979, 4398.692091553593, 4410.867673969754, 4415.536368681274, 4426.7122637028815, 5132.9743351283005, 5173.1722924331925, 5178.741062946838, 5208.453112423179, 5239.16173412256, 3598.892033239007, 3699.130704284491, 3699.352613292663, 3701.555813302394, 3713.628637136265, 5404.891902161935, 5408.296921400193, 5422.0, 5423.2136340230445, 5438.564914806806, 3775.5846856845724, 3785.734998550075, 3790.886273411747, 3794.506714127201, 3805.5052843130215, 3839.8080095995088, 3839.9232015359535, 3864.652181303696, 3867.6712479439, 3876.2441323942126, 4227.260229459832, 4358.346248062816, 4374.234508960919, 4378.824847006084, 4416.447944006999, 5134.8973020540125, 5162.845114646567, 5218.0, 5221.399539052982, 5231.9476805232225, 1249.775040492702, 1298.8571257161705, 1324.1723922548408, 1330.6939403936956, 1334.2261488336935, 842.5955541340192, 842.6208206307186, 847.8685803700437, 860.6514361683528, 879.9868001979976, 4010.498687664042, 4067.6745860331102, 4078.5105787305715, 4084.2852500812237, 4084.7957602119777, 4687.578117969331, 4703.905921881612, 4724.314974328703, 4726.858194254178, 4731.060265291214, 4053.493313335833, 4065.6137666921595, 4101.015756218486, 4135.441715368387, 4148.7303325284365, 2529.5446819572285, 2644.955242679131, 2875.511163102278, 2879.1650421377567, 2896.174590241771, 5042.168042273057, 5064.721440320818, 5066.46802085783, 5067.797288108434, 5093.0, 5345.33183352081, 5517.2551705520045, 5527.585431092684, 5556.305461817273, 5563.610547261734, 4975.776090075955, 4995.25071239317, 4998.250262460515, 5017.8243761468175, 5021.748912554431, 5346.304980352529, 5363.302770639948, 5386.757595908115, 5388.757505912322, 5404.702741349263, 5076.670016448919, 5221.608379371638, 5271.288376069181, 5287.75270510024, 5306.495882891119, 5013.222950442687, 5013.774380152829, 5026.271190677405, 5033.219850923113, 5042.9243561345875, 3794.146317078635, 3795.0132965428634, 3822.3119838429348, 3822.8279727411777, 3837.788921609338, 5183.5593974512585, 5314.8937021260135, 5333.679979201261, 5364.892702145858, 5374.946250537445, 5118.513741194581, 5120.411152717336, 5122.641415100908, 5145.279660847559, 5224.615476898549, 5098.694078355311, 5150.433452320317, 5155.922661160011, 5170.482951704799, 5219.895602087861, 4913.72243216759, 4998.925016124688, 5093.821716239914, 5099.719515426687, 5209.968112436077, 5222.582193424593, 5229.660072095302, 5260.237265596544, 5280.785419353493, 5360.865978350573, 5133.717645529382, 5153.149730294459, 5200.6879587224885, 5216.582673386196, 5220.738963051756], "value": 3878.693059761982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.4462480826978, 738.0368618952268, 752.1643404365542, 758.757197696737, 773.1186447449904, 10047.14599259063, 12173.573924912629, 12441.315727634976, 12499.437525311349, 12508.186967847083, 11132.666020019393, 11229.270097443681, 11294.09647228222, 11446.542138314479, 11525.250858694179, 677.6442367756943, 847.1443841719846, 864.7103220421167, 882.9558522073903, 883.5052370672412, 871.1897934920521, 872.5637181409295, 874.3573473497006, 874.6719980007497, 874.8862647855769, 892.3485855325616, 892.9017808041143, 900.3832374823266, 901.292485398962, 901.2969883490888, 890.381185076369, 891.3715830339628, 894.6466145872344, 894.9105089491064, 898.5148020069155, 664.2261765043718, 664.7241394821192, 664.9534532582721, 665.527475492401, 665.9800205993828, 13112.606621801362, 13128.2123072615, 13132.737345253137, 13150.408231629599, 13150.934245328808, 10909.618163364323, 10950.178736594788, 10969.616063437821, 11030.117590592734, 11451.599194028253, 8884.422512536728, 8985.0, 9109.089091090904, 9132.634694612274, 9346.065393460667, 3342.565466489365, 3393.0669066007044, 3393.134750638596, 3421.298633780094, 3442.6041005284465, 45725.54274457246, 46384.7680761594, 46395.30407043897, 46442.53557464416, 47698.5230147701, 10247.7438064049, 10450.529726162189, 10568.841467377995, 10639.627613033661, 10645.254832161829, 16645.583860403345, 17106.65786684284, 17143.142842857807, 17348.739768903477, 17572.29710811579, 6889.965550172317, 6912.861742765116, 6987.301269873074, 7044.929550704427, 7057.92942070583, 3496.7202623790035, 3553.8400771964807, 3571.339302229044, 3576.8211589420944, 3608.693261072786, 2888.9855550722114, 2938.3241854373186, 2950.8377039263046, 2955.674875763664, 2976.627921509811, 520.1132069820947, 520.3495630461923, 522.0733198572564, 533.8531903726506, 535.9249705041298, 547.8493414311017, 589.5813972079872, 596.4155127974609, 604.1360853978853, 606.9635821850703, 7383.889241661379, 7431.2197219292275, 7637.045369328834, 7714.5756983366455, 7777.300042996158, 477.3508029080448, 522.3261992030239, 578.5805291163872, 586.5659412035149, 587.2014060877203, 3737.140457694691, 3760.8871733848027, 3761.134938963999, 3817.2365526894732, 3879.0302424393903, 51505.48494515007, 51713.09462737293, 52071.73964130155, 52654.0, 52670.946581068165, 44981.775091124335, 46401.535984640395, 46669.29996050062, 46685.29972050422, 47299.0, 43579.0, 43617.90955226081, 43631.12737745227, 43985.56014439878, 44260.77869610631, 6961.6171110587375, 7004.498347292374, 7016.0, 7029.121359830021, 7169.139703235645, 28424.57363139513, 28432.445944256968, 28973.275668108465, 29549.0, 29668.25829354197, 37488.0, 38041.239175215786, 38775.22449550937, 38781.80609096937, 38875.80562097171, 8935.776605584912, 9158.40470369424, 9181.449113053239, 9222.354435189472, 9251.444913305224, 10083.495825208563, 10320.741981450525, 10398.116160126474, 10402.947985260025, 10495.895041049796, 9261.72214833556, 9359.554627972564, 9370.39092458988, 9389.10803473669, 9543.236541076836, 9678.854817177607, 9788.99173882768, 9885.406875587487, 10139.594416223268, 10181.694549163536, 9796.559154837907, 9847.083855316283, 9862.457564834003, 9959.302848800804, 9997.500124993867, 8477.618507167315, 8555.187257210555, 8665.090165532529, 8719.738407847775, 8950.14973577509, 8764.561771911507, 9026.90973090287, 9051.185393314634, 9083.500407477652, 9165.816683666422], "value": 5800.166007959772, "unit": "score"}], "name": "dromaeo_css", "value": 6302.334794725789, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 105.0, 115.0, 114.0, 116.0, 107.0, 115.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 162.0, 214.0, 131.0, 173.0, 178.0, 133.0, 197.0, 132.0], "value": 161.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 169.0, 169.0, 163.0, 161.0, 162.0, 164.0, 160.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 161.0, 78.0, 79.0, 77.0, 77.0, 172.0, 76.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 183.0, 93.0, 94.0, 94.0, 135.0, 93.0, 93.0, 149.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 77.0, 66.0, 66.0, 69.0, 67.0, 66.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 63.0, 64.0, 66.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 84.0, 84.0, 84.0, 86.0, 91.0, 144.0, 91.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 135.0, 133.0, 140.0, 132.0, 140.0, 143.0, 155.0, 136.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 182.0, 179.0, 182.0, 181.0, 186.0, 180.0, 180.0, 177.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 72.0, 69.0, 68.0, 68.0, 70.0, 68.0, 69.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1619.0, "alertThreshold": 2.0}]} 05:01:51 INFO - Return code: 0 05:01:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:01:51 ERROR - # TBPL SUCCESS # 05:01:51 INFO - Running post-action listener: _resource_record_post_action 05:01:51 INFO - ##### 05:01:51 INFO - ##### Finished run-tests step (success) 05:01:51 INFO - ##### 05:01:51 INFO - Running post-run listener: _resource_record_post_run 05:01:52 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 530231296; Read time: 0; Write time: 460968 05:01:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234856448; Read time: 0; Write time: 223104 05:01:52 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 295374848; Read time: 0; Write time: 237864 05:01:52 INFO - Running post-run listener: _upload_blobber_files 05:01:52 INFO - Blob upload gear active. 05:01:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:01:52 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 05:01:52 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'] 05:01:52 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 05:01:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:01:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:01:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:53 INFO - (blobuploader) - INFO - Done attempting. 05:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:54 INFO - (blobuploader) - INFO - Done attempting. 05:01:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:01:54 INFO - Return code: 0 05:01:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:01:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:01:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c54b309983176ab64fb4a7e76e5307ececc7a95e62adb80e450b0f85a286b517e9e0bfa8214e17081d690567fe3641ee5381c794d5593a940ace2c42eaa2df4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd283ff54da58a5746cab88cc18ae7173409a34bb06135b46e612a39f5694c9f6db9859c5336205fd6bb5276622cca40ee136e605c631664d97a32c9b14197c8"} 05:01:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:01:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:01:54 INFO - Contents: 05:01:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c54b309983176ab64fb4a7e76e5307ececc7a95e62adb80e450b0f85a286b517e9e0bfa8214e17081d690567fe3641ee5381c794d5593a940ace2c42eaa2df4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd283ff54da58a5746cab88cc18ae7173409a34bb06135b46e612a39f5694c9f6db9859c5336205fd6bb5276622cca40ee136e605c631664d97a32c9b14197c8"} 05:01:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:01:54 INFO - Copying logs to upload dir... 05:01:54 INFO - mkdir: /builds/slave/test/build/upload/logs 05:01:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.212658 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-10 05:01:54.261575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:01:54.264921) ========= 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-1462880476.860697-1553045626 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/7c54b309983176ab64fb4a7e76e5307ececc7a95e62adb80e450b0f85a286b517e9e0bfa8214e17081d690567fe3641ee5381c794d5593a940ace2c42eaa2df4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd283ff54da58a5746cab88cc18ae7173409a34bb06135b46e612a39f5694c9f6db9859c5336205fd6bb5276622cca40ee136e605c631664d97a32c9b14197c8"} build_url:https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/Ij_2TJ77QLenFrJJZ321dQ/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/7c54b309983176ab64fb4a7e76e5307ececc7a95e62adb80e450b0f85a286b517e9e0bfa8214e17081d690567fe3641ee5381c794d5593a940ace2c42eaa2df4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd283ff54da58a5746cab88cc18ae7173409a34bb06135b46e612a39f5694c9f6db9859c5336205fd6bb5276622cca40ee136e605c631664d97a32c9b14197c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:01:54.294458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:01:54.295166) ========= 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-1462880476.860697-1553045626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:01:54.376832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:01:54.377443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:01:54.378027) ========= ========= Total master_lag: 0.21 =========