builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1462874892.14 results: success (0) buildid: 20160510023217 builduid: fd7bb5f2090448d7aee97f0ec9b8f060 revision: 553a9575ad40687f2a5486b1170de0ae8a280015 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:08:12.137766) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:08:12.138456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-05-10 03:08:12.138942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-05-10 03:08:16.488045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-05-10 03:08:16.488309) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 03:08:16-- 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% 211M=0s 2016-05-10 03:08:18 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.856100 ========= master_lag: 2.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-05-10 03:08:20.646957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:08:20.647287) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012867 ========= master_lag: 0.60 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:08:21.262058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-05-10 03:08:21.262441) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 553a9575ad40687f2a5486b1170de0ae8a280015 --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 553a9575ad40687f2a5486b1170de0ae8a280015 --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=14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 03:08:21,679 truncating revision to first 12 chars 2016-05-10 03:08:21,679 Setting DEBUG logging. 2016-05-10 03:08:21,680 attempt 1/10 2016-05-10 03:08:21,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/553a9575ad40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 03:08:25,317 unpacking tar archive at: fx-team-553a9575ad40/testing/mozharness/ program finished with exit code 0 elapsedTime=6.041753 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-05-10 03:08:27.573919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:08:27.574234) ========= script_repo_revision: 553a9575ad40687f2a5486b1170de0ae8a280015 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:08:27.574625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-05-10 03:08:27.574885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-05-10 03:08:31.136991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-05-10 03:08:31.137371) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:31 INFO - MultiFileLogger online at 20160510 03:08:31 in /builds/slave/test 03:08:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:08:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:31 INFO - {'append_to_log': False, 03:08:31 INFO - 'base_work_dir': '/builds/slave/test', 03:08:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:08:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:31 INFO - 'branch': 'Fx-Team-Non-PGO', 03:08:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:31 INFO - 'config_files': ('talos/linux_config.py',), 03:08:31 INFO - 'default_actions': ('clobber', 03:08:31 INFO - 'read-buildbot-config', 03:08:31 INFO - 'download-and-extract', 03:08:31 INFO - 'populate-webroot', 03:08:31 INFO - 'create-virtualenv', 03:08:31 INFO - 'install', 03:08:31 INFO - 'run-tests'), 03:08:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:31 INFO - 'download_minidump_stackwalk': True, 03:08:31 INFO - 'download_symbols': 'ondemand', 03:08:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:31 INFO - 'installer_path': 'installer.exe', 03:08:31 INFO - 'log_level': 'info', 03:08:31 INFO - 'log_name': 'talos', 03:08:31 INFO - 'log_to_console': True, 03:08:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:31 INFO - 'opt_config_files': (), 03:08:31 INFO - 'pip_index': False, 03:08:31 INFO - 'sps_profile': False, 03:08:31 INFO - 'sps_profile_interval': 0, 03:08:31 INFO - 'suite': 'dromaeojs-e10s', 03:08:31 INFO - 'system_bits': '32', 03:08:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:31 INFO - 'title': 'talos-linux64-ix-036', 03:08:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:31 INFO - 'use_talos_json': True, 03:08:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:31 INFO - 'work_dir': 'build'} 03:08:31 INFO - ##### 03:08:31 INFO - ##### Running clobber step. 03:08:31 INFO - ##### 03:08:31 INFO - Running pre-action listener: _resource_record_pre_action 03:08:31 INFO - Running main action method: clobber 03:08:31 INFO - rmtree: /builds/slave/test/build 03:08:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:32 INFO - Running post-action listener: _resource_record_post_action 03:08:32 INFO - ##### 03:08:32 INFO - ##### Finished clobber step (success) 03:08:32 INFO - ##### 03:08:32 INFO - ##### 03:08:32 INFO - ##### Running read-buildbot-config step. 03:08:32 INFO - ##### 03:08:32 INFO - Running pre-action listener: _resource_record_pre_action 03:08:32 INFO - Running main action method: read_buildbot_config 03:08:32 INFO - Using buildbot properties: 03:08:32 INFO - { 03:08:32 INFO - "project": "", 03:08:32 INFO - "product": "firefox", 03:08:32 INFO - "script_repo_revision": "production", 03:08:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:08:32 INFO - "repository": "", 03:08:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:08:32 INFO - "buildid": "20160510023217", 03:08:32 INFO - "pgo_build": "False", 03:08:32 INFO - "basedir": "/builds/slave/test", 03:08:32 INFO - "buildnumber": 1249, 03:08:32 INFO - "slavename": "talos-linux64-ix-036", 03:08:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:08:32 INFO - "platform": "ubuntu64_hw", 03:08:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:08:32 INFO - "branch": "fx-team", 03:08:32 INFO - "repo_path": "integration/fx-team", 03:08:32 INFO - "revision": "553a9575ad40687f2a5486b1170de0ae8a280015", 03:08:32 INFO - "stage_platform": "linux64", 03:08:32 INFO - "builduid": "fd7bb5f2090448d7aee97f0ec9b8f060", 03:08:32 INFO - "slavebuilddir": "test" 03:08:32 INFO - } 03:08:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:08:32 INFO - Running post-action listener: _resource_record_post_action 03:08:32 INFO - ##### 03:08:32 INFO - ##### Finished read-buildbot-config step (success) 03:08:32 INFO - ##### 03:08:32 INFO - ##### 03:08:32 INFO - ##### Running download-and-extract step. 03:08:32 INFO - ##### 03:08:32 INFO - Running pre-action listener: _resource_record_pre_action 03:08:32 INFO - Running main action method: download_and_extract 03:08:32 INFO - mkdir: /builds/slave/test/build/tests 03:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:32 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:08:35 INFO - Downloaded 1361 bytes. 03:08:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:35 INFO - Using the following test package requirements: 03:08:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:08:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:08:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'jsshell-linux-x86_64.zip'], 03:08:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:08:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:08:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:08:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:08:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:35 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:08:55 INFO - Downloaded 22323319 bytes. 03:08:55 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'] 03:08:55 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 03:08:56 INFO - Return code: 0 03:08:56 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 03:08:56 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')]} 03:08:56 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:09:15 INFO - Downloaded 22323319 bytes. 03:09:15 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'] 03:09:15 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 03:09:17 INFO - Return code: 0 03:09:17 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')]} 03:09:17 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:09:19 INFO - Downloaded 10840152 bytes. 03:09:19 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'] 03:09:19 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 03:09:19 INFO - Return code: 0 03:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:19 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:09:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:09:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:09:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/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 03:09:21 INFO - Downloaded 54861467 bytes. 03:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:09:21 INFO - mkdir: /builds/slave/test/properties 03:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:21 INFO - Contents: 03:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:09:22 INFO - Running post-action listener: _resource_record_post_action 03:09:22 INFO - Running post-action listener: set_extra_try_arguments 03:09:22 INFO - ##### 03:09:22 INFO - ##### Finished download-and-extract step (success) 03:09:22 INFO - ##### 03:09:22 INFO - ##### 03:09:22 INFO - ##### Running populate-webroot step. 03:09:22 INFO - ##### 03:09:22 INFO - Running pre-action listener: _resource_record_pre_action 03:09:22 INFO - Running main action method: populate_webroot 03:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:22 INFO - '--tppagecycles', 03:09:22 INFO - '7'], 03:09:22 INFO - 'tests': ['tsvgm']}}, 03:09:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:09:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['damp', 'tps']}, 03:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'tests': ['damp', 'tps']}, 03:09:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['dromaeo_dom']}, 03:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['a11yr', 03:09:22 INFO - 'ts_paint', 03:09:22 INFO - 'tpaint', 03:09:22 INFO - 'sessionrestore', 03:09:22 INFO - 'sessionrestore_no_auto_restore', 03:09:22 INFO - 'tabpaint']}, 03:09:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:22 INFO - 'ts_paint', 03:09:22 INFO - 'tpaint', 03:09:22 INFO - 'sessionrestore', 03:09:22 INFO - 'sessionrestore_no_auto_restore', 03:09:22 INFO - 'tabpaint']}, 03:09:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:09:22 INFO - 'ts_paint', 03:09:22 INFO - 'tpaint', 03:09:22 INFO - 'sessionrestore', 03:09:22 INFO - 'sessionrestore_no_auto_restore', 03:09:22 INFO - 'tabpaint']}, 03:09:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:09:22 INFO - 'ts_paint', 03:09:22 INFO - 'tpaint', 03:09:22 INFO - 'sessionrestore', 03:09:22 INFO - 'sessionrestore_no_auto_restore', 03:09:22 INFO - 'tabpaint']}, 03:09:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['a11yr', 03:09:22 INFO - 'ts_paint', 03:09:22 INFO - 'tpaint', 03:09:22 INFO - 'sessionrestore', 03:09:22 INFO - 'sessionrestore_no_auto_restore', 03:09:22 INFO - 'tabpaint']}, 03:09:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['a11yr', 03:09:22 INFO - 'ts_paint', 03:09:22 INFO - 'tpaint', 03:09:22 INFO - 'sessionrestore', 03:09:22 INFO - 'sessionrestore_no_auto_restore', 03:09:22 INFO - 'tabpaint']}, 03:09:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['tsvgx', 03:09:22 INFO - 'tsvgr_opacity', 03:09:22 INFO - 'tart', 03:09:22 INFO - 'tscrollx', 03:09:22 INFO - 'cart']}, 03:09:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:22 INFO - 'tsvgr_opacity', 03:09:22 INFO - 'tart', 03:09:22 INFO - 'tscrollx', 03:09:22 INFO - 'cart']}, 03:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'talos_options': ['--disable-e10s'], 03:09:22 INFO - 'tests': ['tp5o']}, 03:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'tests': ['tp5o']}, 03:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'talos_options': ['--disable-e10s', 03:09:22 INFO - '--xperf_path', 03:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:22 INFO - 'tests': ['tp5n']}, 03:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:09:22 INFO - 'talos_options': ['--xperf_path', 03:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:22 INFO - 'tests': ['tp5n']}}, 03:09:22 INFO - 'talos.zip': {'path': '', 03:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:22 INFO - Running post-action listener: _resource_record_post_action 03:09:22 INFO - ##### 03:09:22 INFO - ##### Finished populate-webroot step (success) 03:09:22 INFO - ##### 03:09:22 INFO - ##### 03:09:22 INFO - ##### Running create-virtualenv step. 03:09:22 INFO - ##### 03:09:22 INFO - Running pre-action listener: _resource_record_pre_action 03:09:22 INFO - Running main action method: create_virtualenv 03:09:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:22 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 03:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:22 INFO - Using real prefix '/usr' 03:09:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:25 INFO - Installing pip.................done. 03:09:25 INFO - Return code: 0 03:09:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:25 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')]} 03:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:25 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')]} 03:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:25 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:25 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 03:09:25 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 03:09:25 INFO - Using env: {'DISPLAY': ':0', 03:09:25 INFO - 'HOME': '/home/cltbld', 03:09:25 INFO - 'LANG': 'en_US.UTF-8', 03:09:25 INFO - 'LANGUAGE': 'en_US:en', 03:09:25 INFO - 'LOGNAME': 'cltbld', 03:09:25 INFO - 'MAIL': '/var/mail/cltbld', 03:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:25 INFO - 'MOZ_NO_REMOTE': '1', 03:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:25 INFO - 'NO_EM_RESTART': '1', 03:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:25 INFO - 'PWD': '/builds/slave/test', 03:09:25 INFO - 'SHELL': '/bin/bash', 03:09:25 INFO - 'SHLVL': '1', 03:09:25 INFO - 'TERM': 'linux', 03:09:25 INFO - 'TMOUT': '86400', 03:09:25 INFO - 'USER': 'cltbld', 03:09:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:25 INFO - '_': '/tools/buildbot/bin/python'} 03:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:25 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 03:09:25 INFO - Cleaning up... 03:09:25 INFO - Return code: 0 03:09:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:09:25 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')]} 03:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:25 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')]} 03:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:25 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:25 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 03:09:25 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 03:09:25 INFO - Using env: {'DISPLAY': ':0', 03:09:25 INFO - 'HOME': '/home/cltbld', 03:09:25 INFO - 'LANG': 'en_US.UTF-8', 03:09:25 INFO - 'LANGUAGE': 'en_US:en', 03:09:25 INFO - 'LOGNAME': 'cltbld', 03:09:25 INFO - 'MAIL': '/var/mail/cltbld', 03:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:25 INFO - 'MOZ_NO_REMOTE': '1', 03:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:25 INFO - 'NO_EM_RESTART': '1', 03:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:25 INFO - 'PWD': '/builds/slave/test', 03:09:25 INFO - 'SHELL': '/bin/bash', 03:09:25 INFO - 'SHLVL': '1', 03:09:25 INFO - 'TERM': 'linux', 03:09:25 INFO - 'TMOUT': '86400', 03:09:25 INFO - 'USER': 'cltbld', 03:09:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:25 INFO - '_': '/tools/buildbot/bin/python'} 03:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:25 INFO - Downloading/unpacking psutil>=0.7.1 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:29 INFO - Installing collected packages: psutil 03:09:29 INFO - Running setup.py install for psutil 03:09:29 INFO - building 'psutil._psutil_linux' extension 03:09:29 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 03:09:29 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 03:09:29 INFO - building 'psutil._psutil_posix' extension 03:09:29 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 03:09:29 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 03:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:29 INFO - Successfully installed psutil 03:09:29 INFO - Cleaning up... 03:09:29 INFO - Return code: 0 03:09:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:09:29 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')]} 03:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:29 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')]} 03:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:29 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:29 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 03:09:29 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 03:09:29 INFO - Using env: {'DISPLAY': ':0', 03:09:29 INFO - 'HOME': '/home/cltbld', 03:09:29 INFO - 'LANG': 'en_US.UTF-8', 03:09:29 INFO - 'LANGUAGE': 'en_US:en', 03:09:29 INFO - 'LOGNAME': 'cltbld', 03:09:29 INFO - 'MAIL': '/var/mail/cltbld', 03:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:29 INFO - 'MOZ_NO_REMOTE': '1', 03:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:29 INFO - 'NO_EM_RESTART': '1', 03:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:29 INFO - 'PWD': '/builds/slave/test', 03:09:29 INFO - 'SHELL': '/bin/bash', 03:09:29 INFO - 'SHLVL': '1', 03:09:29 INFO - 'TERM': 'linux', 03:09:29 INFO - 'TMOUT': '86400', 03:09:29 INFO - 'USER': 'cltbld', 03:09:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:29 INFO - '_': '/tools/buildbot/bin/python'} 03:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:09:30 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 03:09:30 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 03:09:30 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 03:09:30 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 03:09:30 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 03:09:30 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 03:09:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:09:32 INFO - Installing collected packages: mozsystemmonitor 03:09:32 INFO - Running setup.py install for mozsystemmonitor 03:09:32 INFO - Successfully installed mozsystemmonitor 03:09:32 INFO - Cleaning up... 03:09:32 INFO - Return code: 0 03:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:09:32 INFO - Using env: {'DISPLAY': ':0', 03:09:32 INFO - 'HOME': '/home/cltbld', 03:09:32 INFO - 'LANG': 'en_US.UTF-8', 03:09:32 INFO - 'LANGUAGE': 'en_US:en', 03:09:32 INFO - 'LOGNAME': 'cltbld', 03:09:32 INFO - 'MAIL': '/var/mail/cltbld', 03:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:32 INFO - 'MOZ_NO_REMOTE': '1', 03:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:32 INFO - 'NO_EM_RESTART': '1', 03:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:32 INFO - 'PWD': '/builds/slave/test', 03:09:32 INFO - 'SHELL': '/bin/bash', 03:09:32 INFO - 'SHLVL': '1', 03:09:32 INFO - 'TERM': 'linux', 03:09:32 INFO - 'TMOUT': '86400', 03:09:32 INFO - 'USER': 'cltbld', 03:09:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:32 INFO - '_': '/tools/buildbot/bin/python'} 03:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:36 INFO - Downloading docopt-0.6.1.tar.gz 03:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:36 INFO - Running setup.py install for blobuploader 03:09:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:36 INFO - Running setup.py install for requests 03:09:36 INFO - Running setup.py install for docopt 03:09:36 INFO - Successfully installed blobuploader requests docopt 03:09:36 INFO - Cleaning up... 03:09:36 INFO - Return code: 0 03:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:36 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')]} 03:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:36 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')]} 03:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:36 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:36 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 03:09:36 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 03:09:36 INFO - Using env: {'DISPLAY': ':0', 03:09:36 INFO - 'HOME': '/home/cltbld', 03:09:36 INFO - 'LANG': 'en_US.UTF-8', 03:09:36 INFO - 'LANGUAGE': 'en_US:en', 03:09:36 INFO - 'LOGNAME': 'cltbld', 03:09:36 INFO - 'MAIL': '/var/mail/cltbld', 03:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:36 INFO - 'MOZ_NO_REMOTE': '1', 03:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:36 INFO - 'NO_EM_RESTART': '1', 03:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:36 INFO - 'PWD': '/builds/slave/test', 03:09:36 INFO - 'SHELL': '/bin/bash', 03:09:36 INFO - 'SHLVL': '1', 03:09:36 INFO - 'TERM': 'linux', 03:09:36 INFO - 'TMOUT': '86400', 03:09:36 INFO - 'USER': 'cltbld', 03:09:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:36 INFO - '_': '/tools/buildbot/bin/python'} 03:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:37 INFO - Running setup.py (path:/tmp/pip-LLAic6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:37 INFO - Running setup.py (path:/tmp/pip-jHn8NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:37 INFO - Running setup.py (path:/tmp/pip-remmdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:37 INFO - Running setup.py (path:/tmp/pip-552063-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:37 INFO - Running setup.py (path:/tmp/pip-9dH_Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:37 INFO - Running setup.py (path:/tmp/pip-QHV5Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:37 INFO - Running setup.py (path:/tmp/pip-FNiKVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:37 INFO - Running setup.py (path:/tmp/pip-Az8t9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:37 INFO - Running setup.py (path:/tmp/pip-kU37NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:37 INFO - Running setup.py (path:/tmp/pip-gZj4Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:37 INFO - Running setup.py (path:/tmp/pip-98DTyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:37 INFO - Running setup.py (path:/tmp/pip-ZErfBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:37 INFO - Running setup.py (path:/tmp/pip-8ZZnB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:37 INFO - Running setup.py (path:/tmp/pip-BQiU7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:38 INFO - Running setup.py (path:/tmp/pip-iSsufI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:38 INFO - Running setup.py (path:/tmp/pip-m_0fGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:38 INFO - Running setup.py (path:/tmp/pip-thy2tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:38 INFO - Running setup.py install for manifestparser 03:09:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:38 INFO - Running setup.py install for mozcrash 03:09:38 INFO - Running setup.py install for mozdebug 03:09:38 INFO - Running setup.py install for mozdevice 03:09:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:38 INFO - Running setup.py install for mozfile 03:09:38 INFO - Running setup.py install for mozhttpd 03:09:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:38 INFO - Running setup.py install for mozinfo 03:09:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:38 INFO - Running setup.py install for mozInstall 03:09:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Running setup.py install for mozleak 03:09:39 INFO - Running setup.py install for mozlog 03:09:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Running setup.py install for moznetwork 03:09:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Running setup.py install for mozprocess 03:09:39 INFO - Running setup.py install for mozprofile 03:09:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Running setup.py install for mozrunner 03:09:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Running setup.py install for mozscreenshot 03:09:39 INFO - Running setup.py install for moztest 03:09:39 INFO - Running setup.py install for mozversion 03:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:39 INFO - Cleaning up... 03:09:39 INFO - Return code: 0 03:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:39 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')]} 03:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:39 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')]} 03:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:39 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:39 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 03:09:39 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 03:09:39 INFO - Using env: {'DISPLAY': ':0', 03:09:39 INFO - 'HOME': '/home/cltbld', 03:09:39 INFO - 'LANG': 'en_US.UTF-8', 03:09:39 INFO - 'LANGUAGE': 'en_US:en', 03:09:39 INFO - 'LOGNAME': 'cltbld', 03:09:39 INFO - 'MAIL': '/var/mail/cltbld', 03:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:39 INFO - 'MOZ_NO_REMOTE': '1', 03:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:39 INFO - 'NO_EM_RESTART': '1', 03:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:39 INFO - 'PWD': '/builds/slave/test', 03:09:39 INFO - 'SHELL': '/bin/bash', 03:09:39 INFO - 'SHLVL': '1', 03:09:40 INFO - 'TERM': 'linux', 03:09:40 INFO - 'TMOUT': '86400', 03:09:40 INFO - 'USER': 'cltbld', 03:09:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:40 INFO - '_': '/tools/buildbot/bin/python'} 03:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:40 INFO - Running setup.py (path:/tmp/pip-l8Ylym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:40 INFO - Running setup.py (path:/tmp/pip-QFJtV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:40 INFO - Running setup.py (path:/tmp/pip-uRHofW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:40 INFO - Running setup.py (path:/tmp/pip-mZ6k2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:40 INFO - Running setup.py (path:/tmp/pip-5Gk6ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:40 INFO - Running setup.py (path:/tmp/pip-fyFryt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:40 INFO - Running setup.py (path:/tmp/pip-HCIAVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:40 INFO - Running setup.py (path:/tmp/pip-PiVbHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:40 INFO - Running setup.py (path:/tmp/pip-MaX_Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:40 INFO - Running setup.py (path:/tmp/pip-qRMyQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:40 INFO - Running setup.py (path:/tmp/pip-IrJ5Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:40 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)) 03:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:41 INFO - Running setup.py (path:/tmp/pip-4hb3Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:41 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)) 03:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:41 INFO - Running setup.py (path:/tmp/pip-ZNj6tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:41 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)) 03:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:41 INFO - Running setup.py (path:/tmp/pip-p0T6FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:41 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)) 03:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:41 INFO - Running setup.py (path:/tmp/pip-GUR5Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:41 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)) 03:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:41 INFO - Running setup.py (path:/tmp/pip-I3TC5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:41 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)) 03:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:41 INFO - Running setup.py (path:/tmp/pip-Se50D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:41 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)) 03:09:41 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)) 03:09:41 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)) 03:09:41 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)) 03:09:41 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)) 03:09:41 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)) 03:09:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:41 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 03:09:41 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 03:09:41 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 03:09:41 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 03:09:41 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 03:09:41 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 03:09:43 INFO - Downloading blessings-1.6.tar.gz 03:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:43 INFO - Installing collected packages: blessings 03:09:43 INFO - Running setup.py install for blessings 03:09:43 INFO - Successfully installed blessings 03:09:43 INFO - Cleaning up... 03:09:43 INFO - Return code: 0 03:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:43 INFO - Reading from file tmpfile_stdout 03:09:43 INFO - Current package versions: 03:09:43 INFO - argparse == 1.2.1 03:09:43 INFO - blessings == 1.6 03:09:43 INFO - blobuploader == 1.2.4 03:09:43 INFO - docopt == 0.6.1 03:09:43 INFO - manifestparser == 1.1 03:09:43 INFO - mozInstall == 1.12 03:09:43 INFO - mozcrash == 0.17 03:09:43 INFO - mozdebug == 0.1 03:09:43 INFO - mozdevice == 0.48 03:09:43 INFO - mozfile == 1.2 03:09:43 INFO - mozhttpd == 0.7 03:09:43 INFO - mozinfo == 0.9 03:09:43 INFO - mozleak == 0.1 03:09:43 INFO - mozlog == 3.1 03:09:43 INFO - moznetwork == 0.27 03:09:43 INFO - mozprocess == 0.22 03:09:43 INFO - mozprofile == 0.28 03:09:43 INFO - mozrunner == 6.11 03:09:43 INFO - mozscreenshot == 0.1 03:09:43 INFO - mozsystemmonitor == 0.0 03:09:43 INFO - moztest == 0.7 03:09:43 INFO - mozversion == 1.4 03:09:43 INFO - psutil == 3.1.1 03:09:43 INFO - requests == 1.2.3 03:09:43 INFO - wsgiref == 0.1.2 03:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:43 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')]} 03:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:43 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')]} 03:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:43 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:43 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 03:09:43 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 03:09:43 INFO - Using env: {'DISPLAY': ':0', 03:09:43 INFO - 'HOME': '/home/cltbld', 03:09:43 INFO - 'LANG': 'en_US.UTF-8', 03:09:43 INFO - 'LANGUAGE': 'en_US:en', 03:09:43 INFO - 'LOGNAME': 'cltbld', 03:09:43 INFO - 'MAIL': '/var/mail/cltbld', 03:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:43 INFO - 'MOZ_NO_REMOTE': '1', 03:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:43 INFO - 'NO_EM_RESTART': '1', 03:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:43 INFO - 'PWD': '/builds/slave/test', 03:09:43 INFO - 'SHELL': '/bin/bash', 03:09:43 INFO - 'SHLVL': '1', 03:09:43 INFO - 'TERM': 'linux', 03:09:43 INFO - 'TMOUT': '86400', 03:09:43 INFO - 'USER': 'cltbld', 03:09:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:43 INFO - '_': '/tools/buildbot/bin/python'} 03:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 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)) 03:09:44 INFO - Cleaning up... 03:09:44 INFO - Return code: 0 03:09:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:44 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:44 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 03:09:44 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 03:09:44 INFO - Using env: {'DISPLAY': ':0', 03:09:44 INFO - 'HOME': '/home/cltbld', 03:09:44 INFO - 'LANG': 'en_US.UTF-8', 03:09:44 INFO - 'LANGUAGE': 'en_US:en', 03:09:44 INFO - 'LOGNAME': 'cltbld', 03:09:44 INFO - 'MAIL': '/var/mail/cltbld', 03:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:44 INFO - 'MOZ_NO_REMOTE': '1', 03:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:44 INFO - 'NO_EM_RESTART': '1', 03:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:44 INFO - 'PWD': '/builds/slave/test', 03:09:44 INFO - 'SHELL': '/bin/bash', 03:09:44 INFO - 'SHLVL': '1', 03:09:44 INFO - 'TERM': 'linux', 03:09:44 INFO - 'TMOUT': '86400', 03:09:44 INFO - 'USER': 'cltbld', 03:09:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:44 INFO - '_': '/tools/buildbot/bin/python'} 03:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:44 INFO - Downloading/unpacking jsonschema 03:09:44 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 03:09:44 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 03:09:44 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 03:09:44 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 03:09:44 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 03:09:44 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 03:09:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:46 INFO - Downloading/unpacking functools32 (from jsonschema) 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:46 INFO - warning: no files found matching '*.txt' 03:09:46 INFO - no previously-included directories found matching 'build' 03:09:46 INFO - no previously-included directories found matching 'dist' 03:09:46 INFO - no previously-included directories found matching '.git*' 03:09:46 INFO - Installing collected packages: jsonschema, functools32 03:09:46 INFO - Running setup.py install for functools32 03:09:46 INFO - warning: no files found matching '*.txt' 03:09:46 INFO - no previously-included directories found matching 'build' 03:09:46 INFO - no previously-included directories found matching 'dist' 03:09:46 INFO - no previously-included directories found matching '.git*' 03:09:46 INFO - Successfully installed jsonschema functools32 03:09:46 INFO - Cleaning up... 03:09:46 INFO - Return code: 0 03:09:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:46 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 0x7f505c0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1936770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', '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 03:09:46 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 03:09:46 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 03:09:46 INFO - Using env: {'DISPLAY': ':0', 03:09:46 INFO - 'HOME': '/home/cltbld', 03:09:46 INFO - 'LANG': 'en_US.UTF-8', 03:09:46 INFO - 'LANGUAGE': 'en_US:en', 03:09:46 INFO - 'LOGNAME': 'cltbld', 03:09:46 INFO - 'MAIL': '/var/mail/cltbld', 03:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:46 INFO - 'MOZ_NO_REMOTE': '1', 03:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:46 INFO - 'NO_EM_RESTART': '1', 03:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:46 INFO - 'PWD': '/builds/slave/test', 03:09:46 INFO - 'SHELL': '/bin/bash', 03:09:46 INFO - 'SHLVL': '1', 03:09:46 INFO - 'TERM': 'linux', 03:09:46 INFO - 'TMOUT': '86400', 03:09:46 INFO - 'USER': 'cltbld', 03:09:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:46 INFO - '_': '/tools/buildbot/bin/python'} 03:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:46 INFO - Downloading/unpacking flake8 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 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 03:09:46 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 03:09:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:09:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:09:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:09:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:49 INFO - no previously-included directories found matching 'docs/_build' 03:09:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:09:49 INFO - Running setup.py install for pep8 03:09:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:49 INFO - no previously-included directories found matching 'docs/_build' 03:09:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:09:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:09:49 INFO - Cleaning up... 03:09:49 INFO - Return code: 0 03:09:49 INFO - Running post-action listener: _resource_record_post_action 03:09:49 INFO - Running post-action listener: _start_resource_monitoring 03:09:49 INFO - Starting resource monitoring. 03:09:49 INFO - ##### 03:09:49 INFO - ##### Finished create-virtualenv step (success) 03:09:49 INFO - ##### 03:09:49 INFO - ##### 03:09:49 INFO - ##### Running install step. 03:09:49 INFO - ##### 03:09:49 INFO - Running pre-action listener: _resource_record_pre_action 03:09:49 INFO - Running main action method: install 03:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:49 INFO - Reading from file tmpfile_stdout 03:09:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:09:49 INFO - Reading from file tmpfile_stdout 03:09:49 INFO - Output received: 03:09:49 INFO - Usage: mozinstall [options] installer 03:09:49 INFO - Options: 03:09:49 INFO - -h, --help show this help message and exit 03:09:49 INFO - -d DEST, --destination=DEST 03:09:49 INFO - Directory to install application into. [default: 03:09:49 INFO - "/builds/slave/test"] 03:09:49 INFO - --app=APP Application being installed. [default: firefox] 03:09:49 INFO - mkdir: /builds/slave/test/build/application 03:09:49 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'] 03:09:49 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 03:10:05 INFO - Reading from file tmpfile_stdout 03:10:05 INFO - Output received: 03:10:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:05 INFO - Running post-action listener: _resource_record_post_action 03:10:05 INFO - ##### 03:10:05 INFO - ##### Finished install step (success) 03:10:05 INFO - ##### 03:10:05 INFO - ##### 03:10:05 INFO - ##### Running run-tests step. 03:10:05 INFO - ##### 03:10:05 INFO - Running pre-action listener: _resource_record_pre_action 03:10:05 INFO - Running main action method: run_tests 03:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:05 INFO - Python 2.7.3 03:10:05 INFO - Return code: 0 03:10:05 INFO - grabbing minidump binary from tooltool 03:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c59c0>, '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 0x19c68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:05 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 03:10:05 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 03:10:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:05 INFO - Return code: 0 03:10:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:10:06 INFO - Return code: 0 03:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 03:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 03:10:06 INFO - Using env: {'DISPLAY': ':0', 03:10:06 INFO - 'HOME': '/home/cltbld', 03:10:06 INFO - 'LANG': 'en_US.UTF-8', 03:10:06 INFO - 'LANGUAGE': 'en_US:en', 03:10:06 INFO - 'LOGNAME': 'cltbld', 03:10:06 INFO - 'MAIL': '/var/mail/cltbld', 03:10:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:06 INFO - 'MOZ_NO_REMOTE': '1', 03:10:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:06 INFO - 'NO_EM_RESTART': '1', 03:10:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:06 INFO - 'PWD': '/builds/slave/test', 03:10:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:06 INFO - 'SHELL': '/bin/bash', 03:10:06 INFO - 'SHLVL': '1', 03:10:06 INFO - 'TERM': 'linux', 03:10:06 INFO - 'TMOUT': '86400', 03:10:06 INFO - 'USER': 'cltbld', 03:10:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325', 03:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:06 INFO - '_': '/tools/buildbot/bin/python'} 03:10:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 03:10:06 INFO - mozversion application_buildid: 20160510023217 03:10:06 INFO - mozversion application_changeset: 553a9575ad40687f2a5486b1170de0ae8a280015 03:10:06 INFO - mozversion application_display_name: Nightly 03:10:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:06 INFO - mozversion application_name: Firefox 03:10:06 INFO - mozversion application_remotingname: firefox 03:10:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:10:06 INFO - mozversion application_vendor: Mozilla 03:10:06 INFO - mozversion application_version: 49.0a1 03:10:06 INFO - mozversion platform_buildid: 20160510023217 03:10:06 INFO - mozversion platform_changeset: 553a9575ad40687f2a5486b1170de0ae8a280015 03:10:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:10:06 INFO - mozversion platform_version: 49.0a1 03:10:06 INFO - using testdate: 1462875006 03:10:06 INFO - actual date: 1462875006 03:10:06 INFO - starting webserver on 'localhost:46859' 03:10:06 INFO - SUITE-START | Running 2 tests 03:10:06 INFO - TEST-START | dromaeo_css 03:10:06 INFO - operating with platform_type : linux_ 03:10:06 INFO - Initialising browser for dromaeo_css test... 03:10:06 INFO - TEST-INFO | started process 6708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMrMvZ/profile http://localhost:46859/getInfo.html) 03:10:11 INFO - PROCESS | 6708 | 03:10:11 INFO - PROCESS | 6708 | (process:6776): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:10:12 INFO - PROCESS | 6708 | __metrics Screen width/height:1600/1200 03:10:12 INFO - PROCESS | 6708 | colorDepth:24 03:10:12 INFO - PROCESS | 6708 | Browser inner width/height: 1024/697 03:10:12 INFO - PROCESS | 6708 | __metrics 03:10:13 ERROR - PROCESS | 6708 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 03:10:14 INFO - TEST-INFO | 6708: exit 0 03:10:14 INFO - Browser initialized. 03:10:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:14 INFO - TEST-INFO | started process 6827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMrMvZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:16 INFO - PROCESS | 6827 | 03:10:16 INFO - PROCESS | 6827 | (process:6889): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:10:26 INFO - PROCESS | 6827 | RSS: Main: 164220928 03:10:26 INFO - PROCESS | 6827 | 03:11:15 INFO - PROCESS | 6827 | 1462875075807 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] 03:13:27 INFO - PROCESS | 6827 | Cycle 1(1): loaded http://localhost:46859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46859/tests/dromaeo/cssquery-ext.html) 03:13:28 INFO - PROCESS | 6827 | RSS: Main: 166699008 03:13:28 INFO - PROCESS | 6827 | 03:16:30 INFO - PROCESS | 6827 | Cycle 1(1): loaded http://localhost:46859/tests/dromaeo/cssquery-ext.html (next: http://localhost:46859/tests/dromaeo/cssquery-jquery.html) 03:16:31 INFO - PROCESS | 6827 | RSS: Main: 165888000 03:16:31 INFO - PROCESS | 6827 | 03:19:33 INFO - PROCESS | 6827 | Cycle 1(1): loaded http://localhost:46859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46859/tests/dromaeo/cssquery-mootools.html) 03:19:33 INFO - PROCESS | 6827 | RSS: Main: 167456768 03:19:33 INFO - PROCESS | 6827 | 03:22:35 INFO - PROCESS | 6827 | Cycle 1(1): loaded http://localhost:46859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46859/tests/dromaeo/cssquery-prototype.html) 03:22:36 INFO - PROCESS | 6827 | RSS: Main: 165335040 03:22:36 INFO - PROCESS | 6827 | 03:25:39 INFO - PROCESS | 6827 | Cycle 1(1): loaded http://localhost:46859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46859/tests/dromaeo/cssquery-yui.html) 03:25:39 INFO - PROCESS | 6827 | RSS: Main: 166752256 03:25:39 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | Cycle 1(1): loaded http://localhost:46859/tests/dromaeo/cssquery-yui.html (next: http://localhost:46859/tests/dromaeo/cssquery-dojo.html) 03:28:42 INFO - PROCESS | 6827 | RSS: Main: 168656896 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | __start_tp_report 03:28:42 INFO - PROCESS | 6827 | _x_x_mozilla_page_load 03:28:42 INFO - PROCESS | 6827 | _x_x_mozilla_page_load_details 03:28:42 INFO - PROCESS | 6827 | |i|pagename|runs| 03:28:42 INFO - PROCESS | 6827 | |0;dojo.html;2660.6674165729282;2731.754142127208;2739.657542807149;2742.958855617166;2765.3916138449545;4723.7165770053825;4785.688930219533;4837.830675926339;4896.363472748547;4954.380702412199;4700.459447163577;4751;4793.880152996177;4795.712257264567;4830.44449888263;4420.513743488222;4457.977710111445;4549.909001819961;4561.908761824761;4565.703229290102;4457.08629730906;4569.497355290915;4574.290984897346;4591.219492686235;4611.746353950532;4324.935125973113;4406.933895991563;4433.312836510346;4473.865784026484;4476.060027394251;4445.555444455561;4453.79957901892;4455.331700244957;4464.799084041193;4503.842365517191;4481.775911204427;4483.439570053743;4496.8875778105485;4513.661475389359;4520.660950428698;4657.604103651193;4730.314104454869;4734.26618874075;4751.14479393709;4754.5245475452175;5175.430702622709;5176.016556854186;5194.402643695986;5200.401953775327;5230.084735171368;4911.803527858881;5088.694678319275;5117.7185254810975;5121.513456221653;5153.433122356538;4825.276208568707;4910.680805747615;4919.2129259318335;4931.654784165074;4938.185199442052;5328.6802791832615;5370.462953704677;5387.138057910715;5402.324709411324;5438.592105592096;4892.584130348961;5062.265971434195;5143.485651434827;5150.459201783834;5158.174692049254;5174.53429191367;5181.326427564468;5195.9740201298755;5219.686818790885;5266.578673706094;5044.041632089891;5116.897662046738;5142.5885929126325;5176.120059589879;5180.067587834151;5004.149294619923;5111.131107711698;5163.638545301793;5174.223866420067;5177.275181474596;4436.134953684001;4473.753943533072;4475.440569928759;4514.300283456069;4524.773761311922;3869.496965394481;3879.612038796154;3887.3974533947285;3896.668783153407;3932.4494570760116;4278.914421711548;4412.3160910059;4440.444944381952;4441.511433742286;4512.278035514302;5230.110881150214;5237.764300606482;5259.684418934876;5270.78916843322;5294.23233631129;4459.3979812724865;4472.597466228055;4483.058557702853;4518.9548104518535;4524.140413321458;4595.333676616939;4666;4700.083483720641;4706.388169537938;4716.080364328923;4870.366852309177;4891.51084891508;4892.706437613754;4897.338859253955;4945.23348880924;5197.974010129925;5208.687478751287;5211.400688920823;5218.843434696965;5250.317458730341;4754.548317909793;4808.687435316693;4825.734584597741;4870.926936095891;4877.5366340197625;5005.524475174852;5052.949470505395;5053.2420136979745;5062.190049592195;5107.897842043212;4984.22744474607;5189.532942035235;5191.714455704972;5191.844244672666;5197.454267301879;4824.107540105092;4905;4938.209886418156;4978.228374601942;5026.24606309042;4899.583535399388;4970.527799859007;4988.575971042357;5001.049800537886;5022.522860328263;4790.640701947437;4875.68308059975;4921.360223171108;4949.653524253412;4981.775820088033;4988.775505102207;5051.166557517969;5057.671251368649;5063.3417655706;5073.695578265316;4948.529889660476;4954.256861470808;4981.850544483671;4994.700317980933;4996.500349964975 03:28:42 INFO - PROCESS | 6827 | |1;ext.html;563.5266376243954;606.6784604159795;613.7913109542754;614.2199406753422;624.416170880227;29933.850330748344;42088.15823683528;43192.352114718306;43286.567134328645;43398.78300608497;43426.56573434265;43606.34590481137;43653.345199822026;43697.563024369745;43862.34206486897;7974.122846486882;8148.062972758149;8151.06262779779;8161.510309381456;8182.140875208107;7907.44647874649;8042.798930026737;8043.678252869879;8064.27421532062;8073.555954422504;8068.959655201745;8092.231238032377;8099.55452450115;8100;8121.228483294078;8010.118886922434;8040.195980401972;8051.396145289068;8058.274755272025;8072.354211663082;7963.601819908981;7978.202179782033;8012.198780121999;8012.439129260954;8054.872317875502;40335;40878.38682419766;41009.58990410117;41015.38476922848;41083.7945810272;3137.607799025122;3186.633537143235;3237.077432931603;3276.836158192105;3656.963430365689;29489.557656635166;29743.70256297431;30130.548041779173;30137.397252055056;30275.545866812015;3228.580284562992;3252.8210948397827;3343.9498407523906;3378.4256676365076;3415.2315728960784;239153;239442;239690;240537;240648;33826.49260261098;34590.65409345875;54037;54819.725901370235;54835.72582137064;35431.64568354283;35678.82160589232;35795.64204357975;35896.282074358365;36102.27795444077;12488.000959923365;12580.119391642496;12611.684707882376;12623.93688031554;12630.305333206577;9426.670066547638;9458.479783611967;9558.713238602853;9575.856362154573;9611.759706007266;8342.416030877781;8368.748937531884;8383.748487545383;8434.156584341517;8460.111688272766;3286.802791832498;3323.916902077419;3337.199072222698;3338.132085657698;3338.582677165354;955.040184614458;967.9225661947028;980.0003995924118;996.4768496539375;1068.604616291977;28445.857770711013;29304.267393314913;29405.11784646464;29565.55651665227;29907;1004.3321191407632;1016.2378216337746;1023.6263763726187;1048.1248157788332;1083.4203701019917;14994.47519336818;15109.320080596399;15149.545513634608;15177;15372.923135384475;365840;472007;483806;485733;789290;47034;47561;47766.522334776906;48005.799855003905;48121;1280.5006047641427;1288.8066789981578;1293.2628401811066;1298.8246586710861;1360.8230929979238;27743.30641733973;28565.857170714015;29128.56307155352;29278;29459.705402946554;42802.78598607112;42954;42955.7852210737;43385.132297353244;43394.349084763126;272881;273438;273472;273564;275119;25895.741042589332;26120.738792612592;26317;26406.603900941118;26469.205923822316;40846;40958.38562421626;41048.17903641851;41083.97290067772;42287.577124228366;35094;35462.82268588744;35905.82047089748;36179.095522612144;36256.45615315825;35519.82240088783;35552.28895422129;35607.28785424329;35837;36120.4581931266;33400.498992514644;34556.481652774724;36009.639903600626;37399.06502337354;38363.80818095891;32227.35545289128;33998.8300058508;34201;34250.657493425744;34342.14144646404;25775.6133657999;25937.351566210997;26202.73797262079;26359.604605930544;26588 03:28:42 INFO - PROCESS | 6827 | |2;jquery.html;365.80382150368314;382.279403324733;383.6892117384917;385.06813511302647;403.91719697462025;16040.438584649539;17162.914185429054;17533.649327013467;17848.999999999985;17869;17221.22504487298;17395.695322850806;17707.380241691542;17926.462206133805;17983.37058202963;5076.974615126919;5211.86970325743;5238.47615238475;5248.239005344223;5256.92114618281;3634.6365363463706;5651.378348381695;5869.55978301627;5944.375840536746;5989.131575921489;5780.739866705987;5858.238429004224;5920.259967504062;5945.732442040097;5953.940460595382;5031.672941258825;5143.9454911743005;5167.22491626259;5171.301874246966;5211.088059589576;4637.258038713823;4664.673472856902;4668.789904454307;4672.789724462407;4733.668643194977;11534.134939879543;11604.651860444115;11713;11792.941035294854;11803.822942655866;1978.7526559180103;2024.9392518224477;2034.440528854562;2095.9476013099643;2096.9934431472825;9404.153626173676;9479.383840050443;9518.904810951872;9596.23230141587;9754.46350450725;1736.4443378119006;1739.0782885070932;1758.7238285144567;1772.698641230981;1795.6947318955808;70564.6471767643;71490.64254678745;72084;72288;73343.63328183378;10095.192384609214;10433.5826566938;10475.84286235707;10902.945485272523;11155.107591392669;14422.42310307576;14571.344289506786;14600.34298456572;14602.853971460361;14612;6823.795286141423;7192.42460603161;7219.639018049182;7249.565026098451;7257.0565826442225;6579.736810527525;6657.801595712721;6728.865422691519;6737.8652426951185;6805.625690586966;4452.9554704453185;4457.576530229623;4499.505054444008;4499.865004049884;4546.681732278708;1553.9456119035779;1745.127436281859;1753.2373417563401;1758.9912050439666;1864.319523373986;828.2918105020121;882.4881568690145;909.9863502047475;1017.9311722691144;1044.5612842606124;15991;16728.66542669164;16835.336232419566;17149.142542872807;17456.65086698259;882.1222883231226;918.8162367526521;925.9629215278796;931.9906800931903;938.9953050234706;6918.515703900679;9794.755131121636;9807.705768826947;9809.166220871306;9893.208543316518;127688.36155819347;128189;128364;401656;430609;79018;80648.19351806524;81060;81304.18695813084;82211;911.521451238092;935.6538080910107;962.9229661627053;1013.422349260929;1015.263933648114;14603.780943286072;15552.322684788656;16277.67444651124;16298;16380.672386551963;36637;36934.8153259232;37243.44134837925;37605.81197094107;38953.610463895;47007;47022.76488617535;47594.52405475901;48381.75809120932;48538.27192592184;5217.06092903281;6805.727770889109;7401.1488678802625;7697.499662521918;7885.723999659985;7214;7304.5252058616015;8416.242538171595;11070.889291107307;11152.609658661908;9066.09339066088;9744.269179811401;9864;9888.456134912649;10495.21285903545;4483.618892394183;9523.619055237712;10324;10398.896011039793;10735.731606709582;10607.522661480098;10967.451627418757;10985.176111791488;11027.283226590245;11062.668119956414;7899.368050555827;8197.303229225583;8309.875351869849;8374.330053595819;8376;10414.323069000491;10827.458627068772;10953.945230273797;11067.889321107008;11144.554217831195 03:28:42 INFO - PROCESS | 6827 | |3;mootools.html;1485.0718301061836;1524.611224137845;1646.1851383565129;1797.3439694511499;1832.1846778183697;6362.395572420624;7030.894536581949;7046.647667616624;7524.962375188124;7538.396928245741;7208.639568021604;7384.520006199593;7385.5568665879955;7441.553506789596;7455.589942553157;2188.9233876814274;2225.3657707553352;2225.710657614516;2227.0535022615404;2230.7546169921375;2196.81327087197;2221.2669818959785;2223.4663680716594;2237.4965632732587;2240.7535171131162;2187.037703410502;2188.72640919885;2193.5174261662487;2208.8232941364654;2237.5636750833596;2149.570085982802;2156.0836644426136;2158.870467771923;2159.5680863827297;2164.7185865837496;2108.673155660875;2124.2989813361555;2147.9785202147937;2151.085788539864;2177.466520702438;7376.114866216035;7376.151742549622;7435.405167586634;7441.776746697554;7447.590382528959;4326.199653064194;4444.933326000112;4462.620677242438;4465.151621191963;4466.6203372713035;2867.813592116506;2942.7792915531422;3016.3967206558555;3037.9848100759577;3054.083774867553;891.8350105230553;910.1717437132178;920.746794631475;928.3594319919301;947.5735918836482;9035.774105647346;9296.256299496024;9340.626374944994;9546.188573971222;9592;4053.0677944073027;4118.279301122292;4186.91626167475;4216.430781844473;4216.894577635584;8471.788205294793;8530.445521041112;8539.14608539141;8565.314774818;8585.270252028648;4382.145481631052;4435.733855968652;4442.289233722653;4445.066536027471;4452.065066336106;3418.0942050356675;3896.883093507199;3981.6615587675374;4014.578469260744;4061.147159096564;3543.2382037861466;3571.3035957988463;3625.782453052825;3662.8901132966053;3702.5927148013698;1180.2092597959388;1182.9822552661717;1195.36048214205;1216.397883047897;1217.9147459677915;774.38823329569;872.47651409154;878.2754227761994;898.0256421782309;907.4328544659588;5058.291839142523;5083.593312534988;5110.182370820651;5147.6654017488745;5171.689698618095;424.1368814462554;426.79727129613184;441.85639667107677;444.5554445554446;445.8862989937545;3505.8948231553095;3531.0642679689904;3550.3786837303887;3570.428731402963;3612.440071788877;8250.876236856451;8452.74641760748;8483.575821208915;8512.957435212908;8514.10601886793;8355.331573474108;8423.199796019491;8431.325493960469;8461.95769021151;8483.406161568755;6479.1901012373455;6595.373439523333;6601.867962640817;6651.501137414713;6757.459403247728;4920.261960705922;4962.6774259673;4992.026554821775;5020.272060551272;5035.395752509722;7849.136594974662;7864.882026769717;7933.286004259644;8011.83976320482;8026.197380262161;7991.560464174526;7996.480228785111;8099.352051835956;8100.83798324042;8157.592120393838;5750.424957504216;6261.968690156702;6322.683865806784;6327.335629758809;6479.449246813885;7165.426765858823;7167.247439018828;7219.963900180465;7240.022596949344;7291.270872912666;6376.266729326187;6555.934440655532;6559.14731084975;6604.174478190226;6630.834229144117;6448.806535803933;6449.645269510034;6459.289478157305;6477.384648458389;6495.253045899782;5940.049592065248;6043.607165534227;6178.073289006685;6180.783672571439;6182.536309776875;4486.573775491323;4539.5006549280215;4558.726476411426;4726.952730472789;4796.112719146969;4664.183767840682;4726.1729197391005;4768.046390721939;4780.330753694555;4785.712857228577 03:28:42 INFO - PROCESS | 6827 | |4;prototype.html;298.25882681536393;310.5729621770066;313.6596792480159;315.0674004945361;317.00460553860864;4822.84251779573;4960.950390496094;4972.403311602604;5001.649884508086;5118.513741194581;4963.851084467472;4981.576565991886;4992.151334273173;5004.849854504361;5005.0990821652085;3905.4727611772473;3911.8630847920326;3954.4463775071513;3969.8412063517426;3970.9205815883665;3742.9625703743022;3960.9009774755573;3982.2035592881393;3984.402339649047;4002.699797515198;3889.5138107736534;3905.882823515299;3936.055346716796;3937.1338305572726;3937.783421911808;3881.7088718346236;3897.1036661567996;3898.5906479819637;3925.430812532167;3932.1152740633415;3424.9828750856086;3433.776804507699;3454.3436747017986;3472.9305413891834;3490.092575930251;4634.629229661619;4908.141075311806;4908.607311415079;4928.482509336504;4931.679440836334;4370.994671225636;4428.40216570762;4444.911101777979;4488.842890498817;4509.233430316821;5209.400918894337;5233.738313084331;5243.764030618593;5288.286081379041;5294.311739473844;3648.72634552407;3679.981600092009;3718.1448266898497;3743.887683369503;3771.5662698789442;5397.8380648580605;5449.891002179974;5458.590605704549;5515.338159420895;5527.364353099445;3763.8682646107254;3767.246550689873;3773.5660399053913;3784.9810750946067;3821.178446633987;3814.828332725034;3830.1765120499226;3832.6742226911024;3855;3855.267499175148;4146.232946904832;4377.934330985037;4402.229609818269;4409.823607055746;4423.756693381831;5236.9738151309;5281.207818827206;5287.4448182941005;5300.549453296436;5365.417201925441;1263.2420547671325;1278.769821432151;1300.0054957956982;1302.8501722301867;1304.1979182802509;865.6321063547967;877.087828658201;886.4193952960821;887.7558671365297;893.8301722672801;4330.891727706832;4355.847545335898;4358.411614432074;4389.62688171509;4402.4056752338665;5202.557782588447;5222.746540830173;5229.294045303835;5257.8695580450385;5259.421463638997;4401.163778882003;4405.515393306734;4408.889777755582;4432.645388368923;4486.237339652267;2672.986635066812;2848.735255471905;2849.9170315280476;2854.401535140328;2854.971450285512;5004.424491183488;5038.294638750578;5049.166887463601;5053.898922021539;5060.165072763027;5243.790248390022;5438.673679579238;5440.347158341025;5483.396826349099;5489.149181876815;5008.123578373843;5019.84940451787;5020.422651395063;5037.773300201499;5041.924371134436;5308.2568440419145;5340.118880384693;5350.678959262456;5352.919706204332;5357.866053348542;4996.300517927566;5166.844994650167;5310.840674779763;5313.229581710708;5320.14877619579;4942.283368911416;5025.824096156617;5030.698158110525;5058.900556269107;5075.593952483866;3721.1441368484857;3723.5159429275104;3756.549214094326;3759.548854137521;3767.773933563995;5129.563987061141;5209.192575150858;5276.155815069724;5293.417724050274;5335.706536140394;5235.1623740201385;5241.240020196974;5270.4202537721585;5307.946920530745;5308.761105750174;5253.789848406021;5260.526552610283;5264.289320941624;5298.284731561344;5304.787808487617;4949.30709700635;5179.948200517946;5217.791288348423;5233;5244.984134122971;5316.255724198692;5325.334333208349;5365.141577347606;5366.382865970308;5379.892402151857;5247.239150323258;5273.947260527346;5277.419483856849;5280.339957505312;5282.339707536558 03:28:42 INFO - PROCESS | 6827 | |5;yui.html;744.1256523584786;765.9080910290764;786.3787607789844;795.9801004974878;814.2102160903921;10892.346459212453;11467.426628668574;11488.827667584992;11508.884911150886;11513.366764827932;11841.881581184185;11955.880441195586;11965.820512692317;11976.221545599552;12045.51817927284;665.6172700697094;850.995745021274;859.1666083898624;869.4174902815129;877.1973644115626;865.926396256319;869.148234729965;873.7509809704236;873.8033942362981;876.1019954546609;920.2637889688256;925.7222833150028;925.7639301977986;931.3201363005011;934.0799312677042;909.4225167018958;913.6528119314651;914.2548822709504;917.2386918857333;919.3702313914989;674.2381109346456;677.6543962579071;677.6679427080744;679.5514960126343;681.6523572977767;11932.642020739391;11934.283942963362;11939.641810745692;11941.64175074749;11967.700807479883;12564.308963007032;12575.371231438392;12704.110712250145;12732.745345093139;12833.743325133539;9558.474283914382;9591.904080959172;9747.951260243724;9756.609735610567;10035.849462257998;3371.477420999749;3372.5615669962995;3402.574678165229;3421.5894092708786;3421.81180035098;41671.58328416707;41736.79131604323;42294;42396.78801606003;43566.12867742628;10042.146417554444;10115.039071288216;10240.692779216635;10264;10330.741731456623;17943;18023.72964405535;18036.368727094752;18200;18301.7254741179;6445.355464453611;6657.633830139389;6662.86674266512;6725.831854203586;6803.387695107464;3527.6825085742407;3615.6022837487853;3660.0028936773238;3718.4794128821986;3786.2995345861104;2827.2366461055813;2912.228259511231;2913.839738814343;2921.6347956505438;2936.4420760055523;496.0129342608184;496.22341036278107;500.69707826764284;512.344199424737;515.4098557152115;600.5915977135589;603.7675494934394;614.3641331222253;615.5506480269429;621.7916997805695;6952.270011648805;7206.927930720625;7304.415646748247;7381.224971378036;7445.590492522963;579.6522086748001;622.4366947912147;625.6402568523117;632.7310892870512;638.4286063972719;3627.183883626163;3718.6839118674675;3735.14091758897;3740.5137332146646;3811.123441608446;48812.26781598279;48965;49713.265770382975;49828;50251.74874125606;45300.3204951926;45765.542344576796;45929;46429.303560445944;47284.7635761819;41780.37329440061;41952.370714439305;42066.57933420688;42245.15509689789;43079.13841723148;6914.757983470555;6941.132358455193;6944.548604340702;6955.165380154212;7054.153501579844;26679.599806003313;27479.313017173932;28079.0172343967;28380.574291385234;29426.411471770873;35760.10599735028;36200;36848.44727329146;36964;37348;10102.545385457524;10253.948730256301;10453.843192352273;10541.20940929418;10760.246782725135;11298.661040168809;11409;11492.482838272465;11634.76730465403;11772.293662380285;10484.318519296221;10514.158867290445;10746.785064298827;10958.178136639624;11078.446077696244;10854.511546980248;10991.725206869893;11084.113270938144;11096.88903110991;11301.604443844426;9168.908310917072;10626.149908007495;10783.568657253936;10799.244052916534;11013.779724405307;9130.49782261982;9300.767480812763;9305.11601397866;9407.24742020623;9415.529223538933;9377.718668439958;9478.763030924281;9506.619735210514;9545.809083818145;9568.665096721581 03:28:42 INFO - PROCESS | 6827 | __end_tp_report 03:28:42 INFO - PROCESS | 6827 | __start_cc_report 03:28:42 INFO - PROCESS | 6827 | _x_x_mozilla_cycle_collect,359 03:28:42 INFO - PROCESS | 6827 | __end_cc_report 03:28:42 INFO - PROCESS | 6827 | __startTimestamp1462876122731__endTimestamp 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | ------- Summary: start ------- 03:28:42 INFO - PROCESS | 6827 | Number of tests: 6 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | [#0] dojo.html Cycles:165 Average:4783.28 Median:4897.34 stddev:488.42 (10.0%) stddev-sans-first:460.66 03:28:42 INFO - PROCESS | 6827 | Values: 2660.7 2731.8 2739.7 2743.0 2765.4 4723.7 4785.7 4837.8 4896.4 4954.4 4700.5 4751.0 4793.9 4795.7 4830.4 4420.5 4458.0 4549.9 4561.9 4565.7 4457.1 4569.5 4574.3 4591.2 4611.7 4324.9 4406.9 4433.3 4473.9 4476.1 4445.6 4453.8 4455.3 4464.8 4503.8 4481.8 4483.4 4496.9 4513.7 4520.7 4657.6 4730.3 4734.3 4751.1 4754.5 5175.4 5176.0 5194.4 5200.4 5230.1 4911.8 5088.7 5117.7 5121.5 5153.4 4825.3 4910.7 4919.2 4931.7 4938.2 5328.7 5370.5 5387.1 5402.3 5438.6 4892.6 5062.3 5143.5 5150.5 5158.2 5174.5 5181.3 5196.0 5219.7 5266.6 5044.0 5116.9 5142.6 5176.1 5180.1 5004.1 5111.1 5163.6 5174.2 5177.3 4436.1 4473.8 4475.4 4514.3 4524.8 3869.5 3879.6 3887.4 3896.7 3932.4 4278.9 4412.3 4440.4 4441.5 4512.3 5230.1 5237.8 5259.7 5270.8 5294.2 4459.4 4472.6 4483.1 4519.0 4524.1 4595.3 4666.0 4700.1 4706.4 4716.1 4870.4 4891.5 4892.7 4897.3 4945.2 5198.0 5208.7 5211.4 5218.8 5250.3 4754.5 4808.7 4825.7 4870.9 4877.5 5005.5 5052.9 5053.2 5062.2 5107.9 4984.2 5189.5 5191.7 5191.8 5197.5 4824.1 4905.0 4938.2 4978.2 5026.2 4899.6 4970.5 4988.6 5001.0 5022.5 4790.6 4875.7 4921.4 4949.7 4981.8 4988.8 5051.2 5057.7 5063.3 5073.7 4948.5 4954.3 4981.9 4994.7 4996.5 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | [#1] ext.html Cycles:180 Average:48713.96 Median:35957.73 stddev:100477.13 (279.4%) stddev-sans-first:100693.96 03:28:42 INFO - PROCESS | 6827 | Values: 563.5 606.7 613.8 614.2 624.4 29933.9 42088.2 43192.4 43286.6 43398.8 43426.6 43606.3 43653.3 43697.6 43862.3 7974.1 8148.1 8151.1 8161.5 8182.1 7907.4 8042.8 8043.7 8064.3 8073.6 8069.0 8092.2 8099.6 8100.0 8121.2 8010.1 8040.2 8051.4 8058.3 8072.4 7963.6 7978.2 8012.2 8012.4 8054.9 40335.0 40878.4 41009.6 41015.4 41083.8 3137.6 3186.6 3237.1 3276.8 3657.0 29489.6 29743.7 30130.5 30137.4 30275.5 3228.6 3252.8 3343.9 3378.4 3415.2 239153.0 239442.0 239690.0 240537.0 240648.0 33826.5 34590.7 54037.0 54819.7 54835.7 35431.6 35678.8 35795.6 35896.3 36102.3 12488.0 12580.1 12611.7 12623.9 12630.3 9426.7 9458.5 9558.7 9575.9 9611.8 8342.4 8368.7 8383.7 8434.2 8460.1 3286.8 3323.9 3337.2 3338.1 3338.6 955.0 967.9 980.0 996.5 1068.6 28445.9 29304.3 29405.1 29565.6 29907.0 1004.3 1016.2 1023.6 1048.1 1083.4 14994.5 15109.3 15149.5 15177.0 15372.9 365840.0 472007.0 483806.0 485733.0 789290.0 47034.0 47561.0 47766.5 48005.8 48121.0 1280.5 1288.8 1293.3 1298.8 1360.8 27743.3 28565.9 29128.6 29278.0 29459.7 42802.8 42954.0 42955.8 43385.1 43394.3 272881.0 273438.0 273472.0 273564.0 275119.0 25895.7 26120.7 26317.0 26406.6 26469.2 40846.0 40958.4 41048.2 41084.0 42287.6 35094.0 35462.8 35905.8 36179.1 36256.5 35519.8 35552.3 35607.3 35837.0 36120.5 33400.5 34556.5 36009.6 37399.1 38363.8 32227.4 33998.8 34201.0 34250.7 34342.1 25775.6 25937.4 26202.7 26359.6 26588.0 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | [#2] jquery.html Cycles:180 Average:20081.91 Median:4523.27 stddev:48078.09 (1062.9%) stddev-sans-first:48190.17 03:28:42 INFO - PROCESS | 6827 | Values: 365.8 382.3 383.7 385.1 403.9 16040.4 17162.9 17533.6 17849.0 17869.0 17221.2 17395.7 17707.4 17926.5 17983.4 5077.0 5211.9 5238.5 5248.2 5256.9 3634.6 5651.4 5869.6 5944.4 5989.1 5780.7 5858.2 5920.3 5945.7 5953.9 5031.7 5143.9 5167.2 5171.3 5211.1 4637.3 4664.7 4668.8 4672.8 4733.7 11534.1 11604.7 11713.0 11792.9 11803.8 1978.8 2024.9 2034.4 2095.9 2097.0 9404.2 9479.4 9518.9 9596.2 9754.5 1736.4 1739.1 1758.7 1772.7 1795.7 70564.6 71490.6 72084.0 72288.0 73343.6 10095.2 10433.6 10475.8 10902.9 11155.1 14422.4 14571.3 14600.3 14602.9 14612.0 6823.8 7192.4 7219.6 7249.6 7257.1 6579.7 6657.8 6728.9 6737.9 6805.6 4453.0 4457.6 4499.5 4499.9 4546.7 1553.9 1745.1 1753.2 1759.0 1864.3 828.3 882.5 910.0 1017.9 1044.6 15991.0 16728.7 16835.3 17149.1 17456.7 882.1 918.8 926.0 932.0 939.0 6918.5 9794.8 9807.7 9809.2 9893.2 127688.4 128189.0 128364.0 401656.0 430609.0 79018.0 80648.2 81060.0 81304.2 82211.0 911.5 935.7 962.9 1013.4 1015.3 14603.8 15552.3 16277.7 16298.0 16380.7 36637.0 36934.8 37243.4 37605.8 38953.6 47007.0 47022.8 47594.5 48381.8 48538.3 5217.1 6805.7 7401.1 7697.5 7885.7 7214.0 7304.5 8416.2 11070.9 11152.6 9066.1 9744.3 9864.0 9888.5 10495.2 4483.6 9523.6 10324.0 10398.9 10735.7 10607.5 10967.5 10985.2 11027.3 11062.7 7899.4 8197.3 8309.9 8374.3 8376.0 10414.3 10827.5 10953.9 11067.9 11144.6 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | [#3] mootools.html Cycles:180 Average:4844.40 Median:5070.94 stddev:2557.10 (50.4%) stddev-sans-first:2551.81 03:28:42 INFO - PROCESS | 6827 | Values: 1485.1 1524.6 1646.2 1797.3 1832.2 6362.4 7030.9 7046.6 7525.0 7538.4 7208.6 7384.5 7385.6 7441.6 7455.6 2188.9 2225.4 2225.7 2227.1 2230.8 2196.8 2221.3 2223.5 2237.5 2240.8 2187.0 2188.7 2193.5 2208.8 2237.6 2149.6 2156.1 2158.9 2159.6 2164.7 2108.7 2124.3 2148.0 2151.1 2177.5 7376.1 7376.2 7435.4 7441.8 7447.6 4326.2 4444.9 4462.6 4465.2 4466.6 2867.8 2942.8 3016.4 3038.0 3054.1 891.8 910.2 920.7 928.4 947.6 9035.8 9296.3 9340.6 9546.2 9592.0 4053.1 4118.3 4186.9 4216.4 4216.9 8471.8 8530.4 8539.1 8565.3 8585.3 4382.1 4435.7 4442.3 4445.1 4452.1 3418.1 3896.9 3981.7 4014.6 4061.1 3543.2 3571.3 3625.8 3662.9 3702.6 1180.2 1183.0 1195.4 1216.4 1217.9 774.4 872.5 878.3 898.0 907.4 5058.3 5083.6 5110.2 5147.7 5171.7 424.1 426.8 441.9 444.6 445.9 3505.9 3531.1 3550.4 3570.4 3612.4 8250.9 8452.7 8483.6 8513.0 8514.1 8355.3 8423.2 8431.3 8462.0 8483.4 6479.2 6595.4 6601.9 6651.5 6757.5 4920.3 4962.7 4992.0 5020.3 5035.4 7849.1 7864.9 7933.3 8011.8 8026.2 7991.6 7996.5 8099.4 8100.8 8157.6 5750.4 6262.0 6322.7 6327.3 6479.4 7165.4 7167.2 7220.0 7240.0 7291.3 6376.3 6555.9 6559.1 6604.2 6630.8 6448.8 6449.6 6459.3 6477.4 6495.3 5940.0 6043.6 6178.1 6180.8 6182.5 4486.6 4539.5 4558.7 4727.0 4796.1 4664.2 4726.2 4768.0 4780.3 4785.7 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | [#4] prototype.html Cycles:180 Average:4329.82 Median:4976.99 stddev:1263.62 (25.4%) stddev-sans-first:1230.40 03:28:42 INFO - PROCESS | 6827 | Values: 298.3 310.6 313.7 315.1 317.0 4822.8 4961.0 4972.4 5001.6 5118.5 4963.9 4981.6 4992.2 5004.8 5005.1 3905.5 3911.9 3954.4 3969.8 3970.9 3743.0 3960.9 3982.2 3984.4 4002.7 3889.5 3905.9 3936.1 3937.1 3937.8 3881.7 3897.1 3898.6 3925.4 3932.1 3425.0 3433.8 3454.3 3472.9 3490.1 4634.6 4908.1 4908.6 4928.5 4931.7 4371.0 4428.4 4444.9 4488.8 4509.2 5209.4 5233.7 5243.8 5288.3 5294.3 3648.7 3680.0 3718.1 3743.9 3771.6 5397.8 5449.9 5458.6 5515.3 5527.4 3763.9 3767.2 3773.6 3785.0 3821.2 3814.8 3830.2 3832.7 3855.0 3855.3 4146.2 4377.9 4402.2 4409.8 4423.8 5237.0 5281.2 5287.4 5300.5 5365.4 1263.2 1278.8 1300.0 1302.9 1304.2 865.6 877.1 886.4 887.8 893.8 4330.9 4355.8 4358.4 4389.6 4402.4 5202.6 5222.7 5229.3 5257.9 5259.4 4401.2 4405.5 4408.9 4432.6 4486.2 2673.0 2848.7 2849.9 2854.4 2855.0 5004.4 5038.3 5049.2 5053.9 5060.2 5243.8 5438.7 5440.3 5483.4 5489.1 5008.1 5019.8 5020.4 5037.8 5041.9 5308.3 5340.1 5350.7 5352.9 5357.9 4996.3 5166.8 5310.8 5313.2 5320.1 4942.3 5025.8 5030.7 5058.9 5075.6 3721.1 3723.5 3756.5 3759.5 3767.8 5129.6 5209.2 5276.2 5293.4 5335.7 5235.2 5241.2 5270.4 5307.9 5308.8 5253.8 5260.5 5264.3 5298.3 5304.8 4949.3 5179.9 5217.8 5233.0 5245.0 5316.3 5325.3 5365.1 5366.4 5379.9 5247.2 5273.9 5277.4 5280.3 5282.3 03:28:42 INFO - PROCESS | 6827 | 03:28:42 INFO - PROCESS | 6827 | [#5] yui.html Cycles:180 Average:12366.47 Median:42269.58 stddev:13828.51 (32.7%) stddev-sans-first:13839.75 03:28:42 INFO - PROCESS | 6827 | Values: 744.1 765.9 786.4 796.0 814.2 10892.3 11467.4 11488.8 11508.9 11513.4 11841.9 11955.9 11965.8 11976.2 12045.5 665.6 851.0 859.2 869.4 877.2 865.9 869.1 873.8 873.8 876.1 920.3 925.7 925.8 931.3 934.1 909.4 913.7 914.3 917.2 919.4 674.2 677.7 677.7 679.6 681.7 11932.6 11934.3 11939.6 11941.6 11967.7 12564.3 12575.4 12704.1 12732.7 12833.7 9558.5 9591.9 9748.0 9756.6 10035.8 3371.5 3372.6 3402.6 3421.6 3421.8 41671.6 41736.8 42294.0 42396.8 43566.1 10042.1 10115.0 10240.7 10264.0 10330.7 17943.0 18023.7 18036.4 18200.0 18301.7 6445.4 6657.6 6662.9 6725.8 6803.4 3527.7 3615.6 3660.0 3718.5 3786.3 2827.2 2912.2 2913.8 2921.6 2936.4 496.0 496.2 500.7 512.3 515.4 600.6 603.8 614.4 615.6 621.8 6952.3 7206.9 7304.4 7381.2 7445.6 579.7 622.4 625.6 632.7 638.4 3627.2 3718.7 3735.1 3740.5 3811.1 48812.3 48965.0 49713.3 49828.0 50251.7 45300.3 45765.5 45929.0 46429.3 47284.8 41780.4 41952.4 42066.6 42245.2 43079.1 6914.8 6941.1 6944.5 6955.2 7054.2 26679.6 27479.3 28079.0 28380.6 29426.4 35760.1 36200.0 36848.4 36964.0 37348.0 10102.5 10253.9 10453.8 10541.2 10760.2 11298.7 11409.0 11492.5 11634.8 11772.3 10484.3 10514.2 10746.8 10958.2 11078.4 10854.5 10991.7 11084.1 11096.9 11301.6 9168.9 10626.1 10783.6 10799.2 11013.8 9130.5 9300.8 9305.1 9407.2 9415.5 9377.7 9478.8 9506.6 9545.8 9568.7 03:28:42 INFO - PROCESS | 6827 | -------- Summary: end -------- 03:28:42 INFO - PROCESS | 6827 | 03:28:43 INFO - TEST-INFO | 6827: exit 0 03:28:43 INFO - TEST-OK | dromaeo_css | took 1116599ms 03:28:43 INFO - TEST-START | kraken 03:28:43 INFO - operating with platform_type : linux_ 03:28:43 INFO - Initialising browser for kraken test... 03:28:43 INFO - TEST-INFO | started process 7064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWjUzQ/profile http://localhost:46859/getInfo.html) 03:28:47 INFO - PROCESS | 7064 | 03:28:47 INFO - PROCESS | 7064 | (process:7132): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:28:48 INFO - PROCESS | 7064 | __metrics Screen width/height:1600/1200 03:28:48 INFO - PROCESS | 7064 | colorDepth:24 03:28:48 INFO - PROCESS | 7064 | Browser inner width/height: 1024/697 03:28:48 INFO - PROCESS | 7064 | __metrics 03:28:49 ERROR - PROCESS | 7064 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 03:28:50 INFO - TEST-INFO | 7064: exit 0 03:28:50 INFO - Browser initialized. 03:28:50 INFO - Running cycle 1/1 for kraken test... 03:28:50 INFO - TEST-INFO | started process 7184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXWjUzQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:52 INFO - PROCESS | 7184 | 03:28:52 INFO - PROCESS | 7184 | (process:7245): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:29:02 INFO - PROCESS | 7184 | RSS: Main: 164429824 03:29:02 INFO - PROCESS | 7184 | 03:29:05 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46859/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:05 INFO - PROCESS | 7184 | RSS: Main: 167428096 03:29:05 INFO - PROCESS | 7184 | 03:29:08 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46859/tests/kraken/driver.html?testName=audio-dft) 03:29:09 INFO - PROCESS | 7184 | RSS: Main: 167784448 03:29:09 INFO - PROCESS | 7184 | 03:29:12 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46859/tests/kraken/driver.html?testName=audio-fft) 03:29:13 INFO - PROCESS | 7184 | RSS: Main: 164155392 03:29:13 INFO - PROCESS | 7184 | 03:29:15 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46859/tests/kraken/driver.html?testName=audio-oscillator) 03:29:15 INFO - PROCESS | 7184 | RSS: Main: 163926016 03:29:15 INFO - PROCESS | 7184 | 03:29:18 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:18 INFO - PROCESS | 7184 | RSS: Main: 164253696 03:29:18 INFO - PROCESS | 7184 | 03:29:22 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46859/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:22 INFO - PROCESS | 7184 | RSS: Main: 164122624 03:29:22 INFO - PROCESS | 7184 | 03:29:26 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46859/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:26 INFO - PROCESS | 7184 | RSS: Main: 163180544 03:29:26 INFO - PROCESS | 7184 | 03:29:29 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46859/tests/kraken/driver.html?testName=json-parse-financial) 03:29:30 INFO - PROCESS | 7184 | RSS: Main: 163340288 03:29:30 INFO - PROCESS | 7184 | 03:29:32 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:32 INFO - PROCESS | 7184 | RSS: Main: 164114432 03:29:32 INFO - PROCESS | 7184 | 03:29:34 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:35 INFO - PROCESS | 7184 | RSS: Main: 163696640 03:29:35 INFO - PROCESS | 7184 | 03:29:37 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:38 INFO - PROCESS | 7184 | RSS: Main: 164069376 03:29:38 INFO - PROCESS | 7184 | 03:29:41 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:41 INFO - PROCESS | 7184 | RSS: Main: 165089280 03:29:42 INFO - PROCESS | 7184 | 03:29:44 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:45 INFO - PROCESS | 7184 | RSS: Main: 164921344 03:29:45 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | Cycle 1(1): loaded http://localhost:46859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46859/tests/kraken/driver.html?testName=ai-astar) 03:29:47 INFO - PROCESS | 7184 | RSS: Main: 165957632 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | __start_tp_report 03:29:47 INFO - PROCESS | 7184 | _x_x_mozilla_page_load 03:29:47 INFO - PROCESS | 7184 | _x_x_mozilla_page_load_details 03:29:47 INFO - PROCESS | 7184 | |i|pagename|runs| 03:29:47 INFO - PROCESS | 7184 | |0;ai-astar;115;116;109;115;115;115;109;115;115;115 03:29:47 INFO - PROCESS | 7184 | |1;audio-beat-detection;155;131;156;213;133;157;156;137;178;131 03:29:47 INFO - PROCESS | 7184 | |2;audio-dft;164;163;166;167;161;163;164;163;162;166 03:29:47 INFO - PROCESS | 7184 | |3;audio-fft;78;77;77;168;79;77;76;77;159;77 03:29:47 INFO - PROCESS | 7184 | |4;audio-oscillator;93;94;173;93;94;92;135;93;93;143 03:29:47 INFO - PROCESS | 7184 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;119 03:29:47 INFO - PROCESS | 7184 | |6;imaging-darkroom;149;147;147;147;148;148;147;149;148;147 03:29:47 INFO - PROCESS | 7184 | |7;imaging-desaturate;95;96;97;95;95;96;95;96;96;95 03:29:47 INFO - PROCESS | 7184 | |8;json-parse-financial;67;67;66;68;67;69;71;67;66;67 03:29:47 INFO - PROCESS | 7184 | |9;json-stringify-tinderbox;63;64;65;65;65;65;65;64;70;65 03:29:47 INFO - PROCESS | 7184 | |10;stanford-crypto-aes;82;82;81;86;83;89;83;82;136;87 03:29:47 INFO - PROCESS | 7184 | |11;stanford-crypto-ccm;152;139;142;131;144;132;133;137;158;152 03:29:47 INFO - PROCESS | 7184 | |12;stanford-crypto-pbkdf2;171;174;181;171;173;173;177;173;179;172 03:29:47 INFO - PROCESS | 7184 | |13;stanford-crypto-sha256-iterative;68;71;70;73;69;68;68;70;67;67 03:29:47 INFO - PROCESS | 7184 | __end_tp_report 03:29:47 INFO - PROCESS | 7184 | __start_cc_report 03:29:47 INFO - PROCESS | 7184 | _x_x_mozilla_cycle_collect,918 03:29:47 INFO - PROCESS | 7184 | __end_cc_report 03:29:47 INFO - PROCESS | 7184 | __startTimestamp1462876187702__endTimestamp 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | ------- Summary: start ------- 03:29:47 INFO - PROCESS | 7184 | Number of tests: 14 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:2.60 (2.3%) stddev-sans-first:2.73 03:29:47 INFO - PROCESS | 7184 | Values: 115.0 116.0 109.0 115.0 115.0 115.0 109.0 115.0 115.0 115.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:156.00 stddev:25.51 (16.4%) stddev-sans-first:27.06 03:29:47 INFO - PROCESS | 7184 | Values: 155.0 131.0 156.0 213.0 133.0 157.0 156.0 137.0 178.0 131.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 03:29:47 INFO - PROCESS | 7184 | Values: 164.0 163.0 166.0 167.0 161.0 163.0 164.0 163.0 162.0 166.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.00 stddev:36.44 (47.3%) stddev-sans-first:38.15 03:29:47 INFO - PROCESS | 7184 | Values: 78.0 77.0 77.0 168.0 79.0 77.0 76.0 77.0 159.0 77.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:93.00 stddev:29.20 (31.4%) stddev-sans-first:30.29 03:29:47 INFO - PROCESS | 7184 | Values: 93.0 94.0 173.0 93.0 94.0 92.0 135.0 93.0 93.0 143.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:29:47 INFO - PROCESS | 7184 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 03:29:47 INFO - PROCESS | 7184 | Values: 149.0 147.0 147.0 147.0 148.0 148.0 147.0 149.0 148.0 147.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:29:47 INFO - PROCESS | 7184 | Values: 95.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 03:29:47 INFO - PROCESS | 7184 | Values: 67.0 67.0 66.0 68.0 67.0 69.0 71.0 67.0 66.0 67.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.85 (2.9%) stddev-sans-first:1.80 03:29:47 INFO - PROCESS | 7184 | Values: 63.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 70.0 65.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:83.00 stddev:16.68 (20.1%) stddev-sans-first:17.50 03:29:47 INFO - PROCESS | 7184 | Values: 82.0 82.0 81.0 86.0 83.0 89.0 83.0 82.0 136.0 87.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:143.00 stddev:9.40 (6.6%) stddev-sans-first:9.25 03:29:47 INFO - PROCESS | 7184 | Values: 152.0 139.0 142.0 131.0 144.0 132.0 133.0 137.0 158.0 152.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:173.50 stddev:3.44 (2.0%) stddev-sans-first:3.42 03:29:47 INFO - PROCESS | 7184 | Values: 171.0 174.0 181.0 171.0 173.0 173.0 177.0 173.0 179.0 172.0 03:29:47 INFO - PROCESS | 7184 | 03:29:47 INFO - PROCESS | 7184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.91 (2.8%) stddev-sans-first:1.99 03:29:47 INFO - PROCESS | 7184 | Values: 68.0 71.0 70.0 73.0 69.0 68.0 68.0 70.0 67.0 67.0 03:29:47 INFO - PROCESS | 7184 | -------- Summary: end -------- 03:29:47 INFO - PROCESS | 7184 | 03:29:48 INFO - TEST-INFO | 7184: exit 0 03:29:48 INFO - TEST-OK | kraken | took 65226ms 03:29:48 INFO - SUITE-END | took 1181s 03:29:48 INFO - Completed test suite (00:19:41) 03:29:48 INFO - javascript benchmark 03:29:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.6674165729282, 2731.754142127208, 2739.657542807149, 2742.958855617166, 2765.3916138449545, 4723.7165770053825, 4785.688930219533, 4837.830675926339, 4896.363472748547, 4954.380702412199, 4700.459447163577, 4751.0, 4793.880152996177, 4795.712257264567, 4830.44449888263, 4420.513743488222, 4457.977710111445, 4549.909001819961, 4561.908761824761, 4565.703229290102, 4457.08629730906, 4569.497355290915, 4574.290984897346, 4591.219492686235, 4611.746353950532, 4324.935125973113, 4406.933895991563, 4433.312836510346, 4473.865784026484, 4476.060027394251, 4445.555444455561, 4453.79957901892, 4455.331700244957, 4464.799084041193, 4503.842365517191, 4481.775911204427, 4483.439570053743, 4496.8875778105485, 4513.661475389359, 4520.660950428698, 4657.604103651193, 4730.314104454869, 4734.26618874075, 4751.14479393709, 4754.5245475452175, 5175.430702622709, 5176.016556854186, 5194.402643695986, 5200.401953775327, 5230.084735171368, 4911.803527858881, 5088.694678319275, 5117.7185254810975, 5121.513456221653, 5153.433122356538, 4825.276208568707, 4910.680805747615, 4919.2129259318335, 4931.654784165074, 4938.185199442052, 5328.6802791832615, 5370.462953704677, 5387.138057910715, 5402.324709411324, 5438.592105592096, 4892.584130348961, 5062.265971434195, 5143.485651434827, 5150.459201783834, 5158.174692049254, 5174.53429191367, 5181.326427564468, 5195.9740201298755, 5219.686818790885, 5266.578673706094, 5044.041632089891, 5116.897662046738, 5142.5885929126325, 5176.120059589879, 5180.067587834151, 5004.149294619923, 5111.131107711698, 5163.638545301793, 5174.223866420067, 5177.275181474596, 4436.134953684001, 4473.753943533072, 4475.440569928759, 4514.300283456069, 4524.773761311922, 3869.496965394481, 3879.612038796154, 3887.3974533947285, 3896.668783153407, 3932.4494570760116, 4278.914421711548, 4412.3160910059, 4440.444944381952, 4441.511433742286, 4512.278035514302, 5230.110881150214, 5237.764300606482, 5259.684418934876, 5270.78916843322, 5294.23233631129, 4459.3979812724865, 4472.597466228055, 4483.058557702853, 4518.9548104518535, 4524.140413321458, 4595.333676616939, 4666.0, 4700.083483720641, 4706.388169537938, 4716.080364328923, 4870.366852309177, 4891.51084891508, 4892.706437613754, 4897.338859253955, 4945.23348880924, 5197.974010129925, 5208.687478751287, 5211.400688920823, 5218.843434696965, 5250.317458730341, 4754.548317909793, 4808.687435316693, 4825.734584597741, 4870.926936095891, 4877.5366340197625, 5005.524475174852, 5052.949470505395, 5053.2420136979745, 5062.190049592195, 5107.897842043212, 4984.22744474607, 5189.532942035235, 5191.714455704972, 5191.844244672666, 5197.454267301879, 4824.107540105092, 4905.0, 4938.209886418156, 4978.228374601942, 5026.24606309042, 4899.583535399388, 4970.527799859007, 4988.575971042357, 5001.049800537886, 5022.522860328263, 4790.640701947437, 4875.68308059975, 4921.360223171108, 4949.653524253412, 4981.775820088033, 4988.775505102207, 5051.166557517969, 5057.671251368649, 5063.3417655706, 5073.695578265316, 4948.529889660476, 4954.256861470808, 4981.850544483671, 4994.700317980933, 4996.500349964975], "value": 4752.9915725689925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5266376243954, 606.6784604159795, 613.7913109542754, 614.2199406753422, 624.416170880227, 29933.850330748344, 42088.15823683528, 43192.352114718306, 43286.567134328645, 43398.78300608497, 43426.56573434265, 43606.34590481137, 43653.345199822026, 43697.563024369745, 43862.34206486897, 7974.122846486882, 8148.062972758149, 8151.06262779779, 8161.510309381456, 8182.140875208107, 7907.44647874649, 8042.798930026737, 8043.678252869879, 8064.27421532062, 8073.555954422504, 8068.959655201745, 8092.231238032377, 8099.55452450115, 8100.0, 8121.228483294078, 8010.118886922434, 8040.195980401972, 8051.396145289068, 8058.274755272025, 8072.354211663082, 7963.601819908981, 7978.202179782033, 8012.198780121999, 8012.439129260954, 8054.872317875502, 40335.0, 40878.38682419766, 41009.58990410117, 41015.38476922848, 41083.7945810272, 3137.607799025122, 3186.633537143235, 3237.077432931603, 3276.836158192105, 3656.963430365689, 29489.557656635166, 29743.70256297431, 30130.548041779173, 30137.397252055056, 30275.545866812015, 3228.580284562992, 3252.8210948397827, 3343.9498407523906, 3378.4256676365076, 3415.2315728960784, 239153.0, 239442.0, 239690.0, 240537.0, 240648.0, 33826.49260261098, 34590.65409345875, 54037.0, 54819.725901370235, 54835.72582137064, 35431.64568354283, 35678.82160589232, 35795.64204357975, 35896.282074358365, 36102.27795444077, 12488.000959923365, 12580.119391642496, 12611.684707882376, 12623.93688031554, 12630.305333206577, 9426.670066547638, 9458.479783611967, 9558.713238602853, 9575.856362154573, 9611.759706007266, 8342.416030877781, 8368.748937531884, 8383.748487545383, 8434.156584341517, 8460.111688272766, 3286.802791832498, 3323.916902077419, 3337.199072222698, 3338.132085657698, 3338.582677165354, 955.040184614458, 967.9225661947028, 980.0003995924118, 996.4768496539375, 1068.604616291977, 28445.857770711013, 29304.267393314913, 29405.11784646464, 29565.55651665227, 29907.0, 1004.3321191407632, 1016.2378216337746, 1023.6263763726187, 1048.1248157788332, 1083.4203701019917, 14994.47519336818, 15109.320080596399, 15149.545513634608, 15177.0, 15372.923135384475, 365840.0, 472007.0, 483806.0, 485733.0, 789290.0, 47034.0, 47561.0, 47766.522334776906, 48005.799855003905, 48121.0, 1280.5006047641427, 1288.8066789981578, 1293.2628401811066, 1298.8246586710861, 1360.8230929979238, 27743.30641733973, 28565.857170714015, 29128.56307155352, 29278.0, 29459.705402946554, 42802.78598607112, 42954.0, 42955.7852210737, 43385.132297353244, 43394.349084763126, 272881.0, 273438.0, 273472.0, 273564.0, 275119.0, 25895.741042589332, 26120.738792612592, 26317.0, 26406.603900941118, 26469.205923822316, 40846.0, 40958.38562421626, 41048.17903641851, 41083.97290067772, 42287.577124228366, 35094.0, 35462.82268588744, 35905.82047089748, 36179.095522612144, 36256.45615315825, 35519.82240088783, 35552.28895422129, 35607.28785424329, 35837.0, 36120.4581931266, 33400.498992514644, 34556.481652774724, 36009.639903600626, 37399.06502337354, 38363.80818095891, 32227.35545289128, 33998.8300058508, 34201.0, 34250.657493425744, 34342.14144646404, 25775.6133657999, 25937.351566210997, 26202.73797262079, 26359.604605930544, 26588.0], "value": 16851.22990582574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.80382150368314, 382.279403324733, 383.6892117384917, 385.06813511302647, 403.91719697462025, 16040.438584649539, 17162.914185429054, 17533.649327013467, 17848.999999999985, 17869.0, 17221.22504487298, 17395.695322850806, 17707.380241691542, 17926.462206133805, 17983.37058202963, 5076.974615126919, 5211.86970325743, 5238.47615238475, 5248.239005344223, 5256.92114618281, 3634.6365363463706, 5651.378348381695, 5869.55978301627, 5944.375840536746, 5989.131575921489, 5780.739866705987, 5858.238429004224, 5920.259967504062, 5945.732442040097, 5953.940460595382, 5031.672941258825, 5143.9454911743005, 5167.22491626259, 5171.301874246966, 5211.088059589576, 4637.258038713823, 4664.673472856902, 4668.789904454307, 4672.789724462407, 4733.668643194977, 11534.134939879543, 11604.651860444115, 11713.0, 11792.941035294854, 11803.822942655866, 1978.7526559180103, 2024.9392518224477, 2034.440528854562, 2095.9476013099643, 2096.9934431472825, 9404.153626173676, 9479.383840050443, 9518.904810951872, 9596.23230141587, 9754.46350450725, 1736.4443378119006, 1739.0782885070932, 1758.7238285144567, 1772.698641230981, 1795.6947318955808, 70564.6471767643, 71490.64254678745, 72084.0, 72288.0, 73343.63328183378, 10095.192384609214, 10433.5826566938, 10475.84286235707, 10902.945485272523, 11155.107591392669, 14422.42310307576, 14571.344289506786, 14600.34298456572, 14602.853971460361, 14612.0, 6823.795286141423, 7192.42460603161, 7219.639018049182, 7249.565026098451, 7257.0565826442225, 6579.736810527525, 6657.801595712721, 6728.865422691519, 6737.8652426951185, 6805.625690586966, 4452.9554704453185, 4457.576530229623, 4499.505054444008, 4499.865004049884, 4546.681732278708, 1553.9456119035779, 1745.127436281859, 1753.2373417563401, 1758.9912050439666, 1864.319523373986, 828.2918105020121, 882.4881568690145, 909.9863502047475, 1017.9311722691144, 1044.5612842606124, 15991.0, 16728.66542669164, 16835.336232419566, 17149.142542872807, 17456.65086698259, 882.1222883231226, 918.8162367526521, 925.9629215278796, 931.9906800931903, 938.9953050234706, 6918.515703900679, 9794.755131121636, 9807.705768826947, 9809.166220871306, 9893.208543316518, 127688.36155819347, 128189.0, 128364.0, 401656.0, 430609.0, 79018.0, 80648.19351806524, 81060.0, 81304.18695813084, 82211.0, 911.521451238092, 935.6538080910107, 962.9229661627053, 1013.422349260929, 1015.263933648114, 14603.780943286072, 15552.322684788656, 16277.67444651124, 16298.0, 16380.672386551963, 36637.0, 36934.8153259232, 37243.44134837925, 37605.81197094107, 38953.610463895, 47007.0, 47022.76488617535, 47594.52405475901, 48381.75809120932, 48538.27192592184, 5217.06092903281, 6805.727770889109, 7401.1488678802625, 7697.499662521918, 7885.723999659985, 7214.0, 7304.5252058616015, 8416.242538171595, 11070.889291107307, 11152.609658661908, 9066.09339066088, 9744.269179811401, 9864.0, 9888.456134912649, 10495.21285903545, 4483.618892394183, 9523.619055237712, 10324.0, 10398.896011039793, 10735.731606709582, 10607.522661480098, 10967.451627418757, 10985.176111791488, 11027.283226590245, 11062.668119956414, 7899.368050555827, 8197.303229225583, 8309.875351869849, 8374.330053595819, 8376.0, 10414.323069000491, 10827.458627068772, 10953.945230273797, 11067.889321107008, 11144.554217831195], "value": 7992.525338706979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.0718301061836, 1524.611224137845, 1646.1851383565129, 1797.3439694511499, 1832.1846778183697, 6362.395572420624, 7030.894536581949, 7046.647667616624, 7524.962375188124, 7538.396928245741, 7208.639568021604, 7384.520006199593, 7385.5568665879955, 7441.553506789596, 7455.589942553157, 2188.9233876814274, 2225.3657707553352, 2225.710657614516, 2227.0535022615404, 2230.7546169921375, 2196.81327087197, 2221.2669818959785, 2223.4663680716594, 2237.4965632732587, 2240.7535171131162, 2187.037703410502, 2188.72640919885, 2193.5174261662487, 2208.8232941364654, 2237.5636750833596, 2149.570085982802, 2156.0836644426136, 2158.870467771923, 2159.5680863827297, 2164.7185865837496, 2108.673155660875, 2124.2989813361555, 2147.9785202147937, 2151.085788539864, 2177.466520702438, 7376.114866216035, 7376.151742549622, 7435.405167586634, 7441.776746697554, 7447.590382528959, 4326.199653064194, 4444.933326000112, 4462.620677242438, 4465.151621191963, 4466.6203372713035, 2867.813592116506, 2942.7792915531422, 3016.3967206558555, 3037.9848100759577, 3054.083774867553, 891.8350105230553, 910.1717437132178, 920.746794631475, 928.3594319919301, 947.5735918836482, 9035.774105647346, 9296.256299496024, 9340.626374944994, 9546.188573971222, 9592.0, 4053.0677944073027, 4118.279301122292, 4186.91626167475, 4216.430781844473, 4216.894577635584, 8471.788205294793, 8530.445521041112, 8539.14608539141, 8565.314774818, 8585.270252028648, 4382.145481631052, 4435.733855968652, 4442.289233722653, 4445.066536027471, 4452.065066336106, 3418.0942050356675, 3896.883093507199, 3981.6615587675374, 4014.578469260744, 4061.147159096564, 3543.2382037861466, 3571.3035957988463, 3625.782453052825, 3662.8901132966053, 3702.5927148013698, 1180.2092597959388, 1182.9822552661717, 1195.36048214205, 1216.397883047897, 1217.9147459677915, 774.38823329569, 872.47651409154, 878.2754227761994, 898.0256421782309, 907.4328544659588, 5058.291839142523, 5083.593312534988, 5110.182370820651, 5147.6654017488745, 5171.689698618095, 424.1368814462554, 426.79727129613184, 441.85639667107677, 444.5554445554446, 445.8862989937545, 3505.8948231553095, 3531.0642679689904, 3550.3786837303887, 3570.428731402963, 3612.440071788877, 8250.876236856451, 8452.74641760748, 8483.575821208915, 8512.957435212908, 8514.10601886793, 8355.331573474108, 8423.199796019491, 8431.325493960469, 8461.95769021151, 8483.406161568755, 6479.1901012373455, 6595.373439523333, 6601.867962640817, 6651.501137414713, 6757.459403247728, 4920.261960705922, 4962.6774259673, 4992.026554821775, 5020.272060551272, 5035.395752509722, 7849.136594974662, 7864.882026769717, 7933.286004259644, 8011.83976320482, 8026.197380262161, 7991.560464174526, 7996.480228785111, 8099.352051835956, 8100.83798324042, 8157.592120393838, 5750.424957504216, 6261.968690156702, 6322.683865806784, 6327.335629758809, 6479.449246813885, 7165.426765858823, 7167.247439018828, 7219.963900180465, 7240.022596949344, 7291.270872912666, 6376.266729326187, 6555.934440655532, 6559.14731084975, 6604.174478190226, 6630.834229144117, 6448.806535803933, 6449.645269510034, 6459.289478157305, 6477.384648458389, 6495.253045899782, 5940.049592065248, 6043.607165534227, 6178.073289006685, 6180.783672571439, 6182.536309776875, 4486.573775491323, 4539.5006549280215, 4558.726476411426, 4726.952730472789, 4796.112719146969, 4664.183767840682, 4726.1729197391005, 4768.046390721939, 4780.330753694555, 4785.712857228577], "value": 3933.240669240921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.25882681536393, 310.5729621770066, 313.6596792480159, 315.0674004945361, 317.00460553860864, 4822.84251779573, 4960.950390496094, 4972.403311602604, 5001.649884508086, 5118.513741194581, 4963.851084467472, 4981.576565991886, 4992.151334273173, 5004.849854504361, 5005.0990821652085, 3905.4727611772473, 3911.8630847920326, 3954.4463775071513, 3969.8412063517426, 3970.9205815883665, 3742.9625703743022, 3960.9009774755573, 3982.2035592881393, 3984.402339649047, 4002.699797515198, 3889.5138107736534, 3905.882823515299, 3936.055346716796, 3937.1338305572726, 3937.783421911808, 3881.7088718346236, 3897.1036661567996, 3898.5906479819637, 3925.430812532167, 3932.1152740633415, 3424.9828750856086, 3433.776804507699, 3454.3436747017986, 3472.9305413891834, 3490.092575930251, 4634.629229661619, 4908.141075311806, 4908.607311415079, 4928.482509336504, 4931.679440836334, 4370.994671225636, 4428.40216570762, 4444.911101777979, 4488.842890498817, 4509.233430316821, 5209.400918894337, 5233.738313084331, 5243.764030618593, 5288.286081379041, 5294.311739473844, 3648.72634552407, 3679.981600092009, 3718.1448266898497, 3743.887683369503, 3771.5662698789442, 5397.8380648580605, 5449.891002179974, 5458.590605704549, 5515.338159420895, 5527.364353099445, 3763.8682646107254, 3767.246550689873, 3773.5660399053913, 3784.9810750946067, 3821.178446633987, 3814.828332725034, 3830.1765120499226, 3832.6742226911024, 3855.0, 3855.267499175148, 4146.232946904832, 4377.934330985037, 4402.229609818269, 4409.823607055746, 4423.756693381831, 5236.9738151309, 5281.207818827206, 5287.4448182941005, 5300.549453296436, 5365.417201925441, 1263.2420547671325, 1278.769821432151, 1300.0054957956982, 1302.8501722301867, 1304.1979182802509, 865.6321063547967, 877.087828658201, 886.4193952960821, 887.7558671365297, 893.8301722672801, 4330.891727706832, 4355.847545335898, 4358.411614432074, 4389.62688171509, 4402.4056752338665, 5202.557782588447, 5222.746540830173, 5229.294045303835, 5257.8695580450385, 5259.421463638997, 4401.163778882003, 4405.515393306734, 4408.889777755582, 4432.645388368923, 4486.237339652267, 2672.986635066812, 2848.735255471905, 2849.9170315280476, 2854.401535140328, 2854.971450285512, 5004.424491183488, 5038.294638750578, 5049.166887463601, 5053.898922021539, 5060.165072763027, 5243.790248390022, 5438.673679579238, 5440.347158341025, 5483.396826349099, 5489.149181876815, 5008.123578373843, 5019.84940451787, 5020.422651395063, 5037.773300201499, 5041.924371134436, 5308.2568440419145, 5340.118880384693, 5350.678959262456, 5352.919706204332, 5357.866053348542, 4996.300517927566, 5166.844994650167, 5310.840674779763, 5313.229581710708, 5320.14877619579, 4942.283368911416, 5025.824096156617, 5030.698158110525, 5058.900556269107, 5075.593952483866, 3721.1441368484857, 3723.5159429275104, 3756.549214094326, 3759.548854137521, 3767.773933563995, 5129.563987061141, 5209.192575150858, 5276.155815069724, 5293.417724050274, 5335.706536140394, 5235.1623740201385, 5241.240020196974, 5270.4202537721585, 5307.946920530745, 5308.761105750174, 5253.789848406021, 5260.526552610283, 5264.289320941624, 5298.284731561344, 5304.787808487617, 4949.30709700635, 5179.948200517946, 5217.791288348423, 5233.0, 5244.984134122971, 5316.255724198692, 5325.334333208349, 5365.141577347606, 5366.382865970308, 5379.892402151857, 5247.239150323258, 5273.947260527346, 5277.419483856849, 5280.339957505312, 5282.339707536558], "value": 3927.3499272597924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.1256523584786, 765.9080910290764, 786.3787607789844, 795.9801004974878, 814.2102160903921, 10892.346459212453, 11467.426628668574, 11488.827667584992, 11508.884911150886, 11513.366764827932, 11841.881581184185, 11955.880441195586, 11965.820512692317, 11976.221545599552, 12045.51817927284, 665.6172700697094, 850.995745021274, 859.1666083898624, 869.4174902815129, 877.1973644115626, 865.926396256319, 869.148234729965, 873.7509809704236, 873.8033942362981, 876.1019954546609, 920.2637889688256, 925.7222833150028, 925.7639301977986, 931.3201363005011, 934.0799312677042, 909.4225167018958, 913.6528119314651, 914.2548822709504, 917.2386918857333, 919.3702313914989, 674.2381109346456, 677.6543962579071, 677.6679427080744, 679.5514960126343, 681.6523572977767, 11932.642020739391, 11934.283942963362, 11939.641810745692, 11941.64175074749, 11967.700807479883, 12564.308963007032, 12575.371231438392, 12704.110712250145, 12732.745345093139, 12833.743325133539, 9558.474283914382, 9591.904080959172, 9747.951260243724, 9756.609735610567, 10035.849462257998, 3371.477420999749, 3372.5615669962995, 3402.574678165229, 3421.5894092708786, 3421.81180035098, 41671.58328416707, 41736.79131604323, 42294.0, 42396.78801606003, 43566.12867742628, 10042.146417554444, 10115.039071288216, 10240.692779216635, 10264.0, 10330.741731456623, 17943.0, 18023.72964405535, 18036.368727094752, 18200.0, 18301.7254741179, 6445.355464453611, 6657.633830139389, 6662.86674266512, 6725.831854203586, 6803.387695107464, 3527.6825085742407, 3615.6022837487853, 3660.0028936773238, 3718.4794128821986, 3786.2995345861104, 2827.2366461055813, 2912.228259511231, 2913.839738814343, 2921.6347956505438, 2936.4420760055523, 496.0129342608184, 496.22341036278107, 500.69707826764284, 512.344199424737, 515.4098557152115, 600.5915977135589, 603.7675494934394, 614.3641331222253, 615.5506480269429, 621.7916997805695, 6952.270011648805, 7206.927930720625, 7304.415646748247, 7381.224971378036, 7445.590492522963, 579.6522086748001, 622.4366947912147, 625.6402568523117, 632.7310892870512, 638.4286063972719, 3627.183883626163, 3718.6839118674675, 3735.14091758897, 3740.5137332146646, 3811.123441608446, 48812.26781598279, 48965.0, 49713.265770382975, 49828.0, 50251.74874125606, 45300.3204951926, 45765.542344576796, 45929.0, 46429.303560445944, 47284.7635761819, 41780.37329440061, 41952.370714439305, 42066.57933420688, 42245.15509689789, 43079.13841723148, 6914.757983470555, 6941.132358455193, 6944.548604340702, 6955.165380154212, 7054.153501579844, 26679.599806003313, 27479.313017173932, 28079.0172343967, 28380.574291385234, 29426.411471770873, 35760.10599735028, 36200.0, 36848.44727329146, 36964.0, 37348.0, 10102.545385457524, 10253.948730256301, 10453.843192352273, 10541.20940929418, 10760.246782725135, 11298.661040168809, 11409.0, 11492.482838272465, 11634.76730465403, 11772.293662380285, 10484.318519296221, 10514.158867290445, 10746.785064298827, 10958.178136639624, 11078.446077696244, 10854.511546980248, 10991.725206869893, 11084.113270938144, 11096.88903110991, 11301.604443844426, 9168.908310917072, 10626.149908007495, 10783.568657253936, 10799.244052916534, 11013.779724405307, 9130.49782261982, 9300.767480812763, 9305.11601397866, 9407.24742020623, 9415.529223538933, 9377.718668439958, 9478.763030924281, 9506.619735210514, 9545.809083818145, 9568.665096721581], "value": 5904.645778204836, "unit": "score"}], "name": "dromaeo_css", "value": 6228.675673663316, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 109.0, 115.0, 115.0, 115.0, 109.0, 115.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 156.0, 213.0, 133.0, 157.0, 156.0, 137.0, 178.0, 131.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 167.0, 161.0, 163.0, 164.0, 163.0, 162.0, 166.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 168.0, 79.0, 77.0, 76.0, 77.0, 159.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 173.0, 93.0, 94.0, 92.0, 135.0, 93.0, 93.0, 143.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 149.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 68.0, 67.0, 69.0, 71.0, 67.0, 66.0, 67.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 70.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 86.0, 83.0, 89.0, 83.0, 82.0, 136.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 139.0, 142.0, 131.0, 144.0, 132.0, 133.0, 137.0, 158.0, 152.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 181.0, 171.0, 173.0, 173.0, 177.0, 173.0, 179.0, 172.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 70.0, 73.0, 69.0, 68.0, 68.0, 70.0, 67.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1605.1999999999998, "alertThreshold": 2.0}]} 03:29:48 INFO - Return code: 0 03:29:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:29:48 ERROR - # TBPL SUCCESS # 03:29:48 INFO - Running post-action listener: _resource_record_post_action 03:29:48 INFO - ##### 03:29:48 INFO - ##### Finished run-tests step (success) 03:29:48 INFO - ##### 03:29:48 INFO - Running post-run listener: _resource_record_post_run 03:29:50 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 528326656; Read time: 16; Write time: 857496 03:29:50 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233529344; Read time: 0; Write time: 396552 03:29:50 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294797312; Read time: 16; Write time: 460944 03:29:50 INFO - Running post-run listener: _upload_blobber_files 03:29:50 INFO - Blob upload gear active. 03:29:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:29:50 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 03:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:51 INFO - (blobuploader) - INFO - Done attempting. 03:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:51 INFO - (blobuploader) - INFO - Done attempting. 03:29:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:29:51 INFO - Return code: 0 03:29:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:29:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:29:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9999178845ec0dfdd2c651a20fffeda44439737fc210c6a0e4a41182fedf8e2fd6105a477771717699309a681b479fcc862d3f334fb9b07badcad0e68fe9f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd7b5504630ebf04ba174419d88e7d108a85eca6881edbc7f3789f1c7c19dba8794388c442b66e97b1b050947a32b54325df0d33750b02cb25fa6a5dde5f5612"} 03:29:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:29:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:29:51 INFO - Contents: 03:29:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9999178845ec0dfdd2c651a20fffeda44439737fc210c6a0e4a41182fedf8e2fd6105a477771717699309a681b479fcc862d3f334fb9b07badcad0e68fe9f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd7b5504630ebf04ba174419d88e7d108a85eca6881edbc7f3789f1c7c19dba8794388c442b66e97b1b050947a32b54325df0d33750b02cb25fa6a5dde5f5612"} 03:29:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:29:51 INFO - Copying logs to upload dir... 03:29:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:29:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.486723 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-05-10 03:29:51.758500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:29:51.761923) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9999178845ec0dfdd2c651a20fffeda44439737fc210c6a0e4a41182fedf8e2fd6105a477771717699309a681b479fcc862d3f334fb9b07badcad0e68fe9f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd7b5504630ebf04ba174419d88e7d108a85eca6881edbc7f3789f1c7c19dba8794388c442b66e97b1b050947a32b54325df0d33750b02cb25fa6a5dde5f5612"} build_url:https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9999178845ec0dfdd2c651a20fffeda44439737fc210c6a0e4a41182fedf8e2fd6105a477771717699309a681b479fcc862d3f334fb9b07badcad0e68fe9f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bd7b5504630ebf04ba174419d88e7d108a85eca6881edbc7f3789f1c7c19dba8794388c442b66e97b1b050947a32b54325df0d33750b02cb25fa6a5dde5f5612"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:29:51.787091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:29:51.787418) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462874102.166096-1454776325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:29:51.873119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:29:51.873587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:29:51.873901) ========= ========= Total master_lag: 3.40 =========