builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1462990009.18 results: success (0) buildid: 20160511083011 builduid: 786dd399228846839a4ac8f8fbb9a1f1 revision: a67f6710c37cce1c11882eceefceaaef0b5a9076 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.185380) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.186018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.186409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.203522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.203936) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 11:06:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.18M=0.01s 2016-05-11 11:06:49 (1.18 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115995 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.333407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.333756) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022710 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.383394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:49.383762) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a67f6710c37cce1c11882eceefceaaef0b5a9076 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a67f6710c37cce1c11882eceefceaaef0b5a9076 --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=82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 11:06:49,747 truncating revision to first 12 chars 2016-05-11 11:06:49,747 Setting DEBUG logging. 2016-05-11 11:06:49,747 attempt 1/10 2016-05-11 11:06:49,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a67f6710c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 11:06:50,223 unpacking tar archive at: fx-team-a67f6710c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773449 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:50.170631) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:50.171023) ========= script_repo_revision: a67f6710c37cce1c11882eceefceaaef0b5a9076 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:50.171462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:50.171819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 11:06:50.180899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-11 11:06:50.181261) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:50 INFO - MultiFileLogger online at 20160511 11:06:50 in /builds/slave/test 11:06:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:06:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:50 INFO - {'append_to_log': False, 11:06:50 INFO - 'base_work_dir': '/builds/slave/test', 11:06:50 INFO - 'blob_upload_branch': 'Fx-Team', 11:06:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:50 INFO - 'branch': 'Fx-Team', 11:06:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:50 INFO - 'config_files': ('talos/linux_config.py',), 11:06:50 INFO - 'default_actions': ('clobber', 11:06:50 INFO - 'read-buildbot-config', 11:06:50 INFO - 'download-and-extract', 11:06:50 INFO - 'populate-webroot', 11:06:50 INFO - 'create-virtualenv', 11:06:50 INFO - 'install', 11:06:50 INFO - 'run-tests'), 11:06:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:50 INFO - 'download_minidump_stackwalk': True, 11:06:50 INFO - 'download_symbols': 'ondemand', 11:06:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:50 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:50 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:50 INFO - 'installer_path': 'installer.exe', 11:06:50 INFO - 'log_level': 'info', 11:06:50 INFO - 'log_name': 'talos', 11:06:50 INFO - 'log_to_console': True, 11:06:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:50 INFO - 'opt_config_files': (), 11:06:50 INFO - 'pip_index': False, 11:06:50 INFO - 'sps_profile': False, 11:06:50 INFO - 'sps_profile_interval': 0, 11:06:50 INFO - 'suite': 'dromaeojs-e10s', 11:06:50 INFO - 'system_bits': '32', 11:06:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:50 INFO - 'title': 'talos-linux64-ix-066', 11:06:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:50 INFO - 'use_talos_json': True, 11:06:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:50 INFO - 'work_dir': 'build'} 11:06:50 INFO - ##### 11:06:50 INFO - ##### Running clobber step. 11:06:50 INFO - ##### 11:06:50 INFO - Running pre-action listener: _resource_record_pre_action 11:06:50 INFO - Running main action method: clobber 11:06:50 INFO - rmtree: /builds/slave/test/build 11:06:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:51 INFO - Running post-action listener: _resource_record_post_action 11:06:51 INFO - ##### 11:06:51 INFO - ##### Finished clobber step (success) 11:06:51 INFO - ##### 11:06:51 INFO - ##### 11:06:51 INFO - ##### Running read-buildbot-config step. 11:06:51 INFO - ##### 11:06:51 INFO - Running pre-action listener: _resource_record_pre_action 11:06:51 INFO - Running main action method: read_buildbot_config 11:06:51 INFO - Using buildbot properties: 11:06:51 INFO - { 11:06:51 INFO - "project": "", 11:06:51 INFO - "product": "firefox", 11:06:51 INFO - "script_repo_revision": "production", 11:06:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:06:51 INFO - "repository": "", 11:06:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:06:51 INFO - "buildid": "20160511083011", 11:06:51 INFO - "pgo_build": "True", 11:06:51 INFO - "basedir": "/builds/slave/test", 11:06:51 INFO - "buildnumber": 314, 11:06:51 INFO - "slavename": "talos-linux64-ix-066", 11:06:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:06:51 INFO - "platform": "ubuntu64_hw", 11:06:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:06:51 INFO - "branch": "fx-team", 11:06:51 INFO - "repo_path": "integration/fx-team", 11:06:51 INFO - "revision": "a67f6710c37cce1c11882eceefceaaef0b5a9076", 11:06:51 INFO - "stage_platform": "linux64-pgo", 11:06:51 INFO - "builduid": "786dd399228846839a4ac8f8fbb9a1f1", 11:06:51 INFO - "slavebuilddir": "test" 11:06:51 INFO - } 11:06:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:06:51 INFO - Running post-action listener: _resource_record_post_action 11:06:51 INFO - ##### 11:06:51 INFO - ##### Finished read-buildbot-config step (success) 11:06:51 INFO - ##### 11:06:51 INFO - ##### 11:06:51 INFO - ##### Running download-and-extract step. 11:06:51 INFO - ##### 11:06:51 INFO - Running pre-action listener: _resource_record_pre_action 11:06:51 INFO - Running main action method: download_and_extract 11:06:51 INFO - mkdir: /builds/slave/test/build/tests 11:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:51 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:51 INFO - Downloaded 1361 bytes. 11:06:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:06:51 INFO - Using the following test package requirements: 11:06:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:06:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'jsshell-linux-x86_64.zip'], 11:06:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:06:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:06:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:51 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:52 INFO - Downloaded 23903031 bytes. 11:06:52 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'] 11:06:52 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 11:06:54 INFO - Return code: 0 11:06:54 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 11:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:54 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:06:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:57 INFO - Downloaded 23903031 bytes. 11:06:57 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'] 11:06:57 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 11:06:58 INFO - Return code: 0 11:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:58 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:59 INFO - Downloaded 10840152 bytes. 11:06:59 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'] 11:06:59 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 11:06:59 INFO - Return code: 0 11:06:59 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')]} 11:06:59 INFO - https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bx-O2C0HRQuDuXptOO-Rvg/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 11:07:01 INFO - Downloaded 58333367 bytes. 11:07:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:01 INFO - mkdir: /builds/slave/test/properties 11:07:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:01 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:01 INFO - Contents: 11:07:01 INFO - build_url:https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:07:01 INFO - Running post-action listener: _resource_record_post_action 11:07:01 INFO - Running post-action listener: set_extra_try_arguments 11:07:01 INFO - ##### 11:07:01 INFO - ##### Finished download-and-extract step (success) 11:07:01 INFO - ##### 11:07:01 INFO - ##### 11:07:01 INFO - ##### Running populate-webroot step. 11:07:01 INFO - ##### 11:07:01 INFO - Running pre-action listener: _resource_record_pre_action 11:07:01 INFO - Running main action method: populate_webroot 11:07:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:01 INFO - '--tppagecycles', 11:07:01 INFO - '7'], 11:07:01 INFO - 'tests': ['tsvgm']}}, 11:07:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['damp', 'tps']}, 11:07:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'tests': ['damp', 'tps']}, 11:07:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['dromaeo_dom']}, 11:07:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['a11yr', 11:07:01 INFO - 'ts_paint', 11:07:01 INFO - 'tpaint', 11:07:01 INFO - 'sessionrestore', 11:07:01 INFO - 'sessionrestore_no_auto_restore', 11:07:01 INFO - 'tabpaint']}, 11:07:01 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:01 INFO - 'ts_paint', 11:07:01 INFO - 'tpaint', 11:07:01 INFO - 'sessionrestore', 11:07:01 INFO - 'sessionrestore_no_auto_restore', 11:07:01 INFO - 'tabpaint']}, 11:07:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:01 INFO - 'ts_paint', 11:07:01 INFO - 'tpaint', 11:07:01 INFO - 'sessionrestore', 11:07:01 INFO - 'sessionrestore_no_auto_restore', 11:07:01 INFO - 'tabpaint']}, 11:07:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:01 INFO - 'ts_paint', 11:07:01 INFO - 'tpaint', 11:07:01 INFO - 'sessionrestore', 11:07:01 INFO - 'sessionrestore_no_auto_restore', 11:07:01 INFO - 'tabpaint']}, 11:07:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['a11yr', 11:07:01 INFO - 'ts_paint', 11:07:01 INFO - 'tpaint', 11:07:01 INFO - 'sessionrestore', 11:07:01 INFO - 'sessionrestore_no_auto_restore', 11:07:01 INFO - 'tabpaint']}, 11:07:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['a11yr', 11:07:01 INFO - 'ts_paint', 11:07:01 INFO - 'tpaint', 11:07:01 INFO - 'sessionrestore', 11:07:01 INFO - 'sessionrestore_no_auto_restore', 11:07:01 INFO - 'tabpaint']}, 11:07:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['tsvgx', 11:07:01 INFO - 'tsvgr_opacity', 11:07:01 INFO - 'tart', 11:07:01 INFO - 'tscrollx', 11:07:01 INFO - 'cart']}, 11:07:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:01 INFO - 'tsvgr_opacity', 11:07:01 INFO - 'tart', 11:07:01 INFO - 'tscrollx', 11:07:01 INFO - 'cart']}, 11:07:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'talos_options': ['--disable-e10s'], 11:07:01 INFO - 'tests': ['tp5o']}, 11:07:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'tests': ['tp5o']}, 11:07:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'talos_options': ['--disable-e10s', 11:07:01 INFO - '--xperf_path', 11:07:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:01 INFO - 'tests': ['tp5n']}, 11:07:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:01 INFO - 'talos_options': ['--xperf_path', 11:07:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:01 INFO - 'tests': ['tp5n']}}, 11:07:01 INFO - 'talos.zip': {'path': '', 11:07:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:01 INFO - Running post-action listener: _resource_record_post_action 11:07:01 INFO - ##### 11:07:01 INFO - ##### Finished populate-webroot step (success) 11:07:01 INFO - ##### 11:07:01 INFO - ##### 11:07:01 INFO - ##### Running create-virtualenv step. 11:07:01 INFO - ##### 11:07:01 INFO - Running pre-action listener: _resource_record_pre_action 11:07:01 INFO - Running main action method: create_virtualenv 11:07:01 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:07:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:02 INFO - Using real prefix '/usr' 11:07:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:04 INFO - Installing pip.................done. 11:07:04 INFO - Return code: 0 11:07:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:04 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')]} 11:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:04 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')]} 11:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:04 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:04 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 11:07:04 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 11:07:04 INFO - Using env: {'DISPLAY': ':0', 11:07:04 INFO - 'HOME': '/home/cltbld', 11:07:04 INFO - 'LANG': 'en_US.UTF-8', 11:07:04 INFO - 'LANGUAGE': 'en_US:en', 11:07:04 INFO - 'LOGNAME': 'cltbld', 11:07:04 INFO - 'MAIL': '/var/mail/cltbld', 11:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:04 INFO - 'MOZ_NO_REMOTE': '1', 11:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:04 INFO - 'NO_EM_RESTART': '1', 11:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:04 INFO - 'PWD': '/builds/slave/test', 11:07:04 INFO - 'SHELL': '/bin/bash', 11:07:04 INFO - 'SHLVL': '1', 11:07:04 INFO - 'TERM': 'linux', 11:07:04 INFO - 'TMOUT': '86400', 11:07:04 INFO - 'USER': 'cltbld', 11:07:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:04 INFO - '_': '/tools/buildbot/bin/python'} 11:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:04 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 11:07:04 INFO - Cleaning up... 11:07:04 INFO - Return code: 0 11:07:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:07:04 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')]} 11:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:04 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')]} 11:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:04 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:04 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 11:07:04 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 11:07:04 INFO - Using env: {'DISPLAY': ':0', 11:07:04 INFO - 'HOME': '/home/cltbld', 11:07:04 INFO - 'LANG': 'en_US.UTF-8', 11:07:04 INFO - 'LANGUAGE': 'en_US:en', 11:07:04 INFO - 'LOGNAME': 'cltbld', 11:07:04 INFO - 'MAIL': '/var/mail/cltbld', 11:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:04 INFO - 'MOZ_NO_REMOTE': '1', 11:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:04 INFO - 'NO_EM_RESTART': '1', 11:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:04 INFO - 'PWD': '/builds/slave/test', 11:07:04 INFO - 'SHELL': '/bin/bash', 11:07:04 INFO - 'SHLVL': '1', 11:07:04 INFO - 'TERM': 'linux', 11:07:04 INFO - 'TMOUT': '86400', 11:07:04 INFO - 'USER': 'cltbld', 11:07:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:04 INFO - '_': '/tools/buildbot/bin/python'} 11:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:04 INFO - Downloading/unpacking psutil>=0.7.1 11:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:06 INFO - Installing collected packages: psutil 11:07:06 INFO - Running setup.py install for psutil 11:07:07 INFO - building 'psutil._psutil_linux' extension 11:07:07 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 11:07:07 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 11:07:07 INFO - building 'psutil._psutil_posix' extension 11:07:07 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 11:07:07 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 11:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:07 INFO - Successfully installed psutil 11:07:07 INFO - Cleaning up... 11:07:07 INFO - Return code: 0 11:07:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:07:07 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')]} 11:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:07 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')]} 11:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:07 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:07 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 11:07:07 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 11:07:07 INFO - Using env: {'DISPLAY': ':0', 11:07:07 INFO - 'HOME': '/home/cltbld', 11:07:07 INFO - 'LANG': 'en_US.UTF-8', 11:07:07 INFO - 'LANGUAGE': 'en_US:en', 11:07:07 INFO - 'LOGNAME': 'cltbld', 11:07:07 INFO - 'MAIL': '/var/mail/cltbld', 11:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:07 INFO - 'MOZ_NO_REMOTE': '1', 11:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:07 INFO - 'NO_EM_RESTART': '1', 11:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:07 INFO - 'PWD': '/builds/slave/test', 11:07:07 INFO - 'SHELL': '/bin/bash', 11:07:07 INFO - 'SHLVL': '1', 11:07:07 INFO - 'TERM': 'linux', 11:07:07 INFO - 'TMOUT': '86400', 11:07:07 INFO - 'USER': 'cltbld', 11:07:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:07 INFO - '_': '/tools/buildbot/bin/python'} 11:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:07:09 INFO - Installing collected packages: mozsystemmonitor 11:07:09 INFO - Running setup.py install for mozsystemmonitor 11:07:09 INFO - Successfully installed mozsystemmonitor 11:07:09 INFO - Cleaning up... 11:07:09 INFO - Return code: 0 11:07:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:09 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:09 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 11:07:09 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 11:07:09 INFO - Using env: {'DISPLAY': ':0', 11:07:09 INFO - 'HOME': '/home/cltbld', 11:07:09 INFO - 'LANG': 'en_US.UTF-8', 11:07:09 INFO - 'LANGUAGE': 'en_US:en', 11:07:09 INFO - 'LOGNAME': 'cltbld', 11:07:09 INFO - 'MAIL': '/var/mail/cltbld', 11:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:09 INFO - 'MOZ_NO_REMOTE': '1', 11:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:09 INFO - 'NO_EM_RESTART': '1', 11:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:09 INFO - 'PWD': '/builds/slave/test', 11:07:09 INFO - 'SHELL': '/bin/bash', 11:07:09 INFO - 'SHLVL': '1', 11:07:09 INFO - 'TERM': 'linux', 11:07:09 INFO - 'TMOUT': '86400', 11:07:09 INFO - 'USER': 'cltbld', 11:07:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:09 INFO - '_': '/tools/buildbot/bin/python'} 11:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 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 11:07:12 INFO - Downloading docopt-0.6.1.tar.gz 11:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:12 INFO - Running setup.py install for blobuploader 11:07:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:12 INFO - Running setup.py install for requests 11:07:13 INFO - Running setup.py install for docopt 11:07:13 INFO - Successfully installed blobuploader requests docopt 11:07:13 INFO - Cleaning up... 11:07:13 INFO - Return code: 0 11:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:13 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')]} 11:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:13 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')]} 11:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:13 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:13 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 11:07:13 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 11:07:13 INFO - Using env: {'DISPLAY': ':0', 11:07:13 INFO - 'HOME': '/home/cltbld', 11:07:13 INFO - 'LANG': 'en_US.UTF-8', 11:07:13 INFO - 'LANGUAGE': 'en_US:en', 11:07:13 INFO - 'LOGNAME': 'cltbld', 11:07:13 INFO - 'MAIL': '/var/mail/cltbld', 11:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:13 INFO - 'MOZ_NO_REMOTE': '1', 11:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:13 INFO - 'NO_EM_RESTART': '1', 11:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:13 INFO - 'PWD': '/builds/slave/test', 11:07:13 INFO - 'SHELL': '/bin/bash', 11:07:13 INFO - 'SHLVL': '1', 11:07:13 INFO - 'TERM': 'linux', 11:07:13 INFO - 'TMOUT': '86400', 11:07:13 INFO - 'USER': 'cltbld', 11:07:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:13 INFO - '_': '/tools/buildbot/bin/python'} 11:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:13 INFO - Running setup.py (path:/tmp/pip-Xn7ljA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:13 INFO - Running setup.py (path:/tmp/pip-3rbIzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:13 INFO - Running setup.py (path:/tmp/pip-gwjrPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:13 INFO - Running setup.py (path:/tmp/pip-HZ5Sbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:13 INFO - Running setup.py (path:/tmp/pip-rpyNVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:13 INFO - Running setup.py (path:/tmp/pip-7iG6is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:13 INFO - Running setup.py (path:/tmp/pip-iZaQOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:13 INFO - Running setup.py (path:/tmp/pip-E7YuUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:13 INFO - Running setup.py (path:/tmp/pip-DOqkpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:14 INFO - Running setup.py (path:/tmp/pip-2D3B28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:14 INFO - Running setup.py (path:/tmp/pip-xRnxLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:14 INFO - Running setup.py (path:/tmp/pip-PYqWOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:14 INFO - Running setup.py (path:/tmp/pip-Q2YoW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:14 INFO - Running setup.py (path:/tmp/pip-AHt6Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:14 INFO - Running setup.py (path:/tmp/pip-y9BV2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:14 INFO - Running setup.py (path:/tmp/pip-Off24z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:14 INFO - Running setup.py (path:/tmp/pip-yRNJdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:14 INFO - Running setup.py install for manifestparser 11:07:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:14 INFO - Running setup.py install for mozcrash 11:07:14 INFO - Running setup.py install for mozdebug 11:07:14 INFO - Running setup.py install for mozdevice 11:07:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for mozfile 11:07:15 INFO - Running setup.py install for mozhttpd 11:07:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for mozinfo 11:07:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for mozInstall 11:07:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for mozleak 11:07:15 INFO - Running setup.py install for mozlog 11:07:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for moznetwork 11:07:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for mozprocess 11:07:15 INFO - Running setup.py install for mozprofile 11:07:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:15 INFO - Running setup.py install for mozrunner 11:07:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:16 INFO - Running setup.py install for mozscreenshot 11:07:16 INFO - Running setup.py install for moztest 11:07:16 INFO - Running setup.py install for mozversion 11:07:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:16 INFO - Cleaning up... 11:07:16 INFO - Return code: 0 11:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:16 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:16 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 11:07:16 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 11:07:16 INFO - Using env: {'DISPLAY': ':0', 11:07:16 INFO - 'HOME': '/home/cltbld', 11:07:16 INFO - 'LANG': 'en_US.UTF-8', 11:07:16 INFO - 'LANGUAGE': 'en_US:en', 11:07:16 INFO - 'LOGNAME': 'cltbld', 11:07:16 INFO - 'MAIL': '/var/mail/cltbld', 11:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:16 INFO - 'MOZ_NO_REMOTE': '1', 11:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:16 INFO - 'NO_EM_RESTART': '1', 11:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:16 INFO - 'PWD': '/builds/slave/test', 11:07:16 INFO - 'SHELL': '/bin/bash', 11:07:16 INFO - 'SHLVL': '1', 11:07:16 INFO - 'TERM': 'linux', 11:07:16 INFO - 'TMOUT': '86400', 11:07:16 INFO - 'USER': 'cltbld', 11:07:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:16 INFO - '_': '/tools/buildbot/bin/python'} 11:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:16 INFO - Running setup.py (path:/tmp/pip-zyZcYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:16 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)) 11:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:16 INFO - Running setup.py (path:/tmp/pip-9vHDiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:16 INFO - Running setup.py (path:/tmp/pip-Fkr0xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:16 INFO - Running setup.py (path:/tmp/pip-8RyZdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:16 INFO - Running setup.py (path:/tmp/pip-jv2XS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:17 INFO - Running setup.py (path:/tmp/pip-CjmBRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:17 INFO - Running setup.py (path:/tmp/pip-9nt8U7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:17 INFO - Running setup.py (path:/tmp/pip-oYK6wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:17 INFO - Running setup.py (path:/tmp/pip-M_YgKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:17 INFO - Running setup.py (path:/tmp/pip-MTbuOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:17 INFO - Running setup.py (path:/tmp/pip-w9rQuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:17 INFO - Running setup.py (path:/tmp/pip-aLNBed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:17 INFO - Running setup.py (path:/tmp/pip-syRDEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:17 INFO - Running setup.py (path:/tmp/pip-EHZbrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:17 INFO - Running setup.py (path:/tmp/pip-pv7bo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:17 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)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:17 INFO - Running setup.py (path:/tmp/pip-1CFGqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:17 INFO - Running setup.py (path:/tmp/pip-QtGaed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:07:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:19 INFO - Downloading blessings-1.6.tar.gz 11:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:19 INFO - Installing collected packages: blessings 11:07:19 INFO - Running setup.py install for blessings 11:07:19 INFO - Successfully installed blessings 11:07:19 INFO - Cleaning up... 11:07:19 INFO - Return code: 0 11:07:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:20 INFO - Reading from file tmpfile_stdout 11:07:20 INFO - Current package versions: 11:07:20 INFO - argparse == 1.2.1 11:07:20 INFO - blessings == 1.6 11:07:20 INFO - blobuploader == 1.2.4 11:07:20 INFO - docopt == 0.6.1 11:07:20 INFO - manifestparser == 1.1 11:07:20 INFO - mozInstall == 1.12 11:07:20 INFO - mozcrash == 0.17 11:07:20 INFO - mozdebug == 0.1 11:07:20 INFO - mozdevice == 0.48 11:07:20 INFO - mozfile == 1.2 11:07:20 INFO - mozhttpd == 0.7 11:07:20 INFO - mozinfo == 0.9 11:07:20 INFO - mozleak == 0.1 11:07:20 INFO - mozlog == 3.1 11:07:20 INFO - moznetwork == 0.27 11:07:20 INFO - mozprocess == 0.22 11:07:20 INFO - mozprofile == 0.28 11:07:20 INFO - mozrunner == 6.11 11:07:20 INFO - mozscreenshot == 0.1 11:07:20 INFO - mozsystemmonitor == 0.0 11:07:20 INFO - moztest == 0.7 11:07:20 INFO - mozversion == 1.4 11:07:20 INFO - psutil == 3.1.1 11:07:20 INFO - requests == 1.2.3 11:07:20 INFO - wsgiref == 0.1.2 11:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 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 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:20 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 11:07:20 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 11:07:20 INFO - Using env: {'DISPLAY': ':0', 11:07:20 INFO - 'HOME': '/home/cltbld', 11:07:20 INFO - 'LANG': 'en_US.UTF-8', 11:07:20 INFO - 'LANGUAGE': 'en_US:en', 11:07:20 INFO - 'LOGNAME': 'cltbld', 11:07:20 INFO - 'MAIL': '/var/mail/cltbld', 11:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:20 INFO - 'MOZ_NO_REMOTE': '1', 11:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:20 INFO - 'NO_EM_RESTART': '1', 11:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:20 INFO - 'PWD': '/builds/slave/test', 11:07:20 INFO - 'SHELL': '/bin/bash', 11:07:20 INFO - 'SHLVL': '1', 11:07:20 INFO - 'TERM': 'linux', 11:07:20 INFO - 'TMOUT': '86400', 11:07:20 INFO - 'USER': 'cltbld', 11:07:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:20 INFO - '_': '/tools/buildbot/bin/python'} 11:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 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)) 11:07:20 INFO - Cleaning up... 11:07:20 INFO - Return code: 0 11:07:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07: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', 'jsonschema'] in /builds/slave/test/build 11:07: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 jsonschema 11:07:20 INFO - Using env: {'DISPLAY': ':0', 11:07:20 INFO - 'HOME': '/home/cltbld', 11:07:20 INFO - 'LANG': 'en_US.UTF-8', 11:07:20 INFO - 'LANGUAGE': 'en_US:en', 11:07:20 INFO - 'LOGNAME': 'cltbld', 11:07:20 INFO - 'MAIL': '/var/mail/cltbld', 11:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:20 INFO - 'MOZ_NO_REMOTE': '1', 11:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:20 INFO - 'NO_EM_RESTART': '1', 11:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:20 INFO - 'PWD': '/builds/slave/test', 11:07:20 INFO - 'SHELL': '/bin/bash', 11:07:20 INFO - 'SHLVL': '1', 11:07:20 INFO - 'TERM': 'linux', 11:07:20 INFO - 'TMOUT': '86400', 11:07:20 INFO - 'USER': 'cltbld', 11:07:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:20 INFO - '_': '/tools/buildbot/bin/python'} 11:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:20 INFO - Downloading/unpacking jsonschema 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:22 INFO - Downloading/unpacking functools32 (from jsonschema) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:22 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:22 INFO - warning: no files found matching '*.txt' 11:07:22 INFO - no previously-included directories found matching 'build' 11:07:22 INFO - no previously-included directories found matching 'dist' 11:07:22 INFO - no previously-included directories found matching '.git*' 11:07:22 INFO - Installing collected packages: jsonschema, functools32 11:07:22 INFO - Running setup.py install for functools32 11:07:22 INFO - warning: no files found matching '*.txt' 11:07:22 INFO - no previously-included directories found matching 'build' 11:07:22 INFO - no previously-included directories found matching 'dist' 11:07:22 INFO - no previously-included directories found matching '.git*' 11:07:22 INFO - Successfully installed jsonschema functools32 11:07:22 INFO - Cleaning up... 11:07:22 INFO - Return code: 0 11:07:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82124bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', '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 11:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:07:22 INFO - Using env: {'DISPLAY': ':0', 11:07:22 INFO - 'HOME': '/home/cltbld', 11:07:22 INFO - 'LANG': 'en_US.UTF-8', 11:07:22 INFO - 'LANGUAGE': 'en_US:en', 11:07:22 INFO - 'LOGNAME': 'cltbld', 11:07:22 INFO - 'MAIL': '/var/mail/cltbld', 11:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:22 INFO - 'MOZ_NO_REMOTE': '1', 11:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:22 INFO - 'NO_EM_RESTART': '1', 11:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:22 INFO - 'PWD': '/builds/slave/test', 11:07:22 INFO - 'SHELL': '/bin/bash', 11:07:22 INFO - 'SHLVL': '1', 11:07:22 INFO - 'TERM': 'linux', 11:07:22 INFO - 'TMOUT': '86400', 11:07:22 INFO - 'USER': 'cltbld', 11:07:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:22 INFO - '_': '/tools/buildbot/bin/python'} 11:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:23 INFO - Downloading/unpacking flake8 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 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 11:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:25 INFO - no previously-included directories found matching 'docs/_build' 11:07:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:25 INFO - Running setup.py install for pep8 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:25 INFO - no previously-included directories found matching 'docs/_build' 11:07:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:25 INFO - Cleaning up... 11:07:26 INFO - Return code: 0 11:07:26 INFO - Running post-action listener: _resource_record_post_action 11:07:26 INFO - Running post-action listener: _start_resource_monitoring 11:07:26 INFO - Starting resource monitoring. 11:07:26 INFO - ##### 11:07:26 INFO - ##### Finished create-virtualenv step (success) 11:07:26 INFO - ##### 11:07:26 INFO - ##### 11:07:26 INFO - ##### Running install step. 11:07:26 INFO - ##### 11:07:26 INFO - Running pre-action listener: _resource_record_pre_action 11:07:26 INFO - Running main action method: install 11:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:26 INFO - Reading from file tmpfile_stdout 11:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:26 INFO - Reading from file tmpfile_stdout 11:07:26 INFO - Output received: 11:07:26 INFO - Usage: mozinstall [options] installer 11:07:26 INFO - Options: 11:07:26 INFO - -h, --help show this help message and exit 11:07:26 INFO - -d DEST, --destination=DEST 11:07:26 INFO - Directory to install application into. [default: 11:07:26 INFO - "/builds/slave/test"] 11:07:26 INFO - --app=APP Application being installed. [default: firefox] 11:07:26 INFO - mkdir: /builds/slave/test/build/application 11:07:26 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'] 11:07:26 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 11:07:42 INFO - Reading from file tmpfile_stdout 11:07:42 INFO - Output received: 11:07:42 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:42 INFO - Running post-action listener: _resource_record_post_action 11:07:42 INFO - ##### 11:07:42 INFO - ##### Finished install step (success) 11:07:42 INFO - ##### 11:07:42 INFO - ##### 11:07:42 INFO - ##### Running run-tests step. 11:07:42 INFO - ##### 11:07:42 INFO - Running pre-action listener: _resource_record_pre_action 11:07:42 INFO - Running main action method: run_tests 11:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:42 INFO - Python 2.7.3 11:07:42 INFO - Return code: 0 11:07:42 INFO - grabbing minidump binary from tooltool 11:07:42 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')]} 11:07:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd9c0>, '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 0x1ace8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aced50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:42 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 11:07:42 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 11:07:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:07:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:42 INFO - Return code: 0 11:07:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:07:43 INFO - Return code: 0 11:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 11:07:43 INFO - Using env: {'DISPLAY': ':0', 11:07:43 INFO - 'HOME': '/home/cltbld', 11:07:43 INFO - 'LANG': 'en_US.UTF-8', 11:07:43 INFO - 'LANGUAGE': 'en_US:en', 11:07:43 INFO - 'LOGNAME': 'cltbld', 11:07:43 INFO - 'MAIL': '/var/mail/cltbld', 11:07:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:43 INFO - 'MOZ_NO_REMOTE': '1', 11:07:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:43 INFO - 'NO_EM_RESTART': '1', 11:07:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:43 INFO - 'PWD': '/builds/slave/test', 11:07:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:43 INFO - 'SHELL': '/bin/bash', 11:07:43 INFO - 'SHLVL': '1', 11:07:43 INFO - 'TERM': 'linux', 11:07:43 INFO - 'TMOUT': '86400', 11:07:43 INFO - 'USER': 'cltbld', 11:07:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424', 11:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:43 INFO - '_': '/tools/buildbot/bin/python'} 11:07:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:07:44 INFO - mozversion application_buildid: 20160511083011 11:07:44 INFO - mozversion application_changeset: a67f6710c37cce1c11882eceefceaaef0b5a9076 11:07:44 INFO - mozversion application_display_name: Nightly 11:07:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:44 INFO - mozversion application_name: Firefox 11:07:44 INFO - mozversion application_remotingname: firefox 11:07:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:07:44 INFO - mozversion application_vendor: Mozilla 11:07:44 INFO - mozversion application_version: 49.0a1 11:07:44 INFO - mozversion platform_buildid: 20160511083011 11:07:44 INFO - mozversion platform_changeset: a67f6710c37cce1c11882eceefceaaef0b5a9076 11:07:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:07:44 INFO - mozversion platform_version: 49.0a1 11:07:44 INFO - using testdate: 1462990064 11:07:44 INFO - actual date: 1462990064 11:07:44 INFO - starting webserver on 'localhost:44373' 11:07:44 INFO - SUITE-START | Running 2 tests 11:07:44 INFO - TEST-START | dromaeo_css 11:07:44 INFO - operating with platform_type : linux_ 11:07:44 INFO - Initialising browser for dromaeo_css test... 11:07:44 INFO - TEST-INFO | started process 31184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuha9r3/profile http://localhost:44373/getInfo.html) 11:07:48 INFO - PROCESS | 31184 | 11:07:48 INFO - PROCESS | 31184 | (process:31257): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:07:48 INFO - PROCESS | 31184 | __metrics Screen width/height:1600/1200 11:07:48 INFO - PROCESS | 31184 | colorDepth:24 11:07:48 INFO - PROCESS | 31184 | Browser inner width/height: 1024/697 11:07:48 INFO - PROCESS | 31184 | __metrics 11:07:49 ERROR - PROCESS | 31184 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:07:50 INFO - TEST-INFO | 31184: exit 0 11:07:50 INFO - Browser initialized. 11:07:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:50 INFO - TEST-INFO | started process 31308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuha9r3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:52 INFO - PROCESS | 31308 | 11:07:52 INFO - PROCESS | 31308 | (process:31367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:08:02 INFO - PROCESS | 31308 | RSS: Main: 162848768 11:08:02 INFO - PROCESS | 31308 | 11:08:51 INFO - PROCESS | 31308 | 1462990131956 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] 11:10:59 INFO - PROCESS | 31308 | Cycle 1(1): loaded http://localhost:44373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44373/tests/dromaeo/cssquery-ext.html) 11:11:00 INFO - PROCESS | 31308 | RSS: Main: 166408192 11:11:00 INFO - PROCESS | 31308 | 11:14:02 INFO - PROCESS | 31308 | Cycle 1(1): loaded http://localhost:44373/tests/dromaeo/cssquery-ext.html (next: http://localhost:44373/tests/dromaeo/cssquery-jquery.html) 11:14:02 INFO - PROCESS | 31308 | RSS: Main: 166428672 11:14:02 INFO - PROCESS | 31308 | 11:17:04 INFO - PROCESS | 31308 | Cycle 1(1): loaded http://localhost:44373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44373/tests/dromaeo/cssquery-mootools.html) 11:17:05 INFO - PROCESS | 31308 | RSS: Main: 167202816 11:17:05 INFO - PROCESS | 31308 | 11:20:07 INFO - PROCESS | 31308 | Cycle 1(1): loaded http://localhost:44373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44373/tests/dromaeo/cssquery-prototype.html) 11:20:07 INFO - PROCESS | 31308 | RSS: Main: 165064704 11:20:07 INFO - PROCESS | 31308 | 11:23:10 INFO - PROCESS | 31308 | Cycle 1(1): loaded http://localhost:44373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44373/tests/dromaeo/cssquery-yui.html) 11:23:10 INFO - PROCESS | 31308 | RSS: Main: 165756928 11:23:10 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | Cycle 1(1): loaded http://localhost:44373/tests/dromaeo/cssquery-yui.html (next: http://localhost:44373/tests/dromaeo/cssquery-dojo.html) 11:26:13 INFO - PROCESS | 31308 | RSS: Main: 168013824 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | __start_tp_report 11:26:13 INFO - PROCESS | 31308 | _x_x_mozilla_page_load 11:26:13 INFO - PROCESS | 31308 | _x_x_mozilla_page_load_details 11:26:13 INFO - PROCESS | 31308 | |i|pagename|runs| 11:26:13 INFO - PROCESS | 31308 | |0;dojo.html;3085.382923415317;3118.4698601237797;3159.2417819723273;3225.0324902529237;3239.044481877844;5404.594655400846;5413.242146099545;5482.040642887494;5538.529225015878;5541.0580201365765;5340.599455040868;5481.917771233425;5540.97491963987;5542.944570554293;5562.833115006556;4948.9257661135025;4988.251762235657;5101.464346243647;5103.974480127594;5177.559907407875;599.4426278887697;4906.362172917516;4983.401991760994;5045.84862454127;5059.3169922060415;5007.84976450707;5019.774110165052;5022.42242142151;5043.344365232515;5058.822941197059;4993.575546078588;5000.874978125539;5007.774650140716;5017.37282839645;5023.799048038074;4974.328465657126;5003.349564556621;5010.298558201855;5025.899482010376;5035.974820125876;5403.2705584745945;5429.647072940246;5445.9727701361635;5465.699386533739;5475.479829416199;5716.085426331767;5796.217510636052;5884.352721200665;5887.61730487517;5898.380670029628;5883.38224486427;5910.852228694317;5919.55603329752;5931.970340148315;5975.731092100866;5475.561955043627;5510.504054635062;5520.337559492847;5523.806666766684;5528.391876893538;5860.00379935412;6018.638881667114;6020.157177995085;6021.939780602225;6044.455998960027;5772.105323674838;5774;5782.479576838105;5783.814318064787;5786.826395208151;5891.882162356815;5900.557458190653;5903.527717782567;5904.202932604129;5917.644941303535;5708.40061793514;5742.626729262584;5766.163906233573;5769.88460230793;5922.466977972003;5728.427157284322;5768.94231057684;5778.3643799182055;5785.71071446426;5808.477237048686;4358.21552120615;4391.8682439526865;4402.977985110054;4403.053343531156;4437.511873693891;3822.1782316802023;3923.3330333843314;3987.5613682494904;4021.276170289376;4023;5596.132599447093;5607.80372686954;5610.326760788732;5654.349749778746;5659.943400565941;5814.505767009767;5924.940750592526;5953.315368732565;5962.40375962409;5967.6121052131475;5561.499465048165;5578.44215578447;5593.468620481048;5595.076812326002;5606.579506537026;4952.504749525018;4992.875178120504;5026.924596131061;5029.798808047711;5060.696358218519;5983.760649574056;5989.520838332923;6019.4883434908525;6041.758329666852;6088.238970128734;5883.764649414061;5928.436798504135;5946.28644562638;5955.821325360246;5976.910346344808;6084.969575152096;6096.695165241809;6101.481374083075;6107.267127944675;6109.877802443837;5656.123300888369;5798.420157984337;5803.071508558611;5810.854728631818;5820.82537523875;5986.461218490357;5990.041593345044;5996.640201587918;6002.159697642246;6036.728347224298;5793.768249269982;5861.531077513874;5862.736176871966;5863.413658634103;5869.6771677556435;5558.91661625084;5690.260266165537;5719.256496655408;5734.455226753452;5813.7674493021495;5617.241672374177;5618.606697531133;5623.775048997994;5636.4927156556105;5660.518855897295;5757.971210143923;5773.884522309446;5777.508911742549;5787.784565241346;5827.358990510956;5551.944480555143;5569.470900264469;5627.071533196977;5670.886582268414;5677.403872593483 11:26:13 INFO - PROCESS | 31308 | |1;ext.html;606.1302031584677;658.2627457247883;663.9402453779159;673.3333999340653;682.0928165539832;41990;43503.34744978828;43997;44392.55607443924;44691.329630055494;43992.12015759691;44429.33355999662;44504.55495445045;44543.77728111363;44570.33144502827;8796.95601521993;8958.23854972328;8968.103189681013;8977.730668079936;8997.820043599124;8791.252743516809;8872.423292485968;8940.552972351388;8947.194752472276;8947.239484643813;8948.373613847034;8949.06034866336;8955;8966.237869781076;9007.279417646605;8815.647374105029;8854.911450885538;8865.689700860472;8872.15714507124;8885.422447540921;8789.945206575252;8902.86645700315;8903.154200350957;8904.243139333164;8933.151350621745;40302.798486007676;40402.595974040174;40642.59357406418;40671.796641016605;40950.1809963799;3601.981990090059;3613.4941108244866;3668.8899333020054;3674.2467794102145;4060.20825938942;31651;31783.36433271345;32372.6762732372;32392.19019524507;33552;4348.152110338485;4349.543297953701;4368.060866913597;4371.082072764723;4380.978095109536;323298;323912;325306;326226;328314.35842820874;35371.64628353684;35892.28215435677;56413;57121.428785711614;57373.426265737646;37499.4375084374;37564.24871502555;37643.24713505714;37665.62334376621;37722.43416348757;13864.168149910836;13883.861161388459;13946.86053139476;13949.651258718613;13997.30013499321;11476.59831905896;11512.424378781028;11563.595274165364;11570.132240081859;11621.6513504595;8409.621567029499;8513.808066870643;8547;8549.187827156411;8600.78498037554;3299.637039925606;3339.816310102919;3370.393329200718;3377.5440315557084;3377.8142202179115;1064.8722153341494;1075.93544387337;1086.625114335553;1157.3113997171838;1174.4069245031205;31734.523982140287;32106.83946580299;32387.35225295528;32714;32774.180645484055;1174.7356844710043;1195.8026925557185;1206.9155159138952;1220.0605533738972;1268.6764874957012;16898.831011689726;17145;17250.65498690044;17352.3059077638;17358.652826943642;466635;469812;474009;476133;476522;57404;58747.118793218135;58854.11718824221;58894.116588251214;58938;1410.1468611490106;1411.8235220597426;1428.3715165327224;1440.517426662059;1443.2639353929571;30425.847870760503;31332.373352532366;31438;31936.6806331943;31953.201169970936;49426.25860612166;49473.25790113079;49617.255741163186;49861.25208121809;49958;388082;389313;390686;392311;392689;27817.721822781514;28126.578101328905;28292.575611366257;28379.290517737223;28695.85652071726;47387.52612473969;47839;48349.516504835905;48385.27422088742;48461.757691212726;40137.39793903152;40614.79692601518;41230.79384603058;41432.58567414287;41699.1660166801;41021.38467922924;41412.171756564094;41513.37729933993;41726;42314;39549.60450395574;41735.58264417317;42602.360964584936;43264.56735432606;44912.55087449084;34254;38968.6103138965;39761.40357894692;39993.80003099966;40221.396679049256;28232.85883570569;28262.85868570644;28305;28412.289692757848;28785 11:26:13 INFO - PROCESS | 31308 | |2;jquery.html;398.20359281437123;401.8091406581873;402.21969379403953;404.46408508725926;418.6692512914797;13715.177089374645;18101.366452174178;18871.433856984313;19758.407247782554;19851.617805863298;18377.44867653969;18643.254269829224;19157.616847663037;19252.22991080355;19314.45484361251;5632.464915832989;5720.313562372511;5850.0932355484965;5864.677442740669;5904.439078287577;5761.337446193678;5778.364379918226;5780.682062486561;5787.045137552299;5814.5057670098095;5527.447255274481;5751.913721294184;5784.479396854283;5787.102999035156;5794.884102317972;5706.115552089433;5743.913841292384;5757.07886738124;5761.654300741927;5771.076627739562;6279.623222606612;6738.797836064877;6744.865102697968;6786.72853085876;6881.483888708367;23240.53518929629;25363.239102826945;26371.868140659175;26513.867430662915;26713.332166695793;2455.226603619854;2528.911488097926;2550.642909992584;2600.726923673006;2808.789340799428;16001.919990399974;16024.919875400665;16054.27755750994;16167.676646467122;16296.348146074142;2153;2205.4596623827106;2354.0348457132495;2357.2574638988663;2358.50471401006;93344.53327733318;97053.51473242659;99466.00533994712;100696.49651751768;101050.49474752652;16997.235124419432;18008;18285.268589256546;18308.725369119475;18343.724844127348;32685.673143268737;32986.835065825;33154.17114572155;33346;33388;9386.389884657476;9398.2951278653;9550.185464761811;9609.615615375447;9774.706758797247;7854.921450785419;7924.088729796032;7979.122296547375;8027.879581806277;8034.035915690155;8881.24509416694;8905.154010369004;9120.543972801333;9281.767955801159;9324.627014919462;3560.3235385276716;3582.1223800168605;3612.8012959286966;3707;3708.2398108387715;970.6505657963128;1018.8930162332848;1046.8115739167024;1071.7106381277167;1082.2316155529504;17218.741718874226;18874.528136796416;19134.90432547856;19282.71075933862;19444.611107777764;985.3102828020415;1007.8236308645958;1040.9739756506149;1050.669039252633;1063.2185343772321;10641.148708103334;10747.247692661595;10950.06924411434;10998.395088270221;11039.227254092297;392778;397007;399530;501392;565170;87947;96583.3758286588;98360;103689;107633.46183269033;457.9633629309647;470.15841643457827;471.1096028506126;471.40132032318763;472.84632494439444;10054.49727513636;10527.789444211227;10882.564697412015;10932.289401188897;10962.725931851768;38471.80764096162;39519.80240098896;39896.60103398929;40387.394189087776;40652;51245.743771280904;55323;57265;57297;59912.40087599068;11737.706557336134;12922.224666520038;13020.8046879295;13250.933745331211;13275.867241327463;14774;14793.556193314218;14986.850131498546;15089.54731358061;15250.77123843121;5894.793682221101;9153.901531815958;9217.723468295962;12191.878081219074;12874.806877897026;12448.81326780081;12596.496140154291;12830.55093071738;12979.28613926243;13192.868071319164;12973.870261297267;13025.413856376295;13101.148425352321;13264.46942122343;13299.601011969657;13250;13391.531296404968;13410.463581457023;13410.9329453356;13617.659558511117;12553.560625378068;12668.936655316664;12769.233845969271;12949.223046617233;12978.870211298145 11:26:13 INFO - PROCESS | 31308 | |3;mootools.html;1520.7566789313712;1566.5300409877038;1724.5257554172601;1850.9167087481062;1862.5622978600036;7939;8436.493810371381;8711.651533938642;9158.267338612912;9247.936487303961;8759.386842920998;8762;8831.514266715329;8857.512836793974;8874.556272186397;2337.2871274261342;2347.6595893595418;2368.2539999900064;2371.8932648030795;2373.050779688121;2312.491251924574;2330.2426711318803;2330.673705681206;2344.507653392781;2351.1535847095033;2322.93031209064;2323.732770731362;2333.0667732906886;2352.047420794572;2352.764723527651;2232.0179121186625;2239.5185035217423;2241.036354367613;2255.7744225577476;2263.660450932365;2228.454028762947;2275.954480910389;2284.6344584866506;2287.451011757183;2290.9198178063853;8944.686935957276;9005.864912026325;9010.459372437675;9019.098090190993;9020.323475739346;5282.445343238982;5375.865603359908;5402.189671549259;5408.107662235727;5439.292891924025;3300.6369299377047;3370.241695618466;3387.9661203388146;3505.1587618971516;3540.5751309842726;1079.5627770752858;1089.4008295437477;1098.7088421568292;1102.2614848051744;1112.5994641928899;12721.10952233344;12724.618261452264;12725.55460558876;12793.104482686123;12806.231626102464;4633.606143477842;4645.7167627465515;4701.576858082789;4741.122892264942;4760.45254795696;10590.205734569938;10617.416042117604;10688.893111068945;10702;10702.50164976904;5245.321497120961;5294.894102117936;5322.121849894801;5359.892802143935;5412.5940554458575;4381.474223093249;4824.372831531879;4954.281629163751;5009.373828271466;5029.497050295015;4077.571854955246;4105.322621767435;4126.259367710568;4130.772807495557;4138.565450627701;1280.1870812034426;1326.966825829362;1338.2037687575876;1338.8795008449092;1365.5834970333945;925.7037747920735;955.8088382323563;972.547765289144;982.9164521015794;985.049427302642;5542.334919809648;5856.472917437451;5928.288605367384;5960.37416071315;6040.848978775566;931.1200915135132;952.48565774481;982.5480279071708;1006.3609607898891;1012.00823193271;3947.6052394760295;3948.664363529132;4023.5171779386073;4049.716519843583;4059.9594004060173;10608.31045982024;11127.888721112848;11137.610183643534;11225.494852731483;11302.491387887565;10964.342139471657;11050.502727377287;11055.72360690973;11092.833607495893;11118.833217501744;8301.83396332082;8339.874901876477;8362.777984842838;8437.325013998865;8523.445976011539;5678.517326027334;5707.086866101404;5725.141228815544;5736.99602569557;5899.085641725539;10307.793844122925;10389.532471038972;10418.895811042095;10526.736831579272;10574.8413773795;10320.793584128425;10330.380177189392;10438.68683939483;10609.469526523797;10686.73283167927;7016.438684905297;7652.273034061755;7740.187280335709;7996.680132794623;8063.113057563781;8810.515421651615;8812.16284452976;8828.293736501193;8902.55487225649;8917.10828917103;7564.773056808304;7856.84286314282;8108.310793582612;8110.635021424168;8188.058373287148;7785.766427007199;7838.921610783819;7855.410844186823;7874.251946065115;7961.243681850447;6541.182352205974;7199.2440793715905;7208.243134471015;7240.52936559122;7285.635718213962;5016.448190699093;5027.472115427828;5133.79464821403;5163;5192.948070519397;4976.0794253063295;5015.974920125376;5041.495850414929;5078.669886457368;5107.463716309882 11:26:13 INFO - PROCESS | 31308 | |4;prototype.html;317.4048658764816;319.5191237188032;321.52414426648545;324.4532961959099;326.1162250301682;5721.513671337936;5727.799527016556;5739.139129130627;5768.423157684229;5773.9711301443485;5613.607047506676;5649.971750141254;5674.31908171019;5681.545476361892;5683.744231509581;4097.242010228102;4127.607877251657;4258.850940217093;4261.659067274611;4282.914341713164;4283.550227226143;4305.160493703729;4306.35404689296;4323.5460276670965;4325.00524879278;4279;4282.850100246492;4298.634616057639;4308.246056940038;4319.136172765444;4040.3535434330365;4227.260229459863;4235.449391579105;4242.575742425733;4297.72064815786;3700.703943684499;3707.5550933888107;3713.851445942159;3721.813909304551;3731.3843215869347;5394.568434525268;5446.2375267462585;5453.127499600045;5455.427180146067;5462.863428414282;4633.235516139833;4877.365942427462;4883.926741098886;4885.2427873679635;4931.137051016094;5779.739911703983;5794.304683438015;5814.47669709724;5858.677772722499;5861.150133230701;4035.59644035597;4058.4723985881647;4080.5511393746665;4089.5092588889224;4101.712880098395;5990.520758339322;6154.538184726101;6154.876902461926;6160.490679783437;6172.321044685081;4158.209940111369;4180.352045432963;4180.979095104505;4188.120494696087;4195.748255104703;4252.659787217015;4255.212785634668;4259.488861336597;4260.318349064135;4261.401974259653;4591.4260717410325;4835.975820120877;4868.878278043077;4881.511848815161;4905.9264111038365;5908.675022873783;5924.7926322578505;5926.2295901532525;5992.520598352121;5999.160117583542;1460.7443697353133;1468.3098943496752;1469.926503674812;1477.4533422633478;1480.992595037018;920.7744102694883;938.2259635800356;964.6816550538306;971.4414211828228;980.6567701304486;5530.834074977757;5632.887342253214;5638.436156384329;5654.802081927113;5684.914726279109;5958.404159584007;5959.927213101683;5971.253593300838;5988.323269484551;6111.633302001894;5535.280413546294;5751.683657398799;5766.135079738073;5832.795852145239;5891.941080589225;3210.486322188439;3259.4028925826174;3302.1414432247307;3302.950455743118;3314.2708604107056;6120.418560236771;6287.528435367366;6347.460465860454;6348.396902294275;6479.514036447285;6230.719617617218;6259.7496100156395;6298.212723409574;6341.492680585542;6345.555811093272;6082.11809287642;6389.297177310492;6391.936080639227;6396;6417.711202995876;5993.550483713826;6209.285932117684;6214.658193799384;6236.126942228001;6239.688015599293;6081.604695694766;6104.816855494342;6111.388861113853;6115.04318618038;6182.041783523561;6113.755449781959;6194.318624951342;6238.875222495615;6241.251049874044;6283.403076707888;4139.606737360066;4225.302825033835;4247.490301163756;4258.574142585717;4268.957310426856;5906.2026626406605;6101.481374083252;6105.542084343603;6167.105769663463;6196.783112591038;5807.651540907559;5982.970085149546;5997.610155339889;5998.80023995194;6020.247469066367;6002.519798416203;6030.336662966983;6042.398764327545;6054.697265136813;6074;5611.831645050655;5809.24479817621;5844.912326315194;5868.119782032729;5909;5898.9115163273445;5913.852153696192;5942.524598032233;6030.969845150747;6095.908561371672;5719.227904233042;5830.358660547421;5840.678762668094;5865.73604187804;5883.794067207627 11:26:13 INFO - PROCESS | 31308 | |5;yui.html;817.0522194254665;854.7350321400367;868.7871471489486;869.6521391443425;908.2733812949639;14518.491852785155;15081.547553573397;15105.62235944102;15462.304196311165;15565;15443.92278038611;15482.458113966013;15483.69032619347;15594.142322172276;15616.297266623002;835.173178553231;842.4145219072747;844.771911583872;845.9111793261711;862.0904945282724;851.1190917400492;851.1360968616859;857.8069934264803;858.6007506509471;860.8106216632331;903.8599017152319;905.248643625789;908.2824568590838;908.3732224764924;910.3763921713614;892.7277180459989;896.7847716547982;897.5691667999397;899.6446403670546;900.0909081827336;652.1098700274139;652.2075678051143;653.7123665587173;654.1300070905684;655.5673255651247;14762.114273143647;14766.630834229123;14868.702625947528;14883.776743348859;14909.627259318495;13722.245276509788;13799.51701690436;13829.79255311171;13873.722525549432;13885.722285554233;11391.259568128045;11482.827757583644;11566.47950842214;11665.24175928562;11669.416529173508;3794.677452416548;3835.654791068789;3852.191039881628;3892.9805350973347;3942.1327307992483;53799;53801.1929821053;53876.461235387535;54036;54767;10889.782204355868;10918.1811364148;11100.809506719284;11121.110311175087;11156.107511399068;18949.810501894804;18986;19039.904800476186;19043.714344284846;19261.13324900383;8269.710560130367;8381.371397145238;8421.831563368822;8428.4942903426;8536.914630853613;4724.527547245248;4734.171519983989;4767.475577686451;4807;4838.588719958843;3422.3839708852647;3580.695640870503;3584.766990145632;3595;3600.189957259648;645.5416654175494;650.9349065093453;656.95401321907;657.103054330835;692.4840993459904;706.7914965085312;792.4611264340303;798.1499702816482;801.1867954026668;808.2725547007623;9291.535423228812;9313.953430232805;9615.807683846284;9633.855492167622;9641.951790241004;787.9763607091796;790.9288164065262;792.3621484704753;794.5471081483499;797.2744802229943;4563.224251877189;4717.599004084691;4735.550122738335;4775.832845850378;4835.95164048362;59929.101063484086;60483.69758151181;61750.69124654348;61983.1405057849;62747;56358.43641563614;56384.15423768647;56393.718031410404;56952.14571781427;58842;50041;50456.24315635195;50632.49367506352;51184.74407627938;51621;8610.65557377698;8625.611847467004;8928.464292142233;8984.281257499253;9092.772680683036;33518.83240583781;33761.493577595866;33792;34074.20622531432;34287.48568771421;41960;43215.35176972285;43380.13239735251;43647;43991;10792.946035269773;11003.504842281956;11020.944895275472;11073.612423565137;11221.326720396803;12341;12623.558175464183;12813.295268759935;12833.358332083546;13311.00167487423;12061.585128568408;12071.517139314328;12237.816432753338;12241.326727030098;12276.693082672648;12225.327606981702;12441.315727635067;12487.250764954131;12519.687007824878;13021.934890325489;11371.772564548497;12123;12421.75156496847;12578.55975040869;12872.420741066488;9780;10211.591536338761;10325.74185645335;10577.206709496664;10615.203859710398;10162.593496260066;10450.843237351597;10497.16022718196;10520.263581549218;10637.840432393676 11:26:13 INFO - PROCESS | 31308 | __end_tp_report 11:26:13 INFO - PROCESS | 31308 | __start_cc_report 11:26:13 INFO - PROCESS | 31308 | _x_x_mozilla_cycle_collect,333 11:26:13 INFO - PROCESS | 31308 | __end_cc_report 11:26:13 INFO - PROCESS | 31308 | __startTimestamp1462991173321__endTimestamp 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | ------- Summary: start ------- 11:26:13 INFO - PROCESS | 31308 | Number of tests: 6 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | [#0] dojo.html Cycles:165 Average:5431.89 Median:5659.94 stddev:734.06 (13.0%) stddev-sans-first:712.86 11:26:13 INFO - PROCESS | 31308 | Values: 3085.4 3118.5 3159.2 3225.0 3239.0 5404.6 5413.2 5482.0 5538.5 5541.1 5340.6 5481.9 5541.0 5542.9 5562.8 4948.9 4988.3 5101.5 5104.0 5177.6 599.4 4906.4 4983.4 5045.8 5059.3 5007.8 5019.8 5022.4 5043.3 5058.8 4993.6 5000.9 5007.8 5017.4 5023.8 4974.3 5003.3 5010.3 5025.9 5036.0 5403.3 5429.6 5446.0 5465.7 5475.5 5716.1 5796.2 5884.4 5887.6 5898.4 5883.4 5910.9 5919.6 5932.0 5975.7 5475.6 5510.5 5520.3 5523.8 5528.4 5860.0 6018.6 6020.2 6021.9 6044.5 5772.1 5774.0 5782.5 5783.8 5786.8 5891.9 5900.6 5903.5 5904.2 5917.6 5708.4 5742.6 5766.2 5769.9 5922.5 5728.4 5768.9 5778.4 5785.7 5808.5 4358.2 4391.9 4403.0 4403.1 4437.5 3822.2 3923.3 3987.6 4021.3 4023.0 5596.1 5607.8 5610.3 5654.3 5659.9 5814.5 5924.9 5953.3 5962.4 5967.6 5561.5 5578.4 5593.5 5595.1 5606.6 4952.5 4992.9 5026.9 5029.8 5060.7 5983.8 5989.5 6019.5 6041.8 6088.2 5883.8 5928.4 5946.3 5955.8 5976.9 6085.0 6096.7 6101.5 6107.3 6109.9 5656.1 5798.4 5803.1 5810.9 5820.8 5986.5 5990.0 5996.6 6002.2 6036.7 5793.8 5861.5 5862.7 5863.4 5869.7 5558.9 5690.3 5719.3 5734.5 5813.8 5617.2 5618.6 5623.8 5636.5 5660.5 5758.0 5773.9 5777.5 5787.8 5827.4 5551.9 5569.5 5627.1 5670.9 5677.4 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | [#1] ext.html Cycles:180 Average:55216.30 Median:22337.50 stddev:106001.74 (474.5%) stddev-sans-first:106219.80 11:26:13 INFO - PROCESS | 31308 | Values: 606.1 658.3 663.9 673.3 682.1 41990.0 43503.3 43997.0 44392.6 44691.3 43992.1 44429.3 44504.6 44543.8 44570.3 8797.0 8958.2 8968.1 8977.7 8997.8 8791.3 8872.4 8940.6 8947.2 8947.2 8948.4 8949.1 8955.0 8966.2 9007.3 8815.6 8854.9 8865.7 8872.2 8885.4 8789.9 8902.9 8903.2 8904.2 8933.2 40302.8 40402.6 40642.6 40671.8 40950.2 3602.0 3613.5 3668.9 3674.2 4060.2 31651.0 31783.4 32372.7 32392.2 33552.0 4348.2 4349.5 4368.1 4371.1 4381.0 323298.0 323912.0 325306.0 326226.0 328314.4 35371.6 35892.3 56413.0 57121.4 57373.4 37499.4 37564.2 37643.2 37665.6 37722.4 13864.2 13883.9 13946.9 13949.7 13997.3 11476.6 11512.4 11563.6 11570.1 11621.7 8409.6 8513.8 8547.0 8549.2 8600.8 3299.6 3339.8 3370.4 3377.5 3377.8 1064.9 1075.9 1086.6 1157.3 1174.4 31734.5 32106.8 32387.4 32714.0 32774.2 1174.7 1195.8 1206.9 1220.1 1268.7 16898.8 17145.0 17250.7 17352.3 17358.7 466635.0 469812.0 474009.0 476133.0 476522.0 57404.0 58747.1 58854.1 58894.1 58938.0 1410.1 1411.8 1428.4 1440.5 1443.3 30425.8 31332.4 31438.0 31936.7 31953.2 49426.3 49473.3 49617.3 49861.3 49958.0 388082.0 389313.0 390686.0 392311.0 392689.0 27817.7 28126.6 28292.6 28379.3 28695.9 47387.5 47839.0 48349.5 48385.3 48461.8 40137.4 40614.8 41230.8 41432.6 41699.2 41021.4 41412.2 41513.4 41726.0 42314.0 39549.6 41735.6 42602.4 43264.6 44912.6 34254.0 38968.6 39761.4 39993.8 40221.4 28232.9 28262.9 28305.0 28412.3 28785.0 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | [#2] jquery.html Cycles:180 Average:29782.33 Median:26442.87 stddev:75857.54 (286.9%) stddev-sans-first:76038.26 11:26:13 INFO - PROCESS | 31308 | Values: 398.2 401.8 402.2 404.5 418.7 13715.2 18101.4 18871.4 19758.4 19851.6 18377.4 18643.3 19157.6 19252.2 19314.5 5632.5 5720.3 5850.1 5864.7 5904.4 5761.3 5778.4 5780.7 5787.0 5814.5 5527.4 5751.9 5784.5 5787.1 5794.9 5706.1 5743.9 5757.1 5761.7 5771.1 6279.6 6738.8 6744.9 6786.7 6881.5 23240.5 25363.2 26371.9 26513.9 26713.3 2455.2 2528.9 2550.6 2600.7 2808.8 16001.9 16024.9 16054.3 16167.7 16296.3 2153.0 2205.5 2354.0 2357.3 2358.5 93344.5 97053.5 99466.0 100696.5 101050.5 16997.2 18008.0 18285.3 18308.7 18343.7 32685.7 32986.8 33154.2 33346.0 33388.0 9386.4 9398.3 9550.2 9609.6 9774.7 7854.9 7924.1 7979.1 8027.9 8034.0 8881.2 8905.2 9120.5 9281.8 9324.6 3560.3 3582.1 3612.8 3707.0 3708.2 970.7 1018.9 1046.8 1071.7 1082.2 17218.7 18874.5 19134.9 19282.7 19444.6 985.3 1007.8 1041.0 1050.7 1063.2 10641.1 10747.2 10950.1 10998.4 11039.2 392778.0 397007.0 399530.0 501392.0 565170.0 87947.0 96583.4 98360.0 103689.0 107633.5 458.0 470.2 471.1 471.4 472.8 10054.5 10527.8 10882.6 10932.3 10962.7 38471.8 39519.8 39896.6 40387.4 40652.0 51245.7 55323.0 57265.0 57297.0 59912.4 11737.7 12922.2 13020.8 13250.9 13275.9 14774.0 14793.6 14986.9 15089.5 15250.8 5894.8 9153.9 9217.7 12191.9 12874.8 12448.8 12596.5 12830.6 12979.3 13192.9 12973.9 13025.4 13101.1 13264.5 13299.6 13250.0 13391.5 13410.5 13410.9 13617.7 12553.6 12668.9 12769.2 12949.2 12978.9 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | [#3] mootools.html Cycles:180 Average:5889.68 Median:4721.35 stddev:3388.88 (71.8%) stddev-sans-first:3382.48 11:26:13 INFO - PROCESS | 31308 | Values: 1520.8 1566.5 1724.5 1850.9 1862.6 7939.0 8436.5 8711.7 9158.3 9247.9 8759.4 8762.0 8831.5 8857.5 8874.6 2337.3 2347.7 2368.3 2371.9 2373.1 2312.5 2330.2 2330.7 2344.5 2351.2 2322.9 2323.7 2333.1 2352.0 2352.8 2232.0 2239.5 2241.0 2255.8 2263.7 2228.5 2276.0 2284.6 2287.5 2290.9 8944.7 9005.9 9010.5 9019.1 9020.3 5282.4 5375.9 5402.2 5408.1 5439.3 3300.6 3370.2 3388.0 3505.2 3540.6 1079.6 1089.4 1098.7 1102.3 1112.6 12721.1 12724.6 12725.6 12793.1 12806.2 4633.6 4645.7 4701.6 4741.1 4760.5 10590.2 10617.4 10688.9 10702.0 10702.5 5245.3 5294.9 5322.1 5359.9 5412.6 4381.5 4824.4 4954.3 5009.4 5029.5 4077.6 4105.3 4126.3 4130.8 4138.6 1280.2 1327.0 1338.2 1338.9 1365.6 925.7 955.8 972.5 982.9 985.0 5542.3 5856.5 5928.3 5960.4 6040.8 931.1 952.5 982.5 1006.4 1012.0 3947.6 3948.7 4023.5 4049.7 4060.0 10608.3 11127.9 11137.6 11225.5 11302.5 10964.3 11050.5 11055.7 11092.8 11118.8 8301.8 8339.9 8362.8 8437.3 8523.4 5678.5 5707.1 5725.1 5737.0 5899.1 10307.8 10389.5 10418.9 10526.7 10574.8 10320.8 10330.4 10438.7 10609.5 10686.7 7016.4 7652.3 7740.2 7996.7 8063.1 8810.5 8812.2 8828.3 8902.6 8917.1 7564.8 7856.8 8108.3 8110.6 8188.1 7785.8 7838.9 7855.4 7874.3 7961.2 6541.2 7199.2 7208.2 7240.5 7285.6 5016.4 5027.5 5133.8 5163.0 5192.9 4976.1 5016.0 5041.5 5078.7 5107.5 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | [#4] prototype.html Cycles:180 Average:4957.22 Median:5745.41 stddev:1505.81 (26.2%) stddev-sans-first:1469.21 11:26:13 INFO - PROCESS | 31308 | Values: 317.4 319.5 321.5 324.5 326.1 5721.5 5727.8 5739.1 5768.4 5774.0 5613.6 5650.0 5674.3 5681.5 5683.7 4097.2 4127.6 4258.9 4261.7 4282.9 4283.6 4305.2 4306.4 4323.5 4325.0 4279.0 4282.9 4298.6 4308.2 4319.1 4040.4 4227.3 4235.4 4242.6 4297.7 3700.7 3707.6 3713.9 3721.8 3731.4 5394.6 5446.2 5453.1 5455.4 5462.9 4633.2 4877.4 4883.9 4885.2 4931.1 5779.7 5794.3 5814.5 5858.7 5861.2 4035.6 4058.5 4080.6 4089.5 4101.7 5990.5 6154.5 6154.9 6160.5 6172.3 4158.2 4180.4 4181.0 4188.1 4195.7 4252.7 4255.2 4259.5 4260.3 4261.4 4591.4 4836.0 4868.9 4881.5 4905.9 5908.7 5924.8 5926.2 5992.5 5999.2 1460.7 1468.3 1469.9 1477.5 1481.0 920.8 938.2 964.7 971.4 980.7 5530.8 5632.9 5638.4 5654.8 5684.9 5958.4 5959.9 5971.3 5988.3 6111.6 5535.3 5751.7 5766.1 5832.8 5891.9 3210.5 3259.4 3302.1 3303.0 3314.3 6120.4 6287.5 6347.5 6348.4 6479.5 6230.7 6259.7 6298.2 6341.5 6345.6 6082.1 6389.3 6391.9 6396.0 6417.7 5993.6 6209.3 6214.7 6236.1 6239.7 6081.6 6104.8 6111.4 6115.0 6182.0 6113.8 6194.3 6238.9 6241.3 6283.4 4139.6 4225.3 4247.5 4258.6 4269.0 5906.2 6101.5 6105.5 6167.1 6196.8 5807.7 5983.0 5997.6 5998.8 6020.2 6002.5 6030.3 6042.4 6054.7 6074.0 5611.8 5809.2 5844.9 5868.1 5909.0 5898.9 5913.9 5942.5 6031.0 6095.9 5719.2 5830.4 5840.7 5865.7 5883.8 11:26:13 INFO - PROCESS | 31308 | 11:26:13 INFO - PROCESS | 31308 | [#5] yui.html Cycles:180 Average:14827.77 Median:4721.06 stddev:17041.90 (361.0%) stddev-sans-first:17057.22 11:26:13 INFO - PROCESS | 31308 | Values: 817.1 854.7 868.8 869.7 908.3 14518.5 15081.5 15105.6 15462.3 15565.0 15443.9 15482.5 15483.7 15594.1 15616.3 835.2 842.4 844.8 845.9 862.1 851.1 851.1 857.8 858.6 860.8 903.9 905.2 908.3 908.4 910.4 892.7 896.8 897.6 899.6 900.1 652.1 652.2 653.7 654.1 655.6 14762.1 14766.6 14868.7 14883.8 14909.6 13722.2 13799.5 13829.8 13873.7 13885.7 11391.3 11482.8 11566.5 11665.2 11669.4 3794.7 3835.7 3852.2 3893.0 3942.1 53799.0 53801.2 53876.5 54036.0 54767.0 10889.8 10918.2 11100.8 11121.1 11156.1 18949.8 18986.0 19039.9 19043.7 19261.1 8269.7 8381.4 8421.8 8428.5 8536.9 4724.5 4734.2 4767.5 4807.0 4838.6 3422.4 3580.7 3584.8 3595.0 3600.2 645.5 650.9 657.0 657.1 692.5 706.8 792.5 798.1 801.2 808.3 9291.5 9314.0 9615.8 9633.9 9642.0 788.0 790.9 792.4 794.5 797.3 4563.2 4717.6 4735.6 4775.8 4836.0 59929.1 60483.7 61750.7 61983.1 62747.0 56358.4 56384.2 56393.7 56952.1 58842.0 50041.0 50456.2 50632.5 51184.7 51621.0 8610.7 8625.6 8928.5 8984.3 9092.8 33518.8 33761.5 33792.0 34074.2 34287.5 41960.0 43215.4 43380.1 43647.0 43991.0 10792.9 11003.5 11020.9 11073.6 11221.3 12341.0 12623.6 12813.3 12833.4 13311.0 12061.6 12071.5 12237.8 12241.3 12276.7 12225.3 12441.3 12487.3 12519.7 13021.9 11371.8 12123.0 12421.8 12578.6 12872.4 9780.0 10211.6 10325.7 10577.2 10615.2 10162.6 10450.8 10497.2 10520.3 10637.8 11:26:13 INFO - PROCESS | 31308 | -------- Summary: end -------- 11:26:13 INFO - PROCESS | 31308 | 11:26:14 INFO - TEST-INFO | 31308: exit 0 11:26:14 INFO - TEST-OK | dromaeo_css | took 1110004ms 11:26:14 INFO - TEST-START | kraken 11:26:14 INFO - operating with platform_type : linux_ 11:26:14 INFO - Initialising browser for kraken test... 11:26:14 INFO - TEST-INFO | started process 31540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAUy1rc/profile http://localhost:44373/getInfo.html) 11:26:18 INFO - PROCESS | 31540 | 11:26:18 INFO - PROCESS | 31540 | (process:31608): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:18 INFO - PROCESS | 31540 | __metrics Screen width/height:1600/1200 11:26:18 INFO - PROCESS | 31540 | colorDepth:24 11:26:18 INFO - PROCESS | 31540 | Browser inner width/height: 1024/697 11:26:18 INFO - PROCESS | 31540 | __metrics 11:26:19 ERROR - PROCESS | 31540 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:26:20 INFO - TEST-INFO | 31540: exit 0 11:26:20 INFO - Browser initialized. 11:26:20 INFO - Running cycle 1/1 for kraken test... 11:26:20 INFO - TEST-INFO | started process 31659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAUy1rc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:22 INFO - PROCESS | 31659 | 11:26:22 INFO - PROCESS | 31659 | (process:31720): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:26:32 INFO - PROCESS | 31659 | RSS: Main: 162594816 11:26:32 INFO - PROCESS | 31659 | 11:26:34 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44373/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:35 INFO - PROCESS | 31659 | RSS: Main: 167313408 11:26:35 INFO - PROCESS | 31659 | 11:26:38 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44373/tests/kraken/driver.html?testName=audio-dft) 11:26:39 INFO - PROCESS | 31659 | RSS: Main: 167587840 11:26:39 INFO - PROCESS | 31659 | 11:26:42 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44373/tests/kraken/driver.html?testName=audio-fft) 11:26:42 INFO - PROCESS | 31659 | RSS: Main: 162680832 11:26:42 INFO - PROCESS | 31659 | 11:26:44 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44373/tests/kraken/driver.html?testName=audio-oscillator) 11:26:45 INFO - PROCESS | 31659 | RSS: Main: 163033088 11:26:45 INFO - PROCESS | 31659 | 11:26:47 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:48 INFO - PROCESS | 31659 | RSS: Main: 163401728 11:26:48 INFO - PROCESS | 31659 | 11:26:51 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44373/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:52 INFO - PROCESS | 31659 | RSS: Main: 163606528 11:26:52 INFO - PROCESS | 31659 | 11:26:55 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44373/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:56 INFO - PROCESS | 31659 | RSS: Main: 162099200 11:26:56 INFO - PROCESS | 31659 | 11:26:59 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44373/tests/kraken/driver.html?testName=json-parse-financial) 11:26:59 INFO - PROCESS | 31659 | RSS: Main: 163127296 11:26:59 INFO - PROCESS | 31659 | 11:27:01 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:02 INFO - PROCESS | 31659 | RSS: Main: 163319808 11:27:02 INFO - PROCESS | 31659 | 11:27:03 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:04 INFO - PROCESS | 31659 | RSS: Main: 163282944 11:27:04 INFO - PROCESS | 31659 | 11:27:06 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:07 INFO - PROCESS | 31659 | RSS: Main: 163401728 11:27:07 INFO - PROCESS | 31659 | 11:27:09 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:10 INFO - PROCESS | 31659 | RSS: Main: 163758080 11:27:10 INFO - PROCESS | 31659 | 11:27:13 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:14 INFO - PROCESS | 31659 | RSS: Main: 163725312 11:27:14 INFO - PROCESS | 31659 | 11:27:15 INFO - PROCESS | 31659 | Cycle 1(1): loaded http://localhost:44373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44373/tests/kraken/driver.html?testName=ai-astar) 11:27:16 INFO - PROCESS | 31659 | RSS: Main: 165236736 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | __start_tp_report 11:27:16 INFO - PROCESS | 31659 | _x_x_mozilla_page_load 11:27:16 INFO - PROCESS | 31659 | _x_x_mozilla_page_load_details 11:27:16 INFO - PROCESS | 31659 | |i|pagename|runs| 11:27:16 INFO - PROCESS | 31659 | |0;ai-astar;109;111;103;111;111;112;106;113;110;113 11:27:16 INFO - PROCESS | 31659 | |1;audio-beat-detection;151;128;156;221;127;162;160;133;193;129 11:27:16 INFO - PROCESS | 31659 | |2;audio-dft;162;163;162;164;164;175;163;162;162;163 11:27:16 INFO - PROCESS | 31659 | |3;audio-fft;75;75;75;164;76;76;75;76;180;77 11:27:16 INFO - PROCESS | 31659 | |4;audio-oscillator;93;92;190;93;93;92;150;93;93;146 11:27:16 INFO - PROCESS | 31659 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;118;117;117 11:27:16 INFO - PROCESS | 31659 | |6;imaging-darkroom;147;146;147;147;146;148;147;146;147;146 11:27:16 INFO - PROCESS | 31659 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;96;96 11:27:16 INFO - PROCESS | 31659 | |8;json-parse-financial;61;60;59;61;60;63;59;114;57;57 11:27:16 INFO - PROCESS | 31659 | |9;json-stringify-tinderbox;58;58;59;58;58;58;58;60;59;59 11:27:16 INFO - PROCESS | 31659 | |10;stanford-crypto-aes;85;80;80;80;82;79;85;84;79;80 11:27:16 INFO - PROCESS | 31659 | |11;stanford-crypto-ccm;125;131;133;127;125;131;126;125;195;125 11:27:16 INFO - PROCESS | 31659 | |12;stanford-crypto-pbkdf2;168;173;166;166;167;174;167;169;165;167 11:27:16 INFO - PROCESS | 31659 | |13;stanford-crypto-sha256-iterative;65;66;66;67;64;73;65;72;65;65 11:27:16 INFO - PROCESS | 31659 | __end_tp_report 11:27:16 INFO - PROCESS | 31659 | __start_cc_report 11:27:16 INFO - PROCESS | 31659 | _x_x_mozilla_cycle_collect,815 11:27:16 INFO - PROCESS | 31659 | __end_cc_report 11:27:16 INFO - PROCESS | 31659 | __startTimestamp1462991236007__endTimestamp 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | ------- Summary: start ------- 11:27:16 INFO - PROCESS | 31659 | Number of tests: 14 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.18 (2.9%) stddev-sans-first:3.35 11:27:16 INFO - PROCESS | 31659 | Values: 109.0 111.0 103.0 111.0 111.0 112.0 106.0 113.0 110.0 113.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:158.00 stddev:30.83 (19.5%) stddev-sans-first:32.65 11:27:16 INFO - PROCESS | 31659 | Values: 151.0 128.0 156.0 221.0 127.0 162.0 160.0 133.0 193.0 129.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.94 (2.4%) stddev-sans-first:4.12 11:27:16 INFO - PROCESS | 31659 | Values: 162.0 163.0 162.0 164.0 164.0 175.0 163.0 162.0 162.0 163.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:40.82 (54.1%) stddev-sans-first:42.65 11:27:16 INFO - PROCESS | 31659 | Values: 75.0 75.0 75.0 164.0 76.0 76.0 75.0 76.0 180.0 77.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#4] audio-oscillator Cycles:10 Average:113.50 Median:93.00 stddev:35.38 (38.0%) stddev-sans-first:36.74 11:27:16 INFO - PROCESS | 31659 | Values: 93.0 92.0 190.0 93.0 93.0 92.0 150.0 93.0 93.0 146.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:27:16 INFO - PROCESS | 31659 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:27:16 INFO - PROCESS | 31659 | Values: 147.0 146.0 147.0 147.0 146.0 148.0 147.0 146.0 147.0 146.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:27:16 INFO - PROCESS | 31659 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:60.00 stddev:17.28 (28.8%) stddev-sans-first:18.26 11:27:16 INFO - PROCESS | 31659 | Values: 61.0 60.0 59.0 61.0 60.0 63.0 59.0 114.0 57.0 57.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 11:27:16 INFO - PROCESS | 31659 | Values: 58.0 58.0 59.0 58.0 58.0 58.0 58.0 60.0 59.0 59.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.41 (3.0%) stddev-sans-first:2.18 11:27:16 INFO - PROCESS | 31659 | Values: 85.0 80.0 80.0 80.0 82.0 79.0 85.0 84.0 79.0 80.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:129.00 stddev:21.54 (16.7%) stddev-sans-first:22.58 11:27:16 INFO - PROCESS | 31659 | Values: 125.0 131.0 133.0 127.0 125.0 131.0 126.0 125.0 195.0 125.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:167.50 stddev:3.01 (1.8%) stddev-sans-first:3.19 11:27:16 INFO - PROCESS | 31659 | Values: 168.0 173.0 166.0 166.0 167.0 174.0 167.0 169.0 165.0 167.0 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - PROCESS | 31659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:3.12 (4.7%) stddev-sans-first:3.24 11:27:16 INFO - PROCESS | 31659 | Values: 65.0 66.0 66.0 67.0 64.0 73.0 65.0 72.0 65.0 65.0 11:27:16 INFO - PROCESS | 31659 | -------- Summary: end -------- 11:27:16 INFO - PROCESS | 31659 | 11:27:16 INFO - TEST-INFO | 31659: exit 0 11:27:16 INFO - TEST-OK | kraken | took 62927ms 11:27:16 INFO - SUITE-END | took 1172s 11:27:17 INFO - Completed test suite (00:19:33) 11:27:17 INFO - javascript benchmark 11:27:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.382923415317, 3118.4698601237797, 3159.2417819723273, 3225.0324902529237, 3239.044481877844, 5404.594655400846, 5413.242146099545, 5482.040642887494, 5538.529225015878, 5541.0580201365765, 5340.599455040868, 5481.917771233425, 5540.97491963987, 5542.944570554293, 5562.833115006556, 4948.9257661135025, 4988.251762235657, 5101.464346243647, 5103.974480127594, 5177.559907407875, 599.4426278887697, 4906.362172917516, 4983.401991760994, 5045.84862454127, 5059.3169922060415, 5007.84976450707, 5019.774110165052, 5022.42242142151, 5043.344365232515, 5058.822941197059, 4993.575546078588, 5000.874978125539, 5007.774650140716, 5017.37282839645, 5023.799048038074, 4974.328465657126, 5003.349564556621, 5010.298558201855, 5025.899482010376, 5035.974820125876, 5403.2705584745945, 5429.647072940246, 5445.9727701361635, 5465.699386533739, 5475.479829416199, 5716.085426331767, 5796.217510636052, 5884.352721200665, 5887.61730487517, 5898.380670029628, 5883.38224486427, 5910.852228694317, 5919.55603329752, 5931.970340148315, 5975.731092100866, 5475.561955043627, 5510.504054635062, 5520.337559492847, 5523.806666766684, 5528.391876893538, 5860.00379935412, 6018.638881667114, 6020.157177995085, 6021.939780602225, 6044.455998960027, 5772.105323674838, 5774.0, 5782.479576838105, 5783.814318064787, 5786.826395208151, 5891.882162356815, 5900.557458190653, 5903.527717782567, 5904.202932604129, 5917.644941303535, 5708.40061793514, 5742.626729262584, 5766.163906233573, 5769.88460230793, 5922.466977972003, 5728.427157284322, 5768.94231057684, 5778.3643799182055, 5785.71071446426, 5808.477237048686, 4358.21552120615, 4391.8682439526865, 4402.977985110054, 4403.053343531156, 4437.511873693891, 3822.1782316802023, 3923.3330333843314, 3987.5613682494904, 4021.276170289376, 4023.0, 5596.132599447093, 5607.80372686954, 5610.326760788732, 5654.349749778746, 5659.943400565941, 5814.505767009767, 5924.940750592526, 5953.315368732565, 5962.40375962409, 5967.6121052131475, 5561.499465048165, 5578.44215578447, 5593.468620481048, 5595.076812326002, 5606.579506537026, 4952.504749525018, 4992.875178120504, 5026.924596131061, 5029.798808047711, 5060.696358218519, 5983.760649574056, 5989.520838332923, 6019.4883434908525, 6041.758329666852, 6088.238970128734, 5883.764649414061, 5928.436798504135, 5946.28644562638, 5955.821325360246, 5976.910346344808, 6084.969575152096, 6096.695165241809, 6101.481374083075, 6107.267127944675, 6109.877802443837, 5656.123300888369, 5798.420157984337, 5803.071508558611, 5810.854728631818, 5820.82537523875, 5986.461218490357, 5990.041593345044, 5996.640201587918, 6002.159697642246, 6036.728347224298, 5793.768249269982, 5861.531077513874, 5862.736176871966, 5863.413658634103, 5869.6771677556435, 5558.91661625084, 5690.260266165537, 5719.256496655408, 5734.455226753452, 5813.7674493021495, 5617.241672374177, 5618.606697531133, 5623.775048997994, 5636.4927156556105, 5660.518855897295, 5757.971210143923, 5773.884522309446, 5777.508911742549, 5787.784565241346, 5827.358990510956, 5551.944480555143, 5569.470900264469, 5627.071533196977, 5670.886582268414, 5677.403872593483], "value": 5383.433252044619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1302031584677, 658.2627457247883, 663.9402453779159, 673.3333999340653, 682.0928165539832, 41990.0, 43503.34744978828, 43997.0, 44392.55607443924, 44691.329630055494, 43992.12015759691, 44429.33355999662, 44504.55495445045, 44543.77728111363, 44570.33144502827, 8796.95601521993, 8958.23854972328, 8968.103189681013, 8977.730668079936, 8997.820043599124, 8791.252743516809, 8872.423292485968, 8940.552972351388, 8947.194752472276, 8947.239484643813, 8948.373613847034, 8949.06034866336, 8955.0, 8966.237869781076, 9007.279417646605, 8815.647374105029, 8854.911450885538, 8865.689700860472, 8872.15714507124, 8885.422447540921, 8789.945206575252, 8902.86645700315, 8903.154200350957, 8904.243139333164, 8933.151350621745, 40302.798486007676, 40402.595974040174, 40642.59357406418, 40671.796641016605, 40950.1809963799, 3601.981990090059, 3613.4941108244866, 3668.8899333020054, 3674.2467794102145, 4060.20825938942, 31651.0, 31783.36433271345, 32372.6762732372, 32392.19019524507, 33552.0, 4348.152110338485, 4349.543297953701, 4368.060866913597, 4371.082072764723, 4380.978095109536, 323298.0, 323912.0, 325306.0, 326226.0, 328314.35842820874, 35371.64628353684, 35892.28215435677, 56413.0, 57121.428785711614, 57373.426265737646, 37499.4375084374, 37564.24871502555, 37643.24713505714, 37665.62334376621, 37722.43416348757, 13864.168149910836, 13883.861161388459, 13946.86053139476, 13949.651258718613, 13997.30013499321, 11476.59831905896, 11512.424378781028, 11563.595274165364, 11570.132240081859, 11621.6513504595, 8409.621567029499, 8513.808066870643, 8547.0, 8549.187827156411, 8600.78498037554, 3299.637039925606, 3339.816310102919, 3370.393329200718, 3377.5440315557084, 3377.8142202179115, 1064.8722153341494, 1075.93544387337, 1086.625114335553, 1157.3113997171838, 1174.4069245031205, 31734.523982140287, 32106.83946580299, 32387.35225295528, 32714.0, 32774.180645484055, 1174.7356844710043, 1195.8026925557185, 1206.9155159138952, 1220.0605533738972, 1268.6764874957012, 16898.831011689726, 17145.0, 17250.65498690044, 17352.3059077638, 17358.652826943642, 466635.0, 469812.0, 474009.0, 476133.0, 476522.0, 57404.0, 58747.118793218135, 58854.11718824221, 58894.116588251214, 58938.0, 1410.1468611490106, 1411.8235220597426, 1428.3715165327224, 1440.517426662059, 1443.2639353929571, 30425.847870760503, 31332.373352532366, 31438.0, 31936.6806331943, 31953.201169970936, 49426.25860612166, 49473.25790113079, 49617.255741163186, 49861.25208121809, 49958.0, 388082.0, 389313.0, 390686.0, 392311.0, 392689.0, 27817.721822781514, 28126.578101328905, 28292.575611366257, 28379.290517737223, 28695.85652071726, 47387.52612473969, 47839.0, 48349.516504835905, 48385.27422088742, 48461.757691212726, 40137.39793903152, 40614.79692601518, 41230.79384603058, 41432.58567414287, 41699.1660166801, 41021.38467922924, 41412.171756564094, 41513.37729933993, 41726.0, 42314.0, 39549.60450395574, 41735.58264417317, 42602.360964584936, 43264.56735432606, 44912.55087449084, 34254.0, 38968.6103138965, 39761.40357894692, 39993.80003099966, 40221.396679049256, 28232.85883570569, 28262.85868570644, 28305.0, 28412.289692757848, 28785.0], "value": 18850.19438768617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.20359281437123, 401.8091406581873, 402.21969379403953, 404.46408508725926, 418.6692512914797, 13715.177089374645, 18101.366452174178, 18871.433856984313, 19758.407247782554, 19851.617805863298, 18377.44867653969, 18643.254269829224, 19157.616847663037, 19252.22991080355, 19314.45484361251, 5632.464915832989, 5720.313562372511, 5850.0932355484965, 5864.677442740669, 5904.439078287577, 5761.337446193678, 5778.364379918226, 5780.682062486561, 5787.045137552299, 5814.5057670098095, 5527.447255274481, 5751.913721294184, 5784.479396854283, 5787.102999035156, 5794.884102317972, 5706.115552089433, 5743.913841292384, 5757.07886738124, 5761.654300741927, 5771.076627739562, 6279.623222606612, 6738.797836064877, 6744.865102697968, 6786.72853085876, 6881.483888708367, 23240.53518929629, 25363.239102826945, 26371.868140659175, 26513.867430662915, 26713.332166695793, 2455.226603619854, 2528.911488097926, 2550.642909992584, 2600.726923673006, 2808.789340799428, 16001.919990399974, 16024.919875400665, 16054.27755750994, 16167.676646467122, 16296.348146074142, 2153.0, 2205.4596623827106, 2354.0348457132495, 2357.2574638988663, 2358.50471401006, 93344.53327733318, 97053.51473242659, 99466.00533994712, 100696.49651751768, 101050.49474752652, 16997.235124419432, 18008.0, 18285.268589256546, 18308.725369119475, 18343.724844127348, 32685.673143268737, 32986.835065825, 33154.17114572155, 33346.0, 33388.0, 9386.389884657476, 9398.2951278653, 9550.185464761811, 9609.615615375447, 9774.706758797247, 7854.921450785419, 7924.088729796032, 7979.122296547375, 8027.879581806277, 8034.035915690155, 8881.24509416694, 8905.154010369004, 9120.543972801333, 9281.767955801159, 9324.627014919462, 3560.3235385276716, 3582.1223800168605, 3612.8012959286966, 3707.0, 3708.2398108387715, 970.6505657963128, 1018.8930162332848, 1046.8115739167024, 1071.7106381277167, 1082.2316155529504, 17218.741718874226, 18874.528136796416, 19134.90432547856, 19282.71075933862, 19444.611107777764, 985.3102828020415, 1007.8236308645958, 1040.9739756506149, 1050.669039252633, 1063.2185343772321, 10641.148708103334, 10747.247692661595, 10950.06924411434, 10998.395088270221, 11039.227254092297, 392778.0, 397007.0, 399530.0, 501392.0, 565170.0, 87947.0, 96583.3758286588, 98360.0, 103689.0, 107633.46183269033, 457.9633629309647, 470.15841643457827, 471.1096028506126, 471.40132032318763, 472.84632494439444, 10054.49727513636, 10527.789444211227, 10882.564697412015, 10932.289401188897, 10962.725931851768, 38471.80764096162, 39519.80240098896, 39896.60103398929, 40387.394189087776, 40652.0, 51245.743771280904, 55323.0, 57265.0, 57297.0, 59912.40087599068, 11737.706557336134, 12922.224666520038, 13020.8046879295, 13250.933745331211, 13275.867241327463, 14774.0, 14793.556193314218, 14986.850131498546, 15089.54731358061, 15250.77123843121, 5894.793682221101, 9153.901531815958, 9217.723468295962, 12191.878081219074, 12874.806877897026, 12448.81326780081, 12596.496140154291, 12830.55093071738, 12979.28613926243, 13192.868071319164, 12973.870261297267, 13025.413856376295, 13101.148425352321, 13264.46942122343, 13299.601011969657, 13250.0, 13391.531296404968, 13410.463581457023, 13410.9329453356, 13617.659558511117, 12553.560625378068, 12668.936655316664, 12769.233845969271, 12949.223046617233, 12978.870211298145], "value": 10222.818471354178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.7566789313712, 1566.5300409877038, 1724.5257554172601, 1850.9167087481062, 1862.5622978600036, 7939.0, 8436.493810371381, 8711.651533938642, 9158.267338612912, 9247.936487303961, 8759.386842920998, 8762.0, 8831.514266715329, 8857.512836793974, 8874.556272186397, 2337.2871274261342, 2347.6595893595418, 2368.2539999900064, 2371.8932648030795, 2373.050779688121, 2312.491251924574, 2330.2426711318803, 2330.673705681206, 2344.507653392781, 2351.1535847095033, 2322.93031209064, 2323.732770731362, 2333.0667732906886, 2352.047420794572, 2352.764723527651, 2232.0179121186625, 2239.5185035217423, 2241.036354367613, 2255.7744225577476, 2263.660450932365, 2228.454028762947, 2275.954480910389, 2284.6344584866506, 2287.451011757183, 2290.9198178063853, 8944.686935957276, 9005.864912026325, 9010.459372437675, 9019.098090190993, 9020.323475739346, 5282.445343238982, 5375.865603359908, 5402.189671549259, 5408.107662235727, 5439.292891924025, 3300.6369299377047, 3370.241695618466, 3387.9661203388146, 3505.1587618971516, 3540.5751309842726, 1079.5627770752858, 1089.4008295437477, 1098.7088421568292, 1102.2614848051744, 1112.5994641928899, 12721.10952233344, 12724.618261452264, 12725.55460558876, 12793.104482686123, 12806.231626102464, 4633.606143477842, 4645.7167627465515, 4701.576858082789, 4741.122892264942, 4760.45254795696, 10590.205734569938, 10617.416042117604, 10688.893111068945, 10702.0, 10702.50164976904, 5245.321497120961, 5294.894102117936, 5322.121849894801, 5359.892802143935, 5412.5940554458575, 4381.474223093249, 4824.372831531879, 4954.281629163751, 5009.373828271466, 5029.497050295015, 4077.571854955246, 4105.322621767435, 4126.259367710568, 4130.772807495557, 4138.565450627701, 1280.1870812034426, 1326.966825829362, 1338.2037687575876, 1338.8795008449092, 1365.5834970333945, 925.7037747920735, 955.8088382323563, 972.547765289144, 982.9164521015794, 985.049427302642, 5542.334919809648, 5856.472917437451, 5928.288605367384, 5960.37416071315, 6040.848978775566, 931.1200915135132, 952.48565774481, 982.5480279071708, 1006.3609607898891, 1012.00823193271, 3947.6052394760295, 3948.664363529132, 4023.5171779386073, 4049.716519843583, 4059.9594004060173, 10608.31045982024, 11127.888721112848, 11137.610183643534, 11225.494852731483, 11302.491387887565, 10964.342139471657, 11050.502727377287, 11055.72360690973, 11092.833607495893, 11118.833217501744, 8301.83396332082, 8339.874901876477, 8362.777984842838, 8437.325013998865, 8523.445976011539, 5678.517326027334, 5707.086866101404, 5725.141228815544, 5736.99602569557, 5899.085641725539, 10307.793844122925, 10389.532471038972, 10418.895811042095, 10526.736831579272, 10574.8413773795, 10320.793584128425, 10330.380177189392, 10438.68683939483, 10609.469526523797, 10686.73283167927, 7016.438684905297, 7652.273034061755, 7740.187280335709, 7996.680132794623, 8063.113057563781, 8810.515421651615, 8812.16284452976, 8828.293736501193, 8902.55487225649, 8917.10828917103, 7564.773056808304, 7856.84286314282, 8108.310793582612, 8110.635021424168, 8188.058373287148, 7785.766427007199, 7838.921610783819, 7855.410844186823, 7874.251946065115, 7961.243681850447, 6541.182352205974, 7199.2440793715905, 7208.243134471015, 7240.52936559122, 7285.635718213962, 5016.448190699093, 5027.472115427828, 5133.79464821403, 5163.0, 5192.948070519397, 4976.0794253063295, 5015.974920125376, 5041.495850414929, 5078.669886457368, 5107.463716309882], "value": 4700.575108820537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.4048658764816, 319.5191237188032, 321.52414426648545, 324.4532961959099, 326.1162250301682, 5721.513671337936, 5727.799527016556, 5739.139129130627, 5768.423157684229, 5773.9711301443485, 5613.607047506676, 5649.971750141254, 5674.31908171019, 5681.545476361892, 5683.744231509581, 4097.242010228102, 4127.607877251657, 4258.850940217093, 4261.659067274611, 4282.914341713164, 4283.550227226143, 4305.160493703729, 4306.35404689296, 4323.5460276670965, 4325.00524879278, 4279.0, 4282.850100246492, 4298.634616057639, 4308.246056940038, 4319.136172765444, 4040.3535434330365, 4227.260229459863, 4235.449391579105, 4242.575742425733, 4297.72064815786, 3700.703943684499, 3707.5550933888107, 3713.851445942159, 3721.813909304551, 3731.3843215869347, 5394.568434525268, 5446.2375267462585, 5453.127499600045, 5455.427180146067, 5462.863428414282, 4633.235516139833, 4877.365942427462, 4883.926741098886, 4885.2427873679635, 4931.137051016094, 5779.739911703983, 5794.304683438015, 5814.47669709724, 5858.677772722499, 5861.150133230701, 4035.59644035597, 4058.4723985881647, 4080.5511393746665, 4089.5092588889224, 4101.712880098395, 5990.520758339322, 6154.538184726101, 6154.876902461926, 6160.490679783437, 6172.321044685081, 4158.209940111369, 4180.352045432963, 4180.979095104505, 4188.120494696087, 4195.748255104703, 4252.659787217015, 4255.212785634668, 4259.488861336597, 4260.318349064135, 4261.401974259653, 4591.4260717410325, 4835.975820120877, 4868.878278043077, 4881.511848815161, 4905.9264111038365, 5908.675022873783, 5924.7926322578505, 5926.2295901532525, 5992.520598352121, 5999.160117583542, 1460.7443697353133, 1468.3098943496752, 1469.926503674812, 1477.4533422633478, 1480.992595037018, 920.7744102694883, 938.2259635800356, 964.6816550538306, 971.4414211828228, 980.6567701304486, 5530.834074977757, 5632.887342253214, 5638.436156384329, 5654.802081927113, 5684.914726279109, 5958.404159584007, 5959.927213101683, 5971.253593300838, 5988.323269484551, 6111.633302001894, 5535.280413546294, 5751.683657398799, 5766.135079738073, 5832.795852145239, 5891.941080589225, 3210.486322188439, 3259.4028925826174, 3302.1414432247307, 3302.950455743118, 3314.2708604107056, 6120.418560236771, 6287.528435367366, 6347.460465860454, 6348.396902294275, 6479.514036447285, 6230.719617617218, 6259.7496100156395, 6298.212723409574, 6341.492680585542, 6345.555811093272, 6082.11809287642, 6389.297177310492, 6391.936080639227, 6396.0, 6417.711202995876, 5993.550483713826, 6209.285932117684, 6214.658193799384, 6236.126942228001, 6239.688015599293, 6081.604695694766, 6104.816855494342, 6111.388861113853, 6115.04318618038, 6182.041783523561, 6113.755449781959, 6194.318624951342, 6238.875222495615, 6241.251049874044, 6283.403076707888, 4139.606737360066, 4225.302825033835, 4247.490301163756, 4258.574142585717, 4268.957310426856, 5906.2026626406605, 6101.481374083252, 6105.542084343603, 6167.105769663463, 6196.783112591038, 5807.651540907559, 5982.970085149546, 5997.610155339889, 5998.80023995194, 6020.247469066367, 6002.519798416203, 6030.336662966983, 6042.398764327545, 6054.697265136813, 6074.0, 5611.831645050655, 5809.24479817621, 5844.912326315194, 5868.119782032729, 5909.0, 5898.9115163273445, 5913.852153696192, 5942.524598032233, 6030.969845150747, 6095.908561371672, 5719.227904233042, 5830.358660547421, 5840.678762668094, 5865.73604187804, 5883.794067207627], "value": 4465.472637854684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.0522194254665, 854.7350321400367, 868.7871471489486, 869.6521391443425, 908.2733812949639, 14518.491852785155, 15081.547553573397, 15105.62235944102, 15462.304196311165, 15565.0, 15443.92278038611, 15482.458113966013, 15483.69032619347, 15594.142322172276, 15616.297266623002, 835.173178553231, 842.4145219072747, 844.771911583872, 845.9111793261711, 862.0904945282724, 851.1190917400492, 851.1360968616859, 857.8069934264803, 858.6007506509471, 860.8106216632331, 903.8599017152319, 905.248643625789, 908.2824568590838, 908.3732224764924, 910.3763921713614, 892.7277180459989, 896.7847716547982, 897.5691667999397, 899.6446403670546, 900.0909081827336, 652.1098700274139, 652.2075678051143, 653.7123665587173, 654.1300070905684, 655.5673255651247, 14762.114273143647, 14766.630834229123, 14868.702625947528, 14883.776743348859, 14909.627259318495, 13722.245276509788, 13799.51701690436, 13829.79255311171, 13873.722525549432, 13885.722285554233, 11391.259568128045, 11482.827757583644, 11566.47950842214, 11665.24175928562, 11669.416529173508, 3794.677452416548, 3835.654791068789, 3852.191039881628, 3892.9805350973347, 3942.1327307992483, 53799.0, 53801.1929821053, 53876.461235387535, 54036.0, 54767.0, 10889.782204355868, 10918.1811364148, 11100.809506719284, 11121.110311175087, 11156.107511399068, 18949.810501894804, 18986.0, 19039.904800476186, 19043.714344284846, 19261.13324900383, 8269.710560130367, 8381.371397145238, 8421.831563368822, 8428.4942903426, 8536.914630853613, 4724.527547245248, 4734.171519983989, 4767.475577686451, 4807.0, 4838.588719958843, 3422.3839708852647, 3580.695640870503, 3584.766990145632, 3595.0, 3600.189957259648, 645.5416654175494, 650.9349065093453, 656.95401321907, 657.103054330835, 692.4840993459904, 706.7914965085312, 792.4611264340303, 798.1499702816482, 801.1867954026668, 808.2725547007623, 9291.535423228812, 9313.953430232805, 9615.807683846284, 9633.855492167622, 9641.951790241004, 787.9763607091796, 790.9288164065262, 792.3621484704753, 794.5471081483499, 797.2744802229943, 4563.224251877189, 4717.599004084691, 4735.550122738335, 4775.832845850378, 4835.95164048362, 59929.101063484086, 60483.69758151181, 61750.69124654348, 61983.1405057849, 62747.0, 56358.43641563614, 56384.15423768647, 56393.718031410404, 56952.14571781427, 58842.0, 50041.0, 50456.24315635195, 50632.49367506352, 51184.74407627938, 51621.0, 8610.65557377698, 8625.611847467004, 8928.464292142233, 8984.281257499253, 9092.772680683036, 33518.83240583781, 33761.493577595866, 33792.0, 34074.20622531432, 34287.48568771421, 41960.0, 43215.35176972285, 43380.13239735251, 43647.0, 43991.0, 10792.946035269773, 11003.504842281956, 11020.944895275472, 11073.612423565137, 11221.326720396803, 12341.0, 12623.558175464183, 12813.295268759935, 12833.358332083546, 13311.00167487423, 12061.585128568408, 12071.517139314328, 12237.816432753338, 12241.326727030098, 12276.693082672648, 12225.327606981702, 12441.315727635067, 12487.250764954131, 12519.687007824878, 13021.934890325489, 11371.772564548497, 12123.0, 12421.75156496847, 12578.55975040869, 12872.420741066488, 9780.0, 10211.591536338761, 10325.74185645335, 10577.206709496664, 10615.203859710398, 10162.593496260066, 10450.843237351597, 10497.16022718196, 10520.263581549218, 10637.840432393676], "value": 6878.406716023852, "unit": "score"}], "name": "dromaeo_css", "value": 7287.561795104254, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 103.0, 111.0, 111.0, 112.0, 106.0, 113.0, 110.0, 113.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 156.0, 221.0, 127.0, 162.0, 160.0, 133.0, 193.0, 129.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 164.0, 175.0, 163.0, 162.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 164.0, 76.0, 76.0, 75.0, 76.0, 180.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 190.0, 93.0, 93.0, 92.0, 150.0, 93.0, 93.0, 146.0], "value": 113.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 61.0, 60.0, 63.0, 59.0, 114.0, 57.0, 57.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 60.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 80.0, 80.0, 82.0, 79.0, 85.0, 84.0, 79.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 131.0, 133.0, 127.0, 125.0, 131.0, 126.0, 125.0, 195.0, 125.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 166.0, 166.0, 167.0, 174.0, 167.0, 169.0, 165.0, 167.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 64.0, 73.0, 65.0, 72.0, 65.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1571.7, "alertThreshold": 2.0}]} 11:27:17 INFO - Return code: 0 11:27:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:27:17 ERROR - # TBPL SUCCESS # 11:27:17 INFO - Running post-action listener: _resource_record_post_action 11:27:17 INFO - ##### 11:27:17 INFO - ##### Finished run-tests step (success) 11:27:17 INFO - ##### 11:27:17 INFO - Running post-run listener: _resource_record_post_run 11:27:18 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 543887360; Read time: 0; Write time: 697280 11:27:18 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 254529536; Read time: 0; Write time: 395624 11:27:18 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 288759808; Read time: 0; Write time: 301656 11:27:18 INFO - Running post-run listener: _upload_blobber_files 11:27:18 INFO - Blob upload gear active. 11:27:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:18 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 11:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:19 INFO - (blobuploader) - INFO - Done attempting. 11:27:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:20 INFO - (blobuploader) - INFO - Done attempting. 11:27:20 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:20 INFO - Return code: 0 11:27:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51a024498f7cc3d5ad003eb3ea38933e7c9b5548189785d4953dc4d14f3d12fb73b01ed26f90cb5eed386f7d30b7dfc5336a61d2570382fee9e51086576ee228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50b7f08941d865fc0bdeb7279c09f24dbad9a5963e0adc5f97c9c8d02ebcba7cdb76bb2cf7cbddb32d8178b8b8ae6f8f9cd13881af4497aac959e9328c8bcd5e"} 11:27:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:20 INFO - Contents: 11:27:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51a024498f7cc3d5ad003eb3ea38933e7c9b5548189785d4953dc4d14f3d12fb73b01ed26f90cb5eed386f7d30b7dfc5336a61d2570382fee9e51086576ee228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50b7f08941d865fc0bdeb7279c09f24dbad9a5963e0adc5f97c9c8d02ebcba7cdb76bb2cf7cbddb32d8178b8b8ae6f8f9cd13881af4497aac959e9328c8bcd5e"} 11:27:20 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:20 INFO - Copying logs to upload dir... 11:27:20 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.234077 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-11 11:27:20.409595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:20.412868) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51a024498f7cc3d5ad003eb3ea38933e7c9b5548189785d4953dc4d14f3d12fb73b01ed26f90cb5eed386f7d30b7dfc5336a61d2570382fee9e51086576ee228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50b7f08941d865fc0bdeb7279c09f24dbad9a5963e0adc5f97c9c8d02ebcba7cdb76bb2cf7cbddb32d8178b8b8ae6f8f9cd13881af4497aac959e9328c8bcd5e"} build_url:https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/bx-O2C0HRQuDuXptOO-Rvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51a024498f7cc3d5ad003eb3ea38933e7c9b5548189785d4953dc4d14f3d12fb73b01ed26f90cb5eed386f7d30b7dfc5336a61d2570382fee9e51086576ee228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50b7f08941d865fc0bdeb7279c09f24dbad9a5963e0adc5f97c9c8d02ebcba7cdb76bb2cf7cbddb32d8178b8b8ae6f8f9cd13881af4497aac959e9328c8bcd5e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:20.437472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:20.437844) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1462987561.205085-1074851424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 11:27:20.519797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 11:27:20.520099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 11:27:20.520363) ========= ========= Total master_lag: 0.14 =========