builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1460678164.24 results: success (0) buildid: 20160414161850 builduid: 3e25626c57874c75bbb1991d4b470452 revision: 8cbd3940c47f0babdf44937b799e160278b4a1fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.241653) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.242191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.242524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.260379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.260758) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 16:56:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-04-14 16:56:04 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.401749 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.676799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.677268) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016958 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:04.793261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 16:56:04.796717) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cbd3940c47f0babdf44937b799e160278b4a1fc --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 8cbd3940c47f0babdf44937b799e160278b4a1fc --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=9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 16:56:05,043 truncating revision to first 12 chars 2016-04-14 16:56:05,043 Setting DEBUG logging. 2016-04-14 16:56:05,044 attempt 1/10 2016-04-14 16:56:05,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cbd3940c47f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 16:56:05,779 unpacking tar archive at: fx-team-8cbd3940c47f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990348 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 16:56:06.011466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:06.014936) ========= script_repo_revision: 8cbd3940c47f0babdf44937b799e160278b4a1fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:06.015405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:06.015727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:56:06.028944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-14 16:56:06.029361) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:06 INFO - MultiFileLogger online at 20160414 16:56:06 in /builds/slave/test 16:56:06 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 16:56:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:06 INFO - {'append_to_log': False, 16:56:06 INFO - 'base_work_dir': '/builds/slave/test', 16:56:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:56:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:06 INFO - 'branch': 'Fx-Team-Non-PGO', 16:56:06 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:06 INFO - 'config_files': ('talos/linux_config.py',), 16:56:06 INFO - 'default_actions': ('clobber', 16:56:06 INFO - 'read-buildbot-config', 16:56:06 INFO - 'download-and-extract', 16:56:06 INFO - 'populate-webroot', 16:56:06 INFO - 'create-virtualenv', 16:56:06 INFO - 'install', 16:56:06 INFO - 'run-tests'), 16:56:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:06 INFO - 'download_minidump_stackwalk': True, 16:56:06 INFO - 'download_symbols': 'ondemand', 16:56:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:06 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:06 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:06 INFO - 'installer_path': 'installer.exe', 16:56:06 INFO - 'log_level': 'info', 16:56:06 INFO - 'log_name': 'talos', 16:56:06 INFO - 'log_to_console': True, 16:56:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:06 INFO - 'opt_config_files': (), 16:56:06 INFO - 'pip_index': False, 16:56:06 INFO - 'sps_profile': False, 16:56:06 INFO - 'sps_profile_interval': 0, 16:56:06 INFO - 'suite': 'dromaeojs-e10s', 16:56:06 INFO - 'system_bits': '32', 16:56:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:06 INFO - 'title': 'talos-linux64-ix-013', 16:56:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:06 INFO - 'use_talos_json': True, 16:56:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:06 INFO - 'work_dir': 'build'} 16:56:06 INFO - ##### 16:56:06 INFO - ##### Running clobber step. 16:56:06 INFO - ##### 16:56:06 INFO - Running pre-action listener: _resource_record_pre_action 16:56:06 INFO - Running main action method: clobber 16:56:06 INFO - rmtree: /builds/slave/test/build 16:56:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:06 INFO - Running post-action listener: _resource_record_post_action 16:56:06 INFO - ##### 16:56:06 INFO - ##### Running read-buildbot-config step. 16:56:06 INFO - ##### 16:56:06 INFO - Running pre-action listener: _resource_record_pre_action 16:56:06 INFO - Running main action method: read_buildbot_config 16:56:06 INFO - Using buildbot properties: 16:56:06 INFO - { 16:56:06 INFO - "project": "", 16:56:06 INFO - "product": "firefox", 16:56:06 INFO - "script_repo_revision": "production", 16:56:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:56:06 INFO - "repository": "", 16:56:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:56:06 INFO - "buildid": "20160414161850", 16:56:06 INFO - "pgo_build": "False", 16:56:06 INFO - "basedir": "/builds/slave/test", 16:56:06 INFO - "buildnumber": 1148, 16:56:06 INFO - "slavename": "talos-linux64-ix-013", 16:56:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:56:06 INFO - "platform": "ubuntu64_hw", 16:56:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:56:06 INFO - "branch": "fx-team", 16:56:06 INFO - "repo_path": "integration/fx-team", 16:56:06 INFO - "revision": "8cbd3940c47f0babdf44937b799e160278b4a1fc", 16:56:06 INFO - "stage_platform": "linux64", 16:56:06 INFO - "builduid": "3e25626c57874c75bbb1991d4b470452", 16:56:06 INFO - "slavebuilddir": "test" 16:56:06 INFO - } 16:56:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:56:06 INFO - Running post-action listener: _resource_record_post_action 16:56:06 INFO - ##### 16:56:06 INFO - ##### Running download-and-extract step. 16:56:06 INFO - ##### 16:56:06 INFO - Running pre-action listener: _resource_record_pre_action 16:56:06 INFO - Running main action method: download_and_extract 16:56:06 INFO - mkdir: /builds/slave/test/build/tests 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:06 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:56:07 INFO - Downloaded 1361 bytes. 16:56:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:56:07 INFO - Using the following test package requirements: 16:56:07 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:56:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:56:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'jsshell-linux-x86_64.zip'], 16:56:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:56:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:56:07 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:56:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:56:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:56:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:07 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:56:09 INFO - Downloaded 22202881 bytes. 16:56:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:56:10 INFO - Return code: 0 16:56:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:56:10 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')]} 16:56:10 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:56:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:56:11 INFO - Downloaded 22202881 bytes. 16:56:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:56:12 INFO - Return code: 0 16:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:12 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:56:15 INFO - Downloaded 10841076 bytes. 16:56:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:56:15 INFO - Return code: 0 16:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:15 INFO - https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:56:16 INFO - Downloaded 54448369 bytes. 16:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:56:16 INFO - mkdir: /builds/slave/test/properties 16:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:56:16 INFO - Writing to file /builds/slave/test/properties/build_url 16:56:16 INFO - Contents: 16:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:56:17 INFO - Running post-action listener: _resource_record_post_action 16:56:17 INFO - Running post-action listener: set_extra_try_arguments 16:56:17 INFO - ##### 16:56:17 INFO - ##### Running populate-webroot step. 16:56:17 INFO - ##### 16:56:17 INFO - Running pre-action listener: _resource_record_pre_action 16:56:17 INFO - Running main action method: populate_webroot 16:56:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:56:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:56:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:56:17 INFO - '--tppagecycles', 16:56:17 INFO - '7'], 16:56:17 INFO - 'tests': ['tsvgm']}}, 16:56:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:56:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:56:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:56:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:56:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['damp', 'tps']}, 16:56:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'tests': ['damp', 'tps']}, 16:56:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['dromaeo_dom']}, 16:56:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:56:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['a11yr', 16:56:17 INFO - 'ts_paint', 16:56:17 INFO - 'tpaint', 16:56:17 INFO - 'sessionrestore', 16:56:17 INFO - 'sessionrestore_no_auto_restore', 16:56:17 INFO - 'tabpaint']}, 16:56:17 INFO - 'other-e10s': {'tests': ['a11yr', 16:56:17 INFO - 'ts_paint', 16:56:17 INFO - 'tpaint', 16:56:17 INFO - 'sessionrestore', 16:56:17 INFO - 'sessionrestore_no_auto_restore', 16:56:17 INFO - 'tabpaint']}, 16:56:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:56:17 INFO - 'ts_paint', 16:56:17 INFO - 'tpaint', 16:56:17 INFO - 'sessionrestore', 16:56:17 INFO - 'sessionrestore_no_auto_restore', 16:56:17 INFO - 'tabpaint']}, 16:56:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:56:17 INFO - 'ts_paint', 16:56:17 INFO - 'tpaint', 16:56:17 INFO - 'sessionrestore', 16:56:17 INFO - 'sessionrestore_no_auto_restore', 16:56:17 INFO - 'tabpaint']}, 16:56:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['a11yr', 16:56:17 INFO - 'ts_paint', 16:56:17 INFO - 'tpaint', 16:56:17 INFO - 'sessionrestore', 16:56:17 INFO - 'sessionrestore_no_auto_restore', 16:56:17 INFO - 'tabpaint']}, 16:56:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['a11yr', 16:56:17 INFO - 'ts_paint', 16:56:17 INFO - 'tpaint', 16:56:17 INFO - 'sessionrestore', 16:56:17 INFO - 'sessionrestore_no_auto_restore', 16:56:17 INFO - 'tabpaint']}, 16:56:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['tsvgx', 16:56:17 INFO - 'tsvgr_opacity', 16:56:17 INFO - 'tart', 16:56:17 INFO - 'tscrollx', 16:56:17 INFO - 'cart']}, 16:56:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:56:17 INFO - 'tsvgr_opacity', 16:56:17 INFO - 'tart', 16:56:17 INFO - 'tscrollx', 16:56:17 INFO - 'cart']}, 16:56:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'talos_options': ['--disable-e10s'], 16:56:17 INFO - 'tests': ['tp5o']}, 16:56:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'tests': ['tp5o']}, 16:56:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'talos_options': ['--disable-e10s', 16:56:17 INFO - '--xperf_path', 16:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:17 INFO - 'tests': ['tp5n']}, 16:56:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:17 INFO - 'talos_options': ['--xperf_path', 16:56:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:17 INFO - 'tests': ['tp5n']}}, 16:56:17 INFO - 'talos.zip': {'path': '', 16:56:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:56:17 INFO - Running post-action listener: _resource_record_post_action 16:56:17 INFO - ##### 16:56:17 INFO - ##### Running create-virtualenv step. 16:56:17 INFO - ##### 16:56:17 INFO - Running pre-action listener: _resource_record_pre_action 16:56:17 INFO - Running main action method: create_virtualenv 16:56:17 INFO - Creating virtualenv /builds/slave/test/build/venv 16:56:17 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 16:56:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:56:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:56:17 INFO - Using real prefix '/usr' 16:56:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:56:20 INFO - Installing pip.................done. 16:56:20 INFO - Return code: 0 16:56:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:56:20 INFO - Using env: {'DISPLAY': ':0', 16:56:20 INFO - 'HOME': '/home/cltbld', 16:56:20 INFO - 'LANG': 'en_US.UTF-8', 16:56:20 INFO - 'LANGUAGE': 'en_US:en', 16:56:20 INFO - 'LOGNAME': 'cltbld', 16:56:20 INFO - 'MAIL': '/var/mail/cltbld', 16:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:20 INFO - 'MOZ_NO_REMOTE': '1', 16:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:20 INFO - 'NO_EM_RESTART': '1', 16:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:20 INFO - 'PWD': '/builds/slave/test', 16:56:20 INFO - 'SHELL': '/bin/bash', 16:56:20 INFO - 'SHLVL': '1', 16:56:20 INFO - 'TERM': 'linux', 16:56:20 INFO - 'TMOUT': '86400', 16:56:20 INFO - 'USER': 'cltbld', 16:56:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:20 INFO - '_': '/tools/buildbot/bin/python'} 16:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:20 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 16:56:20 INFO - Cleaning up... 16:56:20 INFO - Return code: 0 16:56:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:56:20 INFO - Using env: {'DISPLAY': ':0', 16:56:20 INFO - 'HOME': '/home/cltbld', 16:56:20 INFO - 'LANG': 'en_US.UTF-8', 16:56:20 INFO - 'LANGUAGE': 'en_US:en', 16:56:20 INFO - 'LOGNAME': 'cltbld', 16:56:20 INFO - 'MAIL': '/var/mail/cltbld', 16:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:20 INFO - 'MOZ_NO_REMOTE': '1', 16:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:20 INFO - 'NO_EM_RESTART': '1', 16:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:20 INFO - 'PWD': '/builds/slave/test', 16:56:20 INFO - 'SHELL': '/bin/bash', 16:56:20 INFO - 'SHLVL': '1', 16:56:20 INFO - 'TERM': 'linux', 16:56:20 INFO - 'TMOUT': '86400', 16:56:20 INFO - 'USER': 'cltbld', 16:56:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:20 INFO - '_': '/tools/buildbot/bin/python'} 16:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:20 INFO - Downloading/unpacking psutil>=0.7.1 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:22 INFO - Installing collected packages: psutil 16:56:22 INFO - Running setup.py install for psutil 16:56:22 INFO - building 'psutil._psutil_linux' extension 16:56:22 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 16:56:23 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 16:56:23 INFO - building 'psutil._psutil_posix' extension 16:56:23 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 16:56:23 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 16:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:23 INFO - Successfully installed psutil 16:56:23 INFO - Cleaning up... 16:56:23 INFO - Return code: 0 16:56:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:23 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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:23 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 16:56:23 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 16:56:23 INFO - Using env: {'DISPLAY': ':0', 16:56:23 INFO - 'HOME': '/home/cltbld', 16:56:23 INFO - 'LANG': 'en_US.UTF-8', 16:56:23 INFO - 'LANGUAGE': 'en_US:en', 16:56:23 INFO - 'LOGNAME': 'cltbld', 16:56:23 INFO - 'MAIL': '/var/mail/cltbld', 16:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:23 INFO - 'MOZ_NO_REMOTE': '1', 16:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:23 INFO - 'NO_EM_RESTART': '1', 16:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:23 INFO - 'PWD': '/builds/slave/test', 16:56:23 INFO - 'SHELL': '/bin/bash', 16:56:23 INFO - 'SHLVL': '1', 16:56:23 INFO - 'TERM': 'linux', 16:56:23 INFO - 'TMOUT': '86400', 16:56:23 INFO - 'USER': 'cltbld', 16:56:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:23 INFO - '_': '/tools/buildbot/bin/python'} 16:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:56:25 INFO - Installing collected packages: mozsystemmonitor 16:56:25 INFO - Running setup.py install for mozsystemmonitor 16:56:25 INFO - Successfully installed mozsystemmonitor 16:56:25 INFO - Cleaning up... 16:56:25 INFO - Return code: 0 16:56:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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', '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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:56: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 blobuploader==1.2.4 16:56:25 INFO - Using env: {'DISPLAY': ':0', 16:56:25 INFO - 'HOME': '/home/cltbld', 16:56:25 INFO - 'LANG': 'en_US.UTF-8', 16:56:25 INFO - 'LANGUAGE': 'en_US:en', 16:56:25 INFO - 'LOGNAME': 'cltbld', 16:56:25 INFO - 'MAIL': '/var/mail/cltbld', 16:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:25 INFO - 'MOZ_NO_REMOTE': '1', 16:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:25 INFO - 'NO_EM_RESTART': '1', 16:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:25 INFO - 'PWD': '/builds/slave/test', 16:56:25 INFO - 'SHELL': '/bin/bash', 16:56:25 INFO - 'SHLVL': '1', 16:56:25 INFO - 'TERM': 'linux', 16:56:25 INFO - 'TMOUT': '86400', 16:56:25 INFO - 'USER': 'cltbld', 16:56:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:25 INFO - '_': '/tools/buildbot/bin/python'} 16:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:25 INFO - Downloading/unpacking blobuploader==1.2.4 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56:27 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:27 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 16:56:27 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 16:56:27 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 16:56:27 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 16:56:27 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 16:56:27 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 16:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:28 INFO - Downloading docopt-0.6.1.tar.gz 16:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:28 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:28 INFO - Running setup.py install for blobuploader 16:56:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:28 INFO - Running setup.py install for requests 16:56:28 INFO - Running setup.py install for docopt 16:56:29 INFO - Successfully installed blobuploader requests docopt 16:56:29 INFO - Cleaning up... 16:56:29 INFO - Return code: 0 16:56:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:29 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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:29 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 16:56:29 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 16:56:29 INFO - Using env: {'DISPLAY': ':0', 16:56:29 INFO - 'HOME': '/home/cltbld', 16:56:29 INFO - 'LANG': 'en_US.UTF-8', 16:56:29 INFO - 'LANGUAGE': 'en_US:en', 16:56:29 INFO - 'LOGNAME': 'cltbld', 16:56:29 INFO - 'MAIL': '/var/mail/cltbld', 16:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:29 INFO - 'MOZ_NO_REMOTE': '1', 16:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:29 INFO - 'NO_EM_RESTART': '1', 16:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:29 INFO - 'PWD': '/builds/slave/test', 16:56:29 INFO - 'SHELL': '/bin/bash', 16:56:29 INFO - 'SHLVL': '1', 16:56:29 INFO - 'TERM': 'linux', 16:56:29 INFO - 'TMOUT': '86400', 16:56:29 INFO - 'USER': 'cltbld', 16:56:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:29 INFO - '_': '/tools/buildbot/bin/python'} 16:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:29 INFO - Running setup.py (path:/tmp/pip-s9WgUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:29 INFO - Running setup.py (path:/tmp/pip-w8IGLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:29 INFO - Running setup.py (path:/tmp/pip-fCaG3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:29 INFO - Running setup.py (path:/tmp/pip-OjaWv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:29 INFO - Running setup.py (path:/tmp/pip-Nn_oh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:29 INFO - Running setup.py (path:/tmp/pip-LKKr7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:29 INFO - Running setup.py (path:/tmp/pip-69PArq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:29 INFO - Running setup.py (path:/tmp/pip-_LIfHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:29 INFO - Running setup.py (path:/tmp/pip-vQ2bSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:29 INFO - Running setup.py (path:/tmp/pip-0TDeN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:30 INFO - Running setup.py (path:/tmp/pip-gxy2HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:30 INFO - Running setup.py (path:/tmp/pip-aKNgFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:30 INFO - Running setup.py (path:/tmp/pip-na3ZJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:30 INFO - Running setup.py (path:/tmp/pip-uWumxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:30 INFO - Running setup.py (path:/tmp/pip-INeJPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:30 INFO - Running setup.py (path:/tmp/pip-lyD0fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:30 INFO - Running setup.py (path:/tmp/pip-wrzn2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:30 INFO - Running setup.py install for manifestparser 16:56:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:30 INFO - Running setup.py install for mozcrash 16:56:30 INFO - Running setup.py install for mozdebug 16:56:30 INFO - Running setup.py install for mozdevice 16:56:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:56:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:30 INFO - Running setup.py install for mozfile 16:56:31 INFO - Running setup.py install for mozhttpd 16:56:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for mozinfo 16:56:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for mozInstall 16:56:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for mozleak 16:56:31 INFO - Running setup.py install for mozlog 16:56:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for moznetwork 16:56:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for mozprocess 16:56:31 INFO - Running setup.py install for mozprofile 16:56:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for mozrunner 16:56:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:31 INFO - Running setup.py install for mozscreenshot 16:56:32 INFO - Running setup.py install for moztest 16:56:32 INFO - Running setup.py install for mozversion 16:56:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:32 INFO - Cleaning up... 16:56:32 INFO - Return code: 0 16:56:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:32 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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:32 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 16:56:32 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 16:56:32 INFO - Using env: {'DISPLAY': ':0', 16:56:32 INFO - 'HOME': '/home/cltbld', 16:56:32 INFO - 'LANG': 'en_US.UTF-8', 16:56:32 INFO - 'LANGUAGE': 'en_US:en', 16:56:32 INFO - 'LOGNAME': 'cltbld', 16:56:32 INFO - 'MAIL': '/var/mail/cltbld', 16:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:32 INFO - 'MOZ_NO_REMOTE': '1', 16:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:32 INFO - 'NO_EM_RESTART': '1', 16:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:32 INFO - 'PWD': '/builds/slave/test', 16:56:32 INFO - 'SHELL': '/bin/bash', 16:56:32 INFO - 'SHLVL': '1', 16:56:32 INFO - 'TERM': 'linux', 16:56:32 INFO - 'TMOUT': '86400', 16:56:32 INFO - 'USER': 'cltbld', 16:56:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:32 INFO - '_': '/tools/buildbot/bin/python'} 16:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:32 INFO - Running setup.py (path:/tmp/pip-1O2lB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:32 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)) 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:32 INFO - Running setup.py (path:/tmp/pip-0oZKaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:32 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)) 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:32 INFO - Running setup.py (path:/tmp/pip-lOmMY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:32 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)) 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:32 INFO - Running setup.py (path:/tmp/pip-aKAMBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:32 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)) 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:32 INFO - Running setup.py (path:/tmp/pip-sZws8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:32 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)) 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:32 INFO - Running setup.py (path:/tmp/pip-ZDrx7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:32 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)) 16:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:32 INFO - Running setup.py (path:/tmp/pip-Ix04Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:33 INFO - Running setup.py (path:/tmp/pip-Bwt0tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:33 INFO - Running setup.py (path:/tmp/pip-yXv2QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:33 INFO - Running setup.py (path:/tmp/pip-p9dPwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:33 INFO - Running setup.py (path:/tmp/pip-FI1vKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:33 INFO - Running setup.py (path:/tmp/pip-N0evzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:33 INFO - Running setup.py (path:/tmp/pip-zo_Rhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:33 INFO - Running setup.py (path:/tmp/pip-ipRKWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:33 INFO - Running setup.py (path:/tmp/pip-DW5umF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:33 INFO - Running setup.py (path:/tmp/pip-NdcnqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:33 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)) 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:33 INFO - Running setup.py (path:/tmp/pip-pxngQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:33 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)) 16:56:33 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)) 16:56:33 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)) 16:56:33 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)) 16:56:33 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)) 16:56:33 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)) 16:56:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:35 INFO - Downloading blessings-1.6.tar.gz 16:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:35 INFO - Installing collected packages: blessings 16:56:35 INFO - Running setup.py install for blessings 16:56:35 INFO - Successfully installed blessings 16:56:35 INFO - Cleaning up... 16:56:35 INFO - Return code: 0 16:56:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:36 INFO - Reading from file tmpfile_stdout 16:56:36 INFO - Current package versions: 16:56:36 INFO - argparse == 1.2.1 16:56:36 INFO - blessings == 1.6 16:56:36 INFO - blobuploader == 1.2.4 16:56:36 INFO - docopt == 0.6.1 16:56:36 INFO - manifestparser == 1.1 16:56:36 INFO - mozInstall == 1.12 16:56:36 INFO - mozcrash == 0.17 16:56:36 INFO - mozdebug == 0.1 16:56:36 INFO - mozdevice == 0.48 16:56:36 INFO - mozfile == 1.2 16:56:36 INFO - mozhttpd == 0.7 16:56:36 INFO - mozinfo == 0.9 16:56:36 INFO - mozleak == 0.1 16:56:36 INFO - mozlog == 3.1 16:56:36 INFO - moznetwork == 0.27 16:56:36 INFO - mozprocess == 0.22 16:56:36 INFO - mozprofile == 0.28 16:56:36 INFO - mozrunner == 6.11 16:56:36 INFO - mozscreenshot == 0.1 16:56:36 INFO - mozsystemmonitor == 0.0 16:56:36 INFO - moztest == 0.7 16:56:36 INFO - mozversion == 1.4 16:56:36 INFO - psutil == 3.1.1 16:56:36 INFO - requests == 1.2.3 16:56:36 INFO - wsgiref == 0.1.2 16:56:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:36 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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:36 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 16:56:36 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 16:56:36 INFO - Using env: {'DISPLAY': ':0', 16:56:36 INFO - 'HOME': '/home/cltbld', 16:56:36 INFO - 'LANG': 'en_US.UTF-8', 16:56:36 INFO - 'LANGUAGE': 'en_US:en', 16:56:36 INFO - 'LOGNAME': 'cltbld', 16:56:36 INFO - 'MAIL': '/var/mail/cltbld', 16:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:36 INFO - 'MOZ_NO_REMOTE': '1', 16:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:36 INFO - 'NO_EM_RESTART': '1', 16:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:36 INFO - 'PWD': '/builds/slave/test', 16:56:36 INFO - 'SHELL': '/bin/bash', 16:56:36 INFO - 'SHLVL': '1', 16:56:36 INFO - 'TERM': 'linux', 16:56:36 INFO - 'TMOUT': '86400', 16:56:36 INFO - 'USER': 'cltbld', 16:56:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:36 INFO - '_': '/tools/buildbot/bin/python'} 16:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 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)) 16:56:36 INFO - Cleaning up... 16:56:36 INFO - Return code: 0 16:56:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:36 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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:36 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 16:56:36 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 16:56:36 INFO - Using env: {'DISPLAY': ':0', 16:56:36 INFO - 'HOME': '/home/cltbld', 16:56:36 INFO - 'LANG': 'en_US.UTF-8', 16:56:36 INFO - 'LANGUAGE': 'en_US:en', 16:56:36 INFO - 'LOGNAME': 'cltbld', 16:56:36 INFO - 'MAIL': '/var/mail/cltbld', 16:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:36 INFO - 'MOZ_NO_REMOTE': '1', 16:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:36 INFO - 'NO_EM_RESTART': '1', 16:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:36 INFO - 'PWD': '/builds/slave/test', 16:56:36 INFO - 'SHELL': '/bin/bash', 16:56:36 INFO - 'SHLVL': '1', 16:56:36 INFO - 'TERM': 'linux', 16:56:36 INFO - 'TMOUT': '86400', 16:56:36 INFO - 'USER': 'cltbld', 16:56:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:36 INFO - '_': '/tools/buildbot/bin/python'} 16:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:36 INFO - Downloading/unpacking jsonschema 16:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:38 INFO - Downloading/unpacking functools32 (from jsonschema) 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:38 INFO - warning: no files found matching '*.txt' 16:56:38 INFO - no previously-included directories found matching 'build' 16:56:38 INFO - no previously-included directories found matching 'dist' 16:56:38 INFO - no previously-included directories found matching '.git*' 16:56:38 INFO - Installing collected packages: jsonschema, functools32 16:56:38 INFO - Running setup.py install for functools32 16:56:38 INFO - warning: no files found matching '*.txt' 16:56:38 INFO - no previously-included directories found matching 'build' 16:56:38 INFO - no previously-included directories found matching 'dist' 16:56:38 INFO - no previously-included directories found matching '.git*' 16:56:38 INFO - Successfully installed jsonschema functools32 16:56:38 INFO - Cleaning up... 16:56:38 INFO - Return code: 0 16:56:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:56:38 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')]} 16:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:38 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')]} 16:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:38 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 0x7f5ad6f40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', '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 16:56:38 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 16:56:38 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 16:56:38 INFO - Using env: {'DISPLAY': ':0', 16:56:38 INFO - 'HOME': '/home/cltbld', 16:56:38 INFO - 'LANG': 'en_US.UTF-8', 16:56:38 INFO - 'LANGUAGE': 'en_US:en', 16:56:38 INFO - 'LOGNAME': 'cltbld', 16:56:38 INFO - 'MAIL': '/var/mail/cltbld', 16:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:38 INFO - 'MOZ_NO_REMOTE': '1', 16:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:38 INFO - 'NO_EM_RESTART': '1', 16:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:38 INFO - 'PWD': '/builds/slave/test', 16:56:38 INFO - 'SHELL': '/bin/bash', 16:56:38 INFO - 'SHLVL': '1', 16:56:38 INFO - 'TERM': 'linux', 16:56:38 INFO - 'TMOUT': '86400', 16:56:38 INFO - 'USER': 'cltbld', 16:56:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:38 INFO - '_': '/tools/buildbot/bin/python'} 16:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:39 INFO - Downloading/unpacking flake8 16:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:56:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:56:40 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 16:56:40 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 16:56:40 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 16:56:40 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 16:56:40 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 16:56:40 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 16:56:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:56:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:56:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:41 INFO - no previously-included directories found matching 'docs/_build' 16:56:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:56:41 INFO - Running setup.py install for pep8 16:56:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:41 INFO - no previously-included directories found matching 'docs/_build' 16:56:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:56:41 INFO - Cleaning up... 16:56:41 INFO - Return code: 0 16:56:41 INFO - Running post-action listener: _resource_record_post_action 16:56:41 INFO - Running post-action listener: _start_resource_monitoring 16:56:41 INFO - Starting resource monitoring. 16:56:41 INFO - ##### 16:56:41 INFO - ##### Running install step. 16:56:41 INFO - ##### 16:56:41 INFO - Running pre-action listener: _resource_record_pre_action 16:56:41 INFO - Running main action method: install 16:56:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:42 INFO - Reading from file tmpfile_stdout 16:56:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:42 INFO - Reading from file tmpfile_stdout 16:56:42 INFO - Output received: 16:56:42 INFO - Usage: mozinstall [options] installer 16:56:42 INFO - Options: 16:56:42 INFO - -h, --help show this help message and exit 16:56:42 INFO - -d DEST, --destination=DEST 16:56:42 INFO - Directory to install application into. [default: 16:56:42 INFO - "/builds/slave/test"] 16:56:42 INFO - --app=APP Application being installed. [default: firefox] 16:56:42 INFO - mkdir: /builds/slave/test/build/application 16:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:56:57 INFO - Reading from file tmpfile_stdout 16:56:57 INFO - Output received: 16:56:57 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:57 INFO - Running post-action listener: _resource_record_post_action 16:56:57 INFO - ##### 16:56:57 INFO - ##### Running run-tests step. 16:56:57 INFO - ##### 16:56:57 INFO - Running pre-action listener: _resource_record_pre_action 16:56:57 INFO - Running main action method: run_tests 16:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:57 INFO - Python 2.7.3 16:56:57 INFO - Return code: 0 16:56:57 INFO - grabbing minidump binary from tooltool 16:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:57 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 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:57 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 16:56:57 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 16:56:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:57 INFO - Return code: 0 16:56:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:56:58 INFO - Return code: 0 16:56:58 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/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:56:58 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/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 16:56:58 INFO - Using env: {'DISPLAY': ':0', 16:56:58 INFO - 'HOME': '/home/cltbld', 16:56:58 INFO - 'LANG': 'en_US.UTF-8', 16:56:58 INFO - 'LANGUAGE': 'en_US:en', 16:56:58 INFO - 'LOGNAME': 'cltbld', 16:56:58 INFO - 'MAIL': '/var/mail/cltbld', 16:56:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:58 INFO - 'MOZ_NO_REMOTE': '1', 16:56:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:58 INFO - 'NO_EM_RESTART': '1', 16:56:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:58 INFO - 'PWD': '/builds/slave/test', 16:56:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:58 INFO - 'SHELL': '/bin/bash', 16:56:58 INFO - 'SHLVL': '1', 16:56:58 INFO - 'TERM': 'linux', 16:56:58 INFO - 'TMOUT': '86400', 16:56:58 INFO - 'USER': 'cltbld', 16:56:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967', 16:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:58 INFO - '_': '/tools/buildbot/bin/python'} 16:56:58 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/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:56:59 INFO - mozversion application_buildid: 20160414161850 16:56:59 INFO - mozversion application_changeset: 8cbd3940c47f0babdf44937b799e160278b4a1fc 16:56:59 INFO - mozversion application_display_name: Nightly 16:56:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:59 INFO - mozversion application_name: Firefox 16:56:59 INFO - mozversion application_remotingname: firefox 16:56:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:56:59 INFO - mozversion application_vendor: Mozilla 16:56:59 INFO - mozversion application_version: 48.0a1 16:56:59 INFO - mozversion platform_buildid: 20160414161850 16:56:59 INFO - mozversion platform_changeset: 8cbd3940c47f0babdf44937b799e160278b4a1fc 16:56:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:56:59 INFO - mozversion platform_version: 48.0a1 16:56:59 INFO - using testdate: 1460678219 16:56:59 INFO - actual date: 1460678219 16:56:59 INFO - starting webserver on 'localhost:49141' 16:56:59 INFO - SUITE-START | Running 2 tests 16:56:59 INFO - TEST-START | dromaeo_css 16:56:59 INFO - operating with platform_type : linux_ 16:56:59 INFO - Initialising browser for dromaeo_css test... 16:56:59 INFO - TEST-INFO | started process 14637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HP8M0/profile http://localhost:49141/getInfo.html) 16:57:03 INFO - PROCESS | 14637 | 16:57:03 INFO - PROCESS | 14637 | (process:14706): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:03 INFO - PROCESS | 14637 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:57:03 INFO - PROCESS | 14637 | __metrics Screen width/height:1600/1200 16:57:03 INFO - PROCESS | 14637 | colorDepth:24 16:57:03 INFO - PROCESS | 14637 | Browser inner width/height: 1024/697 16:57:03 INFO - PROCESS | 14637 | __metrics 16:57:04 ERROR - PROCESS | 14637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:57:05 INFO - TEST-INFO | 14637: exit 0 16:57:05 INFO - Browser initialized. 16:57:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:05 INFO - TEST-INFO | started process 14757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HP8M0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:07 INFO - PROCESS | 14757 | 16:57:07 INFO - PROCESS | 14757 | (process:14816): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:17 INFO - PROCESS | 14757 | RSS: Main: 163844096 16:57:17 INFO - PROCESS | 14757 | 16:58:07 INFO - PROCESS | 14757 | 1460678287110 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] 17:00:18 INFO - PROCESS | 14757 | Cycle 1(1): loaded http://localhost:49141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49141/tests/dromaeo/cssquery-ext.html) 17:00:19 INFO - PROCESS | 14757 | RSS: Main: 166772736 17:00:19 INFO - PROCESS | 14757 | 17:03:21 INFO - PROCESS | 14757 | Cycle 1(1): loaded http://localhost:49141/tests/dromaeo/cssquery-ext.html (next: http://localhost:49141/tests/dromaeo/cssquery-jquery.html) 17:03:22 INFO - PROCESS | 14757 | RSS: Main: 165298176 17:03:22 INFO - PROCESS | 14757 | 17:06:23 INFO - PROCESS | 14757 | Cycle 1(1): loaded http://localhost:49141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49141/tests/dromaeo/cssquery-mootools.html) 17:06:24 INFO - PROCESS | 14757 | RSS: Main: 166305792 17:06:24 INFO - PROCESS | 14757 | 17:09:26 INFO - PROCESS | 14757 | Cycle 1(1): loaded http://localhost:49141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49141/tests/dromaeo/cssquery-prototype.html) 17:09:26 INFO - PROCESS | 14757 | RSS: Main: 164831232 17:09:26 INFO - PROCESS | 14757 | 17:12:29 INFO - PROCESS | 14757 | Cycle 1(1): loaded http://localhost:49141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49141/tests/dromaeo/cssquery-yui.html) 17:12:30 INFO - PROCESS | 14757 | RSS: Main: 165560320 17:12:30 INFO - PROCESS | 14757 | 17:15:32 INFO - PROCESS | 14757 | Cycle 1(1): loaded http://localhost:49141/tests/dromaeo/cssquery-yui.html (next: http://localhost:49141/tests/dromaeo/cssquery-dojo.html) 17:15:33 INFO - PROCESS | 14757 | RSS: Main: 167440384 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | __start_tp_report 17:15:33 INFO - PROCESS | 14757 | _x_x_mozilla_page_load 17:15:33 INFO - PROCESS | 14757 | _x_x_mozilla_page_load_details 17:15:33 INFO - PROCESS | 14757 | |i|pagename|runs| 17:15:33 INFO - PROCESS | 14757 | |0;dojo.html;2646.07387414405;2729.3176705823544;2730.7405796449357;2760.654918135233;2767.2528417327308;4754.8335808246675;4778.235482322829;4793.952060479394;4795.808167673289;4827.082854257688;4636.420447444069;4713.198756211444;4720.5515476029805;4721.575058244757;4725.976370118145;4354.042110735633;4413.6910416270875;4434.201843668138;4436.489803672586;4489.304157855538;4403.427554417921;4426.579474949875;4447.599716025557;4459.10817836434;4507.616852567536;224.48567340208197;4364.258076127066;4408.669349798746;4423.646108311327;4470.865874023768;4410.2282100632265;4431.5789999950275;4434.623057040156;4437.755923424211;4469.396631454777;4442.822287108512;4447.977760111211;4455.10897820434;4481.215787237221;4496.640268778523;4553.066621342617;4607.10161518504;4702.459217190033;4707.270373092176;4772.117158325721;5138.74306284688;5153.407358153823;5163.122269214205;5180.585553155738;5197.064528384889;5186.7147306898105;5203.661761985497;5209.947900520984;5209.973950130225;5213.791448342062;4708.976455117702;4709.293605959099;4772.6420518461255;4778.665493415428;4813.302071199656;5239.345081864691;5255.054090263713;5272.182811664198;5317.521423071942;5342.973285133549;4900.142475066849;5091.261767043758;5095.566876815438;5096.057229412497;5099.69401835891;5149;5174.97412512935;5193.272941788153;5229.189475631283;5240.240165176105;5138.948610513847;5169.043726910459;5180.404253510819;5182.637215394886;5231.032259032091;4955.851324460272;5048.545630893163;5158.200478925697;5168.3539557555305;5184.196449550326;4301.763403012802;4302.634276086505;4323.329883868006;4327.459067616548;4361.5856493633055;3790.6967442604528;3794.886153415402;3803.8098095095133;3818.809059547067;3835.386338185877;4333.263345231318;4489.9775501122285;4510.954890451119;4527.818887244473;4569.223232050559;5149.330587023663;5156.303898973591;5172.612054095958;5173.715445650525;5225.738713064332;4465.977670111629;4470.463544374631;4508.32375143731;4509.368688383629;4553.203189441901;4533.727976321431;4600.585947264763;4623.214053610895;4651.976740116345;4661.906761864811;4826.372571565744;4852;4891.217405215149;4914.410270767459;4937.703737775745;5176.948230517797;5183.844484665466;5188.870278242923;5190.325257716473;5203.323567936144;4772.379590653193;4804.303376010529;4892.119418504561;4894.755262236945;4897.975510122426;5071.290019397214;5077.238414237894;5094.7707353169935;5095.082885080721;5121.975604879113;5155.53600175986;5160.122779127632;5161.122609156378;5165.328507294028;5186.948130518646;4799.1601469743355;4881.072596206709;4895.118878601886;4951.777170027285;5015.498450154955;4920.778564964514;4925.6700690814;4950;4983.302337672656;4986.975065124651;4875.07373599015;4908.582770464408;4912.336834527436;4913.484084171254;4951.3810773653295;4914.287428322802;4996.950030499648;5013.849584512471;5057.671251368649;5060.595152387874;4855.150348688895;4907.803687852589;4917.950820491749;4921.655484116078;4953.430355509163 17:15:33 INFO - PROCESS | 14757 | |1;ext.html;579.5103137848516;590.4597293476469;610.7190692281551;610.9694515274235;649.334432206988;31526.369472610535;32932.67067329326;32953.17617059575;32955;33014.50478242822;34100;34269;34421.13947151323;34478.827605861996;34648.48027279587;7444.553326800409;7679.769606911774;7702.229777022309;7711.537307761524;7724.343430808388;7590.051243594551;7713.305802477776;7787.182345853689;7811.4922530035365;7815.413843961697;7716.845663086735;7821.726239581616;7841.059072911258;7861.567613781268;7873.803154921145;7743;7805.843883122334;7808.687652493893;7813.492123012043;7827.452078354518;7583.924160758377;7723.073231212291;7732.3040926316335;7743.922560774433;7753.767386978399;28660.283492912637;33988;34314.6568534314;34551.82724086389;34582;2977.270568710658;2989.446952313829;3000.729934305923;3040.057582149541;3420.521127042191;25544.616830747367;25862.74137258622;25882.482350352886;26144.86927565369;26172.0839770609;3368.831558422069;3408.625051244361;3439.9312013759586;3444.7071998880124;3537.7700449470703;182878;183744;184497;185353.0732346343;185424;30771.384572308427;30825;30867.536986945215;30988.380232395677;31052;26889.462210755675;27263.727362726517;58192.12711809326;60214.39785602176;60249;14298.85701142996;14581.489647862274;14588.635284117981;14599.78100328496;14600.12399256048;11271.492782824793;11477;11496.137789665809;11523.769524609628;11535.538578456768;17696.203670834842;17720.556986075193;18139.18373673188;18385.08074596265;18463.261469541067;6891.965540172267;6995.265497122728;7018.473614478832;7197.964010179916;7228.638568071576;857.5326447086353;936.4521754773534;949.6771097826772;1054.8839627640953;1057.5082586597268;28293.71706282952;28798.856005720256;28808;28985.42029159405;29016.41967160645;1002.7292630989592;1025.7230547752065;1048.250500891866;1051.3271506236015;1099.3513826842202;14776.187309697854;15112.168830714416;15179.468718594797;15374;15439.382424702886;341863;346772;347825;349567;349574;47129.764351178026;47619.285710714365;47650.285245721345;47748.76125619419;47782;1230.7107829660022;1231.6982339326921;1235.0490122605543;1236.5548402574886;1241.975160496803;25688.743112568634;27675.86162069177;27827.860860695568;27915.441691165655;28323.291917702223;41231;41730.37404438875;42149.99999999877;42325.78837105795;42406.57593424026;318610;318858;320161;320743;320903;24912.12807551727;24976.500469990136;25295.596918292733;25306.493870122125;25359.36601584975;40456.39315410212;40504.797476012434;40682.18635627212;40855.795721021204;40901.38647920224;35218.47172292469;35848.82075589606;35989.64010359863;36266.8186659065;36340.636593633724;34782;34911.60353585828;35256;35573.28853422969;35810.10474738153;34957.30085398227;35038.64961350354;35273.29453410866;36004.639953600126;36017.459738103425;31616.683833161373;32726;32787.672123279415;32942.67057329492;33085.50371744474;25045.624315634916;25067;25514;25584.48831023332;25892.61161082623 17:15:33 INFO - PROCESS | 14757 | |2;jquery.html;369.6839202481878;379.1828609346855;384.3178358413815;387.56399051067547;388.91055057336814;16086.597835054115;17272.309107635694;18121.90939045303;18312.359067432626;18333.17500712468;16222.83777162228;16869.578260543494;16981.235844387;17064.14679266038;17295.913520432412;4567.840125595597;4825.74530622039;4826.17954947658;4859.611231101521;4859.975700121512;3510.7717998330154;5184.637075404723;5431.701256430894;5490.780368785264;5495.807646732365;5451.48210919962;5455.427180146087;5470.56235501159;5482.396936337;5483.835484935458;5184.326037615105;5529.142982837667;5532.30846144232;5536.667799931997;5541.612087153901;5017.89964200714;5272.156454967187;5298.125809241471;5316.12283973144;5346.893062138735;12464.688382790411;12649.177803442746;12767.42546585406;12779.424925878358;12789.296588687619;1832.7067669172868;1939.8157175068345;2119.872807631547;2167.6965224868372;2281.9388984122297;9268.258539316907;9344;9692.660756873545;9856.901430985741;13057.281849498273;1512.7730840373922;1643.8602718768918;1719.1091345123104;1788.6780379531679;1802.6665066962653;67529;70514.64742676305;71982.64008679976;72965;73243.63378183075;9954.601815927283;10095.545700443497;10098.394096354243;10167.084962353423;10292.228082893813;13607.727845443234;13651.658708532366;13683.521076762265;13712.245826479639;13765.036447448583;7098.574085554883;7299.70801167958;7342.853142937111;7402.888956665654;7422.257774222642;6898.482613803984;6950.096487456598;7043.225245223021;7066.752663656747;7095.716171353088;4158.2307273154565;4229.661627069889;4268.573142685706;4349.3041113421705;4356.477222733292;1672.3645014894262;1675.5894805772664;1707.4450803488667;1788.2221233763094;1858.50749551369;910.5583791860943;910.9635614575343;916.3997581584073;945.8864936207699;987.2398253344884;15667.529974100795;15858.60353491172;16020.599485012968;16455.917720411322;16729.749053764204;903.5211337990876;933.3513208320288;962.2542529539663;964.7781010367655;1002.293383164867;9209.309301802392;9334.39326443779;9358.812823743487;9530.189933855561;9592.616295348247;387424;396859;400605;403377;407220;72801;74033.25966740264;75155.62422187853;75884.24115758883;77117.61441192759;957.8275910336067;970.0735797313548;974.5078735238801;979.5689896445541;984.8522721591819;14720.926395367955;14811.333489992761;15005.849941500444;15024.699506010038;15544.150204146834;25204.117855874956;34019.48970765391;35311.470327945615;35400.46899296461;35684;43914.78042609766;49971.750141250515;49998.50001500084;52276.21585676142;52422.21366679579;7474.5888976106835;7669.578173200304;7696.191899850435;7833.216678332121;8046.879296810435;8795.164459376349;10948.616798412017;10993.395363254778;11612.12909031809;11762.58830940913;10349.84475232857;10352.378857268286;10442.530086146293;10647;10775.245732798629;8375.62309696053;10552.314099583502;10640.946795265974;10695.251332406657;10772.24594278393;10404.375737455777;10790.838137428102;10859.076978456604;11018.677758669011;11030.117590592894;7649.235076492307;7815;7850.175731548105;7917.485363451357;7991.680332786624;8876.120363304486;8876.822463550563;9114.225290850087;9148.679796207367;9976.650817221362 17:15:33 INFO - PROCESS | 14757 | |3;mootools.html;1470.8896832737548;1474.719803237385;1641.2696350124193;1774.4765294238198;1788.088075081708;6943.548669336489;7690.307872291507;7728.92271077289;7975.082865470466;7990.360771138309;7743.574103424309;7828.960855195716;7833.882491762628;7908.44640875139;7915.683372665101;2171.7068195793563;2213.5351576169023;2219.556088782242;2221.511267521151;2221.8111460525874;2159.6976423300753;2180.967285490719;2187.529681118559;2188.2013065231235;2198.0658220256328;2177.5318306564086;2188.9452763680874;2191.057845126595;2203.1958335207614;2212.8782916939563;2168.9240876569324;2183.410479170631;2187.4859408039097;2192.3422973108004;2197.637389830676;2171.880546569938;2175.4561359660083;2181.7054697615777;2186.4533866533366;2191.057845126595;7933.365330773524;7944;7966.482178658426;7982.760517184493;7991.760247192536;4525.094981003813;4644.0944015916575;4648.48866624671;4663.60359369454;4672.15901137795;2878.553824157238;3013.2617508710505;3031.257341951236;3042.1481985044225;3050.283183451887;1031.381171297223;1044.7858189071221;1049.21833234241;1067.3702515515884;1076.7523469601956;10402.739931501697;10534.051935325857;10629.521671524722;10649.946750266277;10672.466376681135;4171.249175148441;4193.454850869368;4327.3725309830525;4377.627901628397;4382.145481631115;9107.499087550115;9161.954190229006;9184.357095003286;9199.724008279762;9211.677591284273;4604.171249175113;4643.094596553639;4646.442426908792;4650.5349465053905;4651.9300560870515;3769.754965927206;4155.667546596265;4190.643795277436;4197.811098500575;4318.460192475941;3693.9445908311395;3722.0880884183007;3764.4353346997623;3806.790626515513;3807.200487897517;1218.1290377380217;1226.9325187114616;1243.2043492165021;1253.8056601226824;1254.5044707340548;786.4259090863587;855.9529225892636;897.8922529296526;928.7817362919709;929.1152559533822;5453.618246722771;5562.888742225214;5578.274824272899;5610.102383618601;5780.53755699543;938.7934654376027;947.6777895515557;975.6097560975667;1019.0879163148941;1032.3805716569998;3787.715921305913;3922.764634121962;3925.0776067624083;3948.763074215556;3991.1020020495157;9532.142107210384;9821;9900.702978910644;9991.300608957303;10003.949980250052;9740.902590974141;9810.754731131636;9810.80378392428;9892.505374731378;9901.15840153595;6993.965030174918;7308.269173082649;7392.55644661322;7471.663775130132;7547.849043019109;5478.616496845182;5526.834194974157;5573.665580065209;5630.774769009194;5694.288213973254;8464.703735369232;8501.10738372462;8516.020657624205;8544;8601.870971935301;8538.231559159705;8999.685011024583;9049.683261086093;9051.954740226256;9109.544522773967;6063.5452341073715;6688.899666505104;6783.321667833375;6800.965995169992;7008.264132266038;7474.626268686435;7524.849503010018;7530.359919406912;7546.6604002821105;7608.201138880338;6501.2198536175965;6695.09616201826;6705.530612857053;6709.429698475684;6836.623985680835;6791.89812152828;6819;6970.546914450544;7044.929550704427;7056.470764692771;6569.113169722217;6584.736610535525;6595.274519802721;6660.866782664222;6679.131712877295;4871.610271178368;4917.336159618549;4937.530934561211;4957.801687932442;4974.154393752999;4756.120117778222;4941.481144479778;4948.084604348063;4948.752562371939;4968.428630707371 17:15:33 INFO - PROCESS | 14757 | |4;prototype.html;318.03000847415376;319.2179161055414;322.14631227247804;323.04217993648825;326.92807582331886;5321.445706061093;5328.413874473809;5402.37872644646;5412.594055445843;5426.565874730022;5326.680399176043;5331.546818520431;5341.599380046493;5350.30446042014;5361.329833770778;3943.2902077625945;4003.27859020621;4130.359794231884;4166.458360413158;4183.121544475649;4164.1879833432495;4174.186033723425;4182.707210495267;4184.916301673965;4186.39297301891;4133.81397837098;4133.958660413403;4158.521769996459;4165.66674666026;4176.7911604419805;4070.5522392536795;4149.83400663973;4158.12679337338;4169.45797046382;4179.226843034048;3661.21283923955;3672.412414013745;3680.1167719747336;3689.6494832990825;3689.8524059037604;5141.457562731166;5146.933922201456;5157.664751791159;5166.715830629314;5174.818881339135;4761.428628564595;4802.927956080662;4848.951510484921;4854.053459575384;4862.124817532843;5670.63904662882;5682.943170568283;5698.6865722385255;5712.6286791358425;5714.314282286111;4060.654844338235;4063.817128229237;4064.878053658395;4066.1867626474527;4076.6738660907354;5721.942780572224;5904.143899134644;5928.49607783339;5931.258592675916;5986.551008674323;4148.502179738451;4158.293090174678;4164.646005089541;4166.312643379436;4171.5828417158045;4223.366495025771;4228.4080228768;4235.174141042467;4239.682023848162;4240.321548552279;4681.391419115494;4749.453812811502;4763.237881938942;4767.928481072787;4774.379330686988;5663.433656634386;5664.433556644302;5678.602497825195;5685.090385538294;5688.431156884279;1455.2432734977751;1459.5913144319607;1470.801441805364;1471.007070227592;1485.2647939269914;943.9339246252833;977.4282045003753;994.5922171909482;1005.1857995024054;1031.742064483879;4972.279019542146;4997.600191984632;5000.449950505442;5008.499150085036;5010.974945125251;5857.736401861926;5868.2664666916635;5878.911816322759;5883.235179426732;5912.940870591325;4887.2650209175945;4984.22744474607;4992.90014199714;5018.899622007612;5032.597392208614;3115.345777386729;3146.5122905949156;3151.842407879643;3154.8422578870964;3166.5408515765544;5468.152436372368;5482.737771026233;5487.341519017744;5496.213730537591;5510.366307874646;5804.622699524517;5954.136650185699;5977.163197152402;5978.491828194565;6004.54965877561;5423.430539793265;5457.208704737791;5462.918056229159;5468.808591699271;5496.615236933456;5669.659820410789;5871.882562348815;5880.970595146997;5887.61730487517;6024.608400453956;5781.710914454345;5826.854328641818;5854.385289544536;5866.6480011199465;5869.765209391577;5561.138023606348;5578.442155784389;5588.776448941997;5613.943860561342;5638.182463542681;4000;4059.6752259818554;4106.630403263721;4115.156392939381;4121.649659778953;5930.822075337746;5969.582129250911;5975.581709280483;5977.402259773988;5991.730372133352;5539.556835453234;5602.887942241214;5635.295058371922;5671.829845104653;5699.344575373885;5793.623414478046;5803.8549036274435;5813.854653633693;5814.360420353673;5815.651060936358;5388.575141186403;5649.604527683023;5656.660600363992;5656.88686226265;5666.15007748841;5596.720163991703;5823.417658234142;5841.561882858888;5844.094165404369;5858.970705146447;5617.775288988558;5644.9435505644415;5648.5481161507805;5680.318361796611;5708.686022268649 17:15:33 INFO - PROCESS | 14757 | |5;yui.html;690.2407351912894;768.4697558684508;785.8271180340323;791.1613689489142;826.9090400055993;11826.704332391695;12196.207246528991;12196.878031219707;12204.023678105752;12208.877911220885;11217.943910280457;11237.775244495126;11271.26736762112;11313.717157071056;11335.943320283408;641.791417789218;775.7246177606953;788.8067423481241;801.9037715474151;810.1695761844098;792.0890975378333;797.7885860247039;798.2177466083242;799.6721344248859;799.9560024198666;838.5010918503481;841.1840514700731;843.5950743643054;853.3940901959617;857.438377862498;845.1590667286059;845.5011543189516;849.9702510412168;849.9842687987857;851.7529916324258;621.580433207583;624.4380057947837;624.4536030972898;626.2516293029831;628.0234235763386;10678.1991350649;10727.570897164103;10841.891581084166;10880.12958963281;10900.563977440894;12937.288449135294;13111.803322950163;13189.142705724098;13229.536966206233;13298.40157192919;10091.142252908512;10124.645637402655;10236.692899213036;10328.741781455448;10441.112505437048;3349.095744149066;3380.6281309055985;3427.640097789721;3436.329915666446;3437.724982001434;41808.79095604503;42485.36271955892;42616.78691606522;42729.57270427287;42781;9792.706218813448;10066.798664026679;10256.692299231036;10312.071913527818;10579.894201058045;16308.67382652364;16519.752203716955;16615.6676866462;16622.33510659584;16647.33410663584;5147.897042059138;5176.922346164811;5181.896362072737;5220.190870415092;5924.407559244041;3827.2919509890758;3846.211526637033;3870.574236833946;3946.723729338919;3978.1645854370327;2881.5101432756064;2947.557866320069;2956.6156399667907;2965.777566682464;2979.687132851019;520.7579921886253;521.6687403498805;528.0521463972102;531.1289485244203;541.3720084701727;595.681310498881;606.4905479397328;624.8188025472562;630.5995692735055;658.4469046001286;7673.616319184019;7730.381569474429;7756.762515422788;7810.57041862703;7812.140664526897;631.5831551176202;637.8660481298979;645.4836131095105;652.885744994624;653.8463461086641;3741.494898188764;3765.642263984917;3812.1613245086037;3812.618738126165;3831.63599458051;49491.50508494941;49911.50088499141;50490.74754626277;50496.49503504918;50758;43187;44164.337534937;44216;44393;44461.77769111199;38607.61392386096;39214.803925980756;40461;40611.796941015105;41874.534391296766;7115.395191408788;7323.377512911462;7345.963270183614;7404;7495.512791668524;25831.225063248134;26472.338191545365;26602;27012;27030.729692703608;32710;34336.11151386698;34589.65410345864;35163.64836351604;35325.470117947734;9252.629894804133;9382.15560599522;9383.906160938302;9484.146426821619;10905.83641245366;12030.939845301067;12168.391580420766;12178.330191839534;12274.938625306817;12277.938610306892;10767.3539587625;10903.563857445613;11274.60538881168;11296.943515282372;11360.204785664924;11221.943890280496;11230.270032447865;11301.26541774782;11402.771944561227;11720;10403;10465.633702820365;10498.685039448828;10637.787244254916;10875.07561857251;9417.1935574911;9430.52847357643;9462;9545.713628591153;9872.802543949225;9596.280278979244;9864;9910.207183425164;9946.602135914773;9949.552270148006 17:15:33 INFO - PROCESS | 14757 | __end_tp_report 17:15:33 INFO - PROCESS | 14757 | __start_cc_report 17:15:33 INFO - PROCESS | 14757 | _x_x_mozilla_cycle_collect,382 17:15:33 INFO - PROCESS | 14757 | __end_cc_report 17:15:33 INFO - PROCESS | 14757 | __startTimestamp1460679333091__endTimestamp 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | ------- Summary: start ------- 17:15:33 INFO - PROCESS | 14757 | Number of tests: 6 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | [#0] dojo.html Cycles:165 Average:4726.68 Median:4881.07 stddev:606.71 (12.4%) stddev-sans-first:586.20 17:15:33 INFO - PROCESS | 14757 | Values: 2646.1 2729.3 2730.7 2760.7 2767.3 4754.8 4778.2 4794.0 4795.8 4827.1 4636.4 4713.2 4720.6 4721.6 4726.0 4354.0 4413.7 4434.2 4436.5 4489.3 4403.4 4426.6 4447.6 4459.1 4507.6 224.5 4364.3 4408.7 4423.6 4470.9 4410.2 4431.6 4434.6 4437.8 4469.4 4442.8 4448.0 4455.1 4481.2 4496.6 4553.1 4607.1 4702.5 4707.3 4772.1 5138.7 5153.4 5163.1 5180.6 5197.1 5186.7 5203.7 5209.9 5210.0 5213.8 4709.0 4709.3 4772.6 4778.7 4813.3 5239.3 5255.1 5272.2 5317.5 5343.0 4900.1 5091.3 5095.6 5096.1 5099.7 5149.0 5175.0 5193.3 5229.2 5240.2 5138.9 5169.0 5180.4 5182.6 5231.0 4955.9 5048.5 5158.2 5168.4 5184.2 4301.8 4302.6 4323.3 4327.5 4361.6 3790.7 3794.9 3803.8 3818.8 3835.4 4333.3 4490.0 4511.0 4527.8 4569.2 5149.3 5156.3 5172.6 5173.7 5225.7 4466.0 4470.5 4508.3 4509.4 4553.2 4533.7 4600.6 4623.2 4652.0 4661.9 4826.4 4852.0 4891.2 4914.4 4937.7 5176.9 5183.8 5188.9 5190.3 5203.3 4772.4 4804.3 4892.1 4894.8 4898.0 5071.3 5077.2 5094.8 5095.1 5122.0 5155.5 5160.1 5161.1 5165.3 5186.9 4799.2 4881.1 4895.1 4951.8 5015.5 4920.8 4925.7 4950.0 4983.3 4987.0 4875.1 4908.6 4912.3 4913.5 4951.4 4914.3 4997.0 5013.8 5057.7 5060.6 4855.2 4907.8 4918.0 4921.7 4953.4 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | [#1] ext.html Cycles:180 Average:42967.48 Median:18698.31 stddev:77030.82 (412.0%) stddev-sans-first:77181.17 17:15:33 INFO - PROCESS | 14757 | Values: 579.5 590.5 610.7 611.0 649.3 31526.4 32932.7 32953.2 32955.0 33014.5 34100.0 34269.0 34421.1 34478.8 34648.5 7444.6 7679.8 7702.2 7711.5 7724.3 7590.1 7713.3 7787.2 7811.5 7815.4 7716.8 7821.7 7841.1 7861.6 7873.8 7743.0 7805.8 7808.7 7813.5 7827.5 7583.9 7723.1 7732.3 7743.9 7753.8 28660.3 33988.0 34314.7 34551.8 34582.0 2977.3 2989.4 3000.7 3040.1 3420.5 25544.6 25862.7 25882.5 26144.9 26172.1 3368.8 3408.6 3439.9 3444.7 3537.8 182878.0 183744.0 184497.0 185353.1 185424.0 30771.4 30825.0 30867.5 30988.4 31052.0 26889.5 27263.7 58192.1 60214.4 60249.0 14298.9 14581.5 14588.6 14599.8 14600.1 11271.5 11477.0 11496.1 11523.8 11535.5 17696.2 17720.6 18139.2 18385.1 18463.3 6892.0 6995.3 7018.5 7198.0 7228.6 857.5 936.5 949.7 1054.9 1057.5 28293.7 28798.9 28808.0 28985.4 29016.4 1002.7 1025.7 1048.3 1051.3 1099.4 14776.2 15112.2 15179.5 15374.0 15439.4 341863.0 346772.0 347825.0 349567.0 349574.0 47129.8 47619.3 47650.3 47748.8 47782.0 1230.7 1231.7 1235.0 1236.6 1242.0 25688.7 27675.9 27827.9 27915.4 28323.3 41231.0 41730.4 42150.0 42325.8 42406.6 318610.0 318858.0 320161.0 320743.0 320903.0 24912.1 24976.5 25295.6 25306.5 25359.4 40456.4 40504.8 40682.2 40855.8 40901.4 35218.5 35848.8 35989.6 36266.8 36340.6 34782.0 34911.6 35256.0 35573.3 35810.1 34957.3 35038.6 35273.3 36004.6 36017.5 31616.7 32726.0 32787.7 32942.7 33085.5 25045.6 25067.0 25514.0 25584.5 25892.6 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | [#2] jquery.html Cycles:180 Average:24180.40 Median:24241.31 stddev:65849.41 (271.6%) stddev-sans-first:66009.86 17:15:33 INFO - PROCESS | 14757 | Values: 369.7 379.2 384.3 387.6 388.9 16086.6 17272.3 18121.9 18312.4 18333.2 16222.8 16869.6 16981.2 17064.1 17295.9 4567.8 4825.7 4826.2 4859.6 4860.0 3510.8 5184.6 5431.7 5490.8 5495.8 5451.5 5455.4 5470.6 5482.4 5483.8 5184.3 5529.1 5532.3 5536.7 5541.6 5017.9 5272.2 5298.1 5316.1 5346.9 12464.7 12649.2 12767.4 12779.4 12789.3 1832.7 1939.8 2119.9 2167.7 2281.9 9268.3 9344.0 9692.7 9856.9 13057.3 1512.8 1643.9 1719.1 1788.7 1802.7 67529.0 70514.6 71982.6 72965.0 73243.6 9954.6 10095.5 10098.4 10167.1 10292.2 13607.7 13651.7 13683.5 13712.2 13765.0 7098.6 7299.7 7342.9 7402.9 7422.3 6898.5 6950.1 7043.2 7066.8 7095.7 4158.2 4229.7 4268.6 4349.3 4356.5 1672.4 1675.6 1707.4 1788.2 1858.5 910.6 911.0 916.4 945.9 987.2 15667.5 15858.6 16020.6 16455.9 16729.7 903.5 933.4 962.3 964.8 1002.3 9209.3 9334.4 9358.8 9530.2 9592.6 387424.0 396859.0 400605.0 403377.0 407220.0 72801.0 74033.3 75155.6 75884.2 77117.6 957.8 970.1 974.5 979.6 984.9 14720.9 14811.3 15005.8 15024.7 15544.2 25204.1 34019.5 35311.5 35400.5 35684.0 43914.8 49971.8 49998.5 52276.2 52422.2 7474.6 7669.6 7696.2 7833.2 8046.9 8795.2 10948.6 10993.4 11612.1 11762.6 10349.8 10352.4 10442.5 10647.0 10775.2 8375.6 10552.3 10640.9 10695.3 10772.2 10404.4 10790.8 10859.1 11018.7 11030.1 7649.2 7815.0 7850.2 7917.5 7991.7 8876.1 8876.8 9114.2 9148.7 9976.7 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | [#3] mootools.html Cycles:180 Average:5230.59 Median:4963.12 stddev:2858.52 (57.6%) stddev-sans-first:2852.58 17:15:33 INFO - PROCESS | 14757 | Values: 1470.9 1474.7 1641.3 1774.5 1788.1 6943.5 7690.3 7728.9 7975.1 7990.4 7743.6 7829.0 7833.9 7908.4 7915.7 2171.7 2213.5 2219.6 2221.5 2221.8 2159.7 2181.0 2187.5 2188.2 2198.1 2177.5 2188.9 2191.1 2203.2 2212.9 2168.9 2183.4 2187.5 2192.3 2197.6 2171.9 2175.5 2181.7 2186.5 2191.1 7933.4 7944.0 7966.5 7982.8 7991.8 4525.1 4644.1 4648.5 4663.6 4672.2 2878.6 3013.3 3031.3 3042.1 3050.3 1031.4 1044.8 1049.2 1067.4 1076.8 10402.7 10534.1 10629.5 10649.9 10672.5 4171.2 4193.5 4327.4 4377.6 4382.1 9107.5 9162.0 9184.4 9199.7 9211.7 4604.2 4643.1 4646.4 4650.5 4651.9 3769.8 4155.7 4190.6 4197.8 4318.5 3693.9 3722.1 3764.4 3806.8 3807.2 1218.1 1226.9 1243.2 1253.8 1254.5 786.4 856.0 897.9 928.8 929.1 5453.6 5562.9 5578.3 5610.1 5780.5 938.8 947.7 975.6 1019.1 1032.4 3787.7 3922.8 3925.1 3948.8 3991.1 9532.1 9821.0 9900.7 9991.3 10003.9 9740.9 9810.8 9810.8 9892.5 9901.2 6994.0 7308.3 7392.6 7471.7 7547.8 5478.6 5526.8 5573.7 5630.8 5694.3 8464.7 8501.1 8516.0 8544.0 8601.9 8538.2 8999.7 9049.7 9052.0 9109.5 6063.5 6688.9 6783.3 6801.0 7008.3 7474.6 7524.8 7530.4 7546.7 7608.2 6501.2 6695.1 6705.5 6709.4 6836.6 6791.9 6819.0 6970.5 7044.9 7056.5 6569.1 6584.7 6595.3 6660.9 6679.1 4871.6 4917.3 4937.5 4957.8 4974.2 4756.1 4941.5 4948.1 4948.8 4968.4 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | [#4] prototype.html Cycles:180 Average:4720.88 Median:5336.57 stddev:1381.43 (25.9%) stddev-sans-first:1345.20 17:15:33 INFO - PROCESS | 14757 | Values: 318.0 319.2 322.1 323.0 326.9 5321.4 5328.4 5402.4 5412.6 5426.6 5326.7 5331.5 5341.6 5350.3 5361.3 3943.3 4003.3 4130.4 4166.5 4183.1 4164.2 4174.2 4182.7 4184.9 4186.4 4133.8 4134.0 4158.5 4165.7 4176.8 4070.6 4149.8 4158.1 4169.5 4179.2 3661.2 3672.4 3680.1 3689.6 3689.9 5141.5 5146.9 5157.7 5166.7 5174.8 4761.4 4802.9 4849.0 4854.1 4862.1 5670.6 5682.9 5698.7 5712.6 5714.3 4060.7 4063.8 4064.9 4066.2 4076.7 5721.9 5904.1 5928.5 5931.3 5986.6 4148.5 4158.3 4164.6 4166.3 4171.6 4223.4 4228.4 4235.2 4239.7 4240.3 4681.4 4749.5 4763.2 4767.9 4774.4 5663.4 5664.4 5678.6 5685.1 5688.4 1455.2 1459.6 1470.8 1471.0 1485.3 943.9 977.4 994.6 1005.2 1031.7 4972.3 4997.6 5000.4 5008.5 5011.0 5857.7 5868.3 5878.9 5883.2 5912.9 4887.3 4984.2 4992.9 5018.9 5032.6 3115.3 3146.5 3151.8 3154.8 3166.5 5468.2 5482.7 5487.3 5496.2 5510.4 5804.6 5954.1 5977.2 5978.5 6004.5 5423.4 5457.2 5462.9 5468.8 5496.6 5669.7 5871.9 5881.0 5887.6 6024.6 5781.7 5826.9 5854.4 5866.6 5869.8 5561.1 5578.4 5588.8 5613.9 5638.2 4000.0 4059.7 4106.6 4115.2 4121.6 5930.8 5969.6 5975.6 5977.4 5991.7 5539.6 5602.9 5635.3 5671.8 5699.3 5793.6 5803.9 5813.9 5814.4 5815.7 5388.6 5649.6 5656.7 5656.9 5666.2 5596.7 5823.4 5841.6 5844.1 5859.0 5617.8 5644.9 5648.5 5680.3 5708.7 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - PROCESS | 14757 | [#5] yui.html Cycles:180 Average:12154.67 Median:42179.95 stddev:13474.58 (31.9%) stddev-sans-first:13484.88 17:15:33 INFO - PROCESS | 14757 | Values: 690.2 768.5 785.8 791.2 826.9 11826.7 12196.2 12196.9 12204.0 12208.9 11217.9 11237.8 11271.3 11313.7 11335.9 641.8 775.7 788.8 801.9 810.2 792.1 797.8 798.2 799.7 800.0 838.5 841.2 843.6 853.4 857.4 845.2 845.5 850.0 850.0 851.8 621.6 624.4 624.5 626.3 628.0 10678.2 10727.6 10841.9 10880.1 10900.6 12937.3 13111.8 13189.1 13229.5 13298.4 10091.1 10124.6 10236.7 10328.7 10441.1 3349.1 3380.6 3427.6 3436.3 3437.7 41808.8 42485.4 42616.8 42729.6 42781.0 9792.7 10066.8 10256.7 10312.1 10579.9 16308.7 16519.8 16615.7 16622.3 16647.3 5147.9 5176.9 5181.9 5220.2 5924.4 3827.3 3846.2 3870.6 3946.7 3978.2 2881.5 2947.6 2956.6 2965.8 2979.7 520.8 521.7 528.1 531.1 541.4 595.7 606.5 624.8 630.6 658.4 7673.6 7730.4 7756.8 7810.6 7812.1 631.6 637.9 645.5 652.9 653.8 3741.5 3765.6 3812.2 3812.6 3831.6 49491.5 49911.5 50490.7 50496.5 50758.0 43187.0 44164.3 44216.0 44393.0 44461.8 38607.6 39214.8 40461.0 40611.8 41874.5 7115.4 7323.4 7346.0 7404.0 7495.5 25831.2 26472.3 26602.0 27012.0 27030.7 32710.0 34336.1 34589.7 35163.6 35325.5 9252.6 9382.2 9383.9 9484.1 10905.8 12030.9 12168.4 12178.3 12274.9 12277.9 10767.4 10903.6 11274.6 11296.9 11360.2 11221.9 11230.3 11301.3 11402.8 11720.0 10403.0 10465.6 10498.7 10637.8 10875.1 9417.2 9430.5 9462.0 9545.7 9872.8 9596.3 9864.0 9910.2 9946.6 9949.6 17:15:33 INFO - PROCESS | 14757 | -------- Summary: end -------- 17:15:33 INFO - PROCESS | 14757 | 17:15:33 INFO - TEST-INFO | 14757: exit 0 17:15:33 INFO - TEST-OK | dromaeo_css | took 1114789ms 17:15:33 INFO - TEST-START | kraken 17:15:33 INFO - operating with platform_type : linux_ 17:15:33 INFO - Initialising browser for kraken test... 17:15:33 INFO - TEST-INFO | started process 14983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnfYkdF/profile http://localhost:49141/getInfo.html) 17:15:37 INFO - PROCESS | 14983 | 17:15:37 INFO - PROCESS | 14983 | (process:15052): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:38 INFO - PROCESS | 14983 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 17:15:38 INFO - PROCESS | 14983 | __metrics Screen width/height:1600/1200 17:15:38 INFO - PROCESS | 14983 | colorDepth:24 17:15:38 INFO - PROCESS | 14983 | Browser inner width/height: 1024/697 17:15:38 INFO - PROCESS | 14983 | __metrics 17:15:39 ERROR - PROCESS | 14983 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:15:40 INFO - TEST-INFO | 14983: exit 0 17:15:40 INFO - Browser initialized. 17:15:40 INFO - Running cycle 1/1 for kraken test... 17:15:40 INFO - TEST-INFO | started process 15104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnfYkdF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:42 INFO - PROCESS | 15104 | 17:15:42 INFO - PROCESS | 15104 | (process:15163): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:52 INFO - PROCESS | 15104 | RSS: Main: 164331520 17:15:52 INFO - PROCESS | 15104 | 17:15:54 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49141/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:55 INFO - PROCESS | 15104 | RSS: Main: 168759296 17:15:55 INFO - PROCESS | 15104 | 17:15:58 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49141/tests/kraken/driver.html?testName=audio-dft) 17:15:59 INFO - PROCESS | 15104 | RSS: Main: 171900928 17:15:59 INFO - PROCESS | 15104 | 17:16:02 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49141/tests/kraken/driver.html?testName=audio-fft) 17:16:02 INFO - PROCESS | 15104 | RSS: Main: 162971648 17:16:02 INFO - PROCESS | 15104 | 17:16:04 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49141/tests/kraken/driver.html?testName=audio-oscillator) 17:16:05 INFO - PROCESS | 15104 | RSS: Main: 163270656 17:16:05 INFO - PROCESS | 15104 | 17:16:07 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:08 INFO - PROCESS | 15104 | RSS: Main: 163479552 17:16:08 INFO - PROCESS | 15104 | 17:16:11 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49141/tests/kraken/driver.html?testName=imaging-darkroom) 17:16:12 INFO - PROCESS | 15104 | RSS: Main: 163979264 17:16:12 INFO - PROCESS | 15104 | 17:16:15 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49141/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:16 INFO - PROCESS | 15104 | RSS: Main: 163405824 17:16:16 INFO - PROCESS | 15104 | 17:16:19 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49141/tests/kraken/driver.html?testName=json-parse-financial) 17:16:19 INFO - PROCESS | 15104 | RSS: Main: 164950016 17:16:19 INFO - PROCESS | 15104 | 17:16:21 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:22 INFO - PROCESS | 15104 | RSS: Main: 165482496 17:16:22 INFO - PROCESS | 15104 | 17:16:24 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:24 INFO - PROCESS | 15104 | RSS: Main: 165507072 17:16:24 INFO - PROCESS | 15104 | 17:16:27 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:27 INFO - PROCESS | 15104 | RSS: Main: 165224448 17:16:27 INFO - PROCESS | 15104 | 17:16:30 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:31 INFO - PROCESS | 15104 | RSS: Main: 165720064 17:16:31 INFO - PROCESS | 15104 | 17:16:34 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:34 INFO - PROCESS | 15104 | RSS: Main: 165670912 17:16:34 INFO - PROCESS | 15104 | 17:16:36 INFO - PROCESS | 15104 | Cycle 1(1): loaded http://localhost:49141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49141/tests/kraken/driver.html?testName=ai-astar) 17:16:37 INFO - PROCESS | 15104 | RSS: Main: 166879232 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | __start_tp_report 17:16:37 INFO - PROCESS | 15104 | _x_x_mozilla_page_load 17:16:37 INFO - PROCESS | 15104 | _x_x_mozilla_page_load_details 17:16:37 INFO - PROCESS | 15104 | |i|pagename|runs| 17:16:37 INFO - PROCESS | 15104 | |0;ai-astar;113;108;112;114;114;124;113;113;112;112 17:16:37 INFO - PROCESS | 15104 | |1;audio-beat-detection;167;134;160;186;137;158;160;135;180;141 17:16:37 INFO - PROCESS | 15104 | |2;audio-dft;163;165;162;168;174;163;165;163;167;165 17:16:37 INFO - PROCESS | 15104 | |3;audio-fft;76;77;73;155;74;74;79;74;151;75 17:16:37 INFO - PROCESS | 15104 | |4;audio-oscillator;93;94;145;95;94;95;132;94;94;135 17:16:37 INFO - PROCESS | 15104 | |5;imaging-gaussian-blur;117;117;118;118;117;117;119;119;117;117 17:16:37 INFO - PROCESS | 15104 | |6;imaging-darkroom;148;146;146;147;147;147;147;147;147;146 17:16:37 INFO - PROCESS | 15104 | |7;imaging-desaturate;95;96;96;96;95;95;96;97;95;96 17:16:37 INFO - PROCESS | 15104 | |8;json-parse-financial;67;67;67;66;66;66;68;84;75;65 17:16:37 INFO - PROCESS | 15104 | |9;json-stringify-tinderbox;65;65;66;68;66;65;67;65;66;65 17:16:37 INFO - PROCESS | 15104 | |10;stanford-crypto-aes;83;85;89;86;87;86;87;85;86;85 17:16:37 INFO - PROCESS | 15104 | |11;stanford-crypto-ccm;145;137;147;141;137;148;146;146;230;136 17:16:37 INFO - PROCESS | 15104 | |12;stanford-crypto-pbkdf2;177;177;178;181;175;174;175;189;175;173 17:16:37 INFO - PROCESS | 15104 | |13;stanford-crypto-sha256-iterative;74;76;72;73;72;73;73;79;79;75 17:16:37 INFO - PROCESS | 15104 | __end_tp_report 17:16:37 INFO - PROCESS | 15104 | __start_cc_report 17:16:37 INFO - PROCESS | 15104 | _x_x_mozilla_cycle_collect,931 17:16:37 INFO - PROCESS | 15104 | __end_cc_report 17:16:37 INFO - PROCESS | 15104 | __startTimestamp1460679397008__endTimestamp 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | ------- Summary: start ------- 17:16:37 INFO - PROCESS | 15104 | Number of tests: 14 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.06 (3.6%) stddev-sans-first:4.30 17:16:37 INFO - PROCESS | 15104 | Values: 113.0 108.0 112.0 114.0 114.0 124.0 113.0 113.0 112.0 112.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:160.00 stddev:18.69 (11.7%) stddev-sans-first:19.38 17:16:37 INFO - PROCESS | 15104 | Values: 167.0 134.0 160.0 186.0 137.0 158.0 160.0 135.0 180.0 141.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:3.54 (2.1%) stddev-sans-first:3.63 17:16:37 INFO - PROCESS | 15104 | Values: 163.0 165.0 162.0 168.0 174.0 163.0 165.0 163.0 167.0 165.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#3] audio-fft Cycles:10 Average:90.80 Median:74.50 stddev:32.84 (44.1%) stddev-sans-first:34.40 17:16:37 INFO - PROCESS | 15104 | Values: 76.0 77.0 73.0 155.0 74.0 74.0 79.0 74.0 151.0 75.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:21.12 (22.5%) stddev-sans-first:21.77 17:16:37 INFO - PROCESS | 15104 | Values: 93.0 94.0 145.0 95.0 94.0 95.0 132.0 94.0 94.0 135.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 17:16:37 INFO - PROCESS | 15104 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 119.0 119.0 117.0 117.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 17:16:37 INFO - PROCESS | 15104 | Values: 148.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 17:16:37 INFO - PROCESS | 15104 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 97.0 95.0 96.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:67.00 stddev:5.93 (8.9%) stddev-sans-first:6.24 17:16:37 INFO - PROCESS | 15104 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 68.0 84.0 75.0 65.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 17:16:37 INFO - PROCESS | 15104 | Values: 65.0 65.0 66.0 68.0 66.0 65.0 67.0 65.0 66.0 65.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.60 (1.9%) stddev-sans-first:1.30 17:16:37 INFO - PROCESS | 15104 | Values: 83.0 85.0 89.0 86.0 87.0 86.0 87.0 85.0 86.0 85.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:146.00 stddev:28.02 (19.2%) stddev-sans-first:29.63 17:16:37 INFO - PROCESS | 15104 | Values: 145.0 137.0 147.0 141.0 137.0 148.0 146.0 146.0 230.0 136.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:177.00 stddev:4.67 (2.6%) stddev-sans-first:4.95 17:16:37 INFO - PROCESS | 15104 | Values: 177.0 177.0 178.0 181.0 175.0 174.0 175.0 189.0 175.0 173.0 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - PROCESS | 15104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.50 stddev:2.63 (3.5%) stddev-sans-first:2.78 17:16:37 INFO - PROCESS | 15104 | Values: 74.0 76.0 72.0 73.0 72.0 73.0 73.0 79.0 79.0 75.0 17:16:37 INFO - PROCESS | 15104 | -------- Summary: end -------- 17:16:37 INFO - PROCESS | 15104 | 17:16:37 INFO - TEST-INFO | 15104: exit 0 17:16:37 INFO - TEST-OK | kraken | took 64082ms 17:16:37 INFO - SUITE-END | took 1178s 17:16:38 INFO - Completed test suite (00:19:39) 17:16:38 INFO - javascript benchmark 17:16:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.07387414405, 2729.3176705823544, 2730.7405796449357, 2760.654918135233, 2767.2528417327308, 4754.8335808246675, 4778.235482322829, 4793.952060479394, 4795.808167673289, 4827.082854257688, 4636.420447444069, 4713.198756211444, 4720.5515476029805, 4721.575058244757, 4725.976370118145, 4354.042110735633, 4413.6910416270875, 4434.201843668138, 4436.489803672586, 4489.304157855538, 4403.427554417921, 4426.579474949875, 4447.599716025557, 4459.10817836434, 4507.616852567536, 224.48567340208197, 4364.258076127066, 4408.669349798746, 4423.646108311327, 4470.865874023768, 4410.2282100632265, 4431.5789999950275, 4434.623057040156, 4437.755923424211, 4469.396631454777, 4442.822287108512, 4447.977760111211, 4455.10897820434, 4481.215787237221, 4496.640268778523, 4553.066621342617, 4607.10161518504, 4702.459217190033, 4707.270373092176, 4772.117158325721, 5138.74306284688, 5153.407358153823, 5163.122269214205, 5180.585553155738, 5197.064528384889, 5186.7147306898105, 5203.661761985497, 5209.947900520984, 5209.973950130225, 5213.791448342062, 4708.976455117702, 4709.293605959099, 4772.6420518461255, 4778.665493415428, 4813.302071199656, 5239.345081864691, 5255.054090263713, 5272.182811664198, 5317.521423071942, 5342.973285133549, 4900.142475066849, 5091.261767043758, 5095.566876815438, 5096.057229412497, 5099.69401835891, 5149.0, 5174.97412512935, 5193.272941788153, 5229.189475631283, 5240.240165176105, 5138.948610513847, 5169.043726910459, 5180.404253510819, 5182.637215394886, 5231.032259032091, 4955.851324460272, 5048.545630893163, 5158.200478925697, 5168.3539557555305, 5184.196449550326, 4301.763403012802, 4302.634276086505, 4323.329883868006, 4327.459067616548, 4361.5856493633055, 3790.6967442604528, 3794.886153415402, 3803.8098095095133, 3818.809059547067, 3835.386338185877, 4333.263345231318, 4489.9775501122285, 4510.954890451119, 4527.818887244473, 4569.223232050559, 5149.330587023663, 5156.303898973591, 5172.612054095958, 5173.715445650525, 5225.738713064332, 4465.977670111629, 4470.463544374631, 4508.32375143731, 4509.368688383629, 4553.203189441901, 4533.727976321431, 4600.585947264763, 4623.214053610895, 4651.976740116345, 4661.906761864811, 4826.372571565744, 4852.0, 4891.217405215149, 4914.410270767459, 4937.703737775745, 5176.948230517797, 5183.844484665466, 5188.870278242923, 5190.325257716473, 5203.323567936144, 4772.379590653193, 4804.303376010529, 4892.119418504561, 4894.755262236945, 4897.975510122426, 5071.290019397214, 5077.238414237894, 5094.7707353169935, 5095.082885080721, 5121.975604879113, 5155.53600175986, 5160.122779127632, 5161.122609156378, 5165.328507294028, 5186.948130518646, 4799.1601469743355, 4881.072596206709, 4895.118878601886, 4951.777170027285, 5015.498450154955, 4920.778564964514, 4925.6700690814, 4950.0, 4983.302337672656, 4986.975065124651, 4875.07373599015, 4908.582770464408, 4912.336834527436, 4913.484084171254, 4951.3810773653295, 4914.287428322802, 4996.950030499648, 5013.849584512471, 5057.671251368649, 5060.595152387874, 4855.150348688895, 4907.803687852589, 4917.950820491749, 4921.655484116078, 4953.430355509163], "value": 4691.0642336761875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5103137848516, 590.4597293476469, 610.7190692281551, 610.9694515274235, 649.334432206988, 31526.369472610535, 32932.67067329326, 32953.17617059575, 32955.0, 33014.50478242822, 34100.0, 34269.0, 34421.13947151323, 34478.827605861996, 34648.48027279587, 7444.553326800409, 7679.769606911774, 7702.229777022309, 7711.537307761524, 7724.343430808388, 7590.051243594551, 7713.305802477776, 7787.182345853689, 7811.4922530035365, 7815.413843961697, 7716.845663086735, 7821.726239581616, 7841.059072911258, 7861.567613781268, 7873.803154921145, 7743.0, 7805.843883122334, 7808.687652493893, 7813.492123012043, 7827.452078354518, 7583.924160758377, 7723.073231212291, 7732.3040926316335, 7743.922560774433, 7753.767386978399, 28660.283492912637, 33988.0, 34314.6568534314, 34551.82724086389, 34582.0, 2977.270568710658, 2989.446952313829, 3000.729934305923, 3040.057582149541, 3420.521127042191, 25544.616830747367, 25862.74137258622, 25882.482350352886, 26144.86927565369, 26172.0839770609, 3368.831558422069, 3408.625051244361, 3439.9312013759586, 3444.7071998880124, 3537.7700449470703, 182878.0, 183744.0, 184497.0, 185353.0732346343, 185424.0, 30771.384572308427, 30825.0, 30867.536986945215, 30988.380232395677, 31052.0, 26889.462210755675, 27263.727362726517, 58192.12711809326, 60214.39785602176, 60249.0, 14298.85701142996, 14581.489647862274, 14588.635284117981, 14599.78100328496, 14600.12399256048, 11271.492782824793, 11477.0, 11496.137789665809, 11523.769524609628, 11535.538578456768, 17696.203670834842, 17720.556986075193, 18139.18373673188, 18385.08074596265, 18463.261469541067, 6891.965540172267, 6995.265497122728, 7018.473614478832, 7197.964010179916, 7228.638568071576, 857.5326447086353, 936.4521754773534, 949.6771097826772, 1054.8839627640953, 1057.5082586597268, 28293.71706282952, 28798.856005720256, 28808.0, 28985.42029159405, 29016.41967160645, 1002.7292630989592, 1025.7230547752065, 1048.250500891866, 1051.3271506236015, 1099.3513826842202, 14776.187309697854, 15112.168830714416, 15179.468718594797, 15374.0, 15439.382424702886, 341863.0, 346772.0, 347825.0, 349567.0, 349574.0, 47129.764351178026, 47619.285710714365, 47650.285245721345, 47748.76125619419, 47782.0, 1230.7107829660022, 1231.6982339326921, 1235.0490122605543, 1236.5548402574886, 1241.975160496803, 25688.743112568634, 27675.86162069177, 27827.860860695568, 27915.441691165655, 28323.291917702223, 41231.0, 41730.37404438875, 42149.99999999877, 42325.78837105795, 42406.57593424026, 318610.0, 318858.0, 320161.0, 320743.0, 320903.0, 24912.12807551727, 24976.500469990136, 25295.596918292733, 25306.493870122125, 25359.36601584975, 40456.39315410212, 40504.797476012434, 40682.18635627212, 40855.795721021204, 40901.38647920224, 35218.47172292469, 35848.82075589606, 35989.64010359863, 36266.8186659065, 36340.636593633724, 34782.0, 34911.60353585828, 35256.0, 35573.28853422969, 35810.10474738153, 34957.30085398227, 35038.64961350354, 35273.29453410866, 36004.639953600126, 36017.459738103425, 31616.683833161373, 32726.0, 32787.672123279415, 32942.67057329492, 33085.50371744474, 25045.624315634916, 25067.0, 25514.0, 25584.48831023332, 25892.61161082623], "value": 16787.60892221985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.6839202481878, 379.1828609346855, 384.3178358413815, 387.56399051067547, 388.91055057336814, 16086.597835054115, 17272.309107635694, 18121.90939045303, 18312.359067432626, 18333.17500712468, 16222.83777162228, 16869.578260543494, 16981.235844387, 17064.14679266038, 17295.913520432412, 4567.840125595597, 4825.74530622039, 4826.17954947658, 4859.611231101521, 4859.975700121512, 3510.7717998330154, 5184.637075404723, 5431.701256430894, 5490.780368785264, 5495.807646732365, 5451.48210919962, 5455.427180146087, 5470.56235501159, 5482.396936337, 5483.835484935458, 5184.326037615105, 5529.142982837667, 5532.30846144232, 5536.667799931997, 5541.612087153901, 5017.89964200714, 5272.156454967187, 5298.125809241471, 5316.12283973144, 5346.893062138735, 12464.688382790411, 12649.177803442746, 12767.42546585406, 12779.424925878358, 12789.296588687619, 1832.7067669172868, 1939.8157175068345, 2119.872807631547, 2167.6965224868372, 2281.9388984122297, 9268.258539316907, 9344.0, 9692.660756873545, 9856.901430985741, 13057.281849498273, 1512.7730840373922, 1643.8602718768918, 1719.1091345123104, 1788.6780379531679, 1802.6665066962653, 67529.0, 70514.64742676305, 71982.64008679976, 72965.0, 73243.63378183075, 9954.601815927283, 10095.545700443497, 10098.394096354243, 10167.084962353423, 10292.228082893813, 13607.727845443234, 13651.658708532366, 13683.521076762265, 13712.245826479639, 13765.036447448583, 7098.574085554883, 7299.70801167958, 7342.853142937111, 7402.888956665654, 7422.257774222642, 6898.482613803984, 6950.096487456598, 7043.225245223021, 7066.752663656747, 7095.716171353088, 4158.2307273154565, 4229.661627069889, 4268.573142685706, 4349.3041113421705, 4356.477222733292, 1672.3645014894262, 1675.5894805772664, 1707.4450803488667, 1788.2221233763094, 1858.50749551369, 910.5583791860943, 910.9635614575343, 916.3997581584073, 945.8864936207699, 987.2398253344884, 15667.529974100795, 15858.60353491172, 16020.599485012968, 16455.917720411322, 16729.749053764204, 903.5211337990876, 933.3513208320288, 962.2542529539663, 964.7781010367655, 1002.293383164867, 9209.309301802392, 9334.39326443779, 9358.812823743487, 9530.189933855561, 9592.616295348247, 387424.0, 396859.0, 400605.0, 403377.0, 407220.0, 72801.0, 74033.25966740264, 75155.62422187853, 75884.24115758883, 77117.61441192759, 957.8275910336067, 970.0735797313548, 974.5078735238801, 979.5689896445541, 984.8522721591819, 14720.926395367955, 14811.333489992761, 15005.849941500444, 15024.699506010038, 15544.150204146834, 25204.117855874956, 34019.48970765391, 35311.470327945615, 35400.46899296461, 35684.0, 43914.78042609766, 49971.750141250515, 49998.50001500084, 52276.21585676142, 52422.21366679579, 7474.5888976106835, 7669.578173200304, 7696.191899850435, 7833.216678332121, 8046.879296810435, 8795.164459376349, 10948.616798412017, 10993.395363254778, 11612.12909031809, 11762.58830940913, 10349.84475232857, 10352.378857268286, 10442.530086146293, 10647.0, 10775.245732798629, 8375.62309696053, 10552.314099583502, 10640.946795265974, 10695.251332406657, 10772.24594278393, 10404.375737455777, 10790.838137428102, 10859.076978456604, 11018.677758669011, 11030.117590592894, 7649.235076492307, 7815.0, 7850.175731548105, 7917.485363451357, 7991.680332786624, 8876.120363304486, 8876.822463550563, 9114.225290850087, 9148.679796207367, 9976.650817221362], "value": 8099.288547057609, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.8896832737548, 1474.719803237385, 1641.2696350124193, 1774.4765294238198, 1788.088075081708, 6943.548669336489, 7690.307872291507, 7728.92271077289, 7975.082865470466, 7990.360771138309, 7743.574103424309, 7828.960855195716, 7833.882491762628, 7908.44640875139, 7915.683372665101, 2171.7068195793563, 2213.5351576169023, 2219.556088782242, 2221.511267521151, 2221.8111460525874, 2159.6976423300753, 2180.967285490719, 2187.529681118559, 2188.2013065231235, 2198.0658220256328, 2177.5318306564086, 2188.9452763680874, 2191.057845126595, 2203.1958335207614, 2212.8782916939563, 2168.9240876569324, 2183.410479170631, 2187.4859408039097, 2192.3422973108004, 2197.637389830676, 2171.880546569938, 2175.4561359660083, 2181.7054697615777, 2186.4533866533366, 2191.057845126595, 7933.365330773524, 7944.0, 7966.482178658426, 7982.760517184493, 7991.760247192536, 4525.094981003813, 4644.0944015916575, 4648.48866624671, 4663.60359369454, 4672.15901137795, 2878.553824157238, 3013.2617508710505, 3031.257341951236, 3042.1481985044225, 3050.283183451887, 1031.381171297223, 1044.7858189071221, 1049.21833234241, 1067.3702515515884, 1076.7523469601956, 10402.739931501697, 10534.051935325857, 10629.521671524722, 10649.946750266277, 10672.466376681135, 4171.249175148441, 4193.454850869368, 4327.3725309830525, 4377.627901628397, 4382.145481631115, 9107.499087550115, 9161.954190229006, 9184.357095003286, 9199.724008279762, 9211.677591284273, 4604.171249175113, 4643.094596553639, 4646.442426908792, 4650.5349465053905, 4651.9300560870515, 3769.754965927206, 4155.667546596265, 4190.643795277436, 4197.811098500575, 4318.460192475941, 3693.9445908311395, 3722.0880884183007, 3764.4353346997623, 3806.790626515513, 3807.200487897517, 1218.1290377380217, 1226.9325187114616, 1243.2043492165021, 1253.8056601226824, 1254.5044707340548, 786.4259090863587, 855.9529225892636, 897.8922529296526, 928.7817362919709, 929.1152559533822, 5453.618246722771, 5562.888742225214, 5578.274824272899, 5610.102383618601, 5780.53755699543, 938.7934654376027, 947.6777895515557, 975.6097560975667, 1019.0879163148941, 1032.3805716569998, 3787.715921305913, 3922.764634121962, 3925.0776067624083, 3948.763074215556, 3991.1020020495157, 9532.142107210384, 9821.0, 9900.702978910644, 9991.300608957303, 10003.949980250052, 9740.902590974141, 9810.754731131636, 9810.80378392428, 9892.505374731378, 9901.15840153595, 6993.965030174918, 7308.269173082649, 7392.55644661322, 7471.663775130132, 7547.849043019109, 5478.616496845182, 5526.834194974157, 5573.665580065209, 5630.774769009194, 5694.288213973254, 8464.703735369232, 8501.10738372462, 8516.020657624205, 8544.0, 8601.870971935301, 8538.231559159705, 8999.685011024583, 9049.683261086093, 9051.954740226256, 9109.544522773967, 6063.5452341073715, 6688.899666505104, 6783.321667833375, 6800.965995169992, 7008.264132266038, 7474.626268686435, 7524.849503010018, 7530.359919406912, 7546.6604002821105, 7608.201138880338, 6501.2198536175965, 6695.09616201826, 6705.530612857053, 6709.429698475684, 6836.623985680835, 6791.89812152828, 6819.0, 6970.546914450544, 7044.929550704427, 7056.470764692771, 6569.113169722217, 6584.736610535525, 6595.274519802721, 6660.866782664222, 6679.131712877295, 4871.610271178368, 4917.336159618549, 4937.530934561211, 4957.801687932442, 4974.154393752999, 4756.120117778222, 4941.481144479778, 4948.084604348063, 4948.752562371939, 4968.428630707371], "value": 4261.3866622882015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.03000847415376, 319.2179161055414, 322.14631227247804, 323.04217993648825, 326.92807582331886, 5321.445706061093, 5328.413874473809, 5402.37872644646, 5412.594055445843, 5426.565874730022, 5326.680399176043, 5331.546818520431, 5341.599380046493, 5350.30446042014, 5361.329833770778, 3943.2902077625945, 4003.27859020621, 4130.359794231884, 4166.458360413158, 4183.121544475649, 4164.1879833432495, 4174.186033723425, 4182.707210495267, 4184.916301673965, 4186.39297301891, 4133.81397837098, 4133.958660413403, 4158.521769996459, 4165.66674666026, 4176.7911604419805, 4070.5522392536795, 4149.83400663973, 4158.12679337338, 4169.45797046382, 4179.226843034048, 3661.21283923955, 3672.412414013745, 3680.1167719747336, 3689.6494832990825, 3689.8524059037604, 5141.457562731166, 5146.933922201456, 5157.664751791159, 5166.715830629314, 5174.818881339135, 4761.428628564595, 4802.927956080662, 4848.951510484921, 4854.053459575384, 4862.124817532843, 5670.63904662882, 5682.943170568283, 5698.6865722385255, 5712.6286791358425, 5714.314282286111, 4060.654844338235, 4063.817128229237, 4064.878053658395, 4066.1867626474527, 4076.6738660907354, 5721.942780572224, 5904.143899134644, 5928.49607783339, 5931.258592675916, 5986.551008674323, 4148.502179738451, 4158.293090174678, 4164.646005089541, 4166.312643379436, 4171.5828417158045, 4223.366495025771, 4228.4080228768, 4235.174141042467, 4239.682023848162, 4240.321548552279, 4681.391419115494, 4749.453812811502, 4763.237881938942, 4767.928481072787, 4774.379330686988, 5663.433656634386, 5664.433556644302, 5678.602497825195, 5685.090385538294, 5688.431156884279, 1455.2432734977751, 1459.5913144319607, 1470.801441805364, 1471.007070227592, 1485.2647939269914, 943.9339246252833, 977.4282045003753, 994.5922171909482, 1005.1857995024054, 1031.742064483879, 4972.279019542146, 4997.600191984632, 5000.449950505442, 5008.499150085036, 5010.974945125251, 5857.736401861926, 5868.2664666916635, 5878.911816322759, 5883.235179426732, 5912.940870591325, 4887.2650209175945, 4984.22744474607, 4992.90014199714, 5018.899622007612, 5032.597392208614, 3115.345777386729, 3146.5122905949156, 3151.842407879643, 3154.8422578870964, 3166.5408515765544, 5468.152436372368, 5482.737771026233, 5487.341519017744, 5496.213730537591, 5510.366307874646, 5804.622699524517, 5954.136650185699, 5977.163197152402, 5978.491828194565, 6004.54965877561, 5423.430539793265, 5457.208704737791, 5462.918056229159, 5468.808591699271, 5496.615236933456, 5669.659820410789, 5871.882562348815, 5880.970595146997, 5887.61730487517, 6024.608400453956, 5781.710914454345, 5826.854328641818, 5854.385289544536, 5866.6480011199465, 5869.765209391577, 5561.138023606348, 5578.442155784389, 5588.776448941997, 5613.943860561342, 5638.182463542681, 4000.0, 4059.6752259818554, 4106.630403263721, 4115.156392939381, 4121.649659778953, 5930.822075337746, 5969.582129250911, 5975.581709280483, 5977.402259773988, 5991.730372133352, 5539.556835453234, 5602.887942241214, 5635.295058371922, 5671.829845104653, 5699.344575373885, 5793.623414478046, 5803.8549036274435, 5813.854653633693, 5814.360420353673, 5815.651060936358, 5388.575141186403, 5649.604527683023, 5656.660600363992, 5656.88686226265, 5666.15007748841, 5596.720163991703, 5823.417658234142, 5841.561882858888, 5844.094165404369, 5858.970705146447, 5617.775288988558, 5644.9435505644415, 5648.5481161507805, 5680.318361796611, 5708.686022268649], "value": 4280.635845653435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.2407351912894, 768.4697558684508, 785.8271180340323, 791.1613689489142, 826.9090400055993, 11826.704332391695, 12196.207246528991, 12196.878031219707, 12204.023678105752, 12208.877911220885, 11217.943910280457, 11237.775244495126, 11271.26736762112, 11313.717157071056, 11335.943320283408, 641.791417789218, 775.7246177606953, 788.8067423481241, 801.9037715474151, 810.1695761844098, 792.0890975378333, 797.7885860247039, 798.2177466083242, 799.6721344248859, 799.9560024198666, 838.5010918503481, 841.1840514700731, 843.5950743643054, 853.3940901959617, 857.438377862498, 845.1590667286059, 845.5011543189516, 849.9702510412168, 849.9842687987857, 851.7529916324258, 621.580433207583, 624.4380057947837, 624.4536030972898, 626.2516293029831, 628.0234235763386, 10678.1991350649, 10727.570897164103, 10841.891581084166, 10880.12958963281, 10900.563977440894, 12937.288449135294, 13111.803322950163, 13189.142705724098, 13229.536966206233, 13298.40157192919, 10091.142252908512, 10124.645637402655, 10236.692899213036, 10328.741781455448, 10441.112505437048, 3349.095744149066, 3380.6281309055985, 3427.640097789721, 3436.329915666446, 3437.724982001434, 41808.79095604503, 42485.36271955892, 42616.78691606522, 42729.57270427287, 42781.0, 9792.706218813448, 10066.798664026679, 10256.692299231036, 10312.071913527818, 10579.894201058045, 16308.67382652364, 16519.752203716955, 16615.6676866462, 16622.33510659584, 16647.33410663584, 5147.897042059138, 5176.922346164811, 5181.896362072737, 5220.190870415092, 5924.407559244041, 3827.2919509890758, 3846.211526637033, 3870.574236833946, 3946.723729338919, 3978.1645854370327, 2881.5101432756064, 2947.557866320069, 2956.6156399667907, 2965.777566682464, 2979.687132851019, 520.7579921886253, 521.6687403498805, 528.0521463972102, 531.1289485244203, 541.3720084701727, 595.681310498881, 606.4905479397328, 624.8188025472562, 630.5995692735055, 658.4469046001286, 7673.616319184019, 7730.381569474429, 7756.762515422788, 7810.57041862703, 7812.140664526897, 631.5831551176202, 637.8660481298979, 645.4836131095105, 652.885744994624, 653.8463461086641, 3741.494898188764, 3765.642263984917, 3812.1613245086037, 3812.618738126165, 3831.63599458051, 49491.50508494941, 49911.50088499141, 50490.74754626277, 50496.49503504918, 50758.0, 43187.0, 44164.337534937, 44216.0, 44393.0, 44461.77769111199, 38607.61392386096, 39214.803925980756, 40461.0, 40611.796941015105, 41874.534391296766, 7115.395191408788, 7323.377512911462, 7345.963270183614, 7404.0, 7495.512791668524, 25831.225063248134, 26472.338191545365, 26602.0, 27012.0, 27030.729692703608, 32710.0, 34336.11151386698, 34589.65410345864, 35163.64836351604, 35325.470117947734, 9252.629894804133, 9382.15560599522, 9383.906160938302, 9484.146426821619, 10905.83641245366, 12030.939845301067, 12168.391580420766, 12178.330191839534, 12274.938625306817, 12277.938610306892, 10767.3539587625, 10903.563857445613, 11274.60538881168, 11296.943515282372, 11360.204785664924, 11221.943890280496, 11230.270032447865, 11301.26541774782, 11402.771944561227, 11720.0, 10403.0, 10465.633702820365, 10498.685039448828, 10637.787244254916, 10875.07561857251, 9417.1935574911, 9430.52847357643, 9462.0, 9545.713628591153, 9872.802543949225, 9596.280278979244, 9864.0, 9910.207183425164, 9946.602135914773, 9949.552270148006], "value": 5823.064505334269, "unit": "score"}], "name": "dromaeo_css", "value": 6384.9863106529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 114.0, 114.0, 124.0, 113.0, 113.0, 112.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 134.0, 160.0, 186.0, 137.0, 158.0, 160.0, 135.0, 180.0, 141.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 168.0, 174.0, 163.0, 165.0, 163.0, 167.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 73.0, 155.0, 74.0, 74.0, 79.0, 74.0, 151.0, 75.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 145.0, 95.0, 94.0, 95.0, 132.0, 94.0, 94.0, 135.0], "value": 107.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 119.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 68.0, 84.0, 75.0, 65.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 68.0, 66.0, 65.0, 67.0, 65.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 89.0, 86.0, 87.0, 86.0, 87.0, 85.0, 86.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 137.0, 147.0, 141.0, 137.0, 148.0, 146.0, 146.0, 230.0, 136.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 178.0, 181.0, 175.0, 174.0, 175.0, 189.0, 175.0, 173.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 72.0, 73.0, 72.0, 73.0, 73.0, 79.0, 79.0, 75.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1616.9, "alertThreshold": 2.0}]} 17:16:38 INFO - Return code: 0 17:16:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:16:38 ERROR - # TBPL SUCCESS # 17:16:38 INFO - Running post-action listener: _resource_record_post_action 17:16:38 INFO - Running post-run listener: _resource_record_post_run 17:16:39 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533639168; Read time: 12; Write time: 489292 17:16:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245436416; Read time: 0; Write time: 292684 17:16:39 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288202752; Read time: 12; Write time: 196608 17:16:39 INFO - Running post-run listener: _upload_blobber_files 17:16:39 INFO - Blob upload gear active. 17:16:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:39 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 17:16:39 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'] 17:16:39 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 17:16:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:40 INFO - (blobuploader) - INFO - Done attempting. 17:16:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:41 INFO - (blobuploader) - INFO - Done attempting. 17:16:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:41 INFO - Return code: 0 17:16:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79b66996d3f54dac17e286667bdf0ca09daab9a828d6fd680439dd0d39caf0c5d196d63131c02420a466b536dc2416bdd60c7ccccb57d76586a005986c41f35f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb9539321892bf770bf5899050a03d8523f01944fb78cd570179eb93b140b839942f6f77480f4abebc11d0ec5e907b88b23b53ec96aa164bfb49068280c21e1c"} 17:16:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:41 INFO - Contents: 17:16:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79b66996d3f54dac17e286667bdf0ca09daab9a828d6fd680439dd0d39caf0c5d196d63131c02420a466b536dc2416bdd60c7ccccb57d76586a005986c41f35f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb9539321892bf770bf5899050a03d8523f01944fb78cd570179eb93b140b839942f6f77480f4abebc11d0ec5e907b88b23b53ec96aa164bfb49068280c21e1c"} 17:16:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:41 INFO - Copying logs to upload dir... 17:16:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.320846 ========= master_lag: 16.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-14 17:16:58.168343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:16:58.171957) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967 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/79b66996d3f54dac17e286667bdf0ca09daab9a828d6fd680439dd0d39caf0c5d196d63131c02420a466b536dc2416bdd60c7ccccb57d76586a005986c41f35f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb9539321892bf770bf5899050a03d8523f01944fb78cd570179eb93b140b839942f6f77480f4abebc11d0ec5e907b88b23b53ec96aa164bfb49068280c21e1c"} build_url:https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/dhDqQ3NeRUGWj9xBG9R1mQ/artifacts/public/build/firefox-48.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/79b66996d3f54dac17e286667bdf0ca09daab9a828d6fd680439dd0d39caf0c5d196d63131c02420a466b536dc2416bdd60c7ccccb57d76586a005986c41f35f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb9539321892bf770bf5899050a03d8523f01944fb78cd570179eb93b140b839942f6f77480f4abebc11d0ec5e907b88b23b53ec96aa164bfb49068280c21e1c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:16:58.198430) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:16:58.198816) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460678163.715073-1950683967 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:16:58.249306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:16:58.249806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:16:58.250188) ========= ========= Total master_lag: 17.22 =========