builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1462542054.4 results: success (0) buildid: 20160506051915 builduid: fd1c65a77cf646e2ae6756664448229d revision: 19a1743ceb2e035e571012e88d25275ce627b925 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.402978) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.403414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.403704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.547271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.547896) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 06:40:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-05-06 06:40:54 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161271 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.745422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.745758) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052727 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.809523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:54.809889) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19a1743ceb2e035e571012e88d25275ce627b925 --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 19a1743ceb2e035e571012e88d25275ce627b925 --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=20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 06:40:54,831 truncating revision to first 12 chars 2016-05-06 06:40:54,831 Setting DEBUG logging. 2016-05-06 06:40:54,831 attempt 1/10 2016-05-06 06:40:54,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19a1743ceb2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 06:40:55,336 unpacking tar archive at: mozilla-central-19a1743ceb2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:55.656837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:55.657275) ========= script_repo_revision: 19a1743ceb2e035e571012e88d25275ce627b925 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:55.657715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:55.657986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 06:40:55.672368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-06 06:40:55.672784) ========= /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=20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:40:55 INFO - MultiFileLogger online at 20160506 06:40:55 in /builds/slave/test 06:40:55 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 06:40:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:40:55 INFO - {'append_to_log': False, 06:40:55 INFO - 'base_work_dir': '/builds/slave/test', 06:40:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:40:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:40:55 INFO - 'branch': 'Firefox-Non-PGO', 06:40:55 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:55 INFO - 'config_files': ('talos/linux_config.py',), 06:40:55 INFO - 'default_actions': ('clobber', 06:40:55 INFO - 'read-buildbot-config', 06:40:55 INFO - 'download-and-extract', 06:40:55 INFO - 'populate-webroot', 06:40:55 INFO - 'create-virtualenv', 06:40:55 INFO - 'install', 06:40:55 INFO - 'run-tests'), 06:40:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:55 INFO - 'download_minidump_stackwalk': True, 06:40:55 INFO - 'download_symbols': 'ondemand', 06:40:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:55 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:55 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:55 INFO - 'installer_path': 'installer.exe', 06:40:55 INFO - 'log_level': 'info', 06:40:55 INFO - 'log_name': 'talos', 06:40:55 INFO - 'log_to_console': True, 06:40:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:40:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:40:55 INFO - 'opt_config_files': (), 06:40:55 INFO - 'pip_index': False, 06:40:55 INFO - 'sps_profile': False, 06:40:55 INFO - 'sps_profile_interval': 0, 06:40:55 INFO - 'suite': 'dromaeojs-e10s', 06:40:55 INFO - 'system_bits': '32', 06:40:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:55 INFO - 'title': 'talos-linux64-ix-015', 06:40:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:55 INFO - 'use_talos_json': True, 06:40:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:40:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:55 INFO - 'work_dir': 'build'} 06:40:55 INFO - ##### 06:40:55 INFO - ##### Running clobber step. 06:40:55 INFO - ##### 06:40:55 INFO - Running pre-action listener: _resource_record_pre_action 06:40:55 INFO - Running main action method: clobber 06:40:55 INFO - rmtree: /builds/slave/test/build 06:40:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:00 INFO - Running post-action listener: _resource_record_post_action 06:41:00 INFO - ##### 06:41:00 INFO - ##### Finished clobber step (success) 06:41:00 INFO - ##### 06:41:00 INFO - ##### 06:41:00 INFO - ##### Running read-buildbot-config step. 06:41:00 INFO - ##### 06:41:00 INFO - Running pre-action listener: _resource_record_pre_action 06:41:00 INFO - Running main action method: read_buildbot_config 06:41:00 INFO - Using buildbot properties: 06:41:00 INFO - { 06:41:00 INFO - "project": "", 06:41:00 INFO - "product": "firefox", 06:41:00 INFO - "script_repo_revision": "production", 06:41:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:41:00 INFO - "repository": "", 06:41:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:41:00 INFO - "buildid": "20160506051915", 06:41:00 INFO - "pgo_build": "False", 06:41:00 INFO - "basedir": "/builds/slave/test", 06:41:00 INFO - "buildnumber": 346, 06:41:00 INFO - "slavename": "talos-linux64-ix-015", 06:41:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:41:00 INFO - "platform": "ubuntu64_hw", 06:41:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:41:00 INFO - "branch": "mozilla-central", 06:41:00 INFO - "repo_path": "mozilla-central", 06:41:00 INFO - "revision": "19a1743ceb2e035e571012e88d25275ce627b925", 06:41:00 INFO - "stage_platform": "linux64", 06:41:00 INFO - "builduid": "fd1c65a77cf646e2ae6756664448229d", 06:41:00 INFO - "slavebuilddir": "test" 06:41:00 INFO - } 06:41:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:41:00 INFO - Running post-action listener: _resource_record_post_action 06:41:00 INFO - ##### 06:41:00 INFO - ##### Finished read-buildbot-config step (success) 06:41:00 INFO - ##### 06:41:00 INFO - ##### 06:41:00 INFO - ##### Running download-and-extract step. 06:41:00 INFO - ##### 06:41:00 INFO - Running pre-action listener: _resource_record_pre_action 06:41:00 INFO - Running main action method: download_and_extract 06:41:00 INFO - mkdir: /builds/slave/test/build/tests 06:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:00 INFO - https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:00 INFO - Downloaded 1361 bytes. 06:41:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:41:00 INFO - Using the following test package requirements: 06:41:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:41:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:41:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:41:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'jsshell-linux-x86_64.zip'], 06:41:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:41:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:41:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:41:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:41:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:41:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:41:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:41:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:00 INFO - https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:01 INFO - Downloaded 22321073 bytes. 06:41:01 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'] 06:41:01 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 06:41:03 INFO - Return code: 0 06:41:03 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 06:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:03 INFO - https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:41:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:41:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:05 INFO - Downloaded 22321073 bytes. 06:41:05 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'] 06:41:05 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 06:41:06 INFO - Return code: 0 06:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:06 INFO - https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:41:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:41:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:08 INFO - Downloaded 10840152 bytes. 06:41:08 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'] 06:41:08 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 06:41:09 INFO - Return code: 0 06:41: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')]} 06:41:09 INFO - https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:41:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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 06:41:10 INFO - Downloaded 54836096 bytes. 06:41:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:10 INFO - mkdir: /builds/slave/test/properties 06:41:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:41:10 INFO - Writing to file /builds/slave/test/properties/build_url 06:41:10 INFO - Contents: 06:41:10 INFO - build_url:https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:41:11 INFO - Running post-action listener: _resource_record_post_action 06:41:11 INFO - Running post-action listener: set_extra_try_arguments 06:41:11 INFO - ##### 06:41:11 INFO - ##### Finished download-and-extract step (success) 06:41:11 INFO - ##### 06:41:11 INFO - ##### 06:41:11 INFO - ##### Running populate-webroot step. 06:41:11 INFO - ##### 06:41:11 INFO - Running pre-action listener: _resource_record_pre_action 06:41:11 INFO - Running main action method: populate_webroot 06:41:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:41:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:41:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:41:11 INFO - '--tppagecycles', 06:41:11 INFO - '7'], 06:41:11 INFO - 'tests': ['tsvgm']}}, 06:41:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:41:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:41:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:41:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:41:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['damp', 'tps']}, 06:41:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'tests': ['damp', 'tps']}, 06:41:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['dromaeo_dom']}, 06:41:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['a11yr', 06:41:11 INFO - 'ts_paint', 06:41:11 INFO - 'tpaint', 06:41:11 INFO - 'sessionrestore', 06:41:11 INFO - 'sessionrestore_no_auto_restore', 06:41:11 INFO - 'tabpaint']}, 06:41:11 INFO - 'other-e10s': {'tests': ['a11yr', 06:41:11 INFO - 'ts_paint', 06:41:11 INFO - 'tpaint', 06:41:11 INFO - 'sessionrestore', 06:41:11 INFO - 'sessionrestore_no_auto_restore', 06:41:11 INFO - 'tabpaint']}, 06:41:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:41:11 INFO - 'ts_paint', 06:41:11 INFO - 'tpaint', 06:41:11 INFO - 'sessionrestore', 06:41:11 INFO - 'sessionrestore_no_auto_restore', 06:41:11 INFO - 'tabpaint']}, 06:41:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:41:11 INFO - 'ts_paint', 06:41:11 INFO - 'tpaint', 06:41:11 INFO - 'sessionrestore', 06:41:11 INFO - 'sessionrestore_no_auto_restore', 06:41:11 INFO - 'tabpaint']}, 06:41:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['a11yr', 06:41:11 INFO - 'ts_paint', 06:41:11 INFO - 'tpaint', 06:41:11 INFO - 'sessionrestore', 06:41:11 INFO - 'sessionrestore_no_auto_restore', 06:41:11 INFO - 'tabpaint']}, 06:41:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['a11yr', 06:41:11 INFO - 'ts_paint', 06:41:11 INFO - 'tpaint', 06:41:11 INFO - 'sessionrestore', 06:41:11 INFO - 'sessionrestore_no_auto_restore', 06:41:11 INFO - 'tabpaint']}, 06:41:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['tsvgx', 06:41:11 INFO - 'tsvgr_opacity', 06:41:11 INFO - 'tart', 06:41:11 INFO - 'tscrollx', 06:41:11 INFO - 'cart']}, 06:41:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:41:11 INFO - 'tsvgr_opacity', 06:41:11 INFO - 'tart', 06:41:11 INFO - 'tscrollx', 06:41:11 INFO - 'cart']}, 06:41:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'talos_options': ['--disable-e10s'], 06:41:11 INFO - 'tests': ['tp5o']}, 06:41:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'tests': ['tp5o']}, 06:41:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'talos_options': ['--disable-e10s', 06:41:11 INFO - '--xperf_path', 06:41:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:11 INFO - 'tests': ['tp5n']}, 06:41:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:11 INFO - 'talos_options': ['--xperf_path', 06:41:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:11 INFO - 'tests': ['tp5n']}}, 06:41:11 INFO - 'talos.zip': {'path': '', 06:41:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:11 INFO - Running post-action listener: _resource_record_post_action 06:41:11 INFO - ##### 06:41:11 INFO - ##### Finished populate-webroot step (success) 06:41:11 INFO - ##### 06:41:11 INFO - ##### 06:41:11 INFO - ##### Running create-virtualenv step. 06:41:11 INFO - ##### 06:41:11 INFO - Running pre-action listener: _resource_record_pre_action 06:41:11 INFO - Running main action method: create_virtualenv 06:41:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:41:11 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 06:41:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:41:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:11 INFO - Using real prefix '/usr' 06:41:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:41:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:14 INFO - Installing pip.................done. 06:41:14 INFO - Return code: 0 06:41:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:41:14 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')]} 06:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:14 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')]} 06:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:14 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:14 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 06:41:14 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 06:41:14 INFO - Using env: {'DISPLAY': ':0', 06:41:14 INFO - 'HOME': '/home/cltbld', 06:41:14 INFO - 'LANG': 'en_US.UTF-8', 06:41:14 INFO - 'LANGUAGE': 'en_US:en', 06:41:14 INFO - 'LOGNAME': 'cltbld', 06:41:14 INFO - 'MAIL': '/var/mail/cltbld', 06:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:14 INFO - 'MOZ_NO_REMOTE': '1', 06:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:14 INFO - 'NO_EM_RESTART': '1', 06:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:14 INFO - 'PWD': '/builds/slave/test', 06:41:14 INFO - 'SHELL': '/bin/bash', 06:41:14 INFO - 'SHLVL': '1', 06:41:14 INFO - 'TERM': 'linux', 06:41:14 INFO - 'TMOUT': '86400', 06:41:14 INFO - 'USER': 'cltbld', 06:41:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:14 INFO - '_': '/tools/buildbot/bin/python'} 06:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:14 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 06:41:14 INFO - Cleaning up... 06:41:14 INFO - Return code: 0 06:41:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:41:14 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')]} 06:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:14 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')]} 06:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:14 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:14 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 06:41:14 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 06:41:14 INFO - Using env: {'DISPLAY': ':0', 06:41:14 INFO - 'HOME': '/home/cltbld', 06:41:14 INFO - 'LANG': 'en_US.UTF-8', 06:41:14 INFO - 'LANGUAGE': 'en_US:en', 06:41:14 INFO - 'LOGNAME': 'cltbld', 06:41:14 INFO - 'MAIL': '/var/mail/cltbld', 06:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:14 INFO - 'MOZ_NO_REMOTE': '1', 06:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:14 INFO - 'NO_EM_RESTART': '1', 06:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:14 INFO - 'PWD': '/builds/slave/test', 06:41:14 INFO - 'SHELL': '/bin/bash', 06:41:14 INFO - 'SHLVL': '1', 06:41:14 INFO - 'TERM': 'linux', 06:41:14 INFO - 'TMOUT': '86400', 06:41:14 INFO - 'USER': 'cltbld', 06:41:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:14 INFO - '_': '/tools/buildbot/bin/python'} 06:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:14 INFO - Downloading/unpacking psutil>=0.7.1 06:41:14 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 06:41:14 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 06:41:14 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 06:41:14 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 06:41:14 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 06:41:14 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 06:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:41:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:16 INFO - Installing collected packages: psutil 06:41:16 INFO - Running setup.py install for psutil 06:41:16 INFO - building 'psutil._psutil_linux' extension 06:41:16 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 06:41:17 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 06:41:18 INFO - building 'psutil._psutil_posix' extension 06:41:18 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 06:41:18 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 06:41:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:18 INFO - Successfully installed psutil 06:41:18 INFO - Cleaning up... 06:41:18 INFO - Return code: 0 06:41:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:18 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:18 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 06:41:18 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 06:41:18 INFO - Using env: {'DISPLAY': ':0', 06:41:18 INFO - 'HOME': '/home/cltbld', 06:41:18 INFO - 'LANG': 'en_US.UTF-8', 06:41:18 INFO - 'LANGUAGE': 'en_US:en', 06:41:18 INFO - 'LOGNAME': 'cltbld', 06:41:18 INFO - 'MAIL': '/var/mail/cltbld', 06:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:18 INFO - 'MOZ_NO_REMOTE': '1', 06:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:18 INFO - 'NO_EM_RESTART': '1', 06:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:18 INFO - 'PWD': '/builds/slave/test', 06:41:18 INFO - 'SHELL': '/bin/bash', 06:41:18 INFO - 'SHLVL': '1', 06:41:18 INFO - 'TERM': 'linux', 06:41:18 INFO - 'TMOUT': '86400', 06:41:18 INFO - 'USER': 'cltbld', 06:41:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:18 INFO - '_': '/tools/buildbot/bin/python'} 06:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:41:20 INFO - Installing collected packages: mozsystemmonitor 06:41:20 INFO - Running setup.py install for mozsystemmonitor 06:41:20 INFO - Successfully installed mozsystemmonitor 06:41:20 INFO - Cleaning up... 06:41:20 INFO - Return code: 0 06:41:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:20 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:20 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 06:41:20 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 06:41:20 INFO - Using env: {'DISPLAY': ':0', 06:41:20 INFO - 'HOME': '/home/cltbld', 06:41:20 INFO - 'LANG': 'en_US.UTF-8', 06:41:20 INFO - 'LANGUAGE': 'en_US:en', 06:41:20 INFO - 'LOGNAME': 'cltbld', 06:41:20 INFO - 'MAIL': '/var/mail/cltbld', 06:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:20 INFO - 'MOZ_NO_REMOTE': '1', 06:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:20 INFO - 'NO_EM_RESTART': '1', 06:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:20 INFO - 'PWD': '/builds/slave/test', 06:41:20 INFO - 'SHELL': '/bin/bash', 06:41:20 INFO - 'SHLVL': '1', 06:41:20 INFO - 'TERM': 'linux', 06:41:20 INFO - 'TMOUT': '86400', 06:41:20 INFO - 'USER': 'cltbld', 06:41:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:20 INFO - '_': '/tools/buildbot/bin/python'} 06:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:20 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 06:41:20 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 06:41:20 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 06:41:20 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 06:41:20 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 06:41:20 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 06:41:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:41:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 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 06:41:23 INFO - Downloading docopt-0.6.1.tar.gz 06:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:23 INFO - Running setup.py install for blobuploader 06:41:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:41:23 INFO - Running setup.py install for requests 06:41:23 INFO - Running setup.py install for docopt 06:41:24 INFO - Successfully installed blobuploader requests docopt 06:41:24 INFO - Cleaning up... 06:41:24 INFO - Return code: 0 06:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:24 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')]} 06:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:24 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')]} 06:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:24 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:24 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 06:41:24 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 06:41:24 INFO - Using env: {'DISPLAY': ':0', 06:41:24 INFO - 'HOME': '/home/cltbld', 06:41:24 INFO - 'LANG': 'en_US.UTF-8', 06:41:24 INFO - 'LANGUAGE': 'en_US:en', 06:41:24 INFO - 'LOGNAME': 'cltbld', 06:41:24 INFO - 'MAIL': '/var/mail/cltbld', 06:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:24 INFO - 'MOZ_NO_REMOTE': '1', 06:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:24 INFO - 'NO_EM_RESTART': '1', 06:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:24 INFO - 'PWD': '/builds/slave/test', 06:41:24 INFO - 'SHELL': '/bin/bash', 06:41:24 INFO - 'SHLVL': '1', 06:41:24 INFO - 'TERM': 'linux', 06:41:24 INFO - 'TMOUT': '86400', 06:41:24 INFO - 'USER': 'cltbld', 06:41:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:24 INFO - '_': '/tools/buildbot/bin/python'} 06:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:24 INFO - Running setup.py (path:/tmp/pip-M7LwV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:24 INFO - Running setup.py (path:/tmp/pip-6Utqif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:24 INFO - Running setup.py (path:/tmp/pip-EioZ3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:24 INFO - Running setup.py (path:/tmp/pip-i4F719-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:24 INFO - Running setup.py (path:/tmp/pip-kG4bMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:24 INFO - Running setup.py (path:/tmp/pip-yscx1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:24 INFO - Running setup.py (path:/tmp/pip-yoka83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:24 INFO - Running setup.py (path:/tmp/pip-vSHfLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:24 INFO - Running setup.py (path:/tmp/pip-7IWSnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:24 INFO - Running setup.py (path:/tmp/pip-BiVUGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:25 INFO - Running setup.py (path:/tmp/pip-WDmGVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:25 INFO - Running setup.py (path:/tmp/pip-3UmM0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:25 INFO - Running setup.py (path:/tmp/pip-3sqK1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:25 INFO - Running setup.py (path:/tmp/pip-oqNZIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:25 INFO - Running setup.py (path:/tmp/pip-c_qwZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:25 INFO - Running setup.py (path:/tmp/pip-FF5JtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:25 INFO - Running setup.py (path:/tmp/pip-84zl1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:25 INFO - Running setup.py install for manifestparser 06:41:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:25 INFO - Running setup.py install for mozcrash 06:41:25 INFO - Running setup.py install for mozdebug 06:41:25 INFO - Running setup.py install for mozdevice 06:41:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:41:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:25 INFO - Running setup.py install for mozfile 06:41:26 INFO - Running setup.py install for mozhttpd 06:41:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozinfo 06:41:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozInstall 06:41:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozleak 06:41:26 INFO - Running setup.py install for mozlog 06:41:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for moznetwork 06:41:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozprocess 06:41:26 INFO - Running setup.py install for mozprofile 06:41:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozrunner 06:41:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:26 INFO - Running setup.py install for mozscreenshot 06:41:27 INFO - Running setup.py install for moztest 06:41:27 INFO - Running setup.py install for mozversion 06:41:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:27 INFO - Cleaning up... 06:41:27 INFO - Return code: 0 06:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06: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')]} 06:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:27 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:27 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 06:41:27 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 06:41:27 INFO - Using env: {'DISPLAY': ':0', 06:41:27 INFO - 'HOME': '/home/cltbld', 06:41:27 INFO - 'LANG': 'en_US.UTF-8', 06:41:27 INFO - 'LANGUAGE': 'en_US:en', 06:41:27 INFO - 'LOGNAME': 'cltbld', 06:41:27 INFO - 'MAIL': '/var/mail/cltbld', 06:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:27 INFO - 'MOZ_NO_REMOTE': '1', 06:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:27 INFO - 'NO_EM_RESTART': '1', 06:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:27 INFO - 'PWD': '/builds/slave/test', 06:41:27 INFO - 'SHELL': '/bin/bash', 06:41:27 INFO - 'SHLVL': '1', 06:41:27 INFO - 'TERM': 'linux', 06:41:27 INFO - 'TMOUT': '86400', 06:41:27 INFO - 'USER': 'cltbld', 06:41:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:27 INFO - '_': '/tools/buildbot/bin/python'} 06:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:27 INFO - Running setup.py (path:/tmp/pip-bxh5mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:27 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)) 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:27 INFO - Running setup.py (path:/tmp/pip-6PI3Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:27 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)) 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:27 INFO - Running setup.py (path:/tmp/pip-aH__4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:27 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)) 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:27 INFO - Running setup.py (path:/tmp/pip-3dl7DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:27 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)) 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:27 INFO - Running setup.py (path:/tmp/pip-0zjbSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:27 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)) 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:27 INFO - Running setup.py (path:/tmp/pip-R_ATwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:27 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)) 06:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:27 INFO - Running setup.py (path:/tmp/pip-no7VnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:28 INFO - Running setup.py (path:/tmp/pip-JLQ19_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:28 INFO - Running setup.py (path:/tmp/pip-YWYFz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:28 INFO - Running setup.py (path:/tmp/pip-9g4LFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:28 INFO - Running setup.py (path:/tmp/pip-sSqbq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:28 INFO - Running setup.py (path:/tmp/pip-geZFFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:28 INFO - Running setup.py (path:/tmp/pip-xjsMHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:28 INFO - Running setup.py (path:/tmp/pip-aw4elZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:28 INFO - Running setup.py (path:/tmp/pip-o29piZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:28 INFO - Running setup.py (path:/tmp/pip-yK7sE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:28 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)) 06:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:28 INFO - Running setup.py (path:/tmp/pip-xTsF3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:28 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)) 06:41:28 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)) 06:41:28 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)) 06:41:28 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)) 06:41:28 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)) 06:41:28 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)) 06:41:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:28 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 06:41:30 INFO - Downloading blessings-1.6.tar.gz 06:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:30 INFO - Installing collected packages: blessings 06:41:30 INFO - Running setup.py install for blessings 06:41:30 INFO - Successfully installed blessings 06:41:30 INFO - Cleaning up... 06:41:30 INFO - Return code: 0 06:41:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:31 INFO - Reading from file tmpfile_stdout 06:41:31 INFO - Current package versions: 06:41:31 INFO - argparse == 1.2.1 06:41:31 INFO - blessings == 1.6 06:41:31 INFO - blobuploader == 1.2.4 06:41:31 INFO - docopt == 0.6.1 06:41:31 INFO - manifestparser == 1.1 06:41:31 INFO - mozInstall == 1.12 06:41:31 INFO - mozcrash == 0.17 06:41:31 INFO - mozdebug == 0.1 06:41:31 INFO - mozdevice == 0.48 06:41:31 INFO - mozfile == 1.2 06:41:31 INFO - mozhttpd == 0.7 06:41:31 INFO - mozinfo == 0.9 06:41:31 INFO - mozleak == 0.1 06:41:31 INFO - mozlog == 3.1 06:41:31 INFO - moznetwork == 0.27 06:41:31 INFO - mozprocess == 0.22 06:41:31 INFO - mozprofile == 0.28 06:41:31 INFO - mozrunner == 6.11 06:41:31 INFO - mozscreenshot == 0.1 06:41:31 INFO - mozsystemmonitor == 0.0 06:41:31 INFO - moztest == 0.7 06:41:31 INFO - mozversion == 1.4 06:41:31 INFO - psutil == 3.1.1 06:41:31 INFO - requests == 1.2.3 06:41:31 INFO - wsgiref == 0.1.2 06:41:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:31 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:31 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 06:41:31 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 06:41:31 INFO - Using env: {'DISPLAY': ':0', 06:41:31 INFO - 'HOME': '/home/cltbld', 06:41:31 INFO - 'LANG': 'en_US.UTF-8', 06:41:31 INFO - 'LANGUAGE': 'en_US:en', 06:41:31 INFO - 'LOGNAME': 'cltbld', 06:41:31 INFO - 'MAIL': '/var/mail/cltbld', 06:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:31 INFO - 'MOZ_NO_REMOTE': '1', 06:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:31 INFO - 'NO_EM_RESTART': '1', 06:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:31 INFO - 'PWD': '/builds/slave/test', 06:41:31 INFO - 'SHELL': '/bin/bash', 06:41:31 INFO - 'SHLVL': '1', 06:41:31 INFO - 'TERM': 'linux', 06:41:31 INFO - 'TMOUT': '86400', 06:41:31 INFO - 'USER': 'cltbld', 06:41:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:31 INFO - '_': '/tools/buildbot/bin/python'} 06:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 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)) 06:41:31 INFO - Cleaning up... 06:41:31 INFO - Return code: 0 06:41:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:41:31 INFO - Using env: {'DISPLAY': ':0', 06:41:31 INFO - 'HOME': '/home/cltbld', 06:41:31 INFO - 'LANG': 'en_US.UTF-8', 06:41:31 INFO - 'LANGUAGE': 'en_US:en', 06:41:31 INFO - 'LOGNAME': 'cltbld', 06:41:31 INFO - 'MAIL': '/var/mail/cltbld', 06:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:31 INFO - 'MOZ_NO_REMOTE': '1', 06:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:31 INFO - 'NO_EM_RESTART': '1', 06:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:31 INFO - 'PWD': '/builds/slave/test', 06:41:31 INFO - 'SHELL': '/bin/bash', 06:41:31 INFO - 'SHLVL': '1', 06:41:31 INFO - 'TERM': 'linux', 06:41:31 INFO - 'TMOUT': '86400', 06:41:31 INFO - 'USER': 'cltbld', 06:41:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:31 INFO - '_': '/tools/buildbot/bin/python'} 06:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:31 INFO - Downloading/unpacking jsonschema 06:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:33 INFO - Downloading/unpacking functools32 (from jsonschema) 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:33 INFO - warning: no files found matching '*.txt' 06:41:33 INFO - no previously-included directories found matching 'build' 06:41:33 INFO - no previously-included directories found matching 'dist' 06:41:33 INFO - no previously-included directories found matching '.git*' 06:41:33 INFO - Installing collected packages: jsonschema, functools32 06:41:33 INFO - Running setup.py install for functools32 06:41:33 INFO - warning: no files found matching '*.txt' 06:41:33 INFO - no previously-included directories found matching 'build' 06:41:33 INFO - no previously-included directories found matching 'dist' 06:41:33 INFO - no previously-included directories found matching '.git*' 06:41:33 INFO - Successfully installed jsonschema functools32 06:41:33 INFO - Cleaning up... 06:41:33 INFO - Return code: 0 06:41:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:41:33 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')]} 06:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:33 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')]} 06:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:33 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 0x7f06a1eb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', '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 06:41:33 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 06:41:33 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 06:41:33 INFO - Using env: {'DISPLAY': ':0', 06:41:33 INFO - 'HOME': '/home/cltbld', 06:41:33 INFO - 'LANG': 'en_US.UTF-8', 06:41:33 INFO - 'LANGUAGE': 'en_US:en', 06:41:33 INFO - 'LOGNAME': 'cltbld', 06:41:33 INFO - 'MAIL': '/var/mail/cltbld', 06:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:33 INFO - 'MOZ_NO_REMOTE': '1', 06:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:33 INFO - 'NO_EM_RESTART': '1', 06:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:33 INFO - 'PWD': '/builds/slave/test', 06:41:33 INFO - 'SHELL': '/bin/bash', 06:41:33 INFO - 'SHLVL': '1', 06:41:33 INFO - 'TERM': 'linux', 06:41:33 INFO - 'TMOUT': '86400', 06:41:33 INFO - 'USER': 'cltbld', 06:41:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:33 INFO - '_': '/tools/buildbot/bin/python'} 06:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:34 INFO - Downloading/unpacking flake8 06:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:41:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06: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 06: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 06: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 06: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 06: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 06: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 06:41:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:41:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:41:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:36 INFO - no previously-included directories found matching 'docs/_build' 06:41:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:41:36 INFO - Running setup.py install for pep8 06:41:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:36 INFO - no previously-included directories found matching 'docs/_build' 06:41:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:41:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:41:36 INFO - Cleaning up... 06:41:36 INFO - Return code: 0 06:41:36 INFO - Running post-action listener: _resource_record_post_action 06:41:36 INFO - Running post-action listener: _start_resource_monitoring 06:41:36 INFO - Starting resource monitoring. 06:41:36 INFO - ##### 06:41:36 INFO - ##### Finished create-virtualenv step (success) 06:41:36 INFO - ##### 06:41:36 INFO - ##### 06:41:36 INFO - ##### Running install step. 06:41:36 INFO - ##### 06:41:36 INFO - Running pre-action listener: _resource_record_pre_action 06:41:36 INFO - Running main action method: install 06:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:37 INFO - Reading from file tmpfile_stdout 06:41:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:41:37 INFO - Reading from file tmpfile_stdout 06:41:37 INFO - Output received: 06:41:37 INFO - Usage: mozinstall [options] installer 06:41:37 INFO - Options: 06:41:37 INFO - -h, --help show this help message and exit 06:41:37 INFO - -d DEST, --destination=DEST 06:41:37 INFO - Directory to install application into. [default: 06:41:37 INFO - "/builds/slave/test"] 06:41:37 INFO - --app=APP Application being installed. [default: firefox] 06:41:37 INFO - mkdir: /builds/slave/test/build/application 06:41:37 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'] 06:41:37 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 06:41:53 INFO - Reading from file tmpfile_stdout 06:41:53 INFO - Output received: 06:41:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:41:53 INFO - Running post-action listener: _resource_record_post_action 06:41:53 INFO - ##### 06:41:53 INFO - ##### Finished install step (success) 06:41:53 INFO - ##### 06:41:53 INFO - ##### 06:41:53 INFO - ##### Running run-tests step. 06:41:53 INFO - ##### 06:41:53 INFO - Running pre-action listener: _resource_record_pre_action 06:41:53 INFO - Running main action method: run_tests 06:41:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:41:53 INFO - Python 2.7.3 06:41:53 INFO - Return code: 0 06:41:53 INFO - grabbing minidump binary from tooltool 06:41:53 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')]} 06:41:53 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 0xe8c410>, '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 0xe8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:41:53 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 06:41:53 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 06:41:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:41:53 INFO - Return code: 0 06:41:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:41:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:41:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:41:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:41:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:41:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:41:54 INFO - Return code: 0 06:41:54 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/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 06:41:54 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/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 06:41:54 INFO - Using env: {'DISPLAY': ':0', 06:41:54 INFO - 'HOME': '/home/cltbld', 06:41:54 INFO - 'LANG': 'en_US.UTF-8', 06:41:54 INFO - 'LANGUAGE': 'en_US:en', 06:41:54 INFO - 'LOGNAME': 'cltbld', 06:41:54 INFO - 'MAIL': '/var/mail/cltbld', 06:41:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:41:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:54 INFO - 'MOZ_NO_REMOTE': '1', 06:41:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:54 INFO - 'NO_EM_RESTART': '1', 06:41:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:54 INFO - 'PWD': '/builds/slave/test', 06:41:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:41:54 INFO - 'SHELL': '/bin/bash', 06:41:54 INFO - 'SHLVL': '1', 06:41:54 INFO - 'TERM': 'linux', 06:41:54 INFO - 'TMOUT': '86400', 06:41:54 INFO - 'USER': 'cltbld', 06:41:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160', 06:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:54 INFO - '_': '/tools/buildbot/bin/python'} 06:41:54 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/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 06:41:54 INFO - mozversion application_buildid: 20160506051915 06:41:54 INFO - mozversion application_changeset: 19a1743ceb2e035e571012e88d25275ce627b925 06:41:54 INFO - mozversion application_display_name: Nightly 06:41:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:41:54 INFO - mozversion application_name: Firefox 06:41:54 INFO - mozversion application_remotingname: firefox 06:41:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:41:54 INFO - mozversion application_vendor: Mozilla 06:41:54 INFO - mozversion application_version: 49.0a1 06:41:54 INFO - mozversion platform_buildid: 20160506051915 06:41:54 INFO - mozversion platform_changeset: 19a1743ceb2e035e571012e88d25275ce627b925 06:41:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:41:54 INFO - mozversion platform_version: 49.0a1 06:41:54 INFO - using testdate: 1462542114 06:41:54 INFO - actual date: 1462542114 06:41:54 INFO - starting webserver on 'localhost:56003' 06:41:54 INFO - SUITE-START | Running 2 tests 06:41:54 INFO - TEST-START | dromaeo_css 06:41:54 INFO - operating with platform_type : linux_ 06:41:54 INFO - Initialising browser for dromaeo_css test... 06:41:54 INFO - TEST-INFO | started process 3368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvQzxb/profile http://localhost:56003/getInfo.html) 06:41:59 INFO - PROCESS | 3368 | 06:41:59 INFO - PROCESS | 3368 | (process:3435): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:42:00 INFO - PROCESS | 3368 | __metrics Screen width/height:1600/1200 06:42:00 INFO - PROCESS | 3368 | colorDepth:24 06:42:00 INFO - PROCESS | 3368 | Browser inner width/height: 1024/697 06:42:00 INFO - PROCESS | 3368 | __metrics 06:42:01 ERROR - PROCESS | 3368 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 06:42:02 INFO - TEST-INFO | 3368: exit 0 06:42:02 INFO - Browser initialized. 06:42:02 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:02 INFO - TEST-INFO | started process 3486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvQzxb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:04 INFO - PROCESS | 3486 | 06:42:04 INFO - PROCESS | 3486 | (process:3546): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:42:14 INFO - PROCESS | 3486 | RSS: Main: 164450304 06:42:14 INFO - PROCESS | 3486 | 06:43:03 INFO - PROCESS | 3486 | 1462542183872 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] 06:45:15 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:56003/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56003/tests/dromaeo/cssquery-ext.html) 06:45:16 INFO - PROCESS | 3486 | RSS: Main: 167432192 06:45:16 INFO - PROCESS | 3486 | 06:48:18 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:56003/tests/dromaeo/cssquery-ext.html (next: http://localhost:56003/tests/dromaeo/cssquery-jquery.html) 06:48:19 INFO - PROCESS | 3486 | RSS: Main: 167817216 06:48:19 INFO - PROCESS | 3486 | 06:51:21 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:56003/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56003/tests/dromaeo/cssquery-mootools.html) 06:51:22 INFO - PROCESS | 3486 | RSS: Main: 168308736 06:51:22 INFO - PROCESS | 3486 | 06:54:24 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:56003/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56003/tests/dromaeo/cssquery-prototype.html) 06:54:24 INFO - PROCESS | 3486 | RSS: Main: 165986304 06:54:24 INFO - PROCESS | 3486 | 06:57:27 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:56003/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56003/tests/dromaeo/cssquery-yui.html) 06:57:27 INFO - PROCESS | 3486 | RSS: Main: 166739968 06:57:27 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | Cycle 1(1): loaded http://localhost:56003/tests/dromaeo/cssquery-yui.html (next: http://localhost:56003/tests/dromaeo/cssquery-dojo.html) 07:00:30 INFO - PROCESS | 3486 | RSS: Main: 169357312 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | __start_tp_report 07:00:30 INFO - PROCESS | 3486 | _x_x_mozilla_page_load 07:00:30 INFO - PROCESS | 3486 | _x_x_mozilla_page_load_details 07:00:30 INFO - PROCESS | 3486 | |i|pagename|runs| 07:00:30 INFO - PROCESS | 3486 | |0;dojo.html;2642.405458771776;2681.8390896546207;2688.542947698891;2692.380752426942;2700.29792254014;4687.742174180418;4698.483166851648;4717.150912835688;4774.28385742138;4840.757962101899;4716.4340279166545;4722;4740.549647783464;4749.287606858973;4756.785944632491;4316.287812510932;4357.237483440385;4442.044960333527;4460.955390446103;4465.084657645175;4406.757628330441;4519.954800452003;4532;4565.406497155382;4619.353290539327;4399.208142534342;4403.823847046115;4416.183006143874;4435.423394958667;4443.822247110112;4424.269995450747;4438.489573699034;4450.777461126963;4457.175422546807;4491.910161796778;4392.846250381222;4404.273294906337;4404.8458303959205;4459.397981272519;4466.7766611669285;4541.72749635023;4695.88260293492;4754.619630429557;4768.475467698585;4771.212749896297;5166.095933211673;5187.403448603422;5198.298229739013;5219.8434046978655;5245.86885327866;5061.316722242524;5207.114790485626;5211.5049070338255;5252.264682944391;5256.185291279858;4799.808007679689;4812.181929072066;4819.0843739689;4824.95175048245;4842.83050093245;5276.63063585553;5300.09898317287;5321.5476684482255;5327.786888524493;5343.759530821122;4872.829450969199;4988.875278118004;5083.822066227738;5092.465291144451;5094.643374963717;5051.6716413433005;5097.745112744348;5100.617453690988;5112.284280200774;5153.845384638467;4931.432885218246;5046.62150338726;5051.570616497565;5073.1122053640465;5107.540321371094;4880.6583539152625;5062.721550314768;5068.16375298079;5074.594032477393;5133.435322114565;4304.117655880537;4327.956720432755;4346.304591265382;4371.30059190528;4376.759278239664;3799.981000095037;3816.8774440054967;3823.273578020223;3844.3656796628243;3845.038740314921;4300.075483771005;4421.5578442156175;4428.822847086145;4470.1059788041875;4479.552044795494;5169.4572069932865;5198.324217851655;5211.71335576547;5244.160934250578;5280.9471905281225;4421.977890110529;4481.036577135931;4486.7756612169915;4489.057297967398;4521.3896124023495;4497.640188784955;4624.213883639789;4656.185167595657;4676.088162808288;4707.223308154184;4858.732769697701;4868.148074087091;4881.023795240966;4896.338994235733;4930.778114984762;5154.690718556899;5187.714675692722;5214.322138122172;5225.895482090261;5277.8416647500635;4641.18779213643;4779.713217206979;4802.591779698625;4818.494058123846;4827.3198173660085;5125.846224613268;5136.2552429898205;5139.794408223629;5140.228965655182;5181.326427564392;5211.895762084813;5214.8957020860125;5221.869453263699;5223.843284701465;5260.736963151904;4882.072406242803;4912.975435122801;4922.803087876445;4933.1613625683;5075.670081444842;4980.925286120783;4996.550310472075;5004.224345226496;5007.499250075109;5030.698158110525;4906.264060390828;4918.827841025547;4922.92615610759;4936.901261974668;4951.801927922843;4917.459079501324;4996.625253105959;5048.343715317133;5070.923936141035;5073.974630126826;4928.334674818853;4962.354893863775;4968.527989840959;4972.129877271391;5012.172991456368 07:00:30 INFO - PROCESS | 3486 | |1;ext.html;565.5277843001094;600.6306121735134;603.3242768099727;616.8457885528618;635.920509936258;35873.820630896844;39122.608773912325;39359;39431.211375772466;39487.407688884654;40074.7996260019;40612.59387406133;40627.39058914111;40652;40743.59256407435;7752.302292793647;7873;7886.093099293597;7893.723719669812;7909.169537198598;7782.455228134033;7842.5294482330955;7859.371250299991;7861.724839630614;7881.527108373487;7840.921590784104;7847.6860925562905;7868.685252589889;7900.32847207988;7900.486468379566;7840.960795196044;7845.607719613997;7869.645865936047;7891;7894.881576776353;7654.770356889302;7762;7781.22187781223;7789.532628042336;7792.376609871253;37251.813740931124;37402.8129859349;37802.62197378019;37856;37892;3316.96683033169;3319.452290372086;3378.476336167898;3451.741119416054;3541.5750109986707;29550.26124346887;30229.244268893235;30318;30432.391352173054;31056;3321.800691958466;3334.0831271400316;3371.089805752458;3386.8306584670668;3411.9488207676904;239797;240795;241176;242355;242599;29341.706582934323;53273;53589.196162057604;53621.73189134029;53645.1953220702;35703.4644480333;35780.82109589488;35877.82061089678;36004.279914401566;36012.279754404764;14070.859291406954;14209.573712788426;14223.502177423741;14302.427902883768;14364.784528232085;11724.237924534878;11829.171957963032;11849.822252666218;11862.703432414259;11911.285322880654;8273.627686754111;8317.376196785266;8342.582870856433;8346.791330216793;8401.789955251168;3313.801171929692;3323.3519463704347;3328.8834890778708;3336.6996970272307;3350.396928552835;981.1758123176566;1011.0445628880784;1015.6699072801222;1030.7886883188928;1062.4156713807374;29071.41857162845;29494.11517654474;29711.405771884874;29713;29829.850850745606;1059.9470026498643;1080.0882438084545;1091.252492042953;1100.7193165742844;1137.3045881261464;14536.27318634064;14968.428315026984;14985.999960283583;15048.774268385983;15107;351011;353376;354856;354951;355466;51115.233271500954;51609.483905160465;51744;51832;51927;1301.5249433956537;1325.0856908732944;1334.8197993270785;1346.5219846954385;1347.9730405392033;26497;27868.721312786613;28008.71991280061;28105.859470703333;28266.43467130687;42950;43020.35469468023;43294.783526083425;43304;43407.34888976731;302937;304766;305198;305385;307195;23444.296671099895;24066.15768448096;25447.74552254528;26090.86954565215;26212.344691382867;43365.566344336155;44214.778926105166;44232;44736.552634473235;44886.10227795361;37252.62747372492;37604.435933461566;37675.05812354713;38291.6170838288;38497;36316.81841590775;37587.436188456646;37773.62226377811;38195.42706859455;38507;33301.50047749237;36597.268054638225;37875.431868521446;38163.80918095392;38869.61130388773;33342.66657333493;34786.30427391489;35172.47241291332;35238.647613523535;35299.64700352964;26337.736622634297;26602.600960985215;26676.733232667426;26903;26953 07:00:30 INFO - PROCESS | 3486 | |2;jquery.html;376.85867799575175;381.1481339206873;384.5788861196989;396.62915174312;399.4168513969604;15481.84518154818;16943.745843812354;17520.474385768415;17535.12324383782;17551.73672394915;16834.24245908934;17192.656146877056;17580.736288955675;17588.912055439705;17636.294548218055;4980.501949805027;5111.722069482629;5145.151050076733;5157.149070403379;5178.792848286064;3637.727170462226;5572.3034620672415;5861.53107751381;5871.794487192949;5898.262717160355;5690.687012214326;5862.853428664275;5871.794487192949;5872.207252020965;5893.116032595123;5800.796972105956;5828.708564571754;5833.066709326508;5834.649921004753;5860.589758716891;4554.203014472487;4876.951230487685;5107.642465027449;5140.203268493389;5141.845744627667;12028.879711202864;12256;12498.500059997588;12567.622971310875;12600.558980435733;1819.6269764698338;1839.5309196154894;1875.2405275863298;1924.2591602233101;2074.6369385357502;8809.735707928709;8812.427192232548;9145.222656074242;9353.859692104625;9416.717498474989;1632.8122265939332;1656.9809567116258;1687.7552754850478;1727.8963262204309;1772.0785191700243;67024;69164.6541767293;69850.30149698489;70300;70906;9852.753681157885;10012.644499642678;10080.193584513368;10232.795344093225;10358.585656573803;14196.71606567863;14209.431622735181;14270.429182832571;14284.714305714035;14291.356888940023;7382.114146302478;7424.85150296991;7478.439117066242;7589.8861517077285;7624.42816788743;7163.570185788869;7259.854802903912;7323.121225452873;7368.373688236453;7398.297161769623;4307.504636966726;4342.739435633809;4397.428334316583;4417.734935903856;4473.1277400907165;1721.2082442076785;1750.7986581543285;1844.907754612264;1852.3239017758422;1857.6099019206117;885.3050355471053;914.0886277207117;924.7272054743867;968.9127978481971;972.2610815779917;16372.672546549002;16805.663886722195;17150.399736009178;17329.133543322783;17331;932.7248461703814;934.8831396075491;935.854942483916;965.7151140413595;988.9011098890054;9524.14282714559;9647.517624118766;9693.660721874701;9748.171405430618;9936.304458687822;395976;398924;399033;409858;409866;78407.60796195983;79290.20709792944;79669.20330796618;80272.59863700761;80400;962.6197651927449;974.6004138303404;980.7401038724744;989.8218320702342;991.2664628175098;15298.235088245321;15435.459758908384;15584.142872142142;15637.843621564094;15774.842251577338;31936.68063319337;32518.674813251564;33767.32465350728;35051.12372190614;35075.82462087673;50132.997340052265;52104;52120.436386908455;52312.47687523076;53034.2044869335;6908.1019467468905;7120.6795694194925;7173.246809084971;7615.619219039137;8091.919080809352;10192.439415832201;12122.878771212176;12220.205686630341;12562.434690439135;12744.362781860684;7597.6581053853815;10756.892431075588;11015.733190683173;11097.167712421762;11158.163137764537;10644.574217031231;11037.448127593749;11085.778284434105;11149;11150.107991360834;10736.30214036085;10876.673699789018;10886.782264354826;11060.225784195029;11371.374574398487;7868.488548244346;7899.921000789918;7995.12053674107;8252.628631711708;8264.173582641688;9877.753056173653;10512.474376281309;10665.146788257076;11158.274712143684;11162 07:00:30 INFO - PROCESS | 3486 | |3;mootools.html;1496.6258435391148;1522.9619259518513;1725.6721222967635;1851.25949620152;1899.3257393625263;6667.099941507895;7414.703411863533;7531.698732050718;7877.054753429589;7886.44794864359;7514.3237108660205;7673.232676732324;7715.961420192891;7729.149793522708;7770.067591888981;2161.081540345359;2197.3847322749575;2208.2271205078255;2223.3885681437573;2229.420350708819;2209.62436385814;2230.119102954332;2281.6577513373045;2284.1434462076722;2285.874276914769;2245.9887700561476;2246.528229071897;2247.2359397804826;2261.513774538474;2277.6925115109416;2147.806697397234;2148.2695883399565;2151.967720484194;2171.240065976903;2177.292379976498;2133.7439507259073;2154.838387120972;2172.4894649757293;2175.3582693105573;2175.5866385386726;7740.148583655793;7742.264484873928;7788.221177882223;7790.337821285198;7807.609619519001;4407.140607581523;4463.464384273875;4471.597556219956;4495.325701144821;4518.728876267434;2708.7426694463993;2792.2460935547288;2862.726086891334;2867.4695181391303;2872.296287409598;876.1151237250359;908.7909780750398;913.8126684029758;931.0270767048384;954.2270760683869;10002.249831262612;10097.24270679702;10156.085952264331;10171.389716617026;10190.082892539633;4017.417474466186;4080.2451546463403;4097.672186225095;4115.403266526337;4132.772697501606;8890.377673562918;8905.73282801517;8916.242119419921;8927.062658420902;8932.41939273958;4441.156180325793;4452.621527170162;4467.106578684276;4535;4539.818407263672;3661.707063434919;4034.9798251008556;4068.7762173080764;4120.443740095108;4156.646685031746;3655.2689462107683;3669.633036696309;3790.8104594770152;3796.962030379716;3803.410471376941;1185.057878986208;1232.0451649971164;1234.6049264235357;1237.6348977051791;1241.6585439004346;748.8464864702723;796.3907610677836;882.5366682491743;901.8692289617969;925.319889880937;5019.924701129486;5161.329027226437;5193.844184674465;5225.947740522623;5293.682379057192;404.83199472219286;408.2182620282126;410.83155906078366;411.24331230535955;416.64585102662494;3607.639236076371;3610.8736194233074;3617.5116359291687;3620.5836328822525;3642.581103173116;8665.263452606472;8853.070427605138;8980.55097245135;9003.099690030944;9032.63869445215;8823.647054117764;8884.111588841193;8905.643774249087;8913.5097569633;8915.242204412569;6884.690188941509;7006.719731210796;7074.893876591856;7078.6106764127435;7145.178304494945;5093.923591146062;5129.897402052013;5144.845654630367;5145.61407894402;5169.147090729987;8137.104918458846;8227.095019547725;8365.874511882204;8373.288270496832;8395.70615028471;8313.958430207811;8373.162683731578;8424.663013479638;8526.317894568296;8531.573421328785;6139.539534534839;6340.841478963062;6496.512761542997;6611.570247933869;6625.304343043911;7359.37445317154;7367.742129025459;7413.443991700537;7426.74006409773;7427.554346739213;6489.545731798728;6662.400383965466;6700.396964273239;6727.024581435567;6745.628990405575;6531.248906375828;6587.835304117244;6645.169353830771;6703.631300278532;6806.319368063154;6297.590656607306;6352.301246862934;6364.96817515928;6366.490680745622;6366.777162799465;4288.914221715486;4319.784010799511;4416.889577760582;4453.042595841909;4493.213687604722;4631.374764406762;4654.883627909329;4684.367610372692;4704.388429504143;4742.66801323904 07:00:30 INFO - PROCESS | 3486 | |4;prototype.html;304.7257468278549;312.2163369941446;312.82169163576754;314.63973750056186;316.86849957267736;4965.528274813892;4994.1759609664405;5022.321986531817;5041.798328066878;5048.949510504894;4930.277640381507;4931.3835770528685;4933.45731969483;4939.259111133332;4967.577755890745;3712.2389910068505;3728.850845966158;3854.8843534694006;3873.3221686204943;3874.9418758718643;3870.1485673152;3880.3597406427907;3886.533615966088;3894.9026274343087;3914.862979795708;3863.690904727615;3876.089119057019;3881.4371916072155;3885.6308650678284;3907.882763517099;3789.677877380426;3882.7476214045996;3886.31989401855;3888.4556162137324;3890.6966166334314;3429.605595356541;3429.794212347242;3438.8108654024018;3441.174118211636;3448.913777155566;4678.345031695565;4697.379404105578;4700.42767496705;4713.175194340976;4723.95276047242;4320.524742278347;4367.497737760166;4389.5390983946545;4417.3815665806815;4453.465584129893;4912.803487860481;5088.821891233826;5091.3126727892;5103.744812759384;5127.692338459704;3694.64900834423;3699.5005674233903;3704.592494825594;3706.6664000240107;3721.4603882437164;5344.5724342052545;5349.7057661828585;5351.143816989302;5351.625386222966;5365.704886231256;3510.315488479773;3696.1868388954385;3707.258548290353;3718.9814050930113;3788.6021967692996;3749.4750734897134;3754.7747135171976;3758.0229140423685;3770.792606406619;3777.017975326435;4260.786960651955;4266.146770645883;4292.914141717149;4298.871033868989;4316.266234740102;5006.3992320921725;5127.8718032048755;5141;5151.896962060738;5197.428282888879;1286.5882917466508;1290.8838204561634;1295.7667619828333;1300.232862611064;1302.6027061746258;828.846663367279;855.1064137975831;888.1562515610196;899.3569597737518;908;4449.866504004885;4477.649234152096;4519.389882365905;4550.180967425829;4558.9772051139535;5297.708626025606;5320.058178764801;5338.386085600206;5357.4106848246665;5372.5433338166695;4422.778861056934;4527.7509736964785;4527.909441811145;4563.748993805306;4571.177188106173;2762.4613200426124;2779.610854480374;2782.3461486550646;2786.9688215360447;2790.860456977143;4869.196582563908;4882.7558622068755;4883.706977581356;4884.1941079722155;4884.3161957326;4968.552830245295;5237.790488380499;5332.306800116037;5352.785888564492;5376.811811586654;4824.49342819006;4837.95162048382;4840.620423179377;4876.5854902333695;4896.314515967696;5193.272941788077;5230.476952304739;5240.947590524046;5241.959663395145;5296.576273898002;4923.753812309298;5040.269160971712;5120.71836049006;5145.45972672864;5172.5344718975475;4821.855344339676;4836.830710925242;4858.562729354375;4877.365942427462;4877.6585639004925;3622.873199438007;3644.6902013329163;3653.141511744791;3653.707703383776;3674.669279764834;4850.708957462563;5232.398274198364;5244;5268.078086334953;5284.524392804666;5048.419431765247;5056.154503606231;5060.645754797129;5067.214581739836;5104.540591346797;5072.771725272298;5089.898202035864;5090.650977490894;5091.949080509147;5108.10608143566;4798.280257961194;4962.163999320274;4992.455356696786;4996.725180114983;4998.3252260945765;4980.825671101494;5046.359933021709;5120.385553733576;5172.301739265151;5173.534381905646;5013.799448022039;5015.924761128659;5040.243963405518;5042.445331013659;5045.167547354646 07:00:30 INFO - PROCESS | 3486 | |5;yui.html;727.5852763924563;730.5908691132965;781.6756046240811;798.2815466080531;803.060419309408;11240.437978101092;12411.379431028447;12666.113372063948;12696.047796415283;12720.36398180092;12493.750124997494;12505.68735781606;12536.498540058386;12556.560520381789;12609.684757881058;670.1957650819037;829.179112678447;836.6486075848159;847.9194476524721;849.7493239494333;843.5908584336592;854.2653318146389;855.2345650642671;857.8713193021034;858.6779957515931;903.9502827344494;905.3888625177979;907.3376435202306;907.4600612635471;908.0692290402358;885.0839381240418;888.6756333938131;889.2796834564024;889.6263569300909;895.5298468304127;665.6039656404431;665.9933400666029;666.243813271935;666.7899611622323;667.1160712056496;11851;11874.287542747463;11911.166218364719;11918.940405298004;11958.64124076279;12572.182808117443;12879.227246365155;12916.41876115577;12970.675733106653;13240.073194876362;10045.547950342252;10117.949410252975;10266.230032747573;10290.794184116276;10496;3233.2401885556874;3265.2653153040615;3280.5899262592175;3308.586426696663;3354.2452948086484;43438;43499.34750978738;43776.781116094215;43878.12243755107;44616;9818.852717209247;9860.556274967643;9952.701418957442;10028.548715307828;10041.397516149054;18106.63786724258;18149.546261343574;18194;18303.35938242155;18415;6347.987010719707;6532.052852336385;6727.29363416844;6735.259121496631;6958.37374636275;3652.141746689526;3718.665320121202;3726.5341832270965;3805.961940380616;3813.0276779421624;2780.6802217745217;2894.6236989191693;2897.753690936294;2900.8984685535906;2901.434220327016;518.3391176250236;534.2120372450604;536.6860386673761;545.9044667183227;550.8705454218256;486.1710783114781;491.6533843640225;511.9411267704262;552.1303946284618;574.5834270154188;7009.228984811667;7075.2217256101785;7113.502054856214;7208.891866622005;7341.70633174667;538.7387117248131;568.8037627018672;572.8882867840814;601.3265143039823;601.9608725432832;3325.617553981275;3384.2892992471857;3404.897853064412;3439.9828000860334;3443.500692399588;50419.88327992361;50712;50922.23616645753;51175.48824511782;51953;45298.320525192146;45844.7707761459;45979;46290.76854615705;47639.5236047642;43232.567674322854;43254.35118473225;43309.13381732411;43547.346789798175;43919.34120988188;6548.116004339353;6732.798016059526;6763;6944.791656250321;7073.717051318095;27884.442311153256;28519.857400713692;29060.27349316284;29079.273018174714;29409.85295073511;34352.31295374128;35101.47347789734;35300.82349588236;36001.63998360088;36505;10279.331843430153;10460.581576736846;10649.8935010652;10944.343339399662;11188.72028199269;11275.182413053713;11284.830727538929;11485.48315325829;11563.942180289045;11783.823242651195;11505.252158609663;11920.344381058778;11970.401479925795;11987.40062996864;12300.446479908247;10650.658788305256;11180.664580062612;11236.661642426907;11272.887271127513;11546.94226528862;10445.182592682395;11103.222774405715;11236.269642473213;11363.147763917574;11398.715032123931;8945.552722363725;9066.456012639263;9276.397034192756;9323.300752443729;9515.191208747057;8850.955745221232;8948.821023579621;8987.263558629373;9307.255419566554;9317.767055823659 07:00:30 INFO - PROCESS | 3486 | __end_tp_report 07:00:30 INFO - PROCESS | 3486 | __start_cc_report 07:00:30 INFO - PROCESS | 3486 | _x_x_mozilla_cycle_collect,383 07:00:30 INFO - PROCESS | 3486 | __end_cc_report 07:00:30 INFO - PROCESS | 3486 | __startTimestamp1462543230747__endTimestamp 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | ------- Summary: start ------- 07:00:30 INFO - PROCESS | 3486 | Number of tests: 6 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | [#0] dojo.html Cycles:165 Average:4754.22 Median:4872.83 stddev:501.11 (10.3%) stddev-sans-first:474.47 07:00:30 INFO - PROCESS | 3486 | Values: 2642.4 2681.8 2688.5 2692.4 2700.3 4687.7 4698.5 4717.2 4774.3 4840.8 4716.4 4722.0 4740.5 4749.3 4756.8 4316.3 4357.2 4442.0 4461.0 4465.1 4406.8 4520.0 4532.0 4565.4 4619.4 4399.2 4403.8 4416.2 4435.4 4443.8 4424.3 4438.5 4450.8 4457.2 4491.9 4392.8 4404.3 4404.8 4459.4 4466.8 4541.7 4695.9 4754.6 4768.5 4771.2 5166.1 5187.4 5198.3 5219.8 5245.9 5061.3 5207.1 5211.5 5252.3 5256.2 4799.8 4812.2 4819.1 4825.0 4842.8 5276.6 5300.1 5321.5 5327.8 5343.8 4872.8 4988.9 5083.8 5092.5 5094.6 5051.7 5097.7 5100.6 5112.3 5153.8 4931.4 5046.6 5051.6 5073.1 5107.5 4880.7 5062.7 5068.2 5074.6 5133.4 4304.1 4328.0 4346.3 4371.3 4376.8 3800.0 3816.9 3823.3 3844.4 3845.0 4300.1 4421.6 4428.8 4470.1 4479.6 5169.5 5198.3 5211.7 5244.2 5280.9 4422.0 4481.0 4486.8 4489.1 4521.4 4497.6 4624.2 4656.2 4676.1 4707.2 4858.7 4868.1 4881.0 4896.3 4930.8 5154.7 5187.7 5214.3 5225.9 5277.8 4641.2 4779.7 4802.6 4818.5 4827.3 5125.8 5136.3 5139.8 5140.2 5181.3 5211.9 5214.9 5221.9 5223.8 5260.7 4882.1 4913.0 4922.8 4933.2 5075.7 4980.9 4996.6 5004.2 5007.5 5030.7 4906.3 4918.8 4922.9 4936.9 4951.8 4917.5 4996.6 5048.3 5070.9 5074.0 4928.3 4962.4 4968.5 4972.1 5012.2 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | [#1] ext.html Cycles:180 Average:45284.51 Median:195584.73 stddev:79787.18 (40.8%) stddev-sans-first:79940.36 07:00:30 INFO - PROCESS | 3486 | Values: 565.5 600.6 603.3 616.8 635.9 35873.8 39122.6 39359.0 39431.2 39487.4 40074.8 40612.6 40627.4 40652.0 40743.6 7752.3 7873.0 7886.1 7893.7 7909.2 7782.5 7842.5 7859.4 7861.7 7881.5 7840.9 7847.7 7868.7 7900.3 7900.5 7841.0 7845.6 7869.6 7891.0 7894.9 7654.8 7762.0 7781.2 7789.5 7792.4 37251.8 37402.8 37802.6 37856.0 37892.0 3317.0 3319.5 3378.5 3451.7 3541.6 29550.3 30229.2 30318.0 30432.4 31056.0 3321.8 3334.1 3371.1 3386.8 3411.9 239797.0 240795.0 241176.0 242355.0 242599.0 29341.7 53273.0 53589.2 53621.7 53645.2 35703.5 35780.8 35877.8 36004.3 36012.3 14070.9 14209.6 14223.5 14302.4 14364.8 11724.2 11829.2 11849.8 11862.7 11911.3 8273.6 8317.4 8342.6 8346.8 8401.8 3313.8 3323.4 3328.9 3336.7 3350.4 981.2 1011.0 1015.7 1030.8 1062.4 29071.4 29494.1 29711.4 29713.0 29829.9 1059.9 1080.1 1091.3 1100.7 1137.3 14536.3 14968.4 14986.0 15048.8 15107.0 351011.0 353376.0 354856.0 354951.0 355466.0 51115.2 51609.5 51744.0 51832.0 51927.0 1301.5 1325.1 1334.8 1346.5 1348.0 26497.0 27868.7 28008.7 28105.9 28266.4 42950.0 43020.4 43294.8 43304.0 43407.3 302937.0 304766.0 305198.0 305385.0 307195.0 23444.3 24066.2 25447.7 26090.9 26212.3 43365.6 44214.8 44232.0 44736.6 44886.1 37252.6 37604.4 37675.1 38291.6 38497.0 36316.8 37587.4 37773.6 38195.4 38507.0 33301.5 36597.3 37875.4 38163.8 38869.6 33342.7 34786.3 35172.5 35238.6 35299.6 26337.7 26602.6 26676.7 26903.0 26953.0 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | [#2] jquery.html Cycles:180 Average:24590.42 Median:4407.58 stddev:66482.42 (1508.4%) stddev-sans-first:66644.06 07:00:30 INFO - PROCESS | 3486 | Values: 376.9 381.1 384.6 396.6 399.4 15481.8 16943.7 17520.5 17535.1 17551.7 16834.2 17192.7 17580.7 17588.9 17636.3 4980.5 5111.7 5145.2 5157.1 5178.8 3637.7 5572.3 5861.5 5871.8 5898.3 5690.7 5862.9 5871.8 5872.2 5893.1 5800.8 5828.7 5833.1 5834.6 5860.6 4554.2 4877.0 5107.6 5140.2 5141.8 12028.9 12256.0 12498.5 12567.6 12600.6 1819.6 1839.5 1875.2 1924.3 2074.6 8809.7 8812.4 9145.2 9353.9 9416.7 1632.8 1657.0 1687.8 1727.9 1772.1 67024.0 69164.7 69850.3 70300.0 70906.0 9852.8 10012.6 10080.2 10232.8 10358.6 14196.7 14209.4 14270.4 14284.7 14291.4 7382.1 7424.9 7478.4 7589.9 7624.4 7163.6 7259.9 7323.1 7368.4 7398.3 4307.5 4342.7 4397.4 4417.7 4473.1 1721.2 1750.8 1844.9 1852.3 1857.6 885.3 914.1 924.7 968.9 972.3 16372.7 16805.7 17150.4 17329.1 17331.0 932.7 934.9 935.9 965.7 988.9 9524.1 9647.5 9693.7 9748.2 9936.3 395976.0 398924.0 399033.0 409858.0 409866.0 78407.6 79290.2 79669.2 80272.6 80400.0 962.6 974.6 980.7 989.8 991.3 15298.2 15435.5 15584.1 15637.8 15774.8 31936.7 32518.7 33767.3 35051.1 35075.8 50133.0 52104.0 52120.4 52312.5 53034.2 6908.1 7120.7 7173.2 7615.6 8091.9 10192.4 12122.9 12220.2 12562.4 12744.4 7597.7 10756.9 11015.7 11097.2 11158.2 10644.6 11037.4 11085.8 11149.0 11150.1 10736.3 10876.7 10886.8 11060.2 11371.4 7868.5 7899.9 7995.1 8252.6 8264.2 9877.8 10512.5 10665.1 11158.3 11162.0 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | [#3] mootools.html Cycles:180 Average:4995.05 Median:5056.92 stddev:2723.54 (53.9%) stddev-sans-first:2718.49 07:00:30 INFO - PROCESS | 3486 | Values: 1496.6 1523.0 1725.7 1851.3 1899.3 6667.1 7414.7 7531.7 7877.1 7886.4 7514.3 7673.2 7716.0 7729.1 7770.1 2161.1 2197.4 2208.2 2223.4 2229.4 2209.6 2230.1 2281.7 2284.1 2285.9 2246.0 2246.5 2247.2 2261.5 2277.7 2147.8 2148.3 2152.0 2171.2 2177.3 2133.7 2154.8 2172.5 2175.4 2175.6 7740.1 7742.3 7788.2 7790.3 7807.6 4407.1 4463.5 4471.6 4495.3 4518.7 2708.7 2792.2 2862.7 2867.5 2872.3 876.1 908.8 913.8 931.0 954.2 10002.2 10097.2 10156.1 10171.4 10190.1 4017.4 4080.2 4097.7 4115.4 4132.8 8890.4 8905.7 8916.2 8927.1 8932.4 4441.2 4452.6 4467.1 4535.0 4539.8 3661.7 4035.0 4068.8 4120.4 4156.6 3655.3 3669.6 3790.8 3797.0 3803.4 1185.1 1232.0 1234.6 1237.6 1241.7 748.8 796.4 882.5 901.9 925.3 5019.9 5161.3 5193.8 5225.9 5293.7 404.8 408.2 410.8 411.2 416.6 3607.6 3610.9 3617.5 3620.6 3642.6 8665.3 8853.1 8980.6 9003.1 9032.6 8823.6 8884.1 8905.6 8913.5 8915.2 6884.7 7006.7 7074.9 7078.6 7145.2 5093.9 5129.9 5144.8 5145.6 5169.1 8137.1 8227.1 8365.9 8373.3 8395.7 8314.0 8373.2 8424.7 8526.3 8531.6 6139.5 6340.8 6496.5 6611.6 6625.3 7359.4 7367.7 7413.4 7426.7 7427.6 6489.5 6662.4 6700.4 6727.0 6745.6 6531.2 6587.8 6645.2 6703.6 6806.3 6297.6 6352.3 6365.0 6366.5 6366.8 4288.9 4319.8 4416.9 4453.0 4493.2 4631.4 4654.9 4684.4 4704.4 4742.7 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | [#4] prototype.html Cycles:180 Average:4243.85 Median:4845.66 stddev:1222.30 (25.2%) stddev-sans-first:1189.44 07:00:30 INFO - PROCESS | 3486 | Values: 304.7 312.2 312.8 314.6 316.9 4965.5 4994.2 5022.3 5041.8 5048.9 4930.3 4931.4 4933.5 4939.3 4967.6 3712.2 3728.9 3854.9 3873.3 3874.9 3870.1 3880.4 3886.5 3894.9 3914.9 3863.7 3876.1 3881.4 3885.6 3907.9 3789.7 3882.7 3886.3 3888.5 3890.7 3429.6 3429.8 3438.8 3441.2 3448.9 4678.3 4697.4 4700.4 4713.2 4724.0 4320.5 4367.5 4389.5 4417.4 4453.5 4912.8 5088.8 5091.3 5103.7 5127.7 3694.6 3699.5 3704.6 3706.7 3721.5 5344.6 5349.7 5351.1 5351.6 5365.7 3510.3 3696.2 3707.3 3719.0 3788.6 3749.5 3754.8 3758.0 3770.8 3777.0 4260.8 4266.1 4292.9 4298.9 4316.3 5006.4 5127.9 5141.0 5151.9 5197.4 1286.6 1290.9 1295.8 1300.2 1302.6 828.8 855.1 888.2 899.4 908.0 4449.9 4477.6 4519.4 4550.2 4559.0 5297.7 5320.1 5338.4 5357.4 5372.5 4422.8 4527.8 4527.9 4563.7 4571.2 2762.5 2779.6 2782.3 2787.0 2790.9 4869.2 4882.8 4883.7 4884.2 4884.3 4968.6 5237.8 5332.3 5352.8 5376.8 4824.5 4838.0 4840.6 4876.6 4896.3 5193.3 5230.5 5240.9 5242.0 5296.6 4923.8 5040.3 5120.7 5145.5 5172.5 4821.9 4836.8 4858.6 4877.4 4877.7 3622.9 3644.7 3653.1 3653.7 3674.7 4850.7 5232.4 5244.0 5268.1 5284.5 5048.4 5056.2 5060.6 5067.2 5104.5 5072.8 5089.9 5090.7 5091.9 5108.1 4798.3 4962.2 4992.5 4996.7 4998.3 4980.8 5046.4 5120.4 5172.3 5173.5 5013.8 5015.9 5040.2 5042.4 5045.2 07:00:30 INFO - PROCESS | 3486 | 07:00:30 INFO - PROCESS | 3486 | [#5] yui.html Cycles:180 Average:12557.76 Median:43468.67 stddev:14095.29 (32.4%) stddev-sans-first:14106.83 07:00:30 INFO - PROCESS | 3486 | Values: 727.6 730.6 781.7 798.3 803.1 11240.4 12411.4 12666.1 12696.0 12720.4 12493.8 12505.7 12536.5 12556.6 12609.7 670.2 829.2 836.6 847.9 849.7 843.6 854.3 855.2 857.9 858.7 904.0 905.4 907.3 907.5 908.1 885.1 888.7 889.3 889.6 895.5 665.6 666.0 666.2 666.8 667.1 11851.0 11874.3 11911.2 11918.9 11958.6 12572.2 12879.2 12916.4 12970.7 13240.1 10045.5 10117.9 10266.2 10290.8 10496.0 3233.2 3265.3 3280.6 3308.6 3354.2 43438.0 43499.3 43776.8 43878.1 44616.0 9818.9 9860.6 9952.7 10028.5 10041.4 18106.6 18149.5 18194.0 18303.4 18415.0 6348.0 6532.1 6727.3 6735.3 6958.4 3652.1 3718.7 3726.5 3806.0 3813.0 2780.7 2894.6 2897.8 2900.9 2901.4 518.3 534.2 536.7 545.9 550.9 486.2 491.7 511.9 552.1 574.6 7009.2 7075.2 7113.5 7208.9 7341.7 538.7 568.8 572.9 601.3 602.0 3325.6 3384.3 3404.9 3440.0 3443.5 50419.9 50712.0 50922.2 51175.5 51953.0 45298.3 45844.8 45979.0 46290.8 47639.5 43232.6 43254.4 43309.1 43547.3 43919.3 6548.1 6732.8 6763.0 6944.8 7073.7 27884.4 28519.9 29060.3 29079.3 29409.9 34352.3 35101.5 35300.8 36001.6 36505.0 10279.3 10460.6 10649.9 10944.3 11188.7 11275.2 11284.8 11485.5 11563.9 11783.8 11505.3 11920.3 11970.4 11987.4 12300.4 10650.7 11180.7 11236.7 11272.9 11546.9 10445.2 11103.2 11236.3 11363.1 11398.7 8945.6 9066.5 9276.4 9323.3 9515.2 8851.0 8948.8 8987.3 9307.3 9317.8 07:00:30 INFO - PROCESS | 3486 | -------- Summary: end -------- 07:00:30 INFO - PROCESS | 3486 | 07:00:31 INFO - TEST-INFO | 3486: exit 0 07:00:31 INFO - TEST-OK | dromaeo_css | took 1117216ms 07:00:31 INFO - TEST-START | kraken 07:00:31 INFO - operating with platform_type : linux_ 07:00:31 INFO - Initialising browser for kraken test... 07:00:31 INFO - TEST-INFO | started process 3715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP0XKly/profile http://localhost:56003/getInfo.html) 07:00:35 INFO - PROCESS | 3715 | 07:00:35 INFO - PROCESS | 3715 | (process:3781): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:00:36 INFO - PROCESS | 3715 | __metrics Screen width/height:1600/1200 07:00:36 INFO - PROCESS | 3715 | colorDepth:24 07:00:36 INFO - PROCESS | 3715 | Browser inner width/height: 1024/697 07:00:36 INFO - PROCESS | 3715 | __metrics 07:00:37 ERROR - PROCESS | 3715 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:00:38 INFO - TEST-INFO | 3715: exit 0 07:00:38 INFO - Browser initialized. 07:00:38 INFO - Running cycle 1/1 for kraken test... 07:00:38 INFO - TEST-INFO | started process 3832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP0XKly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:40 INFO - PROCESS | 3832 | 07:00:40 INFO - PROCESS | 3832 | (process:3892): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:00:50 INFO - PROCESS | 3832 | RSS: Main: 164274176 07:00:50 INFO - PROCESS | 3832 | 07:00:52 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56003/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:53 INFO - PROCESS | 3832 | RSS: Main: 168669184 07:00:53 INFO - PROCESS | 3832 | 07:00:56 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56003/tests/kraken/driver.html?testName=audio-dft) 07:00:57 INFO - PROCESS | 3832 | RSS: Main: 169140224 07:00:57 INFO - PROCESS | 3832 | 07:01:00 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56003/tests/kraken/driver.html?testName=audio-fft) 07:01:00 INFO - PROCESS | 3832 | RSS: Main: 164352000 07:01:00 INFO - PROCESS | 3832 | 07:01:02 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56003/tests/kraken/driver.html?testName=audio-oscillator) 07:01:03 INFO - PROCESS | 3832 | RSS: Main: 163749888 07:01:03 INFO - PROCESS | 3832 | 07:01:05 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56003/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:06 INFO - PROCESS | 3832 | RSS: Main: 164855808 07:01:06 INFO - PROCESS | 3832 | 07:01:09 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56003/tests/kraken/driver.html?testName=imaging-darkroom) 07:01:10 INFO - PROCESS | 3832 | RSS: Main: 164663296 07:01:10 INFO - PROCESS | 3832 | 07:01:13 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56003/tests/kraken/driver.html?testName=imaging-desaturate) 07:01:14 INFO - PROCESS | 3832 | RSS: Main: 163565568 07:01:14 INFO - PROCESS | 3832 | 07:01:17 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56003/tests/kraken/driver.html?testName=json-parse-financial) 07:01:17 INFO - PROCESS | 3832 | RSS: Main: 164147200 07:01:17 INFO - PROCESS | 3832 | 07:01:19 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56003/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:01:20 INFO - PROCESS | 3832 | RSS: Main: 164347904 07:01:20 INFO - PROCESS | 3832 | 07:01:22 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:22 INFO - PROCESS | 3832 | RSS: Main: 164421632 07:01:22 INFO - PROCESS | 3832 | 07:01:24 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:25 INFO - PROCESS | 3832 | RSS: Main: 165003264 07:01:25 INFO - PROCESS | 3832 | 07:01:28 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:01:29 INFO - PROCESS | 3832 | RSS: Main: 165048320 07:01:29 INFO - PROCESS | 3832 | 07:01:32 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:32 INFO - PROCESS | 3832 | RSS: Main: 165068800 07:01:32 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:56003/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56003/tests/kraken/driver.html?testName=ai-astar) 07:01:34 INFO - PROCESS | 3832 | RSS: Main: 166600704 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | __start_tp_report 07:01:34 INFO - PROCESS | 3832 | _x_x_mozilla_page_load 07:01:34 INFO - PROCESS | 3832 | _x_x_mozilla_page_load_details 07:01:34 INFO - PROCESS | 3832 | |i|pagename|runs| 07:01:34 INFO - PROCESS | 3832 | |0;ai-astar;110;114;107;114;115;113;108;113;114;115 07:01:34 INFO - PROCESS | 3832 | |1;audio-beat-detection;158;137;159;179;135;162;159;138;186;131 07:01:34 INFO - PROCESS | 3832 | |2;audio-dft;161;164;162;166;171;163;162;163;162;161 07:01:34 INFO - PROCESS | 3832 | |3;audio-fft;77;75;78;151;76;77;75;76;168;77 07:01:34 INFO - PROCESS | 3832 | |4;audio-oscillator;93;93;147;93;93;94;146;92;93;148 07:01:34 INFO - PROCESS | 3832 | |5;imaging-gaussian-blur;117;117;117;117;119;118;118;118;117;118 07:01:34 INFO - PROCESS | 3832 | |6;imaging-darkroom;147;147;148;146;147;148;147;147;150;148 07:01:34 INFO - PROCESS | 3832 | |7;imaging-desaturate;95;96;96;96;96;95;95;96;96;96 07:01:34 INFO - PROCESS | 3832 | |8;json-parse-financial;67;65;68;66;67;67;68;92;64;65 07:01:34 INFO - PROCESS | 3832 | |9;json-stringify-tinderbox;65;64;64;64;65;64;64;64;65;63 07:01:34 INFO - PROCESS | 3832 | |10;stanford-crypto-aes;83;86;82;83;84;83;85;88;85;82 07:01:34 INFO - PROCESS | 3832 | |11;stanford-crypto-ccm;143;144;148;137;135;138;135;135;213;145 07:01:34 INFO - PROCESS | 3832 | |12;stanford-crypto-pbkdf2;175;183;186;178;174;172;180;184;184;173 07:01:34 INFO - PROCESS | 3832 | |13;stanford-crypto-sha256-iterative;67;69;68;68;68;67;67;69;69;69 07:01:34 INFO - PROCESS | 3832 | __end_tp_report 07:01:34 INFO - PROCESS | 3832 | __start_cc_report 07:01:34 INFO - PROCESS | 3832 | _x_x_mozilla_cycle_collect,936 07:01:34 INFO - PROCESS | 3832 | __end_cc_report 07:01:34 INFO - PROCESS | 3832 | __startTimestamp1462543294681__endTimestamp 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | ------- Summary: start ------- 07:01:34 INFO - PROCESS | 3832 | Number of tests: 14 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:2.91 (2.6%) stddev-sans-first:2.96 07:01:34 INFO - PROCESS | 3832 | Values: 110.0 114.0 107.0 114.0 115.0 113.0 108.0 113.0 114.0 115.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:159.00 stddev:18.89 (11.9%) stddev-sans-first:19.99 07:01:34 INFO - PROCESS | 3832 | Values: 158.0 137.0 159.0 179.0 135.0 162.0 159.0 138.0 186.0 131.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.03 (1.9%) stddev-sans-first:3.07 07:01:34 INFO - PROCESS | 3832 | Values: 161.0 164.0 162.0 166.0 171.0 163.0 162.0 163.0 162.0 161.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:35.29 (46.1%) stddev-sans-first:36.95 07:01:34 INFO - PROCESS | 3832 | Values: 77.0 75.0 78.0 151.0 76.0 77.0 75.0 76.0 168.0 77.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:26.09 (28.1%) stddev-sans-first:27.01 07:01:34 INFO - PROCESS | 3832 | Values: 93.0 93.0 147.0 93.0 93.0 94.0 146.0 92.0 93.0 148.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 07:01:34 INFO - PROCESS | 3832 | Values: 117.0 117.0 117.0 117.0 119.0 118.0 118.0 118.0 117.0 118.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 07:01:34 INFO - PROCESS | 3832 | Values: 147.0 147.0 148.0 146.0 147.0 148.0 147.0 147.0 150.0 148.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:01:34 INFO - PROCESS | 3832 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:67.00 stddev:8.23 (12.3%) stddev-sans-first:8.70 07:01:34 INFO - PROCESS | 3832 | Values: 67.0 65.0 68.0 66.0 67.0 67.0 68.0 92.0 64.0 65.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 07:01:34 INFO - PROCESS | 3832 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 65.0 63.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.91 (2.3%) stddev-sans-first:1.99 07:01:34 INFO - PROCESS | 3832 | Values: 83.0 86.0 82.0 83.0 84.0 83.0 85.0 88.0 85.0 82.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:143.50 stddev:23.57 (16.4%) stddev-sans-first:24.94 07:01:34 INFO - PROCESS | 3832 | Values: 143.0 144.0 148.0 137.0 135.0 138.0 135.0 135.0 213.0 145.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:181.50 stddev:5.20 (2.9%) stddev-sans-first:5.32 07:01:34 INFO - PROCESS | 3832 | Values: 175.0 183.0 186.0 178.0 174.0 172.0 180.0 184.0 184.0 173.0 07:01:34 INFO - PROCESS | 3832 | 07:01:34 INFO - PROCESS | 3832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 07:01:34 INFO - PROCESS | 3832 | Values: 67.0 69.0 68.0 68.0 68.0 67.0 67.0 69.0 69.0 69.0 07:01:34 INFO - PROCESS | 3832 | -------- Summary: end -------- 07:01:34 INFO - PROCESS | 3832 | 07:01:35 INFO - TEST-INFO | 3832: exit 0 07:01:36 INFO - TEST-OK | kraken | took 64858ms 07:01:36 INFO - SUITE-END | took 1182s 07:01:36 INFO - Completed test suite (00:19:42) 07:01:36 INFO - javascript benchmark 07:01:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.405458771776, 2681.8390896546207, 2688.542947698891, 2692.380752426942, 2700.29792254014, 4687.742174180418, 4698.483166851648, 4717.150912835688, 4774.28385742138, 4840.757962101899, 4716.4340279166545, 4722.0, 4740.549647783464, 4749.287606858973, 4756.785944632491, 4316.287812510932, 4357.237483440385, 4442.044960333527, 4460.955390446103, 4465.084657645175, 4406.757628330441, 4519.954800452003, 4532.0, 4565.406497155382, 4619.353290539327, 4399.208142534342, 4403.823847046115, 4416.183006143874, 4435.423394958667, 4443.822247110112, 4424.269995450747, 4438.489573699034, 4450.777461126963, 4457.175422546807, 4491.910161796778, 4392.846250381222, 4404.273294906337, 4404.8458303959205, 4459.397981272519, 4466.7766611669285, 4541.72749635023, 4695.88260293492, 4754.619630429557, 4768.475467698585, 4771.212749896297, 5166.095933211673, 5187.403448603422, 5198.298229739013, 5219.8434046978655, 5245.86885327866, 5061.316722242524, 5207.114790485626, 5211.5049070338255, 5252.264682944391, 5256.185291279858, 4799.808007679689, 4812.181929072066, 4819.0843739689, 4824.95175048245, 4842.83050093245, 5276.63063585553, 5300.09898317287, 5321.5476684482255, 5327.786888524493, 5343.759530821122, 4872.829450969199, 4988.875278118004, 5083.822066227738, 5092.465291144451, 5094.643374963717, 5051.6716413433005, 5097.745112744348, 5100.617453690988, 5112.284280200774, 5153.845384638467, 4931.432885218246, 5046.62150338726, 5051.570616497565, 5073.1122053640465, 5107.540321371094, 4880.6583539152625, 5062.721550314768, 5068.16375298079, 5074.594032477393, 5133.435322114565, 4304.117655880537, 4327.956720432755, 4346.304591265382, 4371.30059190528, 4376.759278239664, 3799.981000095037, 3816.8774440054967, 3823.273578020223, 3844.3656796628243, 3845.038740314921, 4300.075483771005, 4421.5578442156175, 4428.822847086145, 4470.1059788041875, 4479.552044795494, 5169.4572069932865, 5198.324217851655, 5211.71335576547, 5244.160934250578, 5280.9471905281225, 4421.977890110529, 4481.036577135931, 4486.7756612169915, 4489.057297967398, 4521.3896124023495, 4497.640188784955, 4624.213883639789, 4656.185167595657, 4676.088162808288, 4707.223308154184, 4858.732769697701, 4868.148074087091, 4881.023795240966, 4896.338994235733, 4930.778114984762, 5154.690718556899, 5187.714675692722, 5214.322138122172, 5225.895482090261, 5277.8416647500635, 4641.18779213643, 4779.713217206979, 4802.591779698625, 4818.494058123846, 4827.3198173660085, 5125.846224613268, 5136.2552429898205, 5139.794408223629, 5140.228965655182, 5181.326427564392, 5211.895762084813, 5214.8957020860125, 5221.869453263699, 5223.843284701465, 5260.736963151904, 4882.072406242803, 4912.975435122801, 4922.803087876445, 4933.1613625683, 5075.670081444842, 4980.925286120783, 4996.550310472075, 5004.224345226496, 5007.499250075109, 5030.698158110525, 4906.264060390828, 4918.827841025547, 4922.92615610759, 4936.901261974668, 4951.801927922843, 4917.459079501324, 4996.625253105959, 5048.343715317133, 5070.923936141035, 5073.974630126826, 4928.334674818853, 4962.354893863775, 4968.527989840959, 4972.129877271391, 5012.172991456368], "value": 4722.14921758397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5277843001094, 600.6306121735134, 603.3242768099727, 616.8457885528618, 635.920509936258, 35873.820630896844, 39122.608773912325, 39359.0, 39431.211375772466, 39487.407688884654, 40074.7996260019, 40612.59387406133, 40627.39058914111, 40652.0, 40743.59256407435, 7752.302292793647, 7873.0, 7886.093099293597, 7893.723719669812, 7909.169537198598, 7782.455228134033, 7842.5294482330955, 7859.371250299991, 7861.724839630614, 7881.527108373487, 7840.921590784104, 7847.6860925562905, 7868.685252589889, 7900.32847207988, 7900.486468379566, 7840.960795196044, 7845.607719613997, 7869.645865936047, 7891.0, 7894.881576776353, 7654.770356889302, 7762.0, 7781.22187781223, 7789.532628042336, 7792.376609871253, 37251.813740931124, 37402.8129859349, 37802.62197378019, 37856.0, 37892.0, 3316.96683033169, 3319.452290372086, 3378.476336167898, 3451.741119416054, 3541.5750109986707, 29550.26124346887, 30229.244268893235, 30318.0, 30432.391352173054, 31056.0, 3321.800691958466, 3334.0831271400316, 3371.089805752458, 3386.8306584670668, 3411.9488207676904, 239797.0, 240795.0, 241176.0, 242355.0, 242599.0, 29341.706582934323, 53273.0, 53589.196162057604, 53621.73189134029, 53645.1953220702, 35703.4644480333, 35780.82109589488, 35877.82061089678, 36004.279914401566, 36012.279754404764, 14070.859291406954, 14209.573712788426, 14223.502177423741, 14302.427902883768, 14364.784528232085, 11724.237924534878, 11829.171957963032, 11849.822252666218, 11862.703432414259, 11911.285322880654, 8273.627686754111, 8317.376196785266, 8342.582870856433, 8346.791330216793, 8401.789955251168, 3313.801171929692, 3323.3519463704347, 3328.8834890778708, 3336.6996970272307, 3350.396928552835, 981.1758123176566, 1011.0445628880784, 1015.6699072801222, 1030.7886883188928, 1062.4156713807374, 29071.41857162845, 29494.11517654474, 29711.405771884874, 29713.0, 29829.850850745606, 1059.9470026498643, 1080.0882438084545, 1091.252492042953, 1100.7193165742844, 1137.3045881261464, 14536.27318634064, 14968.428315026984, 14985.999960283583, 15048.774268385983, 15107.0, 351011.0, 353376.0, 354856.0, 354951.0, 355466.0, 51115.233271500954, 51609.483905160465, 51744.0, 51832.0, 51927.0, 1301.5249433956537, 1325.0856908732944, 1334.8197993270785, 1346.5219846954385, 1347.9730405392033, 26497.0, 27868.721312786613, 28008.71991280061, 28105.859470703333, 28266.43467130687, 42950.0, 43020.35469468023, 43294.783526083425, 43304.0, 43407.34888976731, 302937.0, 304766.0, 305198.0, 305385.0, 307195.0, 23444.296671099895, 24066.15768448096, 25447.74552254528, 26090.86954565215, 26212.344691382867, 43365.566344336155, 44214.778926105166, 44232.0, 44736.552634473235, 44886.10227795361, 37252.62747372492, 37604.435933461566, 37675.05812354713, 38291.6170838288, 38497.0, 36316.81841590775, 37587.436188456646, 37773.62226377811, 38195.42706859455, 38507.0, 33301.50047749237, 36597.268054638225, 37875.431868521446, 38163.80918095392, 38869.61130388773, 33342.66657333493, 34786.30427391489, 35172.47241291332, 35238.647613523535, 35299.64700352964, 26337.736622634297, 26602.600960985215, 26676.733232667426, 26903.0, 26953.0], "value": 16936.613805086825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.85867799575175, 381.1481339206873, 384.5788861196989, 396.62915174312, 399.4168513969604, 15481.84518154818, 16943.745843812354, 17520.474385768415, 17535.12324383782, 17551.73672394915, 16834.24245908934, 17192.656146877056, 17580.736288955675, 17588.912055439705, 17636.294548218055, 4980.501949805027, 5111.722069482629, 5145.151050076733, 5157.149070403379, 5178.792848286064, 3637.727170462226, 5572.3034620672415, 5861.53107751381, 5871.794487192949, 5898.262717160355, 5690.687012214326, 5862.853428664275, 5871.794487192949, 5872.207252020965, 5893.116032595123, 5800.796972105956, 5828.708564571754, 5833.066709326508, 5834.649921004753, 5860.589758716891, 4554.203014472487, 4876.951230487685, 5107.642465027449, 5140.203268493389, 5141.845744627667, 12028.879711202864, 12256.0, 12498.500059997588, 12567.622971310875, 12600.558980435733, 1819.6269764698338, 1839.5309196154894, 1875.2405275863298, 1924.2591602233101, 2074.6369385357502, 8809.735707928709, 8812.427192232548, 9145.222656074242, 9353.859692104625, 9416.717498474989, 1632.8122265939332, 1656.9809567116258, 1687.7552754850478, 1727.8963262204309, 1772.0785191700243, 67024.0, 69164.6541767293, 69850.30149698489, 70300.0, 70906.0, 9852.753681157885, 10012.644499642678, 10080.193584513368, 10232.795344093225, 10358.585656573803, 14196.71606567863, 14209.431622735181, 14270.429182832571, 14284.714305714035, 14291.356888940023, 7382.114146302478, 7424.85150296991, 7478.439117066242, 7589.8861517077285, 7624.42816788743, 7163.570185788869, 7259.854802903912, 7323.121225452873, 7368.373688236453, 7398.297161769623, 4307.504636966726, 4342.739435633809, 4397.428334316583, 4417.734935903856, 4473.1277400907165, 1721.2082442076785, 1750.7986581543285, 1844.907754612264, 1852.3239017758422, 1857.6099019206117, 885.3050355471053, 914.0886277207117, 924.7272054743867, 968.9127978481971, 972.2610815779917, 16372.672546549002, 16805.663886722195, 17150.399736009178, 17329.133543322783, 17331.0, 932.7248461703814, 934.8831396075491, 935.854942483916, 965.7151140413595, 988.9011098890054, 9524.14282714559, 9647.517624118766, 9693.660721874701, 9748.171405430618, 9936.304458687822, 395976.0, 398924.0, 399033.0, 409858.0, 409866.0, 78407.60796195983, 79290.20709792944, 79669.20330796618, 80272.59863700761, 80400.0, 962.6197651927449, 974.6004138303404, 980.7401038724744, 989.8218320702342, 991.2664628175098, 15298.235088245321, 15435.459758908384, 15584.142872142142, 15637.843621564094, 15774.842251577338, 31936.68063319337, 32518.674813251564, 33767.32465350728, 35051.12372190614, 35075.82462087673, 50132.997340052265, 52104.0, 52120.436386908455, 52312.47687523076, 53034.2044869335, 6908.1019467468905, 7120.6795694194925, 7173.246809084971, 7615.619219039137, 8091.919080809352, 10192.439415832201, 12122.878771212176, 12220.205686630341, 12562.434690439135, 12744.362781860684, 7597.6581053853815, 10756.892431075588, 11015.733190683173, 11097.167712421762, 11158.163137764537, 10644.574217031231, 11037.448127593749, 11085.778284434105, 11149.0, 11150.107991360834, 10736.30214036085, 10876.673699789018, 10886.782264354826, 11060.225784195029, 11371.374574398487, 7868.488548244346, 7899.921000789918, 7995.12053674107, 8252.628631711708, 8264.173582641688, 9877.753056173653, 10512.474376281309, 10665.146788257076, 11158.274712143684, 11162.0], "value": 8255.29381880968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.6258435391148, 1522.9619259518513, 1725.6721222967635, 1851.25949620152, 1899.3257393625263, 6667.099941507895, 7414.703411863533, 7531.698732050718, 7877.054753429589, 7886.44794864359, 7514.3237108660205, 7673.232676732324, 7715.961420192891, 7729.149793522708, 7770.067591888981, 2161.081540345359, 2197.3847322749575, 2208.2271205078255, 2223.3885681437573, 2229.420350708819, 2209.62436385814, 2230.119102954332, 2281.6577513373045, 2284.1434462076722, 2285.874276914769, 2245.9887700561476, 2246.528229071897, 2247.2359397804826, 2261.513774538474, 2277.6925115109416, 2147.806697397234, 2148.2695883399565, 2151.967720484194, 2171.240065976903, 2177.292379976498, 2133.7439507259073, 2154.838387120972, 2172.4894649757293, 2175.3582693105573, 2175.5866385386726, 7740.148583655793, 7742.264484873928, 7788.221177882223, 7790.337821285198, 7807.609619519001, 4407.140607581523, 4463.464384273875, 4471.597556219956, 4495.325701144821, 4518.728876267434, 2708.7426694463993, 2792.2460935547288, 2862.726086891334, 2867.4695181391303, 2872.296287409598, 876.1151237250359, 908.7909780750398, 913.8126684029758, 931.0270767048384, 954.2270760683869, 10002.249831262612, 10097.24270679702, 10156.085952264331, 10171.389716617026, 10190.082892539633, 4017.417474466186, 4080.2451546463403, 4097.672186225095, 4115.403266526337, 4132.772697501606, 8890.377673562918, 8905.73282801517, 8916.242119419921, 8927.062658420902, 8932.41939273958, 4441.156180325793, 4452.621527170162, 4467.106578684276, 4535.0, 4539.818407263672, 3661.707063434919, 4034.9798251008556, 4068.7762173080764, 4120.443740095108, 4156.646685031746, 3655.2689462107683, 3669.633036696309, 3790.8104594770152, 3796.962030379716, 3803.410471376941, 1185.057878986208, 1232.0451649971164, 1234.6049264235357, 1237.6348977051791, 1241.6585439004346, 748.8464864702723, 796.3907610677836, 882.5366682491743, 901.8692289617969, 925.319889880937, 5019.924701129486, 5161.329027226437, 5193.844184674465, 5225.947740522623, 5293.682379057192, 404.83199472219286, 408.2182620282126, 410.83155906078366, 411.24331230535955, 416.64585102662494, 3607.639236076371, 3610.8736194233074, 3617.5116359291687, 3620.5836328822525, 3642.581103173116, 8665.263452606472, 8853.070427605138, 8980.55097245135, 9003.099690030944, 9032.63869445215, 8823.647054117764, 8884.111588841193, 8905.643774249087, 8913.5097569633, 8915.242204412569, 6884.690188941509, 7006.719731210796, 7074.893876591856, 7078.6106764127435, 7145.178304494945, 5093.923591146062, 5129.897402052013, 5144.845654630367, 5145.61407894402, 5169.147090729987, 8137.104918458846, 8227.095019547725, 8365.874511882204, 8373.288270496832, 8395.70615028471, 8313.958430207811, 8373.162683731578, 8424.663013479638, 8526.317894568296, 8531.573421328785, 6139.539534534839, 6340.841478963062, 6496.512761542997, 6611.570247933869, 6625.304343043911, 7359.37445317154, 7367.742129025459, 7413.443991700537, 7426.74006409773, 7427.554346739213, 6489.545731798728, 6662.400383965466, 6700.396964273239, 6727.024581435567, 6745.628990405575, 6531.248906375828, 6587.835304117244, 6645.169353830771, 6703.631300278532, 6806.319368063154, 6297.590656607306, 6352.301246862934, 6364.96817515928, 6366.490680745622, 6366.777162799465, 4288.914221715486, 4319.784010799511, 4416.889577760582, 4453.042595841909, 4493.213687604722, 4631.374764406762, 4654.883627909329, 4684.367610372692, 4704.388429504143, 4742.66801323904], "value": 4008.4556439615203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7257468278549, 312.2163369941446, 312.82169163576754, 314.63973750056186, 316.86849957267736, 4965.528274813892, 4994.1759609664405, 5022.321986531817, 5041.798328066878, 5048.949510504894, 4930.277640381507, 4931.3835770528685, 4933.45731969483, 4939.259111133332, 4967.577755890745, 3712.2389910068505, 3728.850845966158, 3854.8843534694006, 3873.3221686204943, 3874.9418758718643, 3870.1485673152, 3880.3597406427907, 3886.533615966088, 3894.9026274343087, 3914.862979795708, 3863.690904727615, 3876.089119057019, 3881.4371916072155, 3885.6308650678284, 3907.882763517099, 3789.677877380426, 3882.7476214045996, 3886.31989401855, 3888.4556162137324, 3890.6966166334314, 3429.605595356541, 3429.794212347242, 3438.8108654024018, 3441.174118211636, 3448.913777155566, 4678.345031695565, 4697.379404105578, 4700.42767496705, 4713.175194340976, 4723.95276047242, 4320.524742278347, 4367.497737760166, 4389.5390983946545, 4417.3815665806815, 4453.465584129893, 4912.803487860481, 5088.821891233826, 5091.3126727892, 5103.744812759384, 5127.692338459704, 3694.64900834423, 3699.5005674233903, 3704.592494825594, 3706.6664000240107, 3721.4603882437164, 5344.5724342052545, 5349.7057661828585, 5351.143816989302, 5351.625386222966, 5365.704886231256, 3510.315488479773, 3696.1868388954385, 3707.258548290353, 3718.9814050930113, 3788.6021967692996, 3749.4750734897134, 3754.7747135171976, 3758.0229140423685, 3770.792606406619, 3777.017975326435, 4260.786960651955, 4266.146770645883, 4292.914141717149, 4298.871033868989, 4316.266234740102, 5006.3992320921725, 5127.8718032048755, 5141.0, 5151.896962060738, 5197.428282888879, 1286.5882917466508, 1290.8838204561634, 1295.7667619828333, 1300.232862611064, 1302.6027061746258, 828.846663367279, 855.1064137975831, 888.1562515610196, 899.3569597737518, 908.0, 4449.866504004885, 4477.649234152096, 4519.389882365905, 4550.180967425829, 4558.9772051139535, 5297.708626025606, 5320.058178764801, 5338.386085600206, 5357.4106848246665, 5372.5433338166695, 4422.778861056934, 4527.7509736964785, 4527.909441811145, 4563.748993805306, 4571.177188106173, 2762.4613200426124, 2779.610854480374, 2782.3461486550646, 2786.9688215360447, 2790.860456977143, 4869.196582563908, 4882.7558622068755, 4883.706977581356, 4884.1941079722155, 4884.3161957326, 4968.552830245295, 5237.790488380499, 5332.306800116037, 5352.785888564492, 5376.811811586654, 4824.49342819006, 4837.95162048382, 4840.620423179377, 4876.5854902333695, 4896.314515967696, 5193.272941788077, 5230.476952304739, 5240.947590524046, 5241.959663395145, 5296.576273898002, 4923.753812309298, 5040.269160971712, 5120.71836049006, 5145.45972672864, 5172.5344718975475, 4821.855344339676, 4836.830710925242, 4858.562729354375, 4877.365942427462, 4877.6585639004925, 3622.873199438007, 3644.6902013329163, 3653.141511744791, 3653.707703383776, 3674.669279764834, 4850.708957462563, 5232.398274198364, 5244.0, 5268.078086334953, 5284.524392804666, 5048.419431765247, 5056.154503606231, 5060.645754797129, 5067.214581739836, 5104.540591346797, 5072.771725272298, 5089.898202035864, 5090.650977490894, 5091.949080509147, 5108.10608143566, 4798.280257961194, 4962.163999320274, 4992.455356696786, 4996.725180114983, 4998.3252260945765, 4980.825671101494, 5046.359933021709, 5120.385553733576, 5172.301739265151, 5173.534381905646, 5013.799448022039, 5015.924761128659, 5040.243963405518, 5042.445331013659, 5045.167547354646], "value": 3857.70326301609, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.5852763924563, 730.5908691132965, 781.6756046240811, 798.2815466080531, 803.060419309408, 11240.437978101092, 12411.379431028447, 12666.113372063948, 12696.047796415283, 12720.36398180092, 12493.750124997494, 12505.68735781606, 12536.498540058386, 12556.560520381789, 12609.684757881058, 670.1957650819037, 829.179112678447, 836.6486075848159, 847.9194476524721, 849.7493239494333, 843.5908584336592, 854.2653318146389, 855.2345650642671, 857.8713193021034, 858.6779957515931, 903.9502827344494, 905.3888625177979, 907.3376435202306, 907.4600612635471, 908.0692290402358, 885.0839381240418, 888.6756333938131, 889.2796834564024, 889.6263569300909, 895.5298468304127, 665.6039656404431, 665.9933400666029, 666.243813271935, 666.7899611622323, 667.1160712056496, 11851.0, 11874.287542747463, 11911.166218364719, 11918.940405298004, 11958.64124076279, 12572.182808117443, 12879.227246365155, 12916.41876115577, 12970.675733106653, 13240.073194876362, 10045.547950342252, 10117.949410252975, 10266.230032747573, 10290.794184116276, 10496.0, 3233.2401885556874, 3265.2653153040615, 3280.5899262592175, 3308.586426696663, 3354.2452948086484, 43438.0, 43499.34750978738, 43776.781116094215, 43878.12243755107, 44616.0, 9818.852717209247, 9860.556274967643, 9952.701418957442, 10028.548715307828, 10041.397516149054, 18106.63786724258, 18149.546261343574, 18194.0, 18303.35938242155, 18415.0, 6347.987010719707, 6532.052852336385, 6727.29363416844, 6735.259121496631, 6958.37374636275, 3652.141746689526, 3718.665320121202, 3726.5341832270965, 3805.961940380616, 3813.0276779421624, 2780.6802217745217, 2894.6236989191693, 2897.753690936294, 2900.8984685535906, 2901.434220327016, 518.3391176250236, 534.2120372450604, 536.6860386673761, 545.9044667183227, 550.8705454218256, 486.1710783114781, 491.6533843640225, 511.9411267704262, 552.1303946284618, 574.5834270154188, 7009.228984811667, 7075.2217256101785, 7113.502054856214, 7208.891866622005, 7341.70633174667, 538.7387117248131, 568.8037627018672, 572.8882867840814, 601.3265143039823, 601.9608725432832, 3325.617553981275, 3384.2892992471857, 3404.897853064412, 3439.9828000860334, 3443.500692399588, 50419.88327992361, 50712.0, 50922.23616645753, 51175.48824511782, 51953.0, 45298.320525192146, 45844.7707761459, 45979.0, 46290.76854615705, 47639.5236047642, 43232.567674322854, 43254.35118473225, 43309.13381732411, 43547.346789798175, 43919.34120988188, 6548.116004339353, 6732.798016059526, 6763.0, 6944.791656250321, 7073.717051318095, 27884.442311153256, 28519.857400713692, 29060.27349316284, 29079.273018174714, 29409.85295073511, 34352.31295374128, 35101.47347789734, 35300.82349588236, 36001.63998360088, 36505.0, 10279.331843430153, 10460.581576736846, 10649.8935010652, 10944.343339399662, 11188.72028199269, 11275.182413053713, 11284.830727538929, 11485.48315325829, 11563.942180289045, 11783.823242651195, 11505.252158609663, 11920.344381058778, 11970.401479925795, 11987.40062996864, 12300.446479908247, 10650.658788305256, 11180.664580062612, 11236.661642426907, 11272.887271127513, 11546.94226528862, 10445.182592682395, 11103.222774405715, 11236.269642473213, 11363.147763917574, 11398.715032123931, 8945.552722363725, 9066.456012639263, 9276.397034192756, 9323.300752443729, 9515.191208747057, 8850.955745221232, 8948.821023579621, 8987.263558629373, 9307.255419566554, 9317.767055823659], "value": 5899.672398153639, "unit": "score"}], "name": "dromaeo_css", "value": 6261.045544371885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 107.0, 114.0, 115.0, 113.0, 108.0, 113.0, 114.0, 115.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 137.0, 159.0, 179.0, 135.0, 162.0, 159.0, 138.0, 186.0, 131.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 166.0, 171.0, 163.0, 162.0, 163.0, 162.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 151.0, 76.0, 77.0, 75.0, 76.0, 168.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 147.0, 93.0, 93.0, 94.0, 146.0, 92.0, 93.0, 148.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 147.0, 150.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 68.0, 66.0, 67.0, 67.0, 68.0, 92.0, 64.0, 65.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 82.0, 83.0, 84.0, 83.0, 85.0, 88.0, 85.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 148.0, 137.0, 135.0, 138.0, 135.0, 135.0, 213.0, 145.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 183.0, 186.0, 178.0, 174.0, 172.0, 180.0, 184.0, 184.0, 173.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0, 69.0, 69.0, 69.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1604.7, "alertThreshold": 2.0}]} 07:01:36 INFO - Return code: 0 07:01:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:01:36 ERROR - # TBPL SUCCESS # 07:01:36 INFO - Running post-action listener: _resource_record_post_action 07:01:36 INFO - ##### 07:01:36 INFO - ##### Finished run-tests step (success) 07:01:36 INFO - ##### 07:01:36 INFO - Running post-run listener: _resource_record_post_run 07:01:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7671808; Write bytes: 416849920; Read time: 960; Write time: 300728 07:01:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99827712; Read time: 0; Write time: 78612 07:01:38 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5910528; Write bytes: 317022208; Read time: 920; Write time: 222116 07:01:38 INFO - Running post-run listener: _upload_blobber_files 07:01:38 INFO - Blob upload gear active. 07:01:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:01:38 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 07:01:38 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'] 07:01:38 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 07:01:38 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:01:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:01:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:39 INFO - (blobuploader) - INFO - Done attempting. 07:01:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:01:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:40 INFO - (blobuploader) - INFO - Done attempting. 07:01:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:01:40 INFO - Return code: 0 07:01:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:01:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:01:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b588cdb50cffe4da0c3c395ea8acb2fee3ac33bbdd70301ed5ceb946a834d8ff2c1c8ad45a594cff7a9b4d0d794f23f62f67aa6ad75c41563cdec4525cb20d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6cd7bafd09d8e5885eed16adc1c23315657cb69ef974992ed1e848a5e6285fd0512d8e476aea3fa4a0422d7e4c57e9e0d9feba144df95c5c4d7422a68d41ad0"} 07:01:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:01:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:01:40 INFO - Contents: 07:01:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b588cdb50cffe4da0c3c395ea8acb2fee3ac33bbdd70301ed5ceb946a834d8ff2c1c8ad45a594cff7a9b4d0d794f23f62f67aa6ad75c41563cdec4525cb20d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6cd7bafd09d8e5885eed16adc1c23315657cb69ef974992ed1e848a5e6285fd0512d8e476aea3fa4a0422d7e4c57e9e0d9feba144df95c5c4d7422a68d41ad0"} 07:01:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:01:40 INFO - Copying logs to upload dir... 07:01:40 INFO - mkdir: /builds/slave/test/build/upload/logs 07:01:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.397123 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-06 07:01:40.090993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 07:01:40.094308) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160 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/b588cdb50cffe4da0c3c395ea8acb2fee3ac33bbdd70301ed5ceb946a834d8ff2c1c8ad45a594cff7a9b4d0d794f23f62f67aa6ad75c41563cdec4525cb20d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6cd7bafd09d8e5885eed16adc1c23315657cb69ef974992ed1e848a5e6285fd0512d8e476aea3fa4a0422d7e4c57e9e0d9feba144df95c5c4d7422a68d41ad0"} build_url:https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/WrCZtJsYSPGw5gE2Q-xWLg/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/b588cdb50cffe4da0c3c395ea8acb2fee3ac33bbdd70301ed5ceb946a834d8ff2c1c8ad45a594cff7a9b4d0d794f23f62f67aa6ad75c41563cdec4525cb20d1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6cd7bafd09d8e5885eed16adc1c23315657cb69ef974992ed1e848a5e6285fd0512d8e476aea3fa4a0422d7e4c57e9e0d9feba144df95c5c4d7422a68d41ad0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 07:01:40.122330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:01:40.122922) ========= 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=20e666a3d4cfbb71505a330e000001b4-1462538806.744560-1300185160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 07:01:40.206160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 07:01:40.206725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 07:01:40.207096) ========= ========= Total master_lag: 0.18 =========