builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1463060252.86 results: success (0) buildid: 20160512060851 builduid: 972a775933a04a02960ab905716bfdbb revision: 1e5b69b0387beb39a0b997938c07a6a05d4ae42a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:32.862043) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:32.862462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:32.862733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:32.893135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:32.893388) ========= 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=920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 06:37:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-05-12 06:37:33 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.029428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.029748) ========= 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=920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018808 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.081420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.081762) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e5b69b0387beb39a0b997938c07a6a05d4ae42a --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 1e5b69b0387beb39a0b997938c07a6a05d4ae42a --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=920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 06:37:33,378 truncating revision to first 12 chars 2016-05-12 06:37:33,378 Setting DEBUG logging. 2016-05-12 06:37:33,378 attempt 1/10 2016-05-12 06:37:33,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e5b69b0387b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 06:37:33,640 unpacking tar archive at: fx-team-1e5b69b0387b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.735238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.735564) ========= script_repo_revision: 1e5b69b0387beb39a0b997938c07a6a05d4ae42a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.735962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.736236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 06:37:33.744633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-12 06:37:33.744954) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:37:34 INFO - MultiFileLogger online at 20160512 06:37:34 in /builds/slave/test 06:37:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 06:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:37:34 INFO - {'append_to_log': False, 06:37:34 INFO - 'base_work_dir': '/builds/slave/test', 06:37:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:37:34 INFO - 'branch': 'Fx-Team-Non-PGO', 06:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:37:34 INFO - 'config_files': ('talos/linux_config.py',), 06:37:34 INFO - 'default_actions': ('clobber', 06:37:34 INFO - 'read-buildbot-config', 06:37:34 INFO - 'download-and-extract', 06:37:34 INFO - 'populate-webroot', 06:37:34 INFO - 'create-virtualenv', 06:37:34 INFO - 'install', 06:37:34 INFO - 'run-tests'), 06:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:37:34 INFO - 'download_minidump_stackwalk': True, 06:37:34 INFO - 'download_symbols': 'ondemand', 06:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:37:34 INFO - 'installer_path': 'installer.exe', 06:37:34 INFO - 'log_level': 'info', 06:37:34 INFO - 'log_name': 'talos', 06:37:34 INFO - 'log_to_console': True, 06:37:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:37:34 INFO - 'opt_config_files': (), 06:37:34 INFO - 'pip_index': False, 06:37:34 INFO - 'sps_profile': False, 06:37:34 INFO - 'sps_profile_interval': 0, 06:37:34 INFO - 'suite': 'dromaeojs', 06:37:34 INFO - 'system_bits': '32', 06:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:37:34 INFO - 'title': 'talos-linux64-ix-053', 06:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:37:34 INFO - 'use_talos_json': True, 06:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:37:34 INFO - 'work_dir': 'build'} 06:37:34 INFO - ##### 06:37:34 INFO - ##### Running clobber step. 06:37:34 INFO - ##### 06:37:34 INFO - Running pre-action listener: _resource_record_pre_action 06:37:34 INFO - Running main action method: clobber 06:37:34 INFO - rmtree: /builds/slave/test/build 06:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:37:34 INFO - Running post-action listener: _resource_record_post_action 06:37:34 INFO - ##### 06:37:34 INFO - ##### Finished clobber step (success) 06:37:34 INFO - ##### 06:37:34 INFO - ##### 06:37:34 INFO - ##### Running read-buildbot-config step. 06:37:34 INFO - ##### 06:37:34 INFO - Running pre-action listener: _resource_record_pre_action 06:37:34 INFO - Running main action method: read_buildbot_config 06:37:34 INFO - Using buildbot properties: 06:37:34 INFO - { 06:37:34 INFO - "project": "", 06:37:34 INFO - "product": "firefox", 06:37:34 INFO - "script_repo_revision": "production", 06:37:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:37:34 INFO - "repository": "", 06:37:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:37:34 INFO - "buildid": "20160512060851", 06:37:34 INFO - "pgo_build": "False", 06:37:34 INFO - "basedir": "/builds/slave/test", 06:37:34 INFO - "buildnumber": 1676, 06:37:34 INFO - "slavename": "talos-linux64-ix-053", 06:37:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:37:34 INFO - "platform": "ubuntu64_hw", 06:37:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:37:34 INFO - "branch": "fx-team", 06:37:34 INFO - "repo_path": "integration/fx-team", 06:37:34 INFO - "revision": "1e5b69b0387beb39a0b997938c07a6a05d4ae42a", 06:37:34 INFO - "stage_platform": "linux64", 06:37:34 INFO - "builduid": "972a775933a04a02960ab905716bfdbb", 06:37:34 INFO - "slavebuilddir": "test" 06:37:34 INFO - } 06:37:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:37:34 INFO - Running post-action listener: _resource_record_post_action 06:37:34 INFO - ##### 06:37:34 INFO - ##### Finished read-buildbot-config step (success) 06:37:34 INFO - ##### 06:37:34 INFO - ##### 06:37:34 INFO - ##### Running download-and-extract step. 06:37:34 INFO - ##### 06:37:34 INFO - Running pre-action listener: _resource_record_pre_action 06:37:34 INFO - Running main action method: download_and_extract 06:37:34 INFO - mkdir: /builds/slave/test/build/tests 06:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:34 INFO - https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:37:37 INFO - Downloaded 1361 bytes. 06:37:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:37 INFO - Using the following test package requirements: 06:37:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:37:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:37:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'jsshell-linux-x86_64.zip'], 06:37:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:37:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:37:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:37:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:37:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:37:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:37 INFO - https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:37:38 INFO - Downloaded 22329650 bytes. 06:37:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:37:40 INFO - Return code: 0 06:37:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:40 INFO - https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:37:41 INFO - Downloaded 22329650 bytes. 06:37:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:37:42 INFO - Return code: 0 06:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:42 INFO - https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:37:44 INFO - Downloaded 10840239 bytes. 06:37:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:37:44 INFO - Return code: 0 06:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:44 INFO - https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:37:46 INFO - Downloaded 54690934 bytes. 06:37:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:46 INFO - mkdir: /builds/slave/test/properties 06:37:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:46 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:46 INFO - Contents: 06:37:46 INFO - build_url:https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - Running post-action listener: set_extra_try_arguments 06:37:47 INFO - ##### 06:37:47 INFO - ##### Finished download-and-extract step (success) 06:37:47 INFO - ##### 06:37:47 INFO - ##### 06:37:47 INFO - ##### Running populate-webroot step. 06:37:47 INFO - ##### 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: populate_webroot 06:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:47 INFO - '--tppagecycles', 06:37:47 INFO - '7'], 06:37:47 INFO - 'tests': ['tsvgm']}}, 06:37:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['damp', 'tps']}, 06:37:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'tests': ['damp', 'tps']}, 06:37:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['dromaeo_dom']}, 06:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['a11yr', 06:37:47 INFO - 'ts_paint', 06:37:47 INFO - 'tpaint', 06:37:47 INFO - 'sessionrestore', 06:37:47 INFO - 'sessionrestore_no_auto_restore', 06:37:47 INFO - 'tabpaint']}, 06:37:47 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:47 INFO - 'ts_paint', 06:37:47 INFO - 'tpaint', 06:37:47 INFO - 'sessionrestore', 06:37:47 INFO - 'sessionrestore_no_auto_restore', 06:37:47 INFO - 'tabpaint']}, 06:37:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:47 INFO - 'ts_paint', 06:37:47 INFO - 'tpaint', 06:37:47 INFO - 'sessionrestore', 06:37:47 INFO - 'sessionrestore_no_auto_restore', 06:37:47 INFO - 'tabpaint']}, 06:37:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:47 INFO - 'ts_paint', 06:37:47 INFO - 'tpaint', 06:37:47 INFO - 'sessionrestore', 06:37:47 INFO - 'sessionrestore_no_auto_restore', 06:37:47 INFO - 'tabpaint']}, 06:37:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['a11yr', 06:37:47 INFO - 'ts_paint', 06:37:47 INFO - 'tpaint', 06:37:47 INFO - 'sessionrestore', 06:37:47 INFO - 'sessionrestore_no_auto_restore', 06:37:47 INFO - 'tabpaint']}, 06:37:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['a11yr', 06:37:47 INFO - 'ts_paint', 06:37:47 INFO - 'tpaint', 06:37:47 INFO - 'sessionrestore', 06:37:47 INFO - 'sessionrestore_no_auto_restore', 06:37:47 INFO - 'tabpaint']}, 06:37:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['tsvgx', 06:37:47 INFO - 'tsvgr_opacity', 06:37:47 INFO - 'tart', 06:37:47 INFO - 'tscrollx', 06:37:47 INFO - 'cart']}, 06:37:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:47 INFO - 'tsvgr_opacity', 06:37:47 INFO - 'tart', 06:37:47 INFO - 'tscrollx', 06:37:47 INFO - 'cart']}, 06:37:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'talos_options': ['--disable-e10s'], 06:37:47 INFO - 'tests': ['tp5o']}, 06:37:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'tests': ['tp5o']}, 06:37:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'talos_options': ['--disable-e10s', 06:37:47 INFO - '--xperf_path', 06:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:47 INFO - 'tests': ['tp5n']}, 06:37:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:47 INFO - 'talos_options': ['--xperf_path', 06:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:47 INFO - 'tests': ['tp5n']}}, 06:37:47 INFO - 'talos.zip': {'path': '', 06:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - ##### 06:37:47 INFO - ##### Finished populate-webroot step (success) 06:37:47 INFO - ##### 06:37:47 INFO - ##### 06:37:47 INFO - ##### Running create-virtualenv step. 06:37:47 INFO - ##### 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: create_virtualenv 06:37:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:47 INFO - Using real prefix '/usr' 06:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:48 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:50 INFO - Installing pip.................done. 06:37:50 INFO - Return code: 0 06:37:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:37:50 INFO - Using env: {'DISPLAY': ':0', 06:37:50 INFO - 'HOME': '/home/cltbld', 06:37:50 INFO - 'LANG': 'en_US.UTF-8', 06:37:50 INFO - 'LANGUAGE': 'en_US:en', 06:37:50 INFO - 'LOGNAME': 'cltbld', 06:37:50 INFO - 'MAIL': '/var/mail/cltbld', 06:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:50 INFO - 'MOZ_NO_REMOTE': '1', 06:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:50 INFO - 'NO_EM_RESTART': '1', 06:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:50 INFO - 'PWD': '/builds/slave/test', 06:37:50 INFO - 'SHELL': '/bin/bash', 06:37:50 INFO - 'SHLVL': '1', 06:37:50 INFO - 'TERM': 'linux', 06:37:50 INFO - 'TMOUT': '86400', 06:37:50 INFO - 'USER': 'cltbld', 06:37:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:50 INFO - '_': '/tools/buildbot/bin/python'} 06:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:37:50 INFO - Cleaning up... 06:37:50 INFO - Return code: 0 06:37:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:37:50 INFO - Using env: {'DISPLAY': ':0', 06:37:50 INFO - 'HOME': '/home/cltbld', 06:37:50 INFO - 'LANG': 'en_US.UTF-8', 06:37:50 INFO - 'LANGUAGE': 'en_US:en', 06:37:50 INFO - 'LOGNAME': 'cltbld', 06:37:50 INFO - 'MAIL': '/var/mail/cltbld', 06:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:50 INFO - 'MOZ_NO_REMOTE': '1', 06:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:50 INFO - 'NO_EM_RESTART': '1', 06:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:50 INFO - 'PWD': '/builds/slave/test', 06:37:50 INFO - 'SHELL': '/bin/bash', 06:37:50 INFO - 'SHLVL': '1', 06:37:50 INFO - 'TERM': 'linux', 06:37:50 INFO - 'TMOUT': '86400', 06:37:50 INFO - 'USER': 'cltbld', 06:37:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:50 INFO - '_': '/tools/buildbot/bin/python'} 06:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:50 INFO - Downloading/unpacking psutil>=0.7.1 06:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:52 INFO - Installing collected packages: psutil 06:37:52 INFO - Running setup.py install for psutil 06:37:52 INFO - building 'psutil._psutil_linux' extension 06:37:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:37:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:37:52 INFO - building 'psutil._psutil_posix' extension 06:37:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:37:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:53 INFO - Successfully installed psutil 06:37:53 INFO - Cleaning up... 06:37:53 INFO - Return code: 0 06:37:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:53 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:37:53 INFO - Using env: {'DISPLAY': ':0', 06:37:53 INFO - 'HOME': '/home/cltbld', 06:37:53 INFO - 'LANG': 'en_US.UTF-8', 06:37:53 INFO - 'LANGUAGE': 'en_US:en', 06:37:53 INFO - 'LOGNAME': 'cltbld', 06:37:53 INFO - 'MAIL': '/var/mail/cltbld', 06:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:53 INFO - 'MOZ_NO_REMOTE': '1', 06:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:53 INFO - 'NO_EM_RESTART': '1', 06:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:53 INFO - 'PWD': '/builds/slave/test', 06:37:53 INFO - 'SHELL': '/bin/bash', 06:37:53 INFO - 'SHLVL': '1', 06:37:53 INFO - 'TERM': 'linux', 06:37:53 INFO - 'TMOUT': '86400', 06:37:53 INFO - 'USER': 'cltbld', 06:37:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:53 INFO - '_': '/tools/buildbot/bin/python'} 06:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:37:55 INFO - Installing collected packages: mozsystemmonitor 06:37:55 INFO - Running setup.py install for mozsystemmonitor 06:37:55 INFO - Successfully installed mozsystemmonitor 06:37:55 INFO - Cleaning up... 06:37:55 INFO - Return code: 0 06:37:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:55 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:37:55 INFO - Using env: {'DISPLAY': ':0', 06:37:55 INFO - 'HOME': '/home/cltbld', 06:37:55 INFO - 'LANG': 'en_US.UTF-8', 06:37:55 INFO - 'LANGUAGE': 'en_US:en', 06:37:55 INFO - 'LOGNAME': 'cltbld', 06:37:55 INFO - 'MAIL': '/var/mail/cltbld', 06:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:55 INFO - 'MOZ_NO_REMOTE': '1', 06:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:55 INFO - 'NO_EM_RESTART': '1', 06:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:55 INFO - 'PWD': '/builds/slave/test', 06:37:55 INFO - 'SHELL': '/bin/bash', 06:37:55 INFO - 'SHLVL': '1', 06:37:55 INFO - 'TERM': 'linux', 06:37:55 INFO - 'TMOUT': '86400', 06:37:55 INFO - 'USER': 'cltbld', 06:37:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:55 INFO - '_': '/tools/buildbot/bin/python'} 06:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:58 INFO - Downloading docopt-0.6.1.tar.gz 06:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:58 INFO - Running setup.py install for blobuploader 06:37:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:58 INFO - Running setup.py install for requests 06:37:58 INFO - Running setup.py install for docopt 06:37:58 INFO - Successfully installed blobuploader requests docopt 06:37:58 INFO - Cleaning up... 06:37:58 INFO - Return code: 0 06:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:58 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:37:58 INFO - Using env: {'DISPLAY': ':0', 06:37:58 INFO - 'HOME': '/home/cltbld', 06:37:58 INFO - 'LANG': 'en_US.UTF-8', 06:37:58 INFO - 'LANGUAGE': 'en_US:en', 06:37:58 INFO - 'LOGNAME': 'cltbld', 06:37:58 INFO - 'MAIL': '/var/mail/cltbld', 06:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:58 INFO - 'MOZ_NO_REMOTE': '1', 06:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:58 INFO - 'NO_EM_RESTART': '1', 06:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:58 INFO - 'PWD': '/builds/slave/test', 06:37:58 INFO - 'SHELL': '/bin/bash', 06:37:58 INFO - 'SHLVL': '1', 06:37:58 INFO - 'TERM': 'linux', 06:37:58 INFO - 'TMOUT': '86400', 06:37:58 INFO - 'USER': 'cltbld', 06:37:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:58 INFO - '_': '/tools/buildbot/bin/python'} 06:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:59 INFO - Running setup.py (path:/tmp/pip-N71jcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:59 INFO - Running setup.py (path:/tmp/pip-vfPz3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:59 INFO - Running setup.py (path:/tmp/pip-wSuMQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:59 INFO - Running setup.py (path:/tmp/pip-1ReY9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:59 INFO - Running setup.py (path:/tmp/pip-Na5yaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:59 INFO - Running setup.py (path:/tmp/pip-GVne2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:59 INFO - Running setup.py (path:/tmp/pip-D8wqBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:59 INFO - Running setup.py (path:/tmp/pip-BsuV4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:59 INFO - Running setup.py (path:/tmp/pip-LEsBjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:59 INFO - Running setup.py (path:/tmp/pip-HdwiQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:59 INFO - Running setup.py (path:/tmp/pip-3POuis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:59 INFO - Running setup.py (path:/tmp/pip-w0FLa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:59 INFO - Running setup.py (path:/tmp/pip-VhztHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:59 INFO - Running setup.py (path:/tmp/pip-4PQMGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:00 INFO - Running setup.py (path:/tmp/pip-WJe0pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:00 INFO - Running setup.py (path:/tmp/pip-2xf25Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:00 INFO - Running setup.py (path:/tmp/pip-spv04_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:00 INFO - Running setup.py install for manifestparser 06:38:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:00 INFO - Running setup.py install for mozcrash 06:38:00 INFO - Running setup.py install for mozdebug 06:38:00 INFO - Running setup.py install for mozdevice 06:38:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:38:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:00 INFO - Running setup.py install for mozfile 06:38:00 INFO - Running setup.py install for mozhttpd 06:38:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:00 INFO - Running setup.py install for mozinfo 06:38:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:00 INFO - Running setup.py install for mozInstall 06:38:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Running setup.py install for mozleak 06:38:01 INFO - Running setup.py install for mozlog 06:38:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Running setup.py install for moznetwork 06:38:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Running setup.py install for mozprocess 06:38:01 INFO - Running setup.py install for mozprofile 06:38:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Running setup.py install for mozrunner 06:38:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:01 INFO - Running setup.py install for mozscreenshot 06:38:01 INFO - Running setup.py install for moztest 06:38:01 INFO - Running setup.py install for mozversion 06:38:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:02 INFO - Cleaning up... 06:38:02 INFO - Return code: 0 06:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:02 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:02 INFO - Using env: {'DISPLAY': ':0', 06:38:02 INFO - 'HOME': '/home/cltbld', 06:38:02 INFO - 'LANG': 'en_US.UTF-8', 06:38:02 INFO - 'LANGUAGE': 'en_US:en', 06:38:02 INFO - 'LOGNAME': 'cltbld', 06:38:02 INFO - 'MAIL': '/var/mail/cltbld', 06:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:02 INFO - 'MOZ_NO_REMOTE': '1', 06:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:02 INFO - 'NO_EM_RESTART': '1', 06:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:02 INFO - 'PWD': '/builds/slave/test', 06:38:02 INFO - 'SHELL': '/bin/bash', 06:38:02 INFO - 'SHLVL': '1', 06:38:02 INFO - 'TERM': 'linux', 06:38:02 INFO - 'TMOUT': '86400', 06:38:02 INFO - 'USER': 'cltbld', 06:38:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:02 INFO - '_': '/tools/buildbot/bin/python'} 06:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:02 INFO - Running setup.py (path:/tmp/pip-TwqyF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:02 INFO - Running setup.py (path:/tmp/pip-fBexpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:02 INFO - Running setup.py (path:/tmp/pip-l10T0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:02 INFO - Running setup.py (path:/tmp/pip-msq9P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:02 INFO - Running setup.py (path:/tmp/pip-A0wHJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:02 INFO - Running setup.py (path:/tmp/pip-ioYorR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:02 INFO - Running setup.py (path:/tmp/pip-OZiNGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:02 INFO - Running setup.py (path:/tmp/pip-Q32emG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:02 INFO - Running setup.py (path:/tmp/pip-4jdwBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:02 INFO - Running setup.py (path:/tmp/pip-sSgpF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:03 INFO - Running setup.py (path:/tmp/pip-42gTps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:03 INFO - Running setup.py (path:/tmp/pip-ZYlAyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:03 INFO - Running setup.py (path:/tmp/pip-tAP4Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:03 INFO - Running setup.py (path:/tmp/pip-PesNwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:03 INFO - Running setup.py (path:/tmp/pip-l0tYQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:03 INFO - Running setup.py (path:/tmp/pip-n0GUzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:03 INFO - Running setup.py (path:/tmp/pip-1BjrVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:38:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:05 INFO - Downloading blessings-1.6.tar.gz 06:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:05 INFO - Installing collected packages: blessings 06:38:05 INFO - Running setup.py install for blessings 06:38:05 INFO - Successfully installed blessings 06:38:05 INFO - Cleaning up... 06:38:05 INFO - Return code: 0 06:38:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:05 INFO - Reading from file tmpfile_stdout 06:38:05 INFO - Current package versions: 06:38:05 INFO - argparse == 1.2.1 06:38:05 INFO - blessings == 1.6 06:38:05 INFO - blobuploader == 1.2.4 06:38:05 INFO - docopt == 0.6.1 06:38:05 INFO - manifestparser == 1.1 06:38:05 INFO - mozInstall == 1.12 06:38:05 INFO - mozcrash == 0.17 06:38:05 INFO - mozdebug == 0.1 06:38:05 INFO - mozdevice == 0.48 06:38:05 INFO - mozfile == 1.2 06:38:05 INFO - mozhttpd == 0.7 06:38:05 INFO - mozinfo == 0.9 06:38:05 INFO - mozleak == 0.1 06:38:05 INFO - mozlog == 3.2 06:38:05 INFO - moznetwork == 0.27 06:38:05 INFO - mozprocess == 0.22 06:38:05 INFO - mozprofile == 0.28 06:38:05 INFO - mozrunner == 6.11 06:38:05 INFO - mozscreenshot == 0.1 06:38:05 INFO - mozsystemmonitor == 0.0 06:38:05 INFO - moztest == 0.7 06:38:05 INFO - mozversion == 1.4 06:38:05 INFO - psutil == 3.1.1 06:38:05 INFO - requests == 1.2.3 06:38:05 INFO - wsgiref == 0.1.2 06:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:05 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:05 INFO - Using env: {'DISPLAY': ':0', 06:38:05 INFO - 'HOME': '/home/cltbld', 06:38:05 INFO - 'LANG': 'en_US.UTF-8', 06:38:05 INFO - 'LANGUAGE': 'en_US:en', 06:38:05 INFO - 'LOGNAME': 'cltbld', 06:38:05 INFO - 'MAIL': '/var/mail/cltbld', 06:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:05 INFO - 'MOZ_NO_REMOTE': '1', 06:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:05 INFO - 'NO_EM_RESTART': '1', 06:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:05 INFO - 'PWD': '/builds/slave/test', 06:38:05 INFO - 'SHELL': '/bin/bash', 06:38:05 INFO - 'SHLVL': '1', 06:38:05 INFO - 'TERM': 'linux', 06:38:05 INFO - 'TMOUT': '86400', 06:38:05 INFO - 'USER': 'cltbld', 06:38:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:05 INFO - '_': '/tools/buildbot/bin/python'} 06:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:38:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:38:06 INFO - Cleaning up... 06:38:06 INFO - Return code: 0 06:38:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:06 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:38:06 INFO - Using env: {'DISPLAY': ':0', 06:38:06 INFO - 'HOME': '/home/cltbld', 06:38:06 INFO - 'LANG': 'en_US.UTF-8', 06:38:06 INFO - 'LANGUAGE': 'en_US:en', 06:38:06 INFO - 'LOGNAME': 'cltbld', 06:38:06 INFO - 'MAIL': '/var/mail/cltbld', 06:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:06 INFO - 'MOZ_NO_REMOTE': '1', 06:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:06 INFO - 'NO_EM_RESTART': '1', 06:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:06 INFO - 'PWD': '/builds/slave/test', 06:38:06 INFO - 'SHELL': '/bin/bash', 06:38:06 INFO - 'SHLVL': '1', 06:38:06 INFO - 'TERM': 'linux', 06:38:06 INFO - 'TMOUT': '86400', 06:38:06 INFO - 'USER': 'cltbld', 06:38:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:06 INFO - '_': '/tools/buildbot/bin/python'} 06:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:06 INFO - Downloading/unpacking jsonschema 06:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:08 INFO - Downloading/unpacking functools32 (from jsonschema) 06:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:08 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:08 INFO - warning: no files found matching '*.txt' 06:38:08 INFO - no previously-included directories found matching 'build' 06:38:08 INFO - no previously-included directories found matching 'dist' 06:38:08 INFO - no previously-included directories found matching '.git*' 06:38:08 INFO - Installing collected packages: jsonschema, functools32 06:38:08 INFO - Running setup.py install for functools32 06:38:08 INFO - warning: no files found matching '*.txt' 06:38:08 INFO - no previously-included directories found matching 'build' 06:38:08 INFO - no previously-included directories found matching 'dist' 06:38:08 INFO - no previously-included directories found matching '.git*' 06:38:08 INFO - Successfully installed jsonschema functools32 06:38:08 INFO - Cleaning up... 06:38:08 INFO - Return code: 0 06:38:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:08 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 0x7f0e6d096f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a2e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, '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': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:38:08 INFO - Using env: {'DISPLAY': ':0', 06:38:08 INFO - 'HOME': '/home/cltbld', 06:38:08 INFO - 'LANG': 'en_US.UTF-8', 06:38:08 INFO - 'LANGUAGE': 'en_US:en', 06:38:08 INFO - 'LOGNAME': 'cltbld', 06:38:08 INFO - 'MAIL': '/var/mail/cltbld', 06:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:08 INFO - 'MOZ_NO_REMOTE': '1', 06:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:08 INFO - 'NO_EM_RESTART': '1', 06:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:08 INFO - 'PWD': '/builds/slave/test', 06:38:08 INFO - 'SHELL': '/bin/bash', 06:38:08 INFO - 'SHLVL': '1', 06:38:08 INFO - 'TERM': 'linux', 06:38:08 INFO - 'TMOUT': '86400', 06:38:08 INFO - 'USER': 'cltbld', 06:38:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:08 INFO - '_': '/tools/buildbot/bin/python'} 06:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:08 INFO - Downloading/unpacking flake8 06:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:38:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:38:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:11 INFO - no previously-included directories found matching 'docs/_build' 06:38:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:38:11 INFO - Running setup.py install for pep8 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:11 INFO - no previously-included directories found matching 'docs/_build' 06:38:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:38:11 INFO - Cleaning up... 06:38:11 INFO - Return code: 0 06:38:11 INFO - Running post-action listener: _resource_record_post_action 06:38:11 INFO - Running post-action listener: _start_resource_monitoring 06:38:11 INFO - Starting resource monitoring. 06:38:11 INFO - ##### 06:38:11 INFO - ##### Finished create-virtualenv step (success) 06:38:11 INFO - ##### 06:38:11 INFO - ##### 06:38:11 INFO - ##### Running install step. 06:38:11 INFO - ##### 06:38:11 INFO - Running pre-action listener: _resource_record_pre_action 06:38:11 INFO - Running main action method: install 06:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:11 INFO - Reading from file tmpfile_stdout 06:38:11 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:11 INFO - Reading from file tmpfile_stdout 06:38:11 INFO - Output received: 06:38:11 INFO - Usage: mozinstall [options] installer 06:38:11 INFO - Options: 06:38:11 INFO - -h, --help show this help message and exit 06:38:11 INFO - -d DEST, --destination=DEST 06:38:11 INFO - Directory to install application into. [default: 06:38:11 INFO - "/builds/slave/test"] 06:38:11 INFO - --app=APP Application being installed. [default: firefox] 06:38:11 INFO - mkdir: /builds/slave/test/build/application 06:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:38:27 INFO - Reading from file tmpfile_stdout 06:38:27 INFO - Output received: 06:38:27 INFO - /builds/slave/test/build/application/firefox/firefox 06:38:27 INFO - Running post-action listener: _resource_record_post_action 06:38:27 INFO - ##### 06:38:27 INFO - ##### Finished install step (success) 06:38:27 INFO - ##### 06:38:27 INFO - ##### 06:38:27 INFO - ##### Running run-tests step. 06:38:27 INFO - ##### 06:38:27 INFO - Running pre-action listener: _resource_record_pre_action 06:38:27 INFO - Running main action method: run_tests 06:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:27 INFO - Python 2.7.3 06:38:27 INFO - Return code: 0 06:38:27 INFO - grabbing minidump binary from tooltool 06:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abd9c0>, '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 0x2abe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:38:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:38:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:38:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:27 INFO - Return code: 0 06:38:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:38:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:38:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:38:28 INFO - Return code: 0 06:38:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:38:28 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:38:28 INFO - Using env: {'DISPLAY': ':0', 06:38:28 INFO - 'HOME': '/home/cltbld', 06:38:28 INFO - 'LANG': 'en_US.UTF-8', 06:38:28 INFO - 'LANGUAGE': 'en_US:en', 06:38:28 INFO - 'LOGNAME': 'cltbld', 06:38:28 INFO - 'MAIL': '/var/mail/cltbld', 06:38:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:28 INFO - 'MOZ_NO_REMOTE': '1', 06:38:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:28 INFO - 'NO_EM_RESTART': '1', 06:38:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:28 INFO - 'PWD': '/builds/slave/test', 06:38:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:28 INFO - 'SHELL': '/bin/bash', 06:38:28 INFO - 'SHLVL': '1', 06:38:28 INFO - 'TERM': 'linux', 06:38:28 INFO - 'TMOUT': '86400', 06:38:28 INFO - 'USER': 'cltbld', 06:38:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965', 06:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:28 INFO - '_': '/tools/buildbot/bin/python'} 06:38:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:38:28 INFO - mozversion application_buildid: 20160512060851 06:38:28 INFO - mozversion application_changeset: 1e5b69b0387beb39a0b997938c07a6a05d4ae42a 06:38:28 INFO - mozversion application_display_name: Nightly 06:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:28 INFO - mozversion application_name: Firefox 06:38:28 INFO - mozversion application_remotingname: firefox 06:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:38:28 INFO - mozversion application_vendor: Mozilla 06:38:28 INFO - mozversion application_version: 49.0a1 06:38:28 INFO - mozversion platform_buildid: 20160512060851 06:38:28 INFO - mozversion platform_changeset: 1e5b69b0387beb39a0b997938c07a6a05d4ae42a 06:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:38:28 INFO - mozversion platform_version: 49.0a1 06:38:28 INFO - using testdate: 1463060308 06:38:28 INFO - actual date: 1463060308 06:38:28 INFO - starting webserver on 'localhost:33551' 06:38:28 INFO - SUITE-START | Running 2 tests 06:38:28 INFO - TEST-START | dromaeo_css 06:38:28 INFO - operating with platform_type : linux_ 06:38:28 INFO - Initialising browser for dromaeo_css test... 06:38:28 INFO - TEST-INFO | started process 8891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpguDq2Q/profile http://localhost:33551/getInfo.html) 06:38:33 INFO - PROCESS | 8891 | __metrics Screen width/height:1600/1200 06:38:33 INFO - PROCESS | 8891 | colorDepth:24 06:38:33 INFO - PROCESS | 8891 | Browser inner width/height: 1024/697 06:38:33 INFO - PROCESS | 8891 | __metrics 06:38:34 ERROR - PROCESS | 8891 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:38:34 INFO - PROCESS | 8891 | console.error: PushService: 06:38:34 INFO - PROCESS | 8891 | stateChangeProcessEnqueue: Error transitioning state 06:38:34 INFO - PROCESS | 8891 | UnknownError 06:38:35 INFO - TEST-INFO | 8891: exit 0 06:38:35 INFO - Browser initialized. 06:38:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:35 INFO - TEST-INFO | started process 8971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpguDq2Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:47 INFO - PROCESS | 8971 | RSS: Main: 154955776 06:38:47 INFO - PROCESS | 8971 | 06:39:38 INFO - PROCESS | 8971 | 1463060378872 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:41:50 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:33551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33551/tests/dromaeo/cssquery-ext.html) 06:41:51 INFO - PROCESS | 8971 | RSS: Main: 228909056 06:41:51 INFO - PROCESS | 8971 | 06:44:54 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:33551/tests/dromaeo/cssquery-ext.html (next: http://localhost:33551/tests/dromaeo/cssquery-jquery.html) 06:44:55 INFO - PROCESS | 8971 | RSS: Main: 238174208 06:44:55 INFO - PROCESS | 8971 | 06:47:57 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:33551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33551/tests/dromaeo/cssquery-mootools.html) 06:47:57 INFO - PROCESS | 8971 | RSS: Main: 236032000 06:47:57 INFO - PROCESS | 8971 | 06:51:00 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:33551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33551/tests/dromaeo/cssquery-prototype.html) 06:51:00 INFO - PROCESS | 8971 | RSS: Main: 242528256 06:51:00 INFO - PROCESS | 8971 | 06:54:03 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:33551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33551/tests/dromaeo/cssquery-yui.html) 06:54:04 INFO - PROCESS | 8971 | RSS: Main: 225394688 06:54:04 INFO - PROCESS | 8971 | 06:57:06 INFO - PROCESS | 8971 | Cycle 1(1): loaded http://localhost:33551/tests/dromaeo/cssquery-yui.html (next: http://localhost:33551/tests/dromaeo/cssquery-dojo.html) 06:57:07 INFO - PROCESS | 8971 | RSS: Main: 289300480 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | __start_tp_report 06:57:07 INFO - PROCESS | 8971 | _x_x_mozilla_page_load 06:57:07 INFO - PROCESS | 8971 | _x_x_mozilla_page_load_details 06:57:07 INFO - PROCESS | 8971 | |i|pagename|runs| 06:57:07 INFO - PROCESS | 8971 | |0;dojo.html;2599.71403145654;2603.8958441662335;2619.070230068325;2642.775364094051;2644.6694163229595;4623;4656.5110663380365;4681.929771053433;4759.6668233223645;4799.640026997971;4679.204535229011;4679.578837904588;4703.459102203247;4736.5500277473675;4771.069641419925;4293.119910418364;4333.393324934512;4383.627391671712;4402.1195760847795;4489.865304040868;4390.297552391618;4430.313301438282;4442.711223770445;4453.465584129909;4483;4205.0748835256345;4262.893427664302;4344.087741574242;4358.3244597087505;4379.75911324877;4355.346697995295;4356.346548017791;4398.428204333448;4411.382406463098;4415.470143582758;4383.364412160251;4401.559844015573;4403.339499075132;4428.158649856549;4440.777961101964;4435.68950173488;4635.629149668019;4694.08465349257;4698.929516057262;4731.479537250934;5085.338905942241;5143.665661731976;5157.097507936133;5157.690538567698;5160.638755287131;5035;5155.149400348938;5170.482951704837;5189.740512974374;5193.740312984373;4730.2431610942085;4777.307290442866;4780.569748722632;4808.759562021885;4845.563899249085;5260.9736951315;5281.841544753664;5313.601479889024;5314.73426328682;5319.627626066138;4874.512548745097;4938.209886418156;5018.824341148115;5067.923981140286;5073.1122053640465;5069.974650126799;5097.592192624581;5119.308893299357;5158.148905430637;5167.044096842096;5054.444011158769;5055.974720126449;5057.8735531612;5061.038402703474;5109.897802043938;4858.125537403231;4953.2074868020945;5057.115004874132;5063.139266324733;5063.265826455144;4337.024169561886;4339.609435150852;4354.455693038371;4399;4404.0971600822395;3754.887353379403;3757.0607348162957;3758.7180961428003;3788.412796016622;3806.200697853482;4193.496780386312;4241.321388577812;4356.019895523482;4361.716488428306;4393.231184542692;4999.100161970808;5032.169692000779;5047.520485553867;5065.645404821627;5069.264956581349;4321.114171594815;4327.6321512671775;4333.904460285001;4334.1548398062705;4368.847090351823;4455;4548.522405147478;4556.476005259371;4556.567126123013;4602.769861506911;4580.816767329269;4585.908281834278;4588.862334129982;4613.261878099488;4627.3521706961055;5059.696418214919;5094.414142373675;5094.668846525113;5095;5096.337476128079;4411.228035093782;4518.457785065813;4530.61489773373;4565.086982603426;4583.083383323416;4994.525520075587;5029.5221953914315;5042.621803364689;5048.091343558195;5086.593072554113;5092.796288148433;5103.10695628271;5106.821261255986;5107.872303192301;5159.432462429205;4807.663463557517;4837.2260438329695;4844.636652251166;4956.950430495649;4961.5286547777905;4843.854684359475;4874.195757700081;4888.58447031992;4910.607151427806;4928.186849169991;4792.856214313576;4804.183288840835;4805.4233491979785;4853.9029219416125;4859.562639362474;4716.457607375196;4929.211326187793;4936.802527898843;4955.331030311006;4966.900661986812;4860.1251774680895;4863.586595139453;4878.512148785093;4880.145974454527;4919.926201106915 06:57:07 INFO - PROCESS | 8971 | |1;ext.html;603.1826874584938;605.3552966091113;612.2591664086456;617.0805499805291;624.9375062493748;27977.58033629495;41031.58968410315;41957.580424195825;42087.57912420875;42112;42173.367399489034;42778;42802.35796463056;42925.7853710731;42958.57041429585;7304.3426091651745;7878.4485086044;8021.799455013642;9914;10146.340487868301;10048.547815348327;10148.238882083837;10152;10154.39073655583;10162;10152.086312231897;10186.083252507273;10188.949055254714;10193.949030254838;10202.693919182437;7509.737159199429;9990.350627209207;10173.491325433773;10253;10602.310849794816;10096.29325947184;10110.44392558409;10172.745681357952;10174.643887463977;10180.38917664935;38540.42189367134;38944.22111557753;38978.220435591415;39016.21967560661;39034.609653903666;3308.933821323584;3329.7336213103135;3342.8495717692763;3437.8281085945605;3634.6365363463706;29877.70122298771;29995.40009199804;30063.849680751675;30247.848760756056;30325.69674303251;3529.7176225901867;3567.8572857085687;3591.838367273479;3646.981765091184;3716.3310604091253;236019;236676;237040.99999999828;237157;237787;34114.48828267578;35142.12144696403;35203.29593408117;36938.630613693516;54795.45204547983;35845.64154358475;35990;36009.639903600626;36034.279314413565;36148;12650.114491985656;14111.435542578387;14247.21640309793;14248.287585620885;14252.501162459264;10981.39602321864;11159.776804464027;11213.55145794159;11334.489947952361;11337.489812958436;8364.749057528285;8367.748967530984;8370.874436883452;8429.578521073921;8442.282405995436;3283.2612662150823;3313.9005829825146;3321.30252646942;3338.8998330050135;3347.4644056951256;918.7060140754894;947.2895328503622;969.5007071358256;1003.7189586915675;1028.0028372478685;28507;28642;29156.271093222414;29179;29229;983.331334692416;1031.5976769060073;1075.763332066944;1085.8588383510094;1105.2318638546294;15096.622584435258;15210.391584336723;15274.159921204218;15462.072275663497;15666.13836238995;333899;336917;337204;337785;337817;50756.238656419446;51060.744696276284;51075.48924510782;51086.48913510892;51137.23294150591;1202.8496437945257;1204.9698757531132;1254.85569159546;1316.5128902305826;1321.4912258780246;28583.28541786472;29368.559471607514;29698.257543561584;29944.550831737975;30020.24949376283;43275;43314.133717326105;43798;43914.78042609766;43918.780406097765;266797;267960;268359;268414;269577;23644.054237830293;25818.741812582386;26427.207183784518;26512.734872651028;28320.291992700346;42713;43041;43289;43296.350554742334;43837.56162438335;35770.642293577774;35956.820215898755;36282.274354512236;36744.63255367412;37135.81432092822;36097.27805443929;36318.455223172205;36489.452658209615;36546;36663.63336366602;35808;36148.27703445969;36413.27173456569;36631.26737465183;36716;32846.6570927078;37090;37540.81229593835;37617.4357384634;37829.81085094557;25208.873955630104;25771.484570308865;25786.8710656453;26110.60834087452;26191.345216369744 06:57:07 INFO - PROCESS | 8971 | |2;jquery.html;379.2025797718813;382.33282921302333;386.1678083729563;393.1704104339842;404.0726532607665;13411.731765364711;14171.149731016121;16110;17953.46139615812;18006.72989905151;16839.158042097875;17060.82939170608;17500.94994300343;17518.737218941726;18035;5062.797488100471;5099.796008159669;5277.445868183843;5305.867353316179;6073.392660733935;6060.454559089681;6096.817095487142;6116.816495505142;6144.324124346318;6145.201123853915;5877.8824423511505;6079.4528492435675;6110.847228819271;6121.387861213865;6125.663088530129;5837.970810145922;6020.397960203988;6069.969650151743;6083.17877086592;6097.085437184413;5291.550218231455;5310.522053015247;5312.203169524602;5323.707196104213;5356.9732151339385;20397.184112635478;20532.58934821295;20627.48431289215;20901.581968360548;20906.477338066517;2070.730804995356;2138.4226258910007;2297.4371279036577;2397.1609936522077;2552.974470255292;13552.728945421135;13555.457781688721;13620.659483512893;13624.523141689993;13944.651383715387;1791.9193636286398;1833.761610990576;1851.2224865556498;1864.9347272845384;1896.933607323737;67317.32682673208;67440.6627966857;68153.31846681569;68890.96663550101;69590;9563.61745530171;9635.56639951204;9836.901630983599;9948.80102397948;10134.949325253327;11174.161937854693;11939.88060119405;13807;13821.723565528633;13822.861771382157;7382.1141463023705;7670.693172273047;7682.7311044113185;7761.223877612194;7899.921000790034;7168.749093781797;7193.388561972291;7399.334059934524;7419.369353605004;7802.414818888606;6231.2522497300615;6274.780382686584;6290.402411770874;6313.40022697843;6323.9683801580695;1786.1426515272742;1821.2350812658715;1834.4313262888547;1869.3737597904583;1880.9059547022869;886.4326830828275;929.1916033051289;934.6822080492665;1060.204846365226;1076.8438576406377;17340.219690113976;17430.65138697219;17454.12729363527;17585.384511542034;17936.372226971995;851.9275861551714;911.5670056723003;939.3471537281661;951.0869565217331;953.6519170502717;9013.324000699973;9260.861087083698;9495.38280011797;9548.761280967892;9755.512224388753;428412;429751;431519;434996;435243;81890.18109818945;83272;83894;84399.57800211082;85301;977.8924318324979;981.4454833019321;997.1972562087444;1005.5575546759549;1006.436395618456;14476.270081744718;14622.561323160322;14633.560993170222;14691.632709182357;14995.100293982396;24802.02660921939;27393.452130957667;33177.33645327128;33819;34541.963741087806;44710.77644611756;50971.490285096676;51053.23420148775;51459.74270128625;51676;7675.577843218676;7954.403419743427;7978.962734844433;8053.516788992679;8062.234087761653;11346.886531134913;11632.88367116352;11725.765484690088;12138.878611213775;12176.208546444454;10072.949635251776;10221.488925553842;10280.331778434378;10591.735206619896;10951.890481095086;10264.692059238234;10392.532336045047;10431.165506759593;10453.581856725647;10557.260991730813;10686.145108391154;10790.73023174427;10986.780264394827;11013.339199648046;11349.432528373383;7937.841243174988;8024.39817013738;8136.87794683092;8163.551004694798;8208.507489550646;9941.801163976825;10624.203184761329;10850.511726972147;10852.945735271589;10955.397453140155 06:57:07 INFO - PROCESS | 8971 | |3;mootools.html;1278.6355888571748;1492.4850926430381;1509.8112735908012;1702.6084000679843;1875.2873907914998;6693.431058360039;7438.107427108748;7661.731839385623;7675.884861727079;7836.568988705619;7595.316421522062;7723.073231212263;7766.883496747553;7787.221277872224;7787.415943804223;1854.6383455226237;1899.3447260695107;1907.3610340535938;2197.63738983068;2229.598672238996;1932.0436383989945;2209.1826024371007;2266.7733226677283;2268.5689718953345;2289.610766169755;2118.7775283595233;2127.4681329667583;2136.935891923237;2138.615049291127;2139.144342263092;1719.6388758360758;2083.718697975769;2085.3326935380683;2094.4030951178843;2096.0253482130884;2063;2120.9151633934625;2125.3305208859315;2132.818710409617;2135.6582946728604;7396.963015184943;7442.925570744277;7455.2172021938;7458.477906546544;7459.254074592552;4420.403245561873;4521.005378816655;4523.344115103291;4529.32060190974;4529.773511324421;2719.6736391632935;2792.3019245188702;2929.5312749959903;2939.4415061138316;2941.2940894185454;864.606603995187;881.3257857738835;892.87941139793;899.3839220134164;913.4017218721748;10203.979602039812;10226.130778883804;10242.692719218436;10254;10254.230932680079;3953.584873588289;4056.918861622751;4135.82129093207;4151.813168407429;4159.500859896832;8690.26132778721;8758.12418758119;8758.2993360531;8778.166074222938;8785.428947118417;4514.932276015862;4525.751083690363;4529.139463501924;4530.569595888385;4532;3713.9442908356395;3943.3493473577114;4053.310937140634;4183.309753890574;4186;3613.8915832525067;3749.362608356586;3791.601881802371;3792.563855156637;3794.127350709297;1183.46743965216;1198.5445530698278;1198.7183011992174;1206.975860482803;1208.1060015588578;900.1718419054355;928.1043792740038;931.8322701913721;934.6121359635811;935.8228813179219;5578;5772.076467765138;5814.244148260699;5834.533237341087;5984.700764961734;920.6041402196986;944.2681921510884;966.7583104223944;974.1232890398697;977.7360112769654;3791.810409479515;3838.1556057667267;3956.8812935611977;3996.4005399189773;4030.919381612351;9434.764130896783;9758.17055550272;9833.852492212622;9967.10296073357;9983.600655973825;9540.856887146698;9798.559064842098;9920.057594528509;10057.094861462358;10107.444090575089;7316.561006339637;7335.1197856257595;7342;7347.412207023533;7360.1535823381;5536.335639723259;5547.583931205095;5634.295713035871;5676.347220069745;5677.233573467529;9246.861297080415;9343.579538920902;9358.766030849283;9456.2907781918;9482.336236463381;9094.363394562317;9410.482423466776;9456.858147127661;9578.616855325708;9594.136527712539;5453.291072160594;5576.414476479911;6278.560500764903;6443.548951573345;6592.373724496165;7573.9242607575425;7861.882071768814;7929.088154862265;7953.0456345238945;7964.442489025712;6986.860262794818;7167.247439018828;7211.531250468703;7263.491555591269;7300.525465844703;6800.115984921928;6829.795106146824;6866.965665171842;6928.064711263914;7020.368166865007;6661.733530658719;6672.399484046459;6717.261101278953;6788.59268443895;6789.15135608049;4696.906061878812;4785.856424307276;4800.4479484859685;4844.128056949642;4881.90236195267;4910.43529994041;4913.680610760289;4918.92621610669;4957.578605818546;4986.276989836526 06:57:07 INFO - PROCESS | 8971 | |4;prototype.html;297.1990485641198;308.5110100490722;313.306027149863;313.9623245210575;320.00159502352665;4691.085238378518;4783.210770222909;4787.2340425531875;4788.569028787409;4826.927596086057;4617.884552886179;4729.172394830908;4768.54698803614;4775.14047471455;4791.976040119804;3809.9619003809885;3812.65686088252;3815.465834783133;3822.57951625321;3846.2115266370465;3657.4330978698345;3692.48305237267;3825.5026846509913;3839.9040023999346;3856.9421458678144;3809.4190910771995;3819.6058438669825;3842.1547259602844;3855.903602409934;3873.845046198149;3829.8659546915865;3833.1758671885677;3844.5390751514246;3860.7104467165077;3865.8646947356706;3428.4286784911314;3432.2277487565348;3447.9655203448146;3449.689527942497;3475.3570589441033;4489.577235611032;4591.678582499227;4596.35651008859;4609.516000819933;4617.37665415168;4348.130373925196;4349.456317960255;4354.7604881731495;4365.995820961165;4370;4971.925421118686;4977.054359671687;4980.576650984671;5000.924986125175;5017.422996355429;3620.294042661682;3671.2657468506404;3677.191017976041;3677.8528858845616;3727.4222495512968;5218.895622087575;5219.451957544441;5231.581473482112;5235.712035838027;5237.371515418136;3741.9625803741615;3766.227923275722;3766.5856755756845;3789.5073640427117;3796.411556208737;3744.681702055356;3821.2548553031893;3843.8078096095082;3847.461355410245;3850.7689538627774;4300.817275249331;4328.199283132631;4329.19909816685;4341.413909122228;4363.3018717005125;4990.30135780991;5001.89996200074;5020.7740651670765;5031.4465408805;5041.621878359138;1253.523661008811;1300.2393599744066;1304.1262354222692;1306.6080175947368;1307.1568838099372;918.4581097152712;945.3146468810057;946.3612061858219;959.8560215967522;961.5288608428975;4397.2085024695225;4411.735295882193;4425.800838962255;4428.889277768081;4430.911381772346;4985.326980857611;5134.845954621367;5163.476774351575;5181.870453238624;5251.921221181686;4475.328700694857;4476.529964353761;4503.932441013388;4514.61625761814;4531.592156705847;2809.918181500137;2813.6482939632547;2818.0418657656496;2822.195674232834;2831.929201769931;4601.792919318638;4710.36410084641;4711.411073615798;4739.336492890998;4753.857384278477;5255.710935898486;5335.466453354634;5369.006733754268;5378.57467771041;5390.97304513475;4661.016949152545;4680.4149481314835;4682.227432473604;4693.9765301173275;4720.551547602972;4987.351644286219;5195.948040519546;5214;5225.6603320784025;5230.398504172069;5106.361704786902;5131.179011358165;5136.460671629425;5144.6913185209005;5149.588032957279;4703.176944034712;4722.48052714208;4738.407699037621;4752.049590082067;4762.309465127606;3521.683048525645;3719.9628003719617;3733.272011957642;3750.0999760057935;3753.9624603753614;5154.355705536808;5155.484451554815;5157.149070403491;5180.248863914787;5197.22041693749;5028.673136246132;5040.672356296829;5066.164082926276;5070.3155074064525;5091.389033316026;4783.402074740658;4836.46798852119;5066.41736200327;5078.822241221539;5084.339035925306;4892.290617860462;4974.204127339608;5022.347094877789;5036.647434679684;5043.84868453947;5114.667546609458;5117.61617878668;5121.001404726043;5165.638405311743;5176.9741151294;4847.418309802846;5003.524665156804;5007.899842003212;5019.247112932943;5057.342545469065 06:57:07 INFO - PROCESS | 8971 | |5;yui.html;713.9750108746194;816.8121332093622;821.6549049399248;829.7303376402667;831.3390854270858;12667.239965602059;13273.734525309488;13398.531051413203;13462.192268463887;13544;12545.435455404506;12554.183978041421;12568.874311256885;12575.308358040327;12589.370531473412;678.0845858091586;836.0803116571752;868.9044205137415;873.1530415496958;875.2210532625968;872.4285592936636;875.4528419737663;879.6129702930722;880.4629176202511;882.1531329923281;915.8397280475923;916.2669864108719;917.7934964632971;917.8439665256923;918.347972939214;706.1279320039747;885.8538341173698;910.6129894794685;911.2254583603884;912.2519533982137;669.7153709673418;670.8188789026984;670.9094272273229;671.0102598666977;671.6104659297645;12186;12263.386830658432;12265.816012759815;12309.93845030778;12334.444949977273;12005.879941200563;12402.19385739924;12426.689332766662;12488.375581220902;12491.949148343765;10759.515821788038;10821;10958.835617465744;11356.48895799691;11398.145139114516;4038.5557588665224;4094.5905409459115;4100.7334523256195;4141.544430112685;4229.471316085489;41739.582604174175;42335.7883210582;43096.56903430988;44120;44528.55471445244;9934.602615895283;9989.100980911608;10003.849942250872;10067.244956628283;10079.798404032024;17407.390741323994;17514.562135946704;17562.824371756375;17653.646927061644;17712.55718607045;6462.903056454157;6672.099266599044;6700.229473610597;6726.697298621574;6871.553349032397;3793.6585707285926;3818.866339678098;3850.9807450962567;3927.5286965564314;3928.64642182205;2641.7886569074426;2747.3543717226435;2747.587861820743;2750.0787236276074;2758.3379988802944;538.7925648625308;549.631746729692;554.0885243773969;558.1488230448598;560.5879678436346;533.8291746641115;572.2290698307614;584.2375699711832;592.3040427497673;597.6772542826825;7721.692357496802;7774.611269436506;7789.143194248628;7813.648385822652;7980.241877021674;538.4319542882218;548.1777333999001;557.6765476023896;563.5013013483097;572.5791543215734;3595.82020898954;3635.2729454109285;3709.350863598859;3759.3045286622064;3844.615538446189;48568;50616.24075638868;50834.237486437734;51945.740271298404;52126;44115;44630.33054504185;45143.322850157274;46798.29802552964;46959.53040469551;44136.77931610322;44679.55320446819;44757;44935.325970110476;44954.32568511475;8210.425270231026;8260.586970651564;8344.83310333802;8349.624266907882;8410.957945210235;29163.562546562243;29312.560311594916;29598.408031839674;30080.54879176858;30142;34562;37356.439653404675;38445.846624601305;38829.805850970566;39138;10941.671749847517;11196.160287978597;11447.25592836463;11475.942620286845;11523.193376463567;11928.165028447926;12208.633740987785;12807.423665934868;12889.226646401246;13012.349382531025;11036;11380.829287560859;11550.191486595857;11551.191416600757;11882.28706277626;11218.719532011439;11359.09127269833;11587.188896777145;11604.88395116038;11853.288802671867;11192.328460292083;11344.773104537699;11386.259893106922;11498.82751758741;11992.160548761503;9629.614815407305;9682.370645907993;9759.658411955548;9863.309568330147;10323.94838025805;9700.272479564203;9968.252381071303;10085.726681993594;10110.69667909964;10125 06:57:07 INFO - PROCESS | 8971 | __end_tp_report 06:57:07 INFO - PROCESS | 8971 | __start_cc_report 06:57:07 INFO - PROCESS | 8971 | _x_x_mozilla_cycle_collect,1005 06:57:07 INFO - PROCESS | 8971 | __end_cc_report 06:57:07 INFO - PROCESS | 8971 | __startTimestamp1463061427193__endTimestamp 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | ------- Summary: start ------- 06:57:07 INFO - PROCESS | 8971 | Number of tests: 6 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | [#0] dojo.html Cycles:165 Average:4675.15 Median:4780.57 stddev:499.04 (10.4%) stddev-sans-first:473.26 06:57:07 INFO - PROCESS | 8971 | Values: 2599.7 2603.9 2619.1 2642.8 2644.7 4623.0 4656.5 4681.9 4759.7 4799.6 4679.2 4679.6 4703.5 4736.6 4771.1 4293.1 4333.4 4383.6 4402.1 4489.9 4390.3 4430.3 4442.7 4453.5 4483.0 4205.1 4262.9 4344.1 4358.3 4379.8 4355.3 4356.3 4398.4 4411.4 4415.5 4383.4 4401.6 4403.3 4428.2 4440.8 4435.7 4635.6 4694.1 4698.9 4731.5 5085.3 5143.7 5157.1 5157.7 5160.6 5035.0 5155.1 5170.5 5189.7 5193.7 4730.2 4777.3 4780.6 4808.8 4845.6 5261.0 5281.8 5313.6 5314.7 5319.6 4874.5 4938.2 5018.8 5067.9 5073.1 5070.0 5097.6 5119.3 5158.1 5167.0 5054.4 5056.0 5057.9 5061.0 5109.9 4858.1 4953.2 5057.1 5063.1 5063.3 4337.0 4339.6 4354.5 4399.0 4404.1 3754.9 3757.1 3758.7 3788.4 3806.2 4193.5 4241.3 4356.0 4361.7 4393.2 4999.1 5032.2 5047.5 5065.6 5069.3 4321.1 4327.6 4333.9 4334.2 4368.8 4455.0 4548.5 4556.5 4556.6 4602.8 4580.8 4585.9 4588.9 4613.3 4627.4 5059.7 5094.4 5094.7 5095.0 5096.3 4411.2 4518.5 4530.6 4565.1 4583.1 4994.5 5029.5 5042.6 5048.1 5086.6 5092.8 5103.1 5106.8 5107.9 5159.4 4807.7 4837.2 4844.6 4957.0 4961.5 4843.9 4874.2 4888.6 4910.6 4928.2 4792.9 4804.2 4805.4 4853.9 4859.6 4716.5 4929.2 4936.8 4955.3 4966.9 4860.1 4863.6 4878.5 4880.1 4919.9 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | [#1] ext.html Cycles:180 Average:43718.34 Median:170132.23 stddev:74229.23 (43.6%) stddev-sans-first:74366.88 06:57:07 INFO - PROCESS | 8971 | Values: 603.2 605.4 612.3 617.1 624.9 27977.6 41031.6 41957.6 42087.6 42112.0 42173.4 42778.0 42802.4 42925.8 42958.6 7304.3 7878.4 8021.8 9914.0 10146.3 10048.5 10148.2 10152.0 10154.4 10162.0 10152.1 10186.1 10188.9 10193.9 10202.7 7509.7 9990.4 10173.5 10253.0 10602.3 10096.3 10110.4 10172.7 10174.6 10180.4 38540.4 38944.2 38978.2 39016.2 39034.6 3308.9 3329.7 3342.8 3437.8 3634.6 29877.7 29995.4 30063.8 30247.8 30325.7 3529.7 3567.9 3591.8 3647.0 3716.3 236019.0 236676.0 237041.0 237157.0 237787.0 34114.5 35142.1 35203.3 36938.6 54795.5 35845.6 35990.0 36009.6 36034.3 36148.0 12650.1 14111.4 14247.2 14248.3 14252.5 10981.4 11159.8 11213.6 11334.5 11337.5 8364.7 8367.7 8370.9 8429.6 8442.3 3283.3 3313.9 3321.3 3338.9 3347.5 918.7 947.3 969.5 1003.7 1028.0 28507.0 28642.0 29156.3 29179.0 29229.0 983.3 1031.6 1075.8 1085.9 1105.2 15096.6 15210.4 15274.2 15462.1 15666.1 333899.0 336917.0 337204.0 337785.0 337817.0 50756.2 51060.7 51075.5 51086.5 51137.2 1202.8 1205.0 1254.9 1316.5 1321.5 28583.3 29368.6 29698.3 29944.6 30020.2 43275.0 43314.1 43798.0 43914.8 43918.8 266797.0 267960.0 268359.0 268414.0 269577.0 23644.1 25818.7 26427.2 26512.7 28320.3 42713.0 43041.0 43289.0 43296.4 43837.6 35770.6 35956.8 36282.3 36744.6 37135.8 36097.3 36318.5 36489.5 36546.0 36663.6 35808.0 36148.3 36413.3 36631.3 36716.0 32846.7 37090.0 37540.8 37617.4 37829.8 25208.9 25771.5 25786.9 26110.6 26191.3 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | [#2] jquery.html Cycles:180 Average:25738.16 Median:430635.00 stddev:71108.34 (16.5%) stddev-sans-first:71282.32 06:57:07 INFO - PROCESS | 8971 | Values: 379.2 382.3 386.2 393.2 404.1 13411.7 14171.1 16110.0 17953.5 18006.7 16839.2 17060.8 17500.9 17518.7 18035.0 5062.8 5099.8 5277.4 5305.9 6073.4 6060.5 6096.8 6116.8 6144.3 6145.2 5877.9 6079.5 6110.8 6121.4 6125.7 5838.0 6020.4 6070.0 6083.2 6097.1 5291.6 5310.5 5312.2 5323.7 5357.0 20397.2 20532.6 20627.5 20901.6 20906.5 2070.7 2138.4 2297.4 2397.2 2553.0 13552.7 13555.5 13620.7 13624.5 13944.7 1791.9 1833.8 1851.2 1864.9 1896.9 67317.3 67440.7 68153.3 68891.0 69590.0 9563.6 9635.6 9836.9 9948.8 10134.9 11174.2 11939.9 13807.0 13821.7 13822.9 7382.1 7670.7 7682.7 7761.2 7899.9 7168.7 7193.4 7399.3 7419.4 7802.4 6231.3 6274.8 6290.4 6313.4 6324.0 1786.1 1821.2 1834.4 1869.4 1880.9 886.4 929.2 934.7 1060.2 1076.8 17340.2 17430.7 17454.1 17585.4 17936.4 851.9 911.6 939.3 951.1 953.7 9013.3 9260.9 9495.4 9548.8 9755.5 428412.0 429751.0 431519.0 434996.0 435243.0 81890.2 83272.0 83894.0 84399.6 85301.0 977.9 981.4 997.2 1005.6 1006.4 14476.3 14622.6 14633.6 14691.6 14995.1 24802.0 27393.5 33177.3 33819.0 34542.0 44710.8 50971.5 51053.2 51459.7 51676.0 7675.6 7954.4 7979.0 8053.5 8062.2 11346.9 11632.9 11725.8 12138.9 12176.2 10072.9 10221.5 10280.3 10591.7 10951.9 10264.7 10392.5 10431.2 10453.6 10557.3 10686.1 10790.7 10986.8 11013.3 11349.4 7937.8 8024.4 8136.9 8163.6 8208.5 9941.8 10624.2 10850.5 10852.9 10955.4 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | [#3] mootools.html Cycles:180 Average:5195.01 Median:5577.21 stddev:2899.42 (52.0%) stddev-sans-first:2892.61 06:57:07 INFO - PROCESS | 8971 | Values: 1278.6 1492.5 1509.8 1702.6 1875.3 6693.4 7438.1 7661.7 7675.9 7836.6 7595.3 7723.1 7766.9 7787.2 7787.4 1854.6 1899.3 1907.4 2197.6 2229.6 1932.0 2209.2 2266.8 2268.6 2289.6 2118.8 2127.5 2136.9 2138.6 2139.1 1719.6 2083.7 2085.3 2094.4 2096.0 2063.0 2120.9 2125.3 2132.8 2135.7 7397.0 7442.9 7455.2 7458.5 7459.3 4420.4 4521.0 4523.3 4529.3 4529.8 2719.7 2792.3 2929.5 2939.4 2941.3 864.6 881.3 892.9 899.4 913.4 10204.0 10226.1 10242.7 10254.0 10254.2 3953.6 4056.9 4135.8 4151.8 4159.5 8690.3 8758.1 8758.3 8778.2 8785.4 4514.9 4525.8 4529.1 4530.6 4532.0 3713.9 3943.3 4053.3 4183.3 4186.0 3613.9 3749.4 3791.6 3792.6 3794.1 1183.5 1198.5 1198.7 1207.0 1208.1 900.2 928.1 931.8 934.6 935.8 5578.0 5772.1 5814.2 5834.5 5984.7 920.6 944.3 966.8 974.1 977.7 3791.8 3838.2 3956.9 3996.4 4030.9 9434.8 9758.2 9833.9 9967.1 9983.6 9540.9 9798.6 9920.1 10057.1 10107.4 7316.6 7335.1 7342.0 7347.4 7360.2 5536.3 5547.6 5634.3 5676.3 5677.2 9246.9 9343.6 9358.8 9456.3 9482.3 9094.4 9410.5 9456.9 9578.6 9594.1 5453.3 5576.4 6278.6 6443.5 6592.4 7573.9 7861.9 7929.1 7953.0 7964.4 6986.9 7167.2 7211.5 7263.5 7300.5 6800.1 6829.8 6867.0 6928.1 7020.4 6661.7 6672.4 6717.3 6788.6 6789.2 4696.9 4785.9 4800.4 4844.1 4881.9 4910.4 4913.7 4918.9 4957.6 4986.3 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | [#4] prototype.html Cycles:180 Average:4201.14 Median:4692.53 stddev:1189.30 (25.3%) stddev-sans-first:1155.98 06:57:07 INFO - PROCESS | 8971 | Values: 297.2 308.5 313.3 314.0 320.0 4691.1 4783.2 4787.2 4788.6 4826.9 4617.9 4729.2 4768.5 4775.1 4792.0 3810.0 3812.7 3815.5 3822.6 3846.2 3657.4 3692.5 3825.5 3839.9 3856.9 3809.4 3819.6 3842.2 3855.9 3873.8 3829.9 3833.2 3844.5 3860.7 3865.9 3428.4 3432.2 3448.0 3449.7 3475.4 4489.6 4591.7 4596.4 4609.5 4617.4 4348.1 4349.5 4354.8 4366.0 4370.0 4971.9 4977.1 4980.6 5000.9 5017.4 3620.3 3671.3 3677.2 3677.9 3727.4 5218.9 5219.5 5231.6 5235.7 5237.4 3742.0 3766.2 3766.6 3789.5 3796.4 3744.7 3821.3 3843.8 3847.5 3850.8 4300.8 4328.2 4329.2 4341.4 4363.3 4990.3 5001.9 5020.8 5031.4 5041.6 1253.5 1300.2 1304.1 1306.6 1307.2 918.5 945.3 946.4 959.9 961.5 4397.2 4411.7 4425.8 4428.9 4430.9 4985.3 5134.8 5163.5 5181.9 5251.9 4475.3 4476.5 4503.9 4514.6 4531.6 2809.9 2813.6 2818.0 2822.2 2831.9 4601.8 4710.4 4711.4 4739.3 4753.9 5255.7 5335.5 5369.0 5378.6 5391.0 4661.0 4680.4 4682.2 4694.0 4720.6 4987.4 5195.9 5214.0 5225.7 5230.4 5106.4 5131.2 5136.5 5144.7 5149.6 4703.2 4722.5 4738.4 4752.0 4762.3 3521.7 3720.0 3733.3 3750.1 3754.0 5154.4 5155.5 5157.1 5180.2 5197.2 5028.7 5040.7 5066.2 5070.3 5091.4 4783.4 4836.5 5066.4 5078.8 5084.3 4892.3 4974.2 5022.3 5036.6 5043.8 5114.7 5117.6 5121.0 5165.6 5177.0 4847.4 5003.5 5007.9 5019.2 5057.3 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - PROCESS | 8971 | [#5] yui.html Cycles:180 Average:12854.25 Median:22940.56 stddev:14137.52 (61.6%) stddev-sans-first:14147.78 06:57:07 INFO - PROCESS | 8971 | Values: 714.0 816.8 821.7 829.7 831.3 12667.2 13273.7 13398.5 13462.2 13544.0 12545.4 12554.2 12568.9 12575.3 12589.4 678.1 836.1 868.9 873.2 875.2 872.4 875.5 879.6 880.5 882.2 915.8 916.3 917.8 917.8 918.3 706.1 885.9 910.6 911.2 912.3 669.7 670.8 670.9 671.0 671.6 12186.0 12263.4 12265.8 12309.9 12334.4 12005.9 12402.2 12426.7 12488.4 12491.9 10759.5 10821.0 10958.8 11356.5 11398.1 4038.6 4094.6 4100.7 4141.5 4229.5 41739.6 42335.8 43096.6 44120.0 44528.6 9934.6 9989.1 10003.8 10067.2 10079.8 17407.4 17514.6 17562.8 17653.6 17712.6 6462.9 6672.1 6700.2 6726.7 6871.6 3793.7 3818.9 3851.0 3927.5 3928.6 2641.8 2747.4 2747.6 2750.1 2758.3 538.8 549.6 554.1 558.1 560.6 533.8 572.2 584.2 592.3 597.7 7721.7 7774.6 7789.1 7813.6 7980.2 538.4 548.2 557.7 563.5 572.6 3595.8 3635.3 3709.4 3759.3 3844.6 48568.0 50616.2 50834.2 51945.7 52126.0 44115.0 44630.3 45143.3 46798.3 46959.5 44136.8 44679.6 44757.0 44935.3 44954.3 8210.4 8260.6 8344.8 8349.6 8411.0 29163.6 29312.6 29598.4 30080.5 30142.0 34562.0 37356.4 38445.8 38829.8 39138.0 10941.7 11196.2 11447.3 11475.9 11523.2 11928.2 12208.6 12807.4 12889.2 13012.3 11036.0 11380.8 11550.2 11551.2 11882.3 11218.7 11359.1 11587.2 11604.9 11853.3 11192.3 11344.8 11386.3 11498.8 11992.2 9629.6 9682.4 9759.7 9863.3 10323.9 9700.3 9968.3 10085.7 10110.7 10125.0 06:57:07 INFO - PROCESS | 8971 | -------- Summary: end -------- 06:57:07 INFO - PROCESS | 8971 | 06:57:07 INFO - TEST-INFO | 8971: exit 0 06:57:07 INFO - TEST-OK | dromaeo_css | took 1118966ms 06:57:07 INFO - TEST-START | kraken 06:57:07 INFO - operating with platform_type : linux_ 06:57:07 INFO - Initialising browser for kraken test... 06:57:07 INFO - TEST-INFO | started process 9147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3jY_ys/profile http://localhost:33551/getInfo.html) 06:57:12 INFO - PROCESS | 9147 | __metrics Screen width/height:1600/1200 06:57:12 INFO - PROCESS | 9147 | colorDepth:24 06:57:12 INFO - PROCESS | 9147 | Browser inner width/height: 1024/697 06:57:12 INFO - PROCESS | 9147 | __metrics 06:57:13 ERROR - PROCESS | 9147 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:57:14 INFO - TEST-INFO | 9147: exit 0 06:57:14 INFO - Browser initialized. 06:57:14 INFO - Running cycle 1/1 for kraken test... 06:57:14 INFO - TEST-INFO | started process 9225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3jY_ys/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:26 INFO - PROCESS | 9225 | RSS: Main: 154435584 06:57:26 INFO - PROCESS | 9225 | 06:57:28 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33551/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:29 INFO - PROCESS | 9225 | RSS: Main: 210391040 06:57:29 INFO - PROCESS | 9225 | 06:57:32 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33551/tests/kraken/driver.html?testName=audio-dft) 06:57:33 INFO - PROCESS | 9225 | RSS: Main: 197681152 06:57:33 INFO - PROCESS | 9225 | 06:57:36 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33551/tests/kraken/driver.html?testName=audio-fft) 06:57:37 INFO - PROCESS | 9225 | RSS: Main: 267505664 06:57:37 INFO - PROCESS | 9225 | 06:57:39 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33551/tests/kraken/driver.html?testName=audio-oscillator) 06:57:39 INFO - PROCESS | 9225 | RSS: Main: 176267264 06:57:39 INFO - PROCESS | 9225 | 06:57:42 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:42 INFO - PROCESS | 9225 | RSS: Main: 180355072 06:57:42 INFO - PROCESS | 9225 | 06:57:46 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33551/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:46 INFO - PROCESS | 9225 | RSS: Main: 216424448 06:57:46 INFO - PROCESS | 9225 | 06:57:50 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33551/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:51 INFO - PROCESS | 9225 | RSS: Main: 214970368 06:57:51 INFO - PROCESS | 9225 | 06:57:54 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33551/tests/kraken/driver.html?testName=json-parse-financial) 06:57:54 INFO - PROCESS | 9225 | RSS: Main: 215293952 06:57:54 INFO - PROCESS | 9225 | 06:57:56 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:57 INFO - PROCESS | 9225 | RSS: Main: 204836864 06:57:57 INFO - PROCESS | 9225 | 06:57:59 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:59 INFO - PROCESS | 9225 | RSS: Main: 208076800 06:57:59 INFO - PROCESS | 9225 | 06:58:02 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:02 INFO - PROCESS | 9225 | RSS: Main: 218681344 06:58:02 INFO - PROCESS | 9225 | 06:58:05 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:06 INFO - PROCESS | 9225 | RSS: Main: 224169984 06:58:06 INFO - PROCESS | 9225 | 06:58:09 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:10 INFO - PROCESS | 9225 | RSS: Main: 221487104 06:58:10 INFO - PROCESS | 9225 | 06:58:11 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33551/tests/kraken/driver.html?testName=ai-astar) 06:58:12 INFO - PROCESS | 9225 | RSS: Main: 267128832 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | __start_tp_report 06:58:12 INFO - PROCESS | 9225 | _x_x_mozilla_page_load 06:58:12 INFO - PROCESS | 9225 | _x_x_mozilla_page_load_details 06:58:12 INFO - PROCESS | 9225 | |i|pagename|runs| 06:58:12 INFO - PROCESS | 9225 | |0;ai-astar;116;112;114;114;114;114;114;114;114;120 06:58:12 INFO - PROCESS | 9225 | |1;audio-beat-detection;168;134;159;214;132;158;159;131;193;136 06:58:12 INFO - PROCESS | 9225 | |2;audio-dft;161;160;161;161;163;161;161;160;160;160 06:58:12 INFO - PROCESS | 9225 | |3;audio-fft;77;78;76;147;75;75;76;75;139;75 06:58:12 INFO - PROCESS | 9225 | |4;audio-oscillator;93;93;150;94;94;93;128;101;94;120 06:58:12 INFO - PROCESS | 9225 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;117;116;117 06:58:12 INFO - PROCESS | 9225 | |6;imaging-darkroom;145;145;145;145;145;146;146;145;146;146 06:58:12 INFO - PROCESS | 9225 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 06:58:12 INFO - PROCESS | 9225 | |8;json-parse-financial;68;67;68;67;66;67;66;128;65;65 06:58:12 INFO - PROCESS | 9225 | |9;json-stringify-tinderbox;63;64;64;64;64;65;64;65;65;64 06:58:12 INFO - PROCESS | 9225 | |10;stanford-crypto-aes;83;84;83;82;83;84;84;84;88;83 06:58:12 INFO - PROCESS | 9225 | |11;stanford-crypto-ccm;133;131;136;134;129;145;132;132;219;136 06:58:12 INFO - PROCESS | 9225 | |12;stanford-crypto-pbkdf2;173;173;174;171;176;174;174;178;172;173 06:58:12 INFO - PROCESS | 9225 | |13;stanford-crypto-sha256-iterative;68;72;67;71;68;68;69;67;66;66 06:58:12 INFO - PROCESS | 9225 | __end_tp_report 06:58:12 INFO - PROCESS | 9225 | __start_cc_report 06:58:12 INFO - PROCESS | 9225 | _x_x_mozilla_cycle_collect,2113 06:58:12 INFO - PROCESS | 9225 | __end_cc_report 06:58:12 INFO - PROCESS | 9225 | __startTimestamp1463061492106__endTimestamp 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | ------- Summary: start ------- 06:58:12 INFO - PROCESS | 9225 | Number of tests: 14 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:2.12 (1.9%) stddev-sans-first:2.19 06:58:12 INFO - PROCESS | 9225 | Values: 116.0 112.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 120.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#1] audio-beat-detection Cycles:10 Average:158.40 Median:159.00 stddev:27.74 (17.4%) stddev-sans-first:29.21 06:58:12 INFO - PROCESS | 9225 | Values: 168.0 134.0 159.0 214.0 132.0 158.0 159.0 131.0 193.0 136.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:58:12 INFO - PROCESS | 9225 | Values: 161.0 160.0 161.0 161.0 163.0 161.0 161.0 160.0 160.0 160.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#3] audio-fft Cycles:10 Average:89.30 Median:75.50 stddev:28.38 (37.6%) stddev-sans-first:29.75 06:58:12 INFO - PROCESS | 9225 | Values: 77.0 78.0 76.0 147.0 75.0 75.0 76.0 75.0 139.0 75.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:19.94 (21.4%) stddev-sans-first:20.59 06:58:12 INFO - PROCESS | 9225 | Values: 93.0 93.0 150.0 94.0 94.0 93.0 128.0 101.0 94.0 120.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 06:58:12 INFO - PROCESS | 9225 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:58:12 INFO - PROCESS | 9225 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:58:12 INFO - PROCESS | 9225 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#8] json-parse-financial Cycles:10 Average:72.70 Median:67.00 stddev:19.46 (29.0%) stddev-sans-first:20.57 06:58:12 INFO - PROCESS | 9225 | Values: 68.0 67.0 68.0 67.0 66.0 67.0 66.0 128.0 65.0 65.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 06:58:12 INFO - PROCESS | 9225 | Values: 63.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.62 (1.9%) stddev-sans-first:1.69 06:58:12 INFO - PROCESS | 9225 | Values: 83.0 84.0 83.0 82.0 83.0 84.0 84.0 84.0 88.0 83.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:135.00 stddev:27.16 (20.1%) stddev-sans-first:28.58 06:58:12 INFO - PROCESS | 9225 | Values: 133.0 131.0 136.0 134.0 129.0 145.0 132.0 132.0 219.0 136.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:1.99 (1.1%) stddev-sans-first:2.09 06:58:12 INFO - PROCESS | 9225 | Values: 173.0 173.0 174.0 171.0 176.0 174.0 174.0 178.0 172.0 173.0 06:58:12 INFO - PROCESS | 9225 | 06:58:12 INFO - PROCESS | 9225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.99 (2.9%) stddev-sans-first:2.11 06:58:12 INFO - PROCESS | 9225 | Values: 68.0 72.0 67.0 71.0 68.0 68.0 69.0 67.0 66.0 66.0 06:58:12 INFO - PROCESS | 9225 | -------- Summary: end -------- 06:58:12 INFO - PROCESS | 9225 | 06:58:13 INFO - TEST-INFO | 9225: exit 0 06:58:13 INFO - TEST-OK | kraken | took 65327ms 06:58:13 INFO - SUITE-END | took 1184s 06:58:13 INFO - Completed test suite (00:19:44) 06:58:13 INFO - javascript benchmark 06:58:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.71403145654, 2603.8958441662335, 2619.070230068325, 2642.775364094051, 2644.6694163229595, 4623.0, 4656.5110663380365, 4681.929771053433, 4759.6668233223645, 4799.640026997971, 4679.204535229011, 4679.578837904588, 4703.459102203247, 4736.5500277473675, 4771.069641419925, 4293.119910418364, 4333.393324934512, 4383.627391671712, 4402.1195760847795, 4489.865304040868, 4390.297552391618, 4430.313301438282, 4442.711223770445, 4453.465584129909, 4483.0, 4205.0748835256345, 4262.893427664302, 4344.087741574242, 4358.3244597087505, 4379.75911324877, 4355.346697995295, 4356.346548017791, 4398.428204333448, 4411.382406463098, 4415.470143582758, 4383.364412160251, 4401.559844015573, 4403.339499075132, 4428.158649856549, 4440.777961101964, 4435.68950173488, 4635.629149668019, 4694.08465349257, 4698.929516057262, 4731.479537250934, 5085.338905942241, 5143.665661731976, 5157.097507936133, 5157.690538567698, 5160.638755287131, 5035.0, 5155.149400348938, 5170.482951704837, 5189.740512974374, 5193.740312984373, 4730.2431610942085, 4777.307290442866, 4780.569748722632, 4808.759562021885, 4845.563899249085, 5260.9736951315, 5281.841544753664, 5313.601479889024, 5314.73426328682, 5319.627626066138, 4874.512548745097, 4938.209886418156, 5018.824341148115, 5067.923981140286, 5073.1122053640465, 5069.974650126799, 5097.592192624581, 5119.308893299357, 5158.148905430637, 5167.044096842096, 5054.444011158769, 5055.974720126449, 5057.8735531612, 5061.038402703474, 5109.897802043938, 4858.125537403231, 4953.2074868020945, 5057.115004874132, 5063.139266324733, 5063.265826455144, 4337.024169561886, 4339.609435150852, 4354.455693038371, 4399.0, 4404.0971600822395, 3754.887353379403, 3757.0607348162957, 3758.7180961428003, 3788.412796016622, 3806.200697853482, 4193.496780386312, 4241.321388577812, 4356.019895523482, 4361.716488428306, 4393.231184542692, 4999.100161970808, 5032.169692000779, 5047.520485553867, 5065.645404821627, 5069.264956581349, 4321.114171594815, 4327.6321512671775, 4333.904460285001, 4334.1548398062705, 4368.847090351823, 4455.0, 4548.522405147478, 4556.476005259371, 4556.567126123013, 4602.769861506911, 4580.816767329269, 4585.908281834278, 4588.862334129982, 4613.261878099488, 4627.3521706961055, 5059.696418214919, 5094.414142373675, 5094.668846525113, 5095.0, 5096.337476128079, 4411.228035093782, 4518.457785065813, 4530.61489773373, 4565.086982603426, 4583.083383323416, 4994.525520075587, 5029.5221953914315, 5042.621803364689, 5048.091343558195, 5086.593072554113, 5092.796288148433, 5103.10695628271, 5106.821261255986, 5107.872303192301, 5159.432462429205, 4807.663463557517, 4837.2260438329695, 4844.636652251166, 4956.950430495649, 4961.5286547777905, 4843.854684359475, 4874.195757700081, 4888.58447031992, 4910.607151427806, 4928.186849169991, 4792.856214313576, 4804.183288840835, 4805.4233491979785, 4853.9029219416125, 4859.562639362474, 4716.457607375196, 4929.211326187793, 4936.802527898843, 4955.331030311006, 4966.900661986812, 4860.1251774680895, 4863.586595139453, 4878.512148785093, 4880.145974454527, 4919.926201106915], "value": 4642.896867476976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.1826874584938, 605.3552966091113, 612.2591664086456, 617.0805499805291, 624.9375062493748, 27977.58033629495, 41031.58968410315, 41957.580424195825, 42087.57912420875, 42112.0, 42173.367399489034, 42778.0, 42802.35796463056, 42925.7853710731, 42958.57041429585, 7304.3426091651745, 7878.4485086044, 8021.799455013642, 9914.0, 10146.340487868301, 10048.547815348327, 10148.238882083837, 10152.0, 10154.39073655583, 10162.0, 10152.086312231897, 10186.083252507273, 10188.949055254714, 10193.949030254838, 10202.693919182437, 7509.737159199429, 9990.350627209207, 10173.491325433773, 10253.0, 10602.310849794816, 10096.29325947184, 10110.44392558409, 10172.745681357952, 10174.643887463977, 10180.38917664935, 38540.42189367134, 38944.22111557753, 38978.220435591415, 39016.21967560661, 39034.609653903666, 3308.933821323584, 3329.7336213103135, 3342.8495717692763, 3437.8281085945605, 3634.6365363463706, 29877.70122298771, 29995.40009199804, 30063.849680751675, 30247.848760756056, 30325.69674303251, 3529.7176225901867, 3567.8572857085687, 3591.838367273479, 3646.981765091184, 3716.3310604091253, 236019.0, 236676.0, 237040.99999999828, 237157.0, 237787.0, 34114.48828267578, 35142.12144696403, 35203.29593408117, 36938.630613693516, 54795.45204547983, 35845.64154358475, 35990.0, 36009.639903600626, 36034.279314413565, 36148.0, 12650.114491985656, 14111.435542578387, 14247.21640309793, 14248.287585620885, 14252.501162459264, 10981.39602321864, 11159.776804464027, 11213.55145794159, 11334.489947952361, 11337.489812958436, 8364.749057528285, 8367.748967530984, 8370.874436883452, 8429.578521073921, 8442.282405995436, 3283.2612662150823, 3313.9005829825146, 3321.30252646942, 3338.8998330050135, 3347.4644056951256, 918.7060140754894, 947.2895328503622, 969.5007071358256, 1003.7189586915675, 1028.0028372478685, 28507.0, 28642.0, 29156.271093222414, 29179.0, 29229.0, 983.331334692416, 1031.5976769060073, 1075.763332066944, 1085.8588383510094, 1105.2318638546294, 15096.622584435258, 15210.391584336723, 15274.159921204218, 15462.072275663497, 15666.13836238995, 333899.0, 336917.0, 337204.0, 337785.0, 337817.0, 50756.238656419446, 51060.744696276284, 51075.48924510782, 51086.48913510892, 51137.23294150591, 1202.8496437945257, 1204.9698757531132, 1254.85569159546, 1316.5128902305826, 1321.4912258780246, 28583.28541786472, 29368.559471607514, 29698.257543561584, 29944.550831737975, 30020.24949376283, 43275.0, 43314.133717326105, 43798.0, 43914.78042609766, 43918.780406097765, 266797.0, 267960.0, 268359.0, 268414.0, 269577.0, 23644.054237830293, 25818.741812582386, 26427.207183784518, 26512.734872651028, 28320.291992700346, 42713.0, 43041.0, 43289.0, 43296.350554742334, 43837.56162438335, 35770.642293577774, 35956.820215898755, 36282.274354512236, 36744.63255367412, 37135.81432092822, 36097.27805443929, 36318.455223172205, 36489.452658209615, 36546.0, 36663.63336366602, 35808.0, 36148.27703445969, 36413.27173456569, 36631.26737465183, 36716.0, 32846.6570927078, 37090.0, 37540.81229593835, 37617.4357384634, 37829.81085094557, 25208.873955630104, 25771.484570308865, 25786.8710656453, 26110.60834087452, 26191.345216369744], "value": 17246.88640084489, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.2025797718813, 382.33282921302333, 386.1678083729563, 393.1704104339842, 404.0726532607665, 13411.731765364711, 14171.149731016121, 16110.0, 17953.46139615812, 18006.72989905151, 16839.158042097875, 17060.82939170608, 17500.94994300343, 17518.737218941726, 18035.0, 5062.797488100471, 5099.796008159669, 5277.445868183843, 5305.867353316179, 6073.392660733935, 6060.454559089681, 6096.817095487142, 6116.816495505142, 6144.324124346318, 6145.201123853915, 5877.8824423511505, 6079.4528492435675, 6110.847228819271, 6121.387861213865, 6125.663088530129, 5837.970810145922, 6020.397960203988, 6069.969650151743, 6083.17877086592, 6097.085437184413, 5291.550218231455, 5310.522053015247, 5312.203169524602, 5323.707196104213, 5356.9732151339385, 20397.184112635478, 20532.58934821295, 20627.48431289215, 20901.581968360548, 20906.477338066517, 2070.730804995356, 2138.4226258910007, 2297.4371279036577, 2397.1609936522077, 2552.974470255292, 13552.728945421135, 13555.457781688721, 13620.659483512893, 13624.523141689993, 13944.651383715387, 1791.9193636286398, 1833.761610990576, 1851.2224865556498, 1864.9347272845384, 1896.933607323737, 67317.32682673208, 67440.6627966857, 68153.31846681569, 68890.96663550101, 69590.0, 9563.61745530171, 9635.56639951204, 9836.901630983599, 9948.80102397948, 10134.949325253327, 11174.161937854693, 11939.88060119405, 13807.0, 13821.723565528633, 13822.861771382157, 7382.1141463023705, 7670.693172273047, 7682.7311044113185, 7761.223877612194, 7899.921000790034, 7168.749093781797, 7193.388561972291, 7399.334059934524, 7419.369353605004, 7802.414818888606, 6231.2522497300615, 6274.780382686584, 6290.402411770874, 6313.40022697843, 6323.9683801580695, 1786.1426515272742, 1821.2350812658715, 1834.4313262888547, 1869.3737597904583, 1880.9059547022869, 886.4326830828275, 929.1916033051289, 934.6822080492665, 1060.204846365226, 1076.8438576406377, 17340.219690113976, 17430.65138697219, 17454.12729363527, 17585.384511542034, 17936.372226971995, 851.9275861551714, 911.5670056723003, 939.3471537281661, 951.0869565217331, 953.6519170502717, 9013.324000699973, 9260.861087083698, 9495.38280011797, 9548.761280967892, 9755.512224388753, 428412.0, 429751.0, 431519.0, 434996.0, 435243.0, 81890.18109818945, 83272.0, 83894.0, 84399.57800211082, 85301.0, 977.8924318324979, 981.4454833019321, 997.1972562087444, 1005.5575546759549, 1006.436395618456, 14476.270081744718, 14622.561323160322, 14633.560993170222, 14691.632709182357, 14995.100293982396, 24802.02660921939, 27393.452130957667, 33177.33645327128, 33819.0, 34541.963741087806, 44710.77644611756, 50971.490285096676, 51053.23420148775, 51459.74270128625, 51676.0, 7675.577843218676, 7954.403419743427, 7978.962734844433, 8053.516788992679, 8062.234087761653, 11346.886531134913, 11632.88367116352, 11725.765484690088, 12138.878611213775, 12176.208546444454, 10072.949635251776, 10221.488925553842, 10280.331778434378, 10591.735206619896, 10951.890481095086, 10264.692059238234, 10392.532336045047, 10431.165506759593, 10453.581856725647, 10557.260991730813, 10686.145108391154, 10790.73023174427, 10986.780264394827, 11013.339199648046, 11349.432528373383, 7937.841243174988, 8024.39817013738, 8136.87794683092, 8163.551004694798, 8208.507489550646, 9941.801163976825, 10624.203184761329, 10850.511726972147, 10852.945735271589, 10955.397453140155], "value": 8652.164903369754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.6355888571748, 1492.4850926430381, 1509.8112735908012, 1702.6084000679843, 1875.2873907914998, 6693.431058360039, 7438.107427108748, 7661.731839385623, 7675.884861727079, 7836.568988705619, 7595.316421522062, 7723.073231212263, 7766.883496747553, 7787.221277872224, 7787.415943804223, 1854.6383455226237, 1899.3447260695107, 1907.3610340535938, 2197.63738983068, 2229.598672238996, 1932.0436383989945, 2209.1826024371007, 2266.7733226677283, 2268.5689718953345, 2289.610766169755, 2118.7775283595233, 2127.4681329667583, 2136.935891923237, 2138.615049291127, 2139.144342263092, 1719.6388758360758, 2083.718697975769, 2085.3326935380683, 2094.4030951178843, 2096.0253482130884, 2063.0, 2120.9151633934625, 2125.3305208859315, 2132.818710409617, 2135.6582946728604, 7396.963015184943, 7442.925570744277, 7455.2172021938, 7458.477906546544, 7459.254074592552, 4420.403245561873, 4521.005378816655, 4523.344115103291, 4529.32060190974, 4529.773511324421, 2719.6736391632935, 2792.3019245188702, 2929.5312749959903, 2939.4415061138316, 2941.2940894185454, 864.606603995187, 881.3257857738835, 892.87941139793, 899.3839220134164, 913.4017218721748, 10203.979602039812, 10226.130778883804, 10242.692719218436, 10254.0, 10254.230932680079, 3953.584873588289, 4056.918861622751, 4135.82129093207, 4151.813168407429, 4159.500859896832, 8690.26132778721, 8758.12418758119, 8758.2993360531, 8778.166074222938, 8785.428947118417, 4514.932276015862, 4525.751083690363, 4529.139463501924, 4530.569595888385, 4532.0, 3713.9442908356395, 3943.3493473577114, 4053.310937140634, 4183.309753890574, 4186.0, 3613.8915832525067, 3749.362608356586, 3791.601881802371, 3792.563855156637, 3794.127350709297, 1183.46743965216, 1198.5445530698278, 1198.7183011992174, 1206.975860482803, 1208.1060015588578, 900.1718419054355, 928.1043792740038, 931.8322701913721, 934.6121359635811, 935.8228813179219, 5578.0, 5772.076467765138, 5814.244148260699, 5834.533237341087, 5984.700764961734, 920.6041402196986, 944.2681921510884, 966.7583104223944, 974.1232890398697, 977.7360112769654, 3791.810409479515, 3838.1556057667267, 3956.8812935611977, 3996.4005399189773, 4030.919381612351, 9434.764130896783, 9758.17055550272, 9833.852492212622, 9967.10296073357, 9983.600655973825, 9540.856887146698, 9798.559064842098, 9920.057594528509, 10057.094861462358, 10107.444090575089, 7316.561006339637, 7335.1197856257595, 7342.0, 7347.412207023533, 7360.1535823381, 5536.335639723259, 5547.583931205095, 5634.295713035871, 5676.347220069745, 5677.233573467529, 9246.861297080415, 9343.579538920902, 9358.766030849283, 9456.2907781918, 9482.336236463381, 9094.363394562317, 9410.482423466776, 9456.858147127661, 9578.616855325708, 9594.136527712539, 5453.291072160594, 5576.414476479911, 6278.560500764903, 6443.548951573345, 6592.373724496165, 7573.9242607575425, 7861.882071768814, 7929.088154862265, 7953.0456345238945, 7964.442489025712, 6986.860262794818, 7167.247439018828, 7211.531250468703, 7263.491555591269, 7300.525465844703, 6800.115984921928, 6829.795106146824, 6866.965665171842, 6928.064711263914, 7020.368166865007, 6661.733530658719, 6672.399484046459, 6717.261101278953, 6788.59268443895, 6789.15135608049, 4696.906061878812, 4785.856424307276, 4800.4479484859685, 4844.128056949642, 4881.90236195267, 4910.43529994041, 4913.680610760289, 4918.92621610669, 4957.578605818546, 4986.276989836526], "value": 4189.867553217037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1990485641198, 308.5110100490722, 313.306027149863, 313.9623245210575, 320.00159502352665, 4691.085238378518, 4783.210770222909, 4787.2340425531875, 4788.569028787409, 4826.927596086057, 4617.884552886179, 4729.172394830908, 4768.54698803614, 4775.14047471455, 4791.976040119804, 3809.9619003809885, 3812.65686088252, 3815.465834783133, 3822.57951625321, 3846.2115266370465, 3657.4330978698345, 3692.48305237267, 3825.5026846509913, 3839.9040023999346, 3856.9421458678144, 3809.4190910771995, 3819.6058438669825, 3842.1547259602844, 3855.903602409934, 3873.845046198149, 3829.8659546915865, 3833.1758671885677, 3844.5390751514246, 3860.7104467165077, 3865.8646947356706, 3428.4286784911314, 3432.2277487565348, 3447.9655203448146, 3449.689527942497, 3475.3570589441033, 4489.577235611032, 4591.678582499227, 4596.35651008859, 4609.516000819933, 4617.37665415168, 4348.130373925196, 4349.456317960255, 4354.7604881731495, 4365.995820961165, 4370.0, 4971.925421118686, 4977.054359671687, 4980.576650984671, 5000.924986125175, 5017.422996355429, 3620.294042661682, 3671.2657468506404, 3677.191017976041, 3677.8528858845616, 3727.4222495512968, 5218.895622087575, 5219.451957544441, 5231.581473482112, 5235.712035838027, 5237.371515418136, 3741.9625803741615, 3766.227923275722, 3766.5856755756845, 3789.5073640427117, 3796.411556208737, 3744.681702055356, 3821.2548553031893, 3843.8078096095082, 3847.461355410245, 3850.7689538627774, 4300.817275249331, 4328.199283132631, 4329.19909816685, 4341.413909122228, 4363.3018717005125, 4990.30135780991, 5001.89996200074, 5020.7740651670765, 5031.4465408805, 5041.621878359138, 1253.523661008811, 1300.2393599744066, 1304.1262354222692, 1306.6080175947368, 1307.1568838099372, 918.4581097152712, 945.3146468810057, 946.3612061858219, 959.8560215967522, 961.5288608428975, 4397.2085024695225, 4411.735295882193, 4425.800838962255, 4428.889277768081, 4430.911381772346, 4985.326980857611, 5134.845954621367, 5163.476774351575, 5181.870453238624, 5251.921221181686, 4475.328700694857, 4476.529964353761, 4503.932441013388, 4514.61625761814, 4531.592156705847, 2809.918181500137, 2813.6482939632547, 2818.0418657656496, 2822.195674232834, 2831.929201769931, 4601.792919318638, 4710.36410084641, 4711.411073615798, 4739.336492890998, 4753.857384278477, 5255.710935898486, 5335.466453354634, 5369.006733754268, 5378.57467771041, 5390.97304513475, 4661.016949152545, 4680.4149481314835, 4682.227432473604, 4693.9765301173275, 4720.551547602972, 4987.351644286219, 5195.948040519546, 5214.0, 5225.6603320784025, 5230.398504172069, 5106.361704786902, 5131.179011358165, 5136.460671629425, 5144.6913185209005, 5149.588032957279, 4703.176944034712, 4722.48052714208, 4738.407699037621, 4752.049590082067, 4762.309465127606, 3521.683048525645, 3719.9628003719617, 3733.272011957642, 3750.0999760057935, 3753.9624603753614, 5154.355705536808, 5155.484451554815, 5157.149070403491, 5180.248863914787, 5197.22041693749, 5028.673136246132, 5040.672356296829, 5066.164082926276, 5070.3155074064525, 5091.389033316026, 4783.402074740658, 4836.46798852119, 5066.41736200327, 5078.822241221539, 5084.339035925306, 4892.290617860462, 4974.204127339608, 5022.347094877789, 5036.647434679684, 5043.84868453947, 5114.667546609458, 5117.61617878668, 5121.001404726043, 5165.638405311743, 5176.9741151294, 4847.418309802846, 5003.524665156804, 5007.899842003212, 5019.247112932943, 5057.342545469065], "value": 3831.037872113978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9750108746194, 816.8121332093622, 821.6549049399248, 829.7303376402667, 831.3390854270858, 12667.239965602059, 13273.734525309488, 13398.531051413203, 13462.192268463887, 13544.0, 12545.435455404506, 12554.183978041421, 12568.874311256885, 12575.308358040327, 12589.370531473412, 678.0845858091586, 836.0803116571752, 868.9044205137415, 873.1530415496958, 875.2210532625968, 872.4285592936636, 875.4528419737663, 879.6129702930722, 880.4629176202511, 882.1531329923281, 915.8397280475923, 916.2669864108719, 917.7934964632971, 917.8439665256923, 918.347972939214, 706.1279320039747, 885.8538341173698, 910.6129894794685, 911.2254583603884, 912.2519533982137, 669.7153709673418, 670.8188789026984, 670.9094272273229, 671.0102598666977, 671.6104659297645, 12186.0, 12263.386830658432, 12265.816012759815, 12309.93845030778, 12334.444949977273, 12005.879941200563, 12402.19385739924, 12426.689332766662, 12488.375581220902, 12491.949148343765, 10759.515821788038, 10821.0, 10958.835617465744, 11356.48895799691, 11398.145139114516, 4038.5557588665224, 4094.5905409459115, 4100.7334523256195, 4141.544430112685, 4229.471316085489, 41739.582604174175, 42335.7883210582, 43096.56903430988, 44120.0, 44528.55471445244, 9934.602615895283, 9989.100980911608, 10003.849942250872, 10067.244956628283, 10079.798404032024, 17407.390741323994, 17514.562135946704, 17562.824371756375, 17653.646927061644, 17712.55718607045, 6462.903056454157, 6672.099266599044, 6700.229473610597, 6726.697298621574, 6871.553349032397, 3793.6585707285926, 3818.866339678098, 3850.9807450962567, 3927.5286965564314, 3928.64642182205, 2641.7886569074426, 2747.3543717226435, 2747.587861820743, 2750.0787236276074, 2758.3379988802944, 538.7925648625308, 549.631746729692, 554.0885243773969, 558.1488230448598, 560.5879678436346, 533.8291746641115, 572.2290698307614, 584.2375699711832, 592.3040427497673, 597.6772542826825, 7721.692357496802, 7774.611269436506, 7789.143194248628, 7813.648385822652, 7980.241877021674, 538.4319542882218, 548.1777333999001, 557.6765476023896, 563.5013013483097, 572.5791543215734, 3595.82020898954, 3635.2729454109285, 3709.350863598859, 3759.3045286622064, 3844.615538446189, 48568.0, 50616.24075638868, 50834.237486437734, 51945.740271298404, 52126.0, 44115.0, 44630.33054504185, 45143.322850157274, 46798.29802552964, 46959.53040469551, 44136.77931610322, 44679.55320446819, 44757.0, 44935.325970110476, 44954.32568511475, 8210.425270231026, 8260.586970651564, 8344.83310333802, 8349.624266907882, 8410.957945210235, 29163.562546562243, 29312.560311594916, 29598.408031839674, 30080.54879176858, 30142.0, 34562.0, 37356.439653404675, 38445.846624601305, 38829.805850970566, 39138.0, 10941.671749847517, 11196.160287978597, 11447.25592836463, 11475.942620286845, 11523.193376463567, 11928.165028447926, 12208.633740987785, 12807.423665934868, 12889.226646401246, 13012.349382531025, 11036.0, 11380.829287560859, 11550.191486595857, 11551.191416600757, 11882.28706277626, 11218.719532011439, 11359.09127269833, 11587.188896777145, 11604.88395116038, 11853.288802671867, 11192.328460292083, 11344.773104537699, 11386.259893106922, 11498.82751758741, 11992.160548761503, 9629.614815407305, 9682.370645907993, 9759.658411955548, 9863.309568330147, 10323.94838025805, 9700.272479564203, 9968.252381071303, 10085.726681993594, 10110.69667909964, 10125.0], "value": 6113.625930990178, "unit": "score"}], "name": "dromaeo_css", "value": 6388.73492349217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 120.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 134.0, 159.0, 214.0, 132.0, 158.0, 159.0, 131.0, 193.0, 136.0], "value": 158.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 161.0, 160.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 147.0, 75.0, 75.0, 76.0, 75.0, 139.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 94.0, 94.0, 93.0, 128.0, 101.0, 94.0, 120.0], "value": 106.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 66.0, 128.0, 65.0, 65.0], "value": 72.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 82.0, 83.0, 84.0, 84.0, 84.0, 88.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 136.0, 134.0, 129.0, 145.0, 132.0, 132.0, 219.0, 136.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 174.0, 171.0, 176.0, 174.0, 174.0, 178.0, 172.0, 173.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 67.0, 71.0, 68.0, 68.0, 69.0, 67.0, 66.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1591.6, "alertThreshold": 2.0}]} 06:58:13 INFO - Return code: 0 06:58:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:58:13 ERROR - # TBPL SUCCESS # 06:58:13 INFO - Running post-action listener: _resource_record_post_action 06:58:13 INFO - ##### 06:58:13 INFO - ##### Finished run-tests step (success) 06:58:13 INFO - ##### 06:58:13 INFO - Running post-run listener: _resource_record_post_run 06:58:14 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535478272; Read time: 12; Write time: 505952 06:58:14 INFO - TinderboxPrint: CPU usage
13.1% 06:58:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:58:14 INFO - TinderboxPrint: I/O write bytes / time
535,478,272 / 505,952 06:58:14 INFO - TinderboxPrint: CPU idle
8,328.3 (86.9%) 06:58:14 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 06:58:14 INFO - TinderboxPrint: Swap in / out
0 / 0 06:58:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241680384; Read time: 0; Write time: 234420 06:58:14 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293797888; Read time: 12; Write time: 271532 06:58:14 INFO - Running post-run listener: _upload_blobber_files 06:58:14 INFO - Blob upload gear active. 06:58:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:14 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 06:58:14 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'] 06:58:14 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 06:58:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:15 INFO - (blobuploader) - INFO - Done attempting. 06:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:16 INFO - (blobuploader) - INFO - Done attempting. 06:58:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:16 INFO - Return code: 0 06:58:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f130870095a2c09564f7f3b9dc88b432ee119ff81c70d3fab5a8760d6c133104599a141941ae490d8c535bb11a24922ade5a395ae244d93c12a39083701682fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6682d7838c6125dd5cfc04d19e7b94a1772ef994a14fb5285fea8cc5865d717dee1af37bd54988735c3a7ebc34cb97267f25818cfe36df5b889894f96e4e0b6d"} 06:58:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:16 INFO - Contents: 06:58:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f130870095a2c09564f7f3b9dc88b432ee119ff81c70d3fab5a8760d6c133104599a141941ae490d8c535bb11a24922ade5a395ae244d93c12a39083701682fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6682d7838c6125dd5cfc04d19e7b94a1772ef994a14fb5285fea8cc5865d717dee1af37bd54988735c3a7ebc34cb97267f25818cfe36df5b889894f96e4e0b6d"} 06:58:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:16 INFO - Copying logs to upload dir... 06:58:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.467131 ========= master_lag: 0.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-12 06:58:16.822797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 06:58:16.825822) ========= 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=920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f130870095a2c09564f7f3b9dc88b432ee119ff81c70d3fab5a8760d6c133104599a141941ae490d8c535bb11a24922ade5a395ae244d93c12a39083701682fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6682d7838c6125dd5cfc04d19e7b94a1772ef994a14fb5285fea8cc5865d717dee1af37bd54988735c3a7ebc34cb97267f25818cfe36df5b889894f96e4e0b6d"} build_url:https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010346 build_url: 'https://queue.taskcluster.net/v1/task/KWjwiKl7Qn6fX1f1lBKJxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f130870095a2c09564f7f3b9dc88b432ee119ff81c70d3fab5a8760d6c133104599a141941ae490d8c535bb11a24922ade5a395ae244d93c12a39083701682fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6682d7838c6125dd5cfc04d19e7b94a1772ef994a14fb5285fea8cc5865d717dee1af37bd54988735c3a7ebc34cb97267f25818cfe36df5b889894f96e4e0b6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 06:58:16.854677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:58:16.854994) ========= 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=920470bf432669ad7e3a5387000001ca-1463059774.35142-1174087965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 06:58:16.904167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 06:58:16.907498) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 06:58:16.907780) ========= ========= Total master_lag: 0.74 =========