builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1463775257.74 results: success (0) buildid: 20160520113540 builduid: 17fc637629294810b3666cd24cc9fe70 revision: 5145d510ffb90e5fca9d2585f1200ae94ef944b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.744969) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.745325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.745608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.755968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.756219) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 13:14:17-- 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% 100M=0s 2016-05-20 13:14:17 (100 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.891152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.891433) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009644 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.937178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:17.937536) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 5145d510ffb90e5fca9d2585f1200ae94ef944b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 5145d510ffb90e5fca9d2585f1200ae94ef944b7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 13:14:18,068 truncating revision to first 12 chars 2016-05-20 13:14:18,069 Setting DEBUG logging. 2016-05-20 13:14:18,069 attempt 1/10 2016-05-20 13:14:18,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/5145d510ffb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 13:14:18,338 unpacking tar archive at: larch-5145d510ffb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:18.454279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:18.454563) ========= script_repo_revision: 5145d510ffb90e5fca9d2585f1200ae94ef944b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:18.454935) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:18.455198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 13:14:18.462946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-20 13:14:18.463237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:14:18 INFO - MultiFileLogger online at 20160520 13:14:18 in /builds/slave/test 13:14:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:14:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:18 INFO - {'append_to_log': False, 13:14:18 INFO - 'base_work_dir': '/builds/slave/test', 13:14:18 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:14:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:18 INFO - 'branch': 'Larch-Non-PGO', 13:14:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:18 INFO - 'config_files': ('talos/linux_config.py',), 13:14:18 INFO - 'default_actions': ('clobber', 13:14:18 INFO - 'read-buildbot-config', 13:14:18 INFO - 'download-and-extract', 13:14:18 INFO - 'populate-webroot', 13:14:18 INFO - 'create-virtualenv', 13:14:18 INFO - 'install', 13:14:18 INFO - 'run-tests'), 13:14:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:18 INFO - 'download_minidump_stackwalk': True, 13:14:18 INFO - 'download_symbols': 'ondemand', 13:14:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:18 INFO - 'installer_path': 'installer.exe', 13:14:18 INFO - 'log_level': 'info', 13:14:18 INFO - 'log_name': 'talos', 13:14:18 INFO - 'log_to_console': True, 13:14:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:14:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:14:18 INFO - 'opt_config_files': (), 13:14:18 INFO - 'pip_index': False, 13:14:18 INFO - 'sps_profile': False, 13:14:18 INFO - 'sps_profile_interval': 0, 13:14:18 INFO - 'suite': 'dromaeojs-e10s', 13:14:18 INFO - 'system_bits': '32', 13:14:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:18 INFO - 'title': 'talos-linux64-ix-036', 13:14:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:18 INFO - 'use_talos_json': True, 13:14:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:18 INFO - 'work_dir': 'build'} 13:14:18 INFO - ##### 13:14:18 INFO - ##### Running clobber step. 13:14:18 INFO - ##### 13:14:18 INFO - Running pre-action listener: _resource_record_pre_action 13:14:18 INFO - Running main action method: clobber 13:14:18 INFO - rmtree: /builds/slave/test/build 13:14:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:19 INFO - Running post-action listener: _resource_record_post_action 13:14:19 INFO - ##### 13:14:19 INFO - ##### Finished clobber step (success) 13:14:19 INFO - ##### 13:14:19 INFO - ##### 13:14:19 INFO - ##### Running read-buildbot-config step. 13:14:19 INFO - ##### 13:14:19 INFO - Running pre-action listener: _resource_record_pre_action 13:14:19 INFO - Running main action method: read_buildbot_config 13:14:19 INFO - Using buildbot properties: 13:14:19 INFO - { 13:14:19 INFO - "project": "", 13:14:19 INFO - "product": "firefox", 13:14:19 INFO - "script_repo_revision": "production", 13:14:19 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 13:14:19 INFO - "repository": "", 13:14:19 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 13:14:19 INFO - "buildid": "20160520113540", 13:14:19 INFO - "pgo_build": "False", 13:14:19 INFO - "basedir": "/builds/slave/test", 13:14:19 INFO - "buildnumber": 0, 13:14:19 INFO - "slavename": "talos-linux64-ix-036", 13:14:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:14:19 INFO - "platform": "ubuntu64_hw", 13:14:19 INFO - "scheduler": "tests-larch-linux64-talos", 13:14:19 INFO - "branch": "larch", 13:14:19 INFO - "repo_path": "projects/larch", 13:14:19 INFO - "revision": "5145d510ffb90e5fca9d2585f1200ae94ef944b7", 13:14:19 INFO - "stage_platform": "linux64", 13:14:19 INFO - "builduid": "17fc637629294810b3666cd24cc9fe70", 13:14:19 INFO - "slavebuilddir": "test" 13:14:19 INFO - } 13:14:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:14:19 INFO - Running post-action listener: _resource_record_post_action 13:14:19 INFO - ##### 13:14:19 INFO - ##### Finished read-buildbot-config step (success) 13:14:19 INFO - ##### 13:14:19 INFO - ##### 13:14:19 INFO - ##### Running download-and-extract step. 13:14:19 INFO - ##### 13:14:19 INFO - Running pre-action listener: _resource_record_pre_action 13:14:19 INFO - Running main action method: download_and_extract 13:14:19 INFO - mkdir: /builds/slave/test/build/tests 13:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:19 INFO - https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:22 INFO - Downloaded 1361 bytes. 13:14:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:14:22 INFO - Using the following test package requirements: 13:14:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:14:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:14:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'jsshell-linux-x86_64.zip'], 13:14:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:14:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:14:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:14:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:14:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:14:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:22 INFO - https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:25 INFO - Downloaded 22328845 bytes. 13:14:25 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'] 13:14:25 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 13:14:26 INFO - Return code: 0 13:14:26 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 13:14:26 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')]} 13:14:26 INFO - https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:32 INFO - Downloaded 22328845 bytes. 13:14:32 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'] 13:14:32 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 13:14:33 INFO - Return code: 0 13:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:33 INFO - https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:34 INFO - Downloaded 10840160 bytes. 13:14:34 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'] 13:14:34 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 13:14:34 INFO - Return code: 0 13:14: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')]} 13:14:34 INFO - https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R2SWt3drTWu1f6rp3zJsng/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 13:14:37 INFO - Downloaded 54804914 bytes. 13:14:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:14:37 INFO - mkdir: /builds/slave/test/properties 13:14:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:14:37 INFO - Writing to file /builds/slave/test/properties/build_url 13:14:37 INFO - Contents: 13:14:37 INFO - build_url:https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:14:37 INFO - Running post-action listener: _resource_record_post_action 13:14:37 INFO - Running post-action listener: set_extra_try_arguments 13:14:37 INFO - ##### 13:14:37 INFO - ##### Finished download-and-extract step (success) 13:14:37 INFO - ##### 13:14:37 INFO - ##### 13:14:37 INFO - ##### Running populate-webroot step. 13:14:37 INFO - ##### 13:14:37 INFO - Running pre-action listener: _resource_record_pre_action 13:14:37 INFO - Running main action method: populate_webroot 13:14:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:14:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:14:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:14:37 INFO - '--tppagecycles', 13:14:37 INFO - '7'], 13:14:37 INFO - 'tests': ['tsvgm']}}, 13:14:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:14:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:14:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:14:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:14:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['damp', 'tps']}, 13:14:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'tests': ['damp', 'tps']}, 13:14:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['dromaeo_dom']}, 13:14:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:14:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['a11yr', 13:14:37 INFO - 'ts_paint', 13:14:37 INFO - 'tpaint', 13:14:37 INFO - 'sessionrestore', 13:14:37 INFO - 'sessionrestore_no_auto_restore', 13:14:37 INFO - 'tabpaint']}, 13:14:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tsvgx', 13:14:37 INFO - 'tsvgr_opacity', 13:14:37 INFO - 'tart', 13:14:37 INFO - 'tscrollx', 13:14:37 INFO - 'cart']}, 13:14:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:14:37 INFO - 'tsvgr_opacity', 13:14:37 INFO - 'tart', 13:14:37 INFO - 'tscrollx', 13:14:37 INFO - 'cart']}, 13:14:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s'], 13:14:37 INFO - 'tests': ['tp5o']}, 13:14:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'tests': ['tp5o']}, 13:14:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'talos_options': ['--disable-e10s', 13:14:37 INFO - '--xperf_path', 13:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:37 INFO - 'tests': ['tp5n']}, 13:14:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:37 INFO - 'talos_options': ['--xperf_path', 13:14:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:37 INFO - 'tests': ['tp5n']}}, 13:14:37 INFO - 'talos.zip': {'path': '', 13:14:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:14:37 INFO - Running post-action listener: _resource_record_post_action 13:14:37 INFO - ##### 13:14:37 INFO - ##### Finished populate-webroot step (success) 13:14:37 INFO - ##### 13:14:37 INFO - ##### 13:14:37 INFO - ##### Running create-virtualenv step. 13:14:37 INFO - ##### 13:14:37 INFO - Running pre-action listener: _resource_record_pre_action 13:14:37 INFO - Running main action method: create_virtualenv 13:14:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:14:37 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 13:14:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:14:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:14:38 INFO - Using real prefix '/usr' 13:14:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:14:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:14:40 INFO - Installing pip.................done. 13:14:40 INFO - Return code: 0 13:14:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:14: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')]} 13:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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')]} 13:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:40 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:40 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 13:14:40 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 13:14:40 INFO - Using env: {'DISPLAY': ':0', 13:14:40 INFO - 'HOME': '/home/cltbld', 13:14:40 INFO - 'LANG': 'en_US.UTF-8', 13:14:40 INFO - 'LANGUAGE': 'en_US:en', 13:14:40 INFO - 'LOGNAME': 'cltbld', 13:14:40 INFO - 'MAIL': '/var/mail/cltbld', 13:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:40 INFO - 'MOZ_NO_REMOTE': '1', 13:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:40 INFO - 'NO_EM_RESTART': '1', 13:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:40 INFO - 'PWD': '/builds/slave/test', 13:14:40 INFO - 'SHELL': '/bin/bash', 13:14:40 INFO - 'SHLVL': '1', 13:14:40 INFO - 'TERM': 'linux', 13:14:40 INFO - 'TMOUT': '86400', 13:14:40 INFO - 'USER': 'cltbld', 13:14:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:40 INFO - '_': '/tools/buildbot/bin/python'} 13:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:40 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 13:14:40 INFO - Cleaning up... 13:14:40 INFO - Return code: 0 13:14:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:14: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')]} 13:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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')]} 13:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:40 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:40 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 13:14:40 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 13:14:40 INFO - Using env: {'DISPLAY': ':0', 13:14:40 INFO - 'HOME': '/home/cltbld', 13:14:40 INFO - 'LANG': 'en_US.UTF-8', 13:14:40 INFO - 'LANGUAGE': 'en_US:en', 13:14:40 INFO - 'LOGNAME': 'cltbld', 13:14:40 INFO - 'MAIL': '/var/mail/cltbld', 13:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:40 INFO - 'MOZ_NO_REMOTE': '1', 13:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:40 INFO - 'NO_EM_RESTART': '1', 13:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:40 INFO - 'PWD': '/builds/slave/test', 13:14:40 INFO - 'SHELL': '/bin/bash', 13:14:40 INFO - 'SHLVL': '1', 13:14:40 INFO - 'TERM': 'linux', 13:14:40 INFO - 'TMOUT': '86400', 13:14:40 INFO - 'USER': 'cltbld', 13:14:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:40 INFO - '_': '/tools/buildbot/bin/python'} 13:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:40 INFO - Downloading/unpacking psutil>=0.7.1 13:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:42 INFO - Installing collected packages: psutil 13:14:42 INFO - Running setup.py install for psutil 13:14:42 INFO - building 'psutil._psutil_linux' extension 13:14:42 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 13:14:43 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 13:14:43 INFO - building 'psutil._psutil_posix' extension 13:14:43 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 13:14:43 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 13:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:43 INFO - Successfully installed psutil 13:14:43 INFO - Cleaning up... 13:14:43 INFO - Return code: 0 13:14:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:43 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:43 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 13:14:43 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 13:14:43 INFO - Using env: {'DISPLAY': ':0', 13:14:43 INFO - 'HOME': '/home/cltbld', 13:14:43 INFO - 'LANG': 'en_US.UTF-8', 13:14:43 INFO - 'LANGUAGE': 'en_US:en', 13:14:43 INFO - 'LOGNAME': 'cltbld', 13:14:43 INFO - 'MAIL': '/var/mail/cltbld', 13:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:43 INFO - 'MOZ_NO_REMOTE': '1', 13:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:43 INFO - 'NO_EM_RESTART': '1', 13:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:43 INFO - 'PWD': '/builds/slave/test', 13:14:43 INFO - 'SHELL': '/bin/bash', 13:14:43 INFO - 'SHLVL': '1', 13:14:43 INFO - 'TERM': 'linux', 13:14:43 INFO - 'TMOUT': '86400', 13:14:43 INFO - 'USER': 'cltbld', 13:14:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:43 INFO - '_': '/tools/buildbot/bin/python'} 13:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:14:43 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 13:14:43 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 13:14:43 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 13:14:43 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 13:14:43 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 13:14:43 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 13:14:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:14:45 INFO - Installing collected packages: mozsystemmonitor 13:14:45 INFO - Running setup.py install for mozsystemmonitor 13:14:45 INFO - Successfully installed mozsystemmonitor 13:14:45 INFO - Cleaning up... 13:14:45 INFO - Return code: 0 13:14:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:14:45 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')]} 13:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:45 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')]} 13:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:45 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:45 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 13:14:45 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 13:14:45 INFO - Using env: {'DISPLAY': ':0', 13:14:45 INFO - 'HOME': '/home/cltbld', 13:14:45 INFO - 'LANG': 'en_US.UTF-8', 13:14:45 INFO - 'LANGUAGE': 'en_US:en', 13:14:45 INFO - 'LOGNAME': 'cltbld', 13:14:45 INFO - 'MAIL': '/var/mail/cltbld', 13:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:45 INFO - 'MOZ_NO_REMOTE': '1', 13:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:45 INFO - 'NO_EM_RESTART': '1', 13:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:45 INFO - 'PWD': '/builds/slave/test', 13:14:45 INFO - 'SHELL': '/bin/bash', 13:14:45 INFO - 'SHLVL': '1', 13:14:45 INFO - 'TERM': 'linux', 13:14:45 INFO - 'TMOUT': '86400', 13:14:45 INFO - 'USER': 'cltbld', 13:14:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:45 INFO - '_': '/tools/buildbot/bin/python'} 13:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:14:45 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 13:14:45 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 13:14:45 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 13:14:45 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 13:14:45 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 13:14:45 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 13:14:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:14:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 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 13:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:14:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:48 INFO - Downloading docopt-0.6.1.tar.gz 13:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:14:48 INFO - Installing collected packages: blobuploader, requests, docopt 13:14:48 INFO - Running setup.py install for blobuploader 13:14:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:14:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:14:48 INFO - Running setup.py install for requests 13:14:48 INFO - Running setup.py install for docopt 13:14:48 INFO - Successfully installed blobuploader requests docopt 13:14:48 INFO - Cleaning up... 13:14:48 INFO - Return code: 0 13:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:48 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')]} 13:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:48 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')]} 13:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:48 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:48 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 13:14:48 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 13:14:48 INFO - Using env: {'DISPLAY': ':0', 13:14:48 INFO - 'HOME': '/home/cltbld', 13:14:48 INFO - 'LANG': 'en_US.UTF-8', 13:14:48 INFO - 'LANGUAGE': 'en_US:en', 13:14:48 INFO - 'LOGNAME': 'cltbld', 13:14:48 INFO - 'MAIL': '/var/mail/cltbld', 13:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:48 INFO - 'MOZ_NO_REMOTE': '1', 13:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:48 INFO - 'NO_EM_RESTART': '1', 13:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:48 INFO - 'PWD': '/builds/slave/test', 13:14:48 INFO - 'SHELL': '/bin/bash', 13:14:48 INFO - 'SHLVL': '1', 13:14:48 INFO - 'TERM': 'linux', 13:14:48 INFO - 'TMOUT': '86400', 13:14:48 INFO - 'USER': 'cltbld', 13:14:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:48 INFO - '_': '/tools/buildbot/bin/python'} 13:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:14:49 INFO - Running setup.py (path:/tmp/pip-gTyaCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:49 INFO - Running setup.py (path:/tmp/pip-LVJg78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:49 INFO - Running setup.py (path:/tmp/pip-V_ywsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:49 INFO - Running setup.py (path:/tmp/pip-bFclqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:49 INFO - Running setup.py (path:/tmp/pip-hKFZxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:49 INFO - Running setup.py (path:/tmp/pip-8I4gND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:49 INFO - Running setup.py (path:/tmp/pip-Mfj7Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:49 INFO - Running setup.py (path:/tmp/pip-vF0LkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:49 INFO - Running setup.py (path:/tmp/pip-s_4vap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:49 INFO - Running setup.py (path:/tmp/pip-69nVM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:49 INFO - Running setup.py (path:/tmp/pip-UkQ12y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:49 INFO - Running setup.py (path:/tmp/pip-vEm3mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:49 INFO - Running setup.py (path:/tmp/pip-oDIz4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:49 INFO - Running setup.py (path:/tmp/pip-0HSqu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:49 INFO - Running setup.py (path:/tmp/pip-5AZmVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:49 INFO - Running setup.py (path:/tmp/pip-_x_jGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:14:49 INFO - Running setup.py (path:/tmp/pip-4g2rrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:14:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:14:50 INFO - Running setup.py install for manifestparser 13:14:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Running setup.py install for mozcrash 13:14:50 INFO - Running setup.py install for mozdebug 13:14:50 INFO - Running setup.py install for mozdevice 13:14:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Running setup.py install for mozfile 13:14:50 INFO - Running setup.py install for mozhttpd 13:14:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Running setup.py install for mozinfo 13:14:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Running setup.py install for mozInstall 13:14:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Running setup.py install for mozleak 13:14:50 INFO - Running setup.py install for mozlog 13:14:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:14:50 INFO - Running setup.py install for moznetwork 13:14:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:14:51 INFO - Running setup.py install for mozprocess 13:14:51 INFO - Running setup.py install for mozprofile 13:14:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:14:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:14:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:14:51 INFO - Running setup.py install for mozrunner 13:14:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:14:51 INFO - Running setup.py install for mozscreenshot 13:14:51 INFO - Running setup.py install for moztest 13:14:51 INFO - Running setup.py install for mozversion 13:14:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:14:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:14:51 INFO - Cleaning up... 13:14:51 INFO - Return code: 0 13:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:51 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:51 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 13:14:51 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 13:14:51 INFO - Using env: {'DISPLAY': ':0', 13:14:51 INFO - 'HOME': '/home/cltbld', 13:14:51 INFO - 'LANG': 'en_US.UTF-8', 13:14:51 INFO - 'LANGUAGE': 'en_US:en', 13:14:51 INFO - 'LOGNAME': 'cltbld', 13:14:51 INFO - 'MAIL': '/var/mail/cltbld', 13:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:51 INFO - 'MOZ_NO_REMOTE': '1', 13:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:51 INFO - 'NO_EM_RESTART': '1', 13:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:51 INFO - 'PWD': '/builds/slave/test', 13:14:51 INFO - 'SHELL': '/bin/bash', 13:14:51 INFO - 'SHLVL': '1', 13:14:51 INFO - 'TERM': 'linux', 13:14:51 INFO - 'TMOUT': '86400', 13:14:51 INFO - 'USER': 'cltbld', 13:14:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:51 INFO - '_': '/tools/buildbot/bin/python'} 13:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:14:51 INFO - Running setup.py (path:/tmp/pip-TDJoDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:51 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)) 13:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:51 INFO - Running setup.py (path:/tmp/pip-eJrSmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:51 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)) 13:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:51 INFO - Running setup.py (path:/tmp/pip-1z2PMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:52 INFO - Running setup.py (path:/tmp/pip-Za8EIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:52 INFO - Running setup.py (path:/tmp/pip-KUbqIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:52 INFO - Running setup.py (path:/tmp/pip-qlMfDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:52 INFO - Running setup.py (path:/tmp/pip-ogOyF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:52 INFO - Running setup.py (path:/tmp/pip-Van7Tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:52 INFO - Running setup.py (path:/tmp/pip-rglbRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:52 INFO - Running setup.py (path:/tmp/pip-dEuV3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:52 INFO - Running setup.py (path:/tmp/pip-I0NoiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:52 INFO - Running setup.py (path:/tmp/pip-kVjQTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:52 INFO - Running setup.py (path:/tmp/pip-Jo5ETi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:52 INFO - Running setup.py (path:/tmp/pip-EgHXqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:52 INFO - Running setup.py (path:/tmp/pip-Mt6kgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:52 INFO - Running setup.py (path:/tmp/pip-8tkhuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:14:52 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)) 13:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:14:52 INFO - Running setup.py (path:/tmp/pip-vCaf_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:14:52 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)) 13:14:52 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)) 13:14:52 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)) 13:14:52 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)) 13:14:52 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)) 13:14:52 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)) 13:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:14:52 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 13:14:52 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 13:14:52 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 13:14:52 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 13:14:52 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 13:14:52 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 13:14:54 INFO - Downloading blessings-1.6.tar.gz 13:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:14:54 INFO - Installing collected packages: blessings 13:14:54 INFO - Running setup.py install for blessings 13:14:54 INFO - Successfully installed blessings 13:14:54 INFO - Cleaning up... 13:14:54 INFO - Return code: 0 13:14:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:14:55 INFO - Reading from file tmpfile_stdout 13:14:55 INFO - Current package versions: 13:14:55 INFO - argparse == 1.2.1 13:14:55 INFO - blessings == 1.6 13:14:55 INFO - blobuploader == 1.2.4 13:14:55 INFO - docopt == 0.6.1 13:14:55 INFO - manifestparser == 1.1 13:14:55 INFO - mozInstall == 1.12 13:14:55 INFO - mozcrash == 0.17 13:14:55 INFO - mozdebug == 0.1 13:14:55 INFO - mozdevice == 0.48 13:14:55 INFO - mozfile == 1.2 13:14:55 INFO - mozhttpd == 0.7 13:14:55 INFO - mozinfo == 0.9 13:14:55 INFO - mozleak == 0.1 13:14:55 INFO - mozlog == 3.1 13:14:55 INFO - moznetwork == 0.27 13:14:55 INFO - mozprocess == 0.22 13:14:55 INFO - mozprofile == 0.28 13:14:55 INFO - mozrunner == 6.11 13:14:55 INFO - mozscreenshot == 0.1 13:14:55 INFO - mozsystemmonitor == 0.0 13:14:55 INFO - moztest == 0.7 13:14:55 INFO - mozversion == 1.4 13:14:55 INFO - psutil == 3.1.1 13:14:55 INFO - requests == 1.2.3 13:14:55 INFO - wsgiref == 0.1.2 13:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14: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')]} 13:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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')]} 13:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:55 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:55 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 13:14:55 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 13:14:55 INFO - Using env: {'DISPLAY': ':0', 13:14:55 INFO - 'HOME': '/home/cltbld', 13:14:55 INFO - 'LANG': 'en_US.UTF-8', 13:14:55 INFO - 'LANGUAGE': 'en_US:en', 13:14:55 INFO - 'LOGNAME': 'cltbld', 13:14:55 INFO - 'MAIL': '/var/mail/cltbld', 13:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:55 INFO - 'MOZ_NO_REMOTE': '1', 13:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:55 INFO - 'NO_EM_RESTART': '1', 13:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:55 INFO - 'PWD': '/builds/slave/test', 13:14:55 INFO - 'SHELL': '/bin/bash', 13:14:55 INFO - 'SHLVL': '1', 13:14:55 INFO - 'TERM': 'linux', 13:14:55 INFO - 'TMOUT': '86400', 13:14:55 INFO - 'USER': 'cltbld', 13:14:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:55 INFO - '_': '/tools/buildbot/bin/python'} 13:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 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)) 13:14:55 INFO - Cleaning up... 13:14:55 INFO - Return code: 0 13:14:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:14: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')]} 13:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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')]} 13:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14: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', 'jsonschema'] in /builds/slave/test/build 13:14: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 jsonschema 13:14:55 INFO - Using env: {'DISPLAY': ':0', 13:14:55 INFO - 'HOME': '/home/cltbld', 13:14:55 INFO - 'LANG': 'en_US.UTF-8', 13:14:55 INFO - 'LANGUAGE': 'en_US:en', 13:14:55 INFO - 'LOGNAME': 'cltbld', 13:14:55 INFO - 'MAIL': '/var/mail/cltbld', 13:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:55 INFO - 'MOZ_NO_REMOTE': '1', 13:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:55 INFO - 'NO_EM_RESTART': '1', 13:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:55 INFO - 'PWD': '/builds/slave/test', 13:14:55 INFO - 'SHELL': '/bin/bash', 13:14:55 INFO - 'SHLVL': '1', 13:14:55 INFO - 'TERM': 'linux', 13:14:55 INFO - 'TMOUT': '86400', 13:14:55 INFO - 'USER': 'cltbld', 13:14:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:55 INFO - '_': '/tools/buildbot/bin/python'} 13:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:55 INFO - Downloading/unpacking jsonschema 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:14:57 INFO - Downloading/unpacking functools32 (from jsonschema) 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:14:57 INFO - warning: no files found matching '*.txt' 13:14:57 INFO - no previously-included directories found matching 'build' 13:14:57 INFO - no previously-included directories found matching 'dist' 13:14:57 INFO - no previously-included directories found matching '.git*' 13:14:57 INFO - Installing collected packages: jsonschema, functools32 13:14:57 INFO - Running setup.py install for functools32 13:14:57 INFO - warning: no files found matching '*.txt' 13:14:57 INFO - no previously-included directories found matching 'build' 13:14:57 INFO - no previously-included directories found matching 'dist' 13:14:57 INFO - no previously-included directories found matching '.git*' 13:14:57 INFO - Successfully installed jsonschema functools32 13:14:57 INFO - Cleaning up... 13:14:57 INFO - Return code: 0 13:14:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:57 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 0x7fb8c449df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c65770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', '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 13:14:57 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 13:14:57 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 13:14:57 INFO - Using env: {'DISPLAY': ':0', 13:14:57 INFO - 'HOME': '/home/cltbld', 13:14:57 INFO - 'LANG': 'en_US.UTF-8', 13:14:57 INFO - 'LANGUAGE': 'en_US:en', 13:14:57 INFO - 'LOGNAME': 'cltbld', 13:14:57 INFO - 'MAIL': '/var/mail/cltbld', 13:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:57 INFO - 'MOZ_NO_REMOTE': '1', 13:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:57 INFO - 'NO_EM_RESTART': '1', 13:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:57 INFO - 'PWD': '/builds/slave/test', 13:14:57 INFO - 'SHELL': '/bin/bash', 13:14:57 INFO - 'SHLVL': '1', 13:14:57 INFO - 'TERM': 'linux', 13:14:57 INFO - 'TMOUT': '86400', 13:14:57 INFO - 'USER': 'cltbld', 13:14:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:57 INFO - '_': '/tools/buildbot/bin/python'} 13:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:57 INFO - Downloading/unpacking flake8 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14: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 13:14:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:14:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:14:59 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 13:14:59 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 13:14:59 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 13:14:59 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 13:14:59 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 13:14:59 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 13:15:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:15:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 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 13:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:00 INFO - no previously-included directories found matching 'docs/_build' 13:15:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:15:00 INFO - Running setup.py install for pep8 13:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:15:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:15:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:15:00 INFO - no previously-included directories found matching 'docs/_build' 13:15:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:15:00 INFO - Cleaning up... 13:15:00 INFO - Return code: 0 13:15:00 INFO - Running post-action listener: _resource_record_post_action 13:15:00 INFO - Running post-action listener: _start_resource_monitoring 13:15:00 INFO - Starting resource monitoring. 13:15:00 INFO - ##### 13:15:00 INFO - ##### Finished create-virtualenv step (success) 13:15:00 INFO - ##### 13:15:00 INFO - ##### 13:15:00 INFO - ##### Running install step. 13:15:00 INFO - ##### 13:15:00 INFO - Running pre-action listener: _resource_record_pre_action 13:15:00 INFO - Running main action method: install 13:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:01 INFO - Reading from file tmpfile_stdout 13:15:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:01 INFO - Reading from file tmpfile_stdout 13:15:01 INFO - Output received: 13:15:01 INFO - Usage: mozinstall [options] installer 13:15:01 INFO - Options: 13:15:01 INFO - -h, --help show this help message and exit 13:15:01 INFO - -d DEST, --destination=DEST 13:15:01 INFO - Directory to install application into. [default: 13:15:01 INFO - "/builds/slave/test"] 13:15:01 INFO - --app=APP Application being installed. [default: firefox] 13:15:01 INFO - mkdir: /builds/slave/test/build/application 13:15:01 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'] 13:15:01 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 13:15:16 INFO - Reading from file tmpfile_stdout 13:15:16 INFO - Output received: 13:15:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:15:16 INFO - Running post-action listener: _resource_record_post_action 13:15:16 INFO - ##### 13:15:16 INFO - ##### Finished install step (success) 13:15:16 INFO - ##### 13:15:16 INFO - ##### 13:15:16 INFO - ##### Running run-tests step. 13:15:16 INFO - ##### 13:15:16 INFO - Running pre-action listener: _resource_record_pre_action 13:15:16 INFO - Running main action method: run_tests 13:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:15:16 INFO - Python 2.7.3 13:15:16 INFO - Return code: 0 13:15:16 INFO - grabbing minidump binary from tooltool 13:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:16 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 0x2cf49c0>, '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 0x2cf58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:15:16 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 13:15:16 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 13:15:16 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 13:15:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:15:17 INFO - Return code: 0 13:15:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:15:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:15:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:15:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:15:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:15:17 INFO - Return code: 0 13:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:15:17 INFO - Using env: {'DISPLAY': ':0', 13:15:17 INFO - 'HOME': '/home/cltbld', 13:15:17 INFO - 'LANG': 'en_US.UTF-8', 13:15:17 INFO - 'LANGUAGE': 'en_US:en', 13:15:17 INFO - 'LOGNAME': 'cltbld', 13:15:17 INFO - 'MAIL': '/var/mail/cltbld', 13:15:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:15:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:17 INFO - 'MOZ_NO_REMOTE': '1', 13:15:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:17 INFO - 'NO_EM_RESTART': '1', 13:15:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:17 INFO - 'PWD': '/builds/slave/test', 13:15:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:15:17 INFO - 'SHELL': '/bin/bash', 13:15:17 INFO - 'SHLVL': '1', 13:15:17 INFO - 'TERM': 'linux', 13:15:17 INFO - 'TMOUT': '86400', 13:15:17 INFO - 'USER': 'cltbld', 13:15:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333', 13:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:17 INFO - '_': '/tools/buildbot/bin/python'} 13:15:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:15:18 INFO - mozversion application_buildid: 20160520113540 13:15:18 INFO - mozversion application_changeset: 5145d510ffb90e5fca9d2585f1200ae94ef944b7 13:15:18 INFO - mozversion application_display_name: Nightly 13:15:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:15:18 INFO - mozversion application_name: Firefox 13:15:18 INFO - mozversion application_remotingname: firefox 13:15:18 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:15:18 INFO - mozversion application_vendor: Mozilla 13:15:18 INFO - mozversion application_version: 49.0a1 13:15:18 INFO - mozversion platform_buildid: 20160520113540 13:15:18 INFO - mozversion platform_changeset: 5145d510ffb90e5fca9d2585f1200ae94ef944b7 13:15:18 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:15:18 INFO - mozversion platform_version: 49.0a1 13:15:18 INFO - using testdate: 1463775318 13:15:18 INFO - actual date: 1463775318 13:15:18 INFO - starting webserver on 'localhost:59092' 13:15:18 INFO - SUITE-START | Running 2 tests 13:15:18 INFO - TEST-START | dromaeo_css 13:15:18 INFO - operating with platform_type : linux_ 13:15:18 INFO - Initialising browser for dromaeo_css test... 13:15:18 INFO - TEST-INFO | started process 16601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0hL12n/profile http://localhost:59092/getInfo.html) 13:15:21 INFO - PROCESS | 16601 | 13:15:21 INFO - PROCESS | 16601 | (process:16669): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:15:22 INFO - PROCESS | 16601 | __metrics Screen width/height:1600/1200 13:15:22 INFO - PROCESS | 16601 | colorDepth:24 13:15:22 INFO - PROCESS | 16601 | Browser inner width/height: 1024/697 13:15:22 INFO - PROCESS | 16601 | __metrics 13:15:23 ERROR - PROCESS | 16601 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:15:24 INFO - TEST-INFO | 16601: exit 0 13:15:24 INFO - Browser initialized. 13:15:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:15:24 INFO - TEST-INFO | started process 16720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0hL12n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:25 INFO - PROCESS | 16720 | 13:15:25 INFO - PROCESS | 16720 | (process:16780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:15:35 INFO - PROCESS | 16720 | RSS: Main: 164294656 13:15:35 INFO - PROCESS | 16720 | 13:16:25 INFO - PROCESS | 16720 | 1463775385276 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] 13:18:36 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59092/tests/dromaeo/cssquery-ext.html) 13:18:37 INFO - PROCESS | 16720 | RSS: Main: 167165952 13:18:37 INFO - PROCESS | 16720 | 13:21:39 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-ext.html (next: http://localhost:59092/tests/dromaeo/cssquery-jquery.html) 13:21:40 INFO - PROCESS | 16720 | RSS: Main: 167198720 13:21:40 INFO - PROCESS | 16720 | 13:24:42 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59092/tests/dromaeo/cssquery-mootools.html) 13:24:42 INFO - PROCESS | 16720 | RSS: Main: 168296448 13:24:42 INFO - PROCESS | 16720 | 13:27:44 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59092/tests/dromaeo/cssquery-prototype.html) 13:27:45 INFO - PROCESS | 16720 | RSS: Main: 165875712 13:27:45 INFO - PROCESS | 16720 | 13:30:47 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59092/tests/dromaeo/cssquery-yui.html) 13:30:48 INFO - PROCESS | 16720 | RSS: Main: 167391232 13:30:48 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-yui.html (next: http://localhost:59092/tests/dromaeo/cssquery-dojo.html) 13:33:50 INFO - PROCESS | 16720 | RSS: Main: 168988672 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | __start_tp_report 13:33:50 INFO - PROCESS | 16720 | _x_x_mozilla_page_load 13:33:50 INFO - PROCESS | 16720 | _x_x_mozilla_page_load_details 13:33:50 INFO - PROCESS | 16720 | |i|pagename|runs| 13:33:50 INFO - PROCESS | 16720 | |0;dojo.html;2619.6594442722444;2624.724403937588;2659.428222932068;2659.48140112678;2678.5982102684593;4578.427696537933;4616.238320677088;4679.695819771712;4695.319178719088;4717.599004084657;4567.451905771304;4648.907021859561;4743.12252233337;4745.833895813647;4772.451168115667;4324.04870928396;4420.3369494575745;4443.333499975013;4471.239889218824;4482.484514280851;4457.531959144292;4466;4488.147252022105;4513.706609070417;4566.566176213271;4326.870193894172;4365.956340436586;4386.320120381346;4390.297552391602;4399.494058183318;4379.1022840317655;4383.846565370229;4389.846355377578;4405.339199120125;4440.134173836103;4214.473190851144;4285.635720963722;4298.398224248608;4325.718828276152;4386.7367957922625;4590.563896429834;4603.355530225771;4630.722156670577;4640.350350950869;4645.605123564501;5052.317937078484;5075.8984820303385;5097.929434818692;5102.872428189288;5132.563732082777;4900.558949694545;5122.066310691668;5161.096808058574;5168;5206;4810.302506136591;4851.733154676492;4867.172580661296;4885.902281954376;4907.435644900882;5299.8410047698635;5308.362996440452;5316.069687804618;5326.094563924142;5328;4849.418069831572;4917.852464426073;4923.384576927884;4937.530934561211;5105.693658380509;4851.223804191312;4962.702237865739;4980.452150263468;5007.349044624176;5059.165237735806;4972.055309491185;5011.649184557119;5045.016221836707;5052.418971818288;5069.746512674352;4884.7069175849565;4934.235193545006;4949.257611358253;4986.551210391082;5072.492750724972;4184.4351012613515;4203.726757760797;4212;4217.62041416274;4258.510271318838;3671.81640917953;3694.6859516941363;3701.481792549045;3719.5350581177354;3730.5336832895887;4383.868483945486;4407.6914615976575;4414.227510185705;4418.315161150027;4448.866534003985;5069.062223488666;5073.619478539124;5085.567726743268;5118.078745825713;5154.484551544891;4327.459067616548;4414.823407063745;4433.046894917608;4458.420405347284;4506.459224893034;4561.703489273186;4572.3827283317;4597.080583883237;4628.259478483494;4629.583337499641;4914.140025495524;4923.08922849274;4931.013797240495;4942.28336891156;4964.280179373971;4966.35437393151;5167.069927413102;5193.480651934777;5218.347706536683;5267.552258058108;4913.877153071202;4940.8764780880765;4958.5041495851565;4959.20652695567;5005.024020316149;5100.846974590768;5111.769970351269;5132.255822905732;5148.150555158357;5185.377754669464;4935.506449355035;4958.677685950402;4976.30331753562;5189.455107213839;5209.374875015023;4826.251930950708;4832.20268655682;4913.70517768935;4916.311716359784;4921.901561968669;4877.048975449753;4880.145974454527;4884.5603895649565;4899.951000490092;4936.629752768485;4638.512956139557;4824.8793780155775;4829.27560865873;4837.830675926326;4852.102361063215;5020.698758074527;5072.28987941681;5090.211017292326;5102.056119617882;5128.128218202989;4915.483874193301;4976.651634385558;4986.077575648372;4987.625928055338;5035.723035233097 13:33:50 INFO - PROCESS | 16720 | |1;ext.html;520.3963402453155;555.7804667156473;558.2352177516798;585.259646547118;598.3657323237369;28505.14484565464;39944.80027599861;40285.79857100718;40337.39493907594;40545.79727101364;41949;42283;42291.36562951558;42420.363694544605;42423.36364954528;7703;7834.647440865175;7849.136594974549;7864.252895974902;7869.567173805438;7697;7782.027246594176;7791.883121753178;7823.139454659983;7827.452078354518;7818.335441487452;7845.568493732842;7875.133735289113;7877.566733829637;7879.527228366316;7814.53112813233;7874.488158269694;7876.80307992299;7887.250711182429;7905.130435652074;7005.859882802315;7063;7075;7078.044463997346;7123.180834204081;38442.80778596117;38832.41751373732;38837.41743873844;38914.80542597269;39000;3023.4708925938094;3047.969520304791;3098.7056229658374;3152.4168028914496;3350.0452371074125;29147.68835402412;29189.708102919125;29731.40537189266;29832.70167298321;30611;3505.1237190702323;3523.4362501999813;3607.2244467439627;3676.0258531489176;3679.098620837885;182516;182892;244477;247663;249693;33648;54391.18413223805;54553.72723136359;54650.180247296325;54828.72585637126;33095.02859656808;35214.94355169349;35224.64775352265;35368;35453.11367215789;12152.635420937386;12320.137590368588;12395.504179832886;12405.44175512104;12417.875821241852;9599.47202903833;9616.134547890724;9644.18024467928;9659;9693.951530242444;8156.959215203886;8218.178182181853;8219.136990616018;8219.671213151527;8257.876131858027;3278.9836050819595;3290.4899740540254;3302.9009129726146;3314.8839790607212;3351.865925362958;943.1464524605243;949.0699114867468;953.6757502449201;1048.5648455890873;1058.30680904008;28229.71770282312;28565;28826.567601485993;28991.565126523117;29039.41921161607;991.8908920018937;1001.9649312274036;1009.5255230041869;1022.7954409118206;1101.9614313499148;14858.554243372717;15035;15216.391344346102;15314.310856011507;15481.259161024647;374030;374214;381224;381806;382694;49259;50513.494865051616;50562.241566376535;50706.23940640893;50786.492135078915;1215.5806246844825;1254.184779893077;1255.1653150654713;1268.1756858042163;1269.7650934577132;26955.595666064633;27846.44307113887;28197.859010704815;28271.717282826907;28292.717072829008;43732;43878.780606098044;43929.34105988349;44102.79486025622;44120.55879441293;249789;251479;251912;253126;255494;25762.35594110162;26151.476970460866;26186.86906565455;26188.476230475666;26285.342866427727;37427.625723742414;42067.158656827305;42481;42544;43402.348964764926;36172.638273616925;36449.817750911076;37561.43657845189;37583.24833503369;37633.62366376301;33915.3216935655;37372.43941340937;37397.626023739416;37645.81177094097;37721.54809937345;34790;36574.817125915266;37771.2445751078;38157.2368552633;41199;32727.34545309033;33150.50822713032;34585;34599.13502162466;34740.82629586937;25508.724563771368;25624;25749.923821227214;26051.218463446126;26246.60630090512 13:33:50 INFO - PROCESS | 16720 | |2;jquery.html;382.8793929912077;389.44504081683596;392.77219212856545;399.3467046427791;400.5333786139148;15897.920510397445;16229.188540572954;17344.826551734477;17374.913125434356;17439.73840392395;9104.362694611364;10304.536295866685;10702.143828493721;10723.678289651323;10735.302205356646;4543.8182472701055;4553.5901768840795;4723.291506274052;4732.124556956956;4739.763011849411;4648.093621743761;4659.324397962293;4662.044280922402;4692.06158768246;4701.036287561059;4666.510016448275;4672.6261899047995;4678.415198100238;4691.061787642485;4994.925076123843;5299.947000530004;5380.2736630555155;5388.595855310868;5414.620976531644;5427.782888684448;5029.5221953914315;5437.483439073281;5451.127819548853;5458.699771512565;5468.234447177399;12397.946174575172;12593;12630.242185468902;17661.911690441593;20545.972701365023;1866.0016890963404;1918.2902326139417;1941.4952112450724;1942.5920556682972;1956.8825870447677;8664.826703465895;8948.64205431782;9111.544422778901;9354.672586459441;9423.717288481357;1699.6770613583503;1717.7766890304306;1744.5725797179646;1783.3936461603116;1799.5591080185438;68871.311286887;69725;70516.29483705148;71587.28412715858;72486;8338.207870252316;8990.955045224731;9012.188902998761;9469.905300946903;9577.23382129428;12379.876201237872;12481.875181248071;12490.75018499625;12528.624141275777;12570.748585028248;6337.081123237105;6508.967455162694;6670.099536562502;6823;6919.965400173068;6305.369463053658;6711.932880671228;6742.932570674328;6837.863242735118;7059.7529086482755;4372.519022907478;4454.977725111418;4503.572160644733;4508.413906192174;4522.706024108423;1879.6052828906084;1880.5204672808347;1917.7219303201236;1919.2610844824842;1932.3043704266454;812.9390295727844;890.7238755985666;900.7387857521377;904.7059705595708;964.6671898195111;16597.668046639;16717.49847504577;16799.91600041992;16991.83008169927;17138.828611713972;873.2097451806126;881.0176653031951;901.3870568013682;902.566767951387;922.3820040572832;9376.718698439057;9450.669226577174;9463.43219406824;9672.274579406572;9703.832493721447;353517;414835;417413.56466087984;420732;425481;45675.543244567794;80247.59876200698;83870.5806470976;85044;85720.57139714262;955.2071780422233;973.6056896956744;985.3644399362371;1014.7361685961703;1021.4637315409469;14761.92619036898;15017.098974061591;15024.474143405365;15029.398824046915;15553.455629052929;32727.672723272462;33294.00117996464;34726.652733473355;35607.465888012215;36747;36811.44782828313;45957.310640339754;46601.766991164826;49260;52057.219141713664;7239.276072392719;7500.774976750488;7526.623668816428;7551.169371369255;7718.382529397522;5903.996320625418;9900.158486528726;10886.237963342806;11014.229003969645;12002.2198557097;4676.766161691834;5378.892422151614;9607.471589062388;9818.214542836413;10295.764508259057;8859.822803544022;9738.707838764849;10027.448490333101;10165.390076595428;10839.67480975572;9930;10465.215108866712;10711.018461584632;10711.94644026775;10721.195910306602;6637.6681165940545;6692.531522793358;6840.965795170992;7752.496087754278;7944.523328600302;10096;10678;10750.569977200825;10818.621348253087;10828.620998265023 13:33:50 INFO - PROCESS | 16720 | |3;mootools.html;1473.8894582906278;1500.3173556032002;1600.415848215401;1775.30763002429;1824.2155872974631;6709.899351509719;7595.658195381207;7890.40821938354;8154.18458154185;8165.714200003001;8054.275115239628;8099.109097999215;8131.796705082361;8136.796580085486;8180.468269562474;2210.2706106984697;2242.439390152462;2249.9437514062115;2252.4481502031945;2258.175765845471;2233.9888300558555;2244.865308081512;2245.158065725353;2246.4047027537717;2254.9887250563725;2215.1360969222014;2217.3015500117413;2221.833362497819;2234.5642599693065;2249.955000899981;2135.9893200533897;2155.4072630026712;2156.8813715245656;2158.751743549496;2158.8596741211772;2174.6411842046045;2175.912963481459;2179.4115588791096;2181.1602533024898;2184.0826852721893;8096;8163.142869998624;8165.755027349189;8174;8204.507729536246;4455.086707225011;4585.72485650862;4605.4933957264675;4608.9308660370125;4611.446626404853;2953.7932344735877;3082.830444325561;3102.565640810288;3113.112762862596;3121.78147529673;952.9142377186017;960.4573416019996;968.5351031504847;974.2936371130944;977.0717818072859;10904.182186336056;10979.011888929956;11001.284916480483;11017.283876548;11070.833937490945;4138.193052354762;4194.6853985951175;4207.347861081537;4217;4298.41971333866;9451;9463.053694630482;9471.715848524418;9481.952590237142;9532.761680958032;4521.231390663595;4527.320901864681;4538.364628951949;4555.794989225493;4576.58810707038;3417.1798768295926;3840.2127563849344;3927.0771368728324;4052.675785937118;4169.874133983807;3803.201327721154;3853.4412510185866;3911.3350730375905;3937.2322397132857;3943.2507823513442;1257.3587470390166;1262.7853264944981;1263.753568054239;1271.1610337177603;1278.897688184943;741.9983022919124;767.1293082351572;786.6302837666287;863.3481721300378;865.0873328638221;4906.386701662293;5140.254663073908;5219.08665983459;5332.893342133136;5346.732663366816;868.4832524647825;906.8458362078462;910.0853642089658;913.949732764691;917.5366439947784;3432.673895979878;3438.8108654023767;3540.32733780586;3544.592371877267;3589.9820500897326;9807.607695692092;9966.40201587907;10087.243456740774;10260.281780275309;10283.228757843191;9908.504574771232;10049.944755800536;10060.597576097021;10107.747306317255;10109.393436393693;6811.557248778813;7171.067761191116;7174.569525828467;7261.237570055174;7428.442866784904;5615.943840561542;5680.318361796611;5805.390434004369;5846.707664616837;5856.092305692625;8804.383693141419;9193.310501712533;9249.213816825377;9288.34981551285;9396;9168.724938251864;9343.73859528955;9426.858597121185;9515.33392662507;9562.665306714232;5753.798617048383;6354.301026886947;6588.967055164693;6605.735770569124;6778.220504641832;7631.8855217172895;7717.421193410404;7722.420818438752;7742.845143097219;7791.727289545065;6538.8365290868105;6719.798406047827;6850.177978642595;7077.5753454792875;7186.209516953027;6451.645159516084;6452.483801295791;6513.902291465726;6519.73921043172;6595.736170553316;5995.910061348996;6019.006863867413;6062.454379105901;6091.208142941389;6097.207363042776;4310.892227694333;4360.106178233391;4392.780360982002;4414.9558504414545;4539.795709193028;4383.408239887702;4386.758728269976;4466.218411777861;4493.393391892053;4505.707129036602 13:33:50 INFO - PROCESS | 16720 | |4;prototype.html;302.7850226339299;305.7156844134954;306.248160765321;311.87992622840216;312.8107494965547;4911.926321105182;4912.557869791718;4925.458199598051;4952.529509696582;4957.62817788666;4811.59101476375;4817.723303324622;4836.637252206081;4866.566716641679;4880.389951256093;3628.219932714466;3658.8595671532184;3793.943090853639;3795.35478968576;3812.65686088252;3816;3822.9617703823023;3834.1373191031935;3839.212961342932;3845.0964023454467;3797.721367179684;3816.580176180618;3819.1406933439894;3822.9426558601645;3827.4832897558754;3587.4887578694756;3815.4276858471176;3821.5414150302004;3829.8468061277517;3833.5208098987487;3380.4422270325367;3391.576052993376;3397.2695870387984;3405.8126803025825;3406.1825161961196;4620.330052142454;4645.651576131803;4678.883027924295;4697.812087516495;4707.105649926503;4391.407160033418;4411.250087485135;4413.646908247332;4416.2713152329825;4427;4955.603551715854;5039.77321020555;5041.319421878036;5069.163588007974;5077.882865769525;3719.6280371962857;3724.348239058181;3726.4037753959237;3726.888193354204;3737.383331750258;5316.963192177527;5319.867003324909;5383.219433182206;5386.892262154735;5400.351957765093;3691;3816.961830381716;3818.770873747584;3836.156045669948;3836.4437156612694;3858.6141385861188;3889.183271513014;3889.5138107736534;3896.7077469189926;3915.432262322004;4342.500612429548;4350.543192964757;4359.302511598193;4375.824967001348;4393.472783266028;4994.90010199794;5063.949360506422;5095.8980820383385;5166.689998600096;5168.19892916591;1328.8405391353099;1336.652470357714;1343.9260840653662;1347.4812197304109;1348.9392977316045;853.9743807685779;859.9570021498901;867.8654808504692;888.4314039015036;888.8444522208588;4404.867853964386;4463.509014008457;4492;4519.322101684774;4522.706024108423;5179.093658609803;5211.218317252366;5222.869428264248;5239.821040265986;5255.817441075727;4381.474223093249;4506.977465112654;4532.501424843264;4534.569215924482;4556.157110934488;2753.7108603596735;2819.3656427303695;2819.900238906828;2828.490871643124;2831.631887854566;4974.701517908937;4979.85463343433;4986.276989836453;4988.72562009093;5011.198208286657;5101.2603172539775;5318.760655770499;5370.516653501204;5375.3012108425655;5393.379761327419;4971.732208286864;4975;4982.501749825061;5019.3976722793495;5027.572656324181;5244.292020577326;5262.684238945675;5277;5286.334804536558;5304.655197412156;4896.681715688469;5149.48505149482;5168.483151684802;5196.454372290855;5205;5011.574016208518;5046.016026874724;5065.974670126626;5067.290579318972;5105.28526006352;3731;3750.3999360102252;3773.1510410157493;3783.697304215601;3784.5458544973676;5055.898882022412;5283.969625922909;5315.448584679453;5317.112425089038;5328.6802791832615;5071.109467603578;5084.339035925306;5154.407243167084;5155.2782610435315;5206.323177986989;5102.897942041212;5128.435872053997;5130.846074617767;5145.61407894402;5171.663841850268;4905.166121759238;4995.975020124876;4998.725070121178;5052.646314757932;5056.266841307916;4884.291777692286;5065;5097.92353114711;5186.118359878754;5187.2478490619405;5006.4743201963265;5014.122528557561;5059.822906198266;5062.063518249136;5090.567301779391 13:33:50 INFO - PROCESS | 16720 | |5;yui.html;643.6524276890478;674.8650269946012;680.9489288303379;738.2211766586253;751.8158051277438;12071.21537100089;12512.124151309412;12554.874451255484;12577.685557861058;12700.872991270107;11331.490082946266;11358.886411135885;11383.829242561369;11428.885711142886;11443.198976071679;647.6211416321457;790.6521130702472;802.8675268580691;811.5658122904248;813.7070654564352;803.9477433966773;804.284187073505;805.3516918880299;806.4234072638092;812.2649002652579;855.995720021399;861.7974775927652;862.6980556805099;863.4128792421151;865.3726048614767;848.9872651910226;850.2347886901777;850.3494826457795;851.2764150472111;855.8074433252468;628.8742251549662;629.2417636747708;630.5019034962374;632.585656395062;635.6281575278467;11950.46222919962;11967;11976.520939162423;11999.580014699532;12070.09474289423;10268.435236062014;10385;10439.321444106108;10473.84289235662;10884.61903833362;9646.565904534313;9691.70924872248;9825.575291582752;9915.355501892354;10194.9490252549;3304.8512816923294;3313.3870234006786;3347.246869454353;3359;3390.643982381839;41494.37758433626;41700.165996680196;42482.78758606218;42621.57378426238;43192.13615727699;9483.905160948303;9621.9037809621;9940.701778946643;9994.200463962865;10282.331648442827;16490.917545412438;16610.335586576402;16632.91683541599;16753.329866805434;16944.57638559021;6431.421172094534;6591.571547849375;6608.966955165193;6665.400113989765;6764.425023873026;3660.522632986532;3707.8331475083146;3707.8516859325323;3723;3752.3245815753426;2627.618995245679;2659.308579769274;2793.608894754736;2802.7057158998014;2817.0985284708695;566.3741565570068;570.4181734630654;572.6478215897193;582.4815913836688;583.7227317024465;502.4673845723545;567.9801206957736;616.1527899138684;619.3713380918372;622.3620788691537;7203.71185152588;7319.74380896666;7521.623918804038;7533.1336896256535;7622.847543049108;499.8375527953357;522.2140678279166;540.1465684218924;599.6701814002281;613.7299588181186;3623.7825730456257;3700.5559332880225;3704.3147017801252;3732.9626703733156;3775.433684947225;53556;55831.441685583435;55849.44150558442;55901.44098558962;56060.719696401255;47141.5285847144;48546.75726621415;48853.755731221114;49104.75447622739;50812;44654.33018504725;44683.436079737054;44808.103837923714;45222.77388613036;45635;6923.134608173978;7063.364297213276;7099.893501597377;7115.181754098345;7176.712931482891;29395.559066614445;29816.10551683453;30216.395672085997;30223.697763022967;30468.238294042825;36183.819080904424;36802.63197367992;37433.43849842309;38053.23893522169;40259.59740402558;10835.566577336818;10854.782904342026;10869.891301087204;10895.455227238448;10925.890741092488;10341.172706183637;10728.034476897117;11281.548738050715;11926.344051077274;12034.75930481403;10391.272610917164;10736.087432568007;10908.072813810597;11136.220464567403;11734.354610496504;10163.507711639848;10378.584856605652;10380.844287335545;10405.27163098606;11088.223824332219;10316.27786054969;10420.32267902584;10559.736006599896;10681.732956676145;10770.407627580558;8596.35527335465;8811.911880881109;8885.733427997171;9041.276697864287;9132.726018219464;8977;9204.631814727336;9222.492762898106;9285.442873427615;9312.115349041831 13:33:50 INFO - PROCESS | 16720 | __end_tp_report 13:33:50 INFO - PROCESS | 16720 | __start_cc_report 13:33:50 INFO - PROCESS | 16720 | _x_x_mozilla_cycle_collect,320 13:33:50 INFO - PROCESS | 16720 | __end_cc_report 13:33:50 INFO - PROCESS | 16720 | __startTimestamp1463776430837__endTimestamp 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | ------- Summary: start ------- 13:33:50 INFO - PROCESS | 16720 | Number of tests: 6 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | [#0] dojo.html Cycles:165 Average:4704.96 Median:4877.05 stddev:504.04 (10.3%) stddev-sans-first:478.31 13:33:50 INFO - PROCESS | 16720 | Values: 2619.7 2624.7 2659.4 2659.5 2678.6 4578.4 4616.2 4679.7 4695.3 4717.6 4567.5 4648.9 4743.1 4745.8 4772.5 4324.0 4420.3 4443.3 4471.2 4482.5 4457.5 4466.0 4488.1 4513.7 4566.6 4326.9 4366.0 4386.3 4390.3 4399.5 4379.1 4383.8 4389.8 4405.3 4440.1 4214.5 4285.6 4298.4 4325.7 4386.7 4590.6 4603.4 4630.7 4640.4 4645.6 5052.3 5075.9 5097.9 5102.9 5132.6 4900.6 5122.1 5161.1 5168.0 5206.0 4810.3 4851.7 4867.2 4885.9 4907.4 5299.8 5308.4 5316.1 5326.1 5328.0 4849.4 4917.9 4923.4 4937.5 5105.7 4851.2 4962.7 4980.5 5007.3 5059.2 4972.1 5011.6 5045.0 5052.4 5069.7 4884.7 4934.2 4949.3 4986.6 5072.5 4184.4 4203.7 4212.0 4217.6 4258.5 3671.8 3694.7 3701.5 3719.5 3730.5 4383.9 4407.7 4414.2 4418.3 4448.9 5069.1 5073.6 5085.6 5118.1 5154.5 4327.5 4414.8 4433.0 4458.4 4506.5 4561.7 4572.4 4597.1 4628.3 4629.6 4914.1 4923.1 4931.0 4942.3 4964.3 4966.4 5167.1 5193.5 5218.3 5267.6 4913.9 4940.9 4958.5 4959.2 5005.0 5100.8 5111.8 5132.3 5148.2 5185.4 4935.5 4958.7 4976.3 5189.5 5209.4 4826.3 4832.2 4913.7 4916.3 4921.9 4877.0 4880.1 4884.6 4900.0 4936.6 4638.5 4824.9 4829.3 4837.8 4852.1 5020.7 5072.3 5090.2 5102.1 5128.1 4915.5 4976.7 4986.1 4987.6 5035.7 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | [#1] ext.html Cycles:180 Average:43730.46 Median:374122.00 stddev:77170.08 (20.6%) stddev-sans-first:77318.36 13:33:50 INFO - PROCESS | 16720 | Values: 520.4 555.8 558.2 585.3 598.4 28505.1 39944.8 40285.8 40337.4 40545.8 41949.0 42283.0 42291.4 42420.4 42423.4 7703.0 7834.6 7849.1 7864.3 7869.6 7697.0 7782.0 7791.9 7823.1 7827.5 7818.3 7845.6 7875.1 7877.6 7879.5 7814.5 7874.5 7876.8 7887.3 7905.1 7005.9 7063.0 7075.0 7078.0 7123.2 38442.8 38832.4 38837.4 38914.8 39000.0 3023.5 3048.0 3098.7 3152.4 3350.0 29147.7 29189.7 29731.4 29832.7 30611.0 3505.1 3523.4 3607.2 3676.0 3679.1 182516.0 182892.0 244477.0 247663.0 249693.0 33648.0 54391.2 54553.7 54650.2 54828.7 33095.0 35214.9 35224.6 35368.0 35453.1 12152.6 12320.1 12395.5 12405.4 12417.9 9599.5 9616.1 9644.2 9659.0 9694.0 8157.0 8218.2 8219.1 8219.7 8257.9 3279.0 3290.5 3302.9 3314.9 3351.9 943.1 949.1 953.7 1048.6 1058.3 28229.7 28565.0 28826.6 28991.6 29039.4 991.9 1002.0 1009.5 1022.8 1102.0 14858.6 15035.0 15216.4 15314.3 15481.3 374030.0 374214.0 381224.0 381806.0 382694.0 49259.0 50513.5 50562.2 50706.2 50786.5 1215.6 1254.2 1255.2 1268.2 1269.8 26955.6 27846.4 28197.9 28271.7 28292.7 43732.0 43878.8 43929.3 44102.8 44120.6 249789.0 251479.0 251912.0 253126.0 255494.0 25762.4 26151.5 26186.9 26188.5 26285.3 37427.6 42067.2 42481.0 42544.0 43402.3 36172.6 36449.8 37561.4 37583.2 37633.6 33915.3 37372.4 37397.6 37645.8 37721.5 34790.0 36574.8 37771.2 38157.2 41199.0 32727.3 33150.5 34585.0 34599.1 34740.8 25508.7 25624.0 25749.9 26051.2 26246.6 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | [#2] jquery.html Cycles:180 Average:23984.64 Median:4664.28 stddev:67256.94 (1442.0%) stddev-sans-first:67422.26 13:33:50 INFO - PROCESS | 16720 | Values: 382.9 389.4 392.8 399.3 400.5 15897.9 16229.2 17344.8 17374.9 17439.7 9104.4 10304.5 10702.1 10723.7 10735.3 4543.8 4553.6 4723.3 4732.1 4739.8 4648.1 4659.3 4662.0 4692.1 4701.0 4666.5 4672.6 4678.4 4691.1 4994.9 5299.9 5380.3 5388.6 5414.6 5427.8 5029.5 5437.5 5451.1 5458.7 5468.2 12397.9 12593.0 12630.2 17661.9 20546.0 1866.0 1918.3 1941.5 1942.6 1956.9 8664.8 8948.6 9111.5 9354.7 9423.7 1699.7 1717.8 1744.6 1783.4 1799.6 68871.3 69725.0 70516.3 71587.3 72486.0 8338.2 8991.0 9012.2 9469.9 9577.2 12379.9 12481.9 12490.8 12528.6 12570.7 6337.1 6509.0 6670.1 6823.0 6920.0 6305.4 6711.9 6742.9 6837.9 7059.8 4372.5 4455.0 4503.6 4508.4 4522.7 1879.6 1880.5 1917.7 1919.3 1932.3 812.9 890.7 900.7 904.7 964.7 16597.7 16717.5 16799.9 16991.8 17138.8 873.2 881.0 901.4 902.6 922.4 9376.7 9450.7 9463.4 9672.3 9703.8 353517.0 414835.0 417413.6 420732.0 425481.0 45675.5 80247.6 83870.6 85044.0 85720.6 955.2 973.6 985.4 1014.7 1021.5 14761.9 15017.1 15024.5 15029.4 15553.5 32727.7 33294.0 34726.7 35607.5 36747.0 36811.4 45957.3 46601.8 49260.0 52057.2 7239.3 7500.8 7526.6 7551.2 7718.4 5904.0 9900.2 10886.2 11014.2 12002.2 4676.8 5378.9 9607.5 9818.2 10295.8 8859.8 9738.7 10027.4 10165.4 10839.7 9930.0 10465.2 10711.0 10711.9 10721.2 6637.7 6692.5 6841.0 7752.5 7944.5 10096.0 10678.0 10750.6 10818.6 10828.6 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | [#3] mootools.html Cycles:180 Average:5222.96 Median:4610.19 stddev:2974.73 (64.5%) stddev-sans-first:2969.73 13:33:50 INFO - PROCESS | 16720 | Values: 1473.9 1500.3 1600.4 1775.3 1824.2 6709.9 7595.7 7890.4 8154.2 8165.7 8054.3 8099.1 8131.8 8136.8 8180.5 2210.3 2242.4 2249.9 2252.4 2258.2 2234.0 2244.9 2245.2 2246.4 2255.0 2215.1 2217.3 2221.8 2234.6 2250.0 2136.0 2155.4 2156.9 2158.8 2158.9 2174.6 2175.9 2179.4 2181.2 2184.1 8096.0 8163.1 8165.8 8174.0 8204.5 4455.1 4585.7 4605.5 4608.9 4611.4 2953.8 3082.8 3102.6 3113.1 3121.8 952.9 960.5 968.5 974.3 977.1 10904.2 10979.0 11001.3 11017.3 11070.8 4138.2 4194.7 4207.3 4217.0 4298.4 9451.0 9463.1 9471.7 9482.0 9532.8 4521.2 4527.3 4538.4 4555.8 4576.6 3417.2 3840.2 3927.1 4052.7 4169.9 3803.2 3853.4 3911.3 3937.2 3943.3 1257.4 1262.8 1263.8 1271.2 1278.9 742.0 767.1 786.6 863.3 865.1 4906.4 5140.3 5219.1 5332.9 5346.7 868.5 906.8 910.1 913.9 917.5 3432.7 3438.8 3540.3 3544.6 3590.0 9807.6 9966.4 10087.2 10260.3 10283.2 9908.5 10049.9 10060.6 10107.7 10109.4 6811.6 7171.1 7174.6 7261.2 7428.4 5615.9 5680.3 5805.4 5846.7 5856.1 8804.4 9193.3 9249.2 9288.3 9396.0 9168.7 9343.7 9426.9 9515.3 9562.7 5753.8 6354.3 6589.0 6605.7 6778.2 7631.9 7717.4 7722.4 7742.8 7791.7 6538.8 6719.8 6850.2 7077.6 7186.2 6451.6 6452.5 6513.9 6519.7 6595.7 5995.9 6019.0 6062.5 6091.2 6097.2 4310.9 4360.1 4392.8 4415.0 4539.8 4383.4 4386.8 4466.2 4493.4 4505.7 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | [#4] prototype.html Cycles:180 Average:4261.38 Median:4890.49 stddev:1226.32 (25.1%) stddev-sans-first:1193.23 13:33:50 INFO - PROCESS | 16720 | Values: 302.8 305.7 306.2 311.9 312.8 4911.9 4912.6 4925.5 4952.5 4957.6 4811.6 4817.7 4836.6 4866.6 4880.4 3628.2 3658.9 3793.9 3795.4 3812.7 3816.0 3823.0 3834.1 3839.2 3845.1 3797.7 3816.6 3819.1 3822.9 3827.5 3587.5 3815.4 3821.5 3829.8 3833.5 3380.4 3391.6 3397.3 3405.8 3406.2 4620.3 4645.7 4678.9 4697.8 4707.1 4391.4 4411.3 4413.6 4416.3 4427.0 4955.6 5039.8 5041.3 5069.2 5077.9 3719.6 3724.3 3726.4 3726.9 3737.4 5317.0 5319.9 5383.2 5386.9 5400.4 3691.0 3817.0 3818.8 3836.2 3836.4 3858.6 3889.2 3889.5 3896.7 3915.4 4342.5 4350.5 4359.3 4375.8 4393.5 4994.9 5063.9 5095.9 5166.7 5168.2 1328.8 1336.7 1343.9 1347.5 1348.9 854.0 860.0 867.9 888.4 888.8 4404.9 4463.5 4492.0 4519.3 4522.7 5179.1 5211.2 5222.9 5239.8 5255.8 4381.5 4507.0 4532.5 4534.6 4556.2 2753.7 2819.4 2819.9 2828.5 2831.6 4974.7 4979.9 4986.3 4988.7 5011.2 5101.3 5318.8 5370.5 5375.3 5393.4 4971.7 4975.0 4982.5 5019.4 5027.6 5244.3 5262.7 5277.0 5286.3 5304.7 4896.7 5149.5 5168.5 5196.5 5205.0 5011.6 5046.0 5066.0 5067.3 5105.3 3731.0 3750.4 3773.2 3783.7 3784.5 5055.9 5284.0 5315.4 5317.1 5328.7 5071.1 5084.3 5154.4 5155.3 5206.3 5102.9 5128.4 5130.8 5145.6 5171.7 4905.2 4996.0 4998.7 5052.6 5056.3 4884.3 5065.0 5097.9 5186.1 5187.2 5006.5 5014.1 5059.8 5062.1 5090.6 13:33:50 INFO - PROCESS | 16720 | 13:33:50 INFO - PROCESS | 16720 | [#5] yui.html Cycles:180 Average:12649.35 Median:45428.89 stddev:14773.06 (32.5%) stddev-sans-first:14786.99 13:33:50 INFO - PROCESS | 16720 | Values: 643.7 674.9 680.9 738.2 751.8 12071.2 12512.1 12554.9 12577.7 12700.9 11331.5 11358.9 11383.8 11428.9 11443.2 647.6 790.7 802.9 811.6 813.7 803.9 804.3 805.4 806.4 812.3 856.0 861.8 862.7 863.4 865.4 849.0 850.2 850.3 851.3 855.8 628.9 629.2 630.5 632.6 635.6 11950.5 11967.0 11976.5 11999.6 12070.1 10268.4 10385.0 10439.3 10473.8 10884.6 9646.6 9691.7 9825.6 9915.4 10194.9 3304.9 3313.4 3347.2 3359.0 3390.6 41494.4 41700.2 42482.8 42621.6 43192.1 9483.9 9621.9 9940.7 9994.2 10282.3 16490.9 16610.3 16632.9 16753.3 16944.6 6431.4 6591.6 6609.0 6665.4 6764.4 3660.5 3707.8 3707.9 3723.0 3752.3 2627.6 2659.3 2793.6 2802.7 2817.1 566.4 570.4 572.6 582.5 583.7 502.5 568.0 616.2 619.4 622.4 7203.7 7319.7 7521.6 7533.1 7622.8 499.8 522.2 540.1 599.7 613.7 3623.8 3700.6 3704.3 3733.0 3775.4 53556.0 55831.4 55849.4 55901.4 56060.7 47141.5 48546.8 48853.8 49104.8 50812.0 44654.3 44683.4 44808.1 45222.8 45635.0 6923.1 7063.4 7099.9 7115.2 7176.7 29395.6 29816.1 30216.4 30223.7 30468.2 36183.8 36802.6 37433.4 38053.2 40259.6 10835.6 10854.8 10869.9 10895.5 10925.9 10341.2 10728.0 11281.5 11926.3 12034.8 10391.3 10736.1 10908.1 11136.2 11734.4 10163.5 10378.6 10380.8 10405.3 11088.2 10316.3 10420.3 10559.7 10681.7 10770.4 8596.4 8811.9 8885.7 9041.3 9132.7 8977.0 9204.6 9222.5 9285.4 9312.1 13:33:50 INFO - PROCESS | 16720 | -------- Summary: end -------- 13:33:50 INFO - PROCESS | 16720 | 13:33:51 INFO - TEST-INFO | 16720: exit 0 13:33:51 INFO - TEST-OK | dromaeo_css | took 1113280ms 13:33:51 INFO - TEST-START | kraken 13:33:51 INFO - operating with platform_type : linux_ 13:33:51 INFO - Initialising browser for kraken test... 13:33:51 INFO - TEST-INFO | started process 16959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJA51VL/profile http://localhost:59092/getInfo.html) 13:33:55 INFO - PROCESS | 16959 | 13:33:55 INFO - PROCESS | 16959 | (process:17025): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:33:55 INFO - PROCESS | 16959 | __metrics Screen width/height:1600/1200 13:33:55 INFO - PROCESS | 16959 | colorDepth:24 13:33:55 INFO - PROCESS | 16959 | Browser inner width/height: 1024/697 13:33:55 INFO - PROCESS | 16959 | __metrics 13:33:56 ERROR - PROCESS | 16959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:33:57 INFO - TEST-INFO | 16959: exit 0 13:33:57 INFO - Browser initialized. 13:33:57 INFO - Running cycle 1/1 for kraken test... 13:33:57 INFO - TEST-INFO | started process 17076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJA51VL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:58 INFO - PROCESS | 17076 | 13:33:58 INFO - PROCESS | 17076 | (process:17137): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:34:08 INFO - PROCESS | 17076 | RSS: Main: 164229120 13:34:08 INFO - PROCESS | 17076 | 13:34:11 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-beat-detection) 13:34:12 INFO - PROCESS | 17076 | RSS: Main: 168300544 13:34:12 INFO - PROCESS | 17076 | 13:34:15 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-dft) 13:34:15 INFO - PROCESS | 17076 | RSS: Main: 169332736 13:34:15 INFO - PROCESS | 17076 | 13:34:18 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-fft) 13:34:19 INFO - PROCESS | 17076 | RSS: Main: 163590144 13:34:19 INFO - PROCESS | 17076 | 13:34:21 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-oscillator) 13:34:22 INFO - PROCESS | 17076 | RSS: Main: 163819520 13:34:22 INFO - PROCESS | 17076 | 13:34:24 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:34:25 INFO - PROCESS | 17076 | RSS: Main: 163934208 13:34:25 INFO - PROCESS | 17076 | 13:34:28 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59092/tests/kraken/driver.html?testName=imaging-darkroom) 13:34:28 INFO - PROCESS | 17076 | RSS: Main: 164184064 13:34:28 INFO - PROCESS | 17076 | 13:34:32 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59092/tests/kraken/driver.html?testName=imaging-desaturate) 13:34:33 INFO - PROCESS | 17076 | RSS: Main: 163102720 13:34:33 INFO - PROCESS | 17076 | 13:34:36 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59092/tests/kraken/driver.html?testName=json-parse-financial) 13:34:36 INFO - PROCESS | 17076 | RSS: Main: 163459072 13:34:36 INFO - PROCESS | 17076 | 13:34:38 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:34:39 INFO - PROCESS | 17076 | RSS: Main: 164282368 13:34:39 INFO - PROCESS | 17076 | 13:34:41 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:34:41 INFO - PROCESS | 17076 | RSS: Main: 164241408 13:34:41 INFO - PROCESS | 17076 | 13:34:43 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:34:44 INFO - PROCESS | 17076 | RSS: Main: 165154816 13:34:44 INFO - PROCESS | 17076 | 13:34:47 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:34:48 INFO - PROCESS | 17076 | RSS: Main: 164499456 13:34:48 INFO - PROCESS | 17076 | 13:34:51 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:34:51 INFO - PROCESS | 17076 | RSS: Main: 164278272 13:34:51 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59092/tests/kraken/driver.html?testName=ai-astar) 13:34:53 INFO - PROCESS | 17076 | RSS: Main: 166203392 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | __start_tp_report 13:34:53 INFO - PROCESS | 17076 | _x_x_mozilla_page_load 13:34:53 INFO - PROCESS | 17076 | _x_x_mozilla_page_load_details 13:34:53 INFO - PROCESS | 17076 | |i|pagename|runs| 13:34:53 INFO - PROCESS | 17076 | |0;ai-astar;117;117;110;117;118;116;110;116;115;116 13:34:53 INFO - PROCESS | 17076 | |1;audio-beat-detection;160;137;160;211;149;157;171;139;186;138 13:34:53 INFO - PROCESS | 17076 | |2;audio-dft;164;163;162;165;177;169;165;167;164;163 13:34:53 INFO - PROCESS | 17076 | |3;audio-fft;77;78;79;155;78;78;78;77;152;78 13:34:53 INFO - PROCESS | 17076 | |4;audio-oscillator;94;95;170;95;94;95;138;98;93;137 13:34:53 INFO - PROCESS | 17076 | |5;imaging-gaussian-blur;119;119;119;120;120;119;120;120;120;118 13:34:53 INFO - PROCESS | 17076 | |6;imaging-darkroom;150;152;150;151;150;150;150;149;150;149 13:34:53 INFO - PROCESS | 17076 | |7;imaging-desaturate;98;97;97;96;97;96;97;97;97;97 13:34:53 INFO - PROCESS | 17076 | |8;json-parse-financial;69;69;67;68;68;68;67;67;67;68 13:34:53 INFO - PROCESS | 17076 | |9;json-stringify-tinderbox;65;64;65;65;66;67;65;65;65;65 13:34:53 INFO - PROCESS | 17076 | |10;stanford-crypto-aes;90;90;87;91;90;87;87;86;151;88 13:34:53 INFO - PROCESS | 17076 | |11;stanford-crypto-ccm;146;149;140;138;148;139;140;155;155;143 13:34:53 INFO - PROCESS | 17076 | |12;stanford-crypto-pbkdf2;179;181;183;183;179;179;178;179;178;182 13:34:53 INFO - PROCESS | 17076 | |13;stanford-crypto-sha256-iterative;73;72;72;71;72;74;90;72;70;70 13:34:53 INFO - PROCESS | 17076 | __end_tp_report 13:34:53 INFO - PROCESS | 17076 | __start_cc_report 13:34:53 INFO - PROCESS | 17076 | _x_x_mozilla_cycle_collect,817 13:34:53 INFO - PROCESS | 17076 | __end_cc_report 13:34:53 INFO - PROCESS | 17076 | __startTimestamp1463776493779__endTimestamp 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | ------- Summary: start ------- 13:34:53 INFO - PROCESS | 17076 | Number of tests: 14 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.50 stddev:2.86 (2.5%) stddev-sans-first:2.96 13:34:53 INFO - PROCESS | 17076 | Values: 117.0 117.0 110.0 117.0 118.0 116.0 110.0 116.0 115.0 116.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#1] audio-beat-detection Cycles:10 Average:160.80 Median:160.00 stddev:23.51 (14.7%) stddev-sans-first:24.94 13:34:53 INFO - PROCESS | 17076 | Values: 160.0 137.0 160.0 211.0 149.0 157.0 171.0 139.0 186.0 138.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:4.41 (2.7%) stddev-sans-first:4.62 13:34:53 INFO - PROCESS | 17076 | Values: 164.0 163.0 162.0 165.0 177.0 169.0 165.0 167.0 164.0 163.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#3] audio-fft Cycles:10 Average:93.00 Median:78.00 stddev:31.90 (40.9%) stddev-sans-first:33.30 13:34:53 INFO - PROCESS | 17076 | Values: 77.0 78.0 79.0 155.0 78.0 78.0 78.0 77.0 152.0 78.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.50 stddev:27.34 (28.9%) stddev-sans-first:28.30 13:34:53 INFO - PROCESS | 17076 | Values: 94.0 95.0 170.0 95.0 94.0 95.0 138.0 98.0 93.0 137.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:120.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:34:53 INFO - PROCESS | 17076 | Values: 119.0 119.0 119.0 120.0 120.0 119.0 120.0 120.0 120.0 118.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 13:34:53 INFO - PROCESS | 17076 | Values: 150.0 152.0 150.0 151.0 150.0 150.0 150.0 149.0 150.0 149.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 13:34:53 INFO - PROCESS | 17076 | Values: 98.0 97.0 97.0 96.0 97.0 96.0 97.0 97.0 97.0 97.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#8] json-parse-financial Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 13:34:53 INFO - PROCESS | 17076 | Values: 69.0 69.0 67.0 68.0 68.0 68.0 67.0 67.0 67.0 68.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 13:34:53 INFO - PROCESS | 17076 | Values: 65.0 64.0 65.0 65.0 66.0 67.0 65.0 65.0 65.0 65.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#10] stanford-crypto-aes Cycles:10 Average:94.70 Median:89.00 stddev:19.86 (22.3%) stddev-sans-first:20.99 13:34:53 INFO - PROCESS | 17076 | Values: 90.0 90.0 87.0 91.0 90.0 87.0 87.0 86.0 151.0 88.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:147.00 stddev:6.36 (4.3%) stddev-sans-first:6.74 13:34:53 INFO - PROCESS | 17076 | Values: 146.0 149.0 140.0 138.0 148.0 139.0 140.0 155.0 155.0 143.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:180.00 stddev:1.97 (1.1%) stddev-sans-first:2.05 13:34:53 INFO - PROCESS | 17076 | Values: 179.0 181.0 183.0 183.0 179.0 179.0 178.0 179.0 178.0 182.0 13:34:53 INFO - PROCESS | 17076 | 13:34:53 INFO - PROCESS | 17076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:72.00 stddev:5.89 (8.2%) stddev-sans-first:6.24 13:34:53 INFO - PROCESS | 17076 | Values: 73.0 72.0 72.0 71.0 72.0 74.0 90.0 72.0 70.0 70.0 13:34:53 INFO - PROCESS | 17076 | -------- Summary: end -------- 13:34:53 INFO - PROCESS | 17076 | 13:34:54 INFO - TEST-INFO | 17076: exit 0 13:34:54 INFO - TEST-OK | kraken | took 63212ms 13:34:54 INFO - SUITE-END | took 1176s 13:34:54 INFO - Completed test suite (00:19:36) 13:34:54 INFO - javascript benchmark 13:34:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.6594442722444, 2624.724403937588, 2659.428222932068, 2659.48140112678, 2678.5982102684593, 4578.427696537933, 4616.238320677088, 4679.695819771712, 4695.319178719088, 4717.599004084657, 4567.451905771304, 4648.907021859561, 4743.12252233337, 4745.833895813647, 4772.451168115667, 4324.04870928396, 4420.3369494575745, 4443.333499975013, 4471.239889218824, 4482.484514280851, 4457.531959144292, 4466.0, 4488.147252022105, 4513.706609070417, 4566.566176213271, 4326.870193894172, 4365.956340436586, 4386.320120381346, 4390.297552391602, 4399.494058183318, 4379.1022840317655, 4383.846565370229, 4389.846355377578, 4405.339199120125, 4440.134173836103, 4214.473190851144, 4285.635720963722, 4298.398224248608, 4325.718828276152, 4386.7367957922625, 4590.563896429834, 4603.355530225771, 4630.722156670577, 4640.350350950869, 4645.605123564501, 5052.317937078484, 5075.8984820303385, 5097.929434818692, 5102.872428189288, 5132.563732082777, 4900.558949694545, 5122.066310691668, 5161.096808058574, 5168.0, 5206.0, 4810.302506136591, 4851.733154676492, 4867.172580661296, 4885.902281954376, 4907.435644900882, 5299.8410047698635, 5308.362996440452, 5316.069687804618, 5326.094563924142, 5328.0, 4849.418069831572, 4917.852464426073, 4923.384576927884, 4937.530934561211, 5105.693658380509, 4851.223804191312, 4962.702237865739, 4980.452150263468, 5007.349044624176, 5059.165237735806, 4972.055309491185, 5011.649184557119, 5045.016221836707, 5052.418971818288, 5069.746512674352, 4884.7069175849565, 4934.235193545006, 4949.257611358253, 4986.551210391082, 5072.492750724972, 4184.4351012613515, 4203.726757760797, 4212.0, 4217.62041416274, 4258.510271318838, 3671.81640917953, 3694.6859516941363, 3701.481792549045, 3719.5350581177354, 3730.5336832895887, 4383.868483945486, 4407.6914615976575, 4414.227510185705, 4418.315161150027, 4448.866534003985, 5069.062223488666, 5073.619478539124, 5085.567726743268, 5118.078745825713, 5154.484551544891, 4327.459067616548, 4414.823407063745, 4433.046894917608, 4458.420405347284, 4506.459224893034, 4561.703489273186, 4572.3827283317, 4597.080583883237, 4628.259478483494, 4629.583337499641, 4914.140025495524, 4923.08922849274, 4931.013797240495, 4942.28336891156, 4964.280179373971, 4966.35437393151, 5167.069927413102, 5193.480651934777, 5218.347706536683, 5267.552258058108, 4913.877153071202, 4940.8764780880765, 4958.5041495851565, 4959.20652695567, 5005.024020316149, 5100.846974590768, 5111.769970351269, 5132.255822905732, 5148.150555158357, 5185.377754669464, 4935.506449355035, 4958.677685950402, 4976.30331753562, 5189.455107213839, 5209.374875015023, 4826.251930950708, 4832.20268655682, 4913.70517768935, 4916.311716359784, 4921.901561968669, 4877.048975449753, 4880.145974454527, 4884.5603895649565, 4899.951000490092, 4936.629752768485, 4638.512956139557, 4824.8793780155775, 4829.27560865873, 4837.830675926326, 4852.102361063215, 5020.698758074527, 5072.28987941681, 5090.211017292326, 5102.056119617882, 5128.128218202989, 4915.483874193301, 4976.651634385558, 4986.077575648372, 4987.625928055338, 5035.723035233097], "value": 4672.215480849725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.3963402453155, 555.7804667156473, 558.2352177516798, 585.259646547118, 598.3657323237369, 28505.14484565464, 39944.80027599861, 40285.79857100718, 40337.39493907594, 40545.79727101364, 41949.0, 42283.0, 42291.36562951558, 42420.363694544605, 42423.36364954528, 7703.0, 7834.647440865175, 7849.136594974549, 7864.252895974902, 7869.567173805438, 7697.0, 7782.027246594176, 7791.883121753178, 7823.139454659983, 7827.452078354518, 7818.335441487452, 7845.568493732842, 7875.133735289113, 7877.566733829637, 7879.527228366316, 7814.53112813233, 7874.488158269694, 7876.80307992299, 7887.250711182429, 7905.130435652074, 7005.859882802315, 7063.0, 7075.0, 7078.044463997346, 7123.180834204081, 38442.80778596117, 38832.41751373732, 38837.41743873844, 38914.80542597269, 39000.0, 3023.4708925938094, 3047.969520304791, 3098.7056229658374, 3152.4168028914496, 3350.0452371074125, 29147.68835402412, 29189.708102919125, 29731.40537189266, 29832.70167298321, 30611.0, 3505.1237190702323, 3523.4362501999813, 3607.2244467439627, 3676.0258531489176, 3679.098620837885, 182516.0, 182892.0, 244477.0, 247663.0, 249693.0, 33648.0, 54391.18413223805, 54553.72723136359, 54650.180247296325, 54828.72585637126, 33095.02859656808, 35214.94355169349, 35224.64775352265, 35368.0, 35453.11367215789, 12152.635420937386, 12320.137590368588, 12395.504179832886, 12405.44175512104, 12417.875821241852, 9599.47202903833, 9616.134547890724, 9644.18024467928, 9659.0, 9693.951530242444, 8156.959215203886, 8218.178182181853, 8219.136990616018, 8219.671213151527, 8257.876131858027, 3278.9836050819595, 3290.4899740540254, 3302.9009129726146, 3314.8839790607212, 3351.865925362958, 943.1464524605243, 949.0699114867468, 953.6757502449201, 1048.5648455890873, 1058.30680904008, 28229.71770282312, 28565.0, 28826.567601485993, 28991.565126523117, 29039.41921161607, 991.8908920018937, 1001.9649312274036, 1009.5255230041869, 1022.7954409118206, 1101.9614313499148, 14858.554243372717, 15035.0, 15216.391344346102, 15314.310856011507, 15481.259161024647, 374030.0, 374214.0, 381224.0, 381806.0, 382694.0, 49259.0, 50513.494865051616, 50562.241566376535, 50706.23940640893, 50786.492135078915, 1215.5806246844825, 1254.184779893077, 1255.1653150654713, 1268.1756858042163, 1269.7650934577132, 26955.595666064633, 27846.44307113887, 28197.859010704815, 28271.717282826907, 28292.717072829008, 43732.0, 43878.780606098044, 43929.34105988349, 44102.79486025622, 44120.55879441293, 249789.0, 251479.0, 251912.0, 253126.0, 255494.0, 25762.35594110162, 26151.476970460866, 26186.86906565455, 26188.476230475666, 26285.342866427727, 37427.625723742414, 42067.158656827305, 42481.0, 42544.0, 43402.348964764926, 36172.638273616925, 36449.817750911076, 37561.43657845189, 37583.24833503369, 37633.62366376301, 33915.3216935655, 37372.43941340937, 37397.626023739416, 37645.81177094097, 37721.54809937345, 34790.0, 36574.817125915266, 37771.2445751078, 38157.2368552633, 41199.0, 32727.34545309033, 33150.50822713032, 34585.0, 34599.13502162466, 34740.82629586937, 25508.724563771368, 25624.0, 25749.923821227214, 26051.218463446126, 26246.60630090512], "value": 16472.57329527994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8793929912077, 389.44504081683596, 392.77219212856545, 399.3467046427791, 400.5333786139148, 15897.920510397445, 16229.188540572954, 17344.826551734477, 17374.913125434356, 17439.73840392395, 9104.362694611364, 10304.536295866685, 10702.143828493721, 10723.678289651323, 10735.302205356646, 4543.8182472701055, 4553.5901768840795, 4723.291506274052, 4732.124556956956, 4739.763011849411, 4648.093621743761, 4659.324397962293, 4662.044280922402, 4692.06158768246, 4701.036287561059, 4666.510016448275, 4672.6261899047995, 4678.415198100238, 4691.061787642485, 4994.925076123843, 5299.947000530004, 5380.2736630555155, 5388.595855310868, 5414.620976531644, 5427.782888684448, 5029.5221953914315, 5437.483439073281, 5451.127819548853, 5458.699771512565, 5468.234447177399, 12397.946174575172, 12593.0, 12630.242185468902, 17661.911690441593, 20545.972701365023, 1866.0016890963404, 1918.2902326139417, 1941.4952112450724, 1942.5920556682972, 1956.8825870447677, 8664.826703465895, 8948.64205431782, 9111.544422778901, 9354.672586459441, 9423.717288481357, 1699.6770613583503, 1717.7766890304306, 1744.5725797179646, 1783.3936461603116, 1799.5591080185438, 68871.311286887, 69725.0, 70516.29483705148, 71587.28412715858, 72486.0, 8338.207870252316, 8990.955045224731, 9012.188902998761, 9469.905300946903, 9577.23382129428, 12379.876201237872, 12481.875181248071, 12490.75018499625, 12528.624141275777, 12570.748585028248, 6337.081123237105, 6508.967455162694, 6670.099536562502, 6823.0, 6919.965400173068, 6305.369463053658, 6711.932880671228, 6742.932570674328, 6837.863242735118, 7059.7529086482755, 4372.519022907478, 4454.977725111418, 4503.572160644733, 4508.413906192174, 4522.706024108423, 1879.6052828906084, 1880.5204672808347, 1917.7219303201236, 1919.2610844824842, 1932.3043704266454, 812.9390295727844, 890.7238755985666, 900.7387857521377, 904.7059705595708, 964.6671898195111, 16597.668046639, 16717.49847504577, 16799.91600041992, 16991.83008169927, 17138.828611713972, 873.2097451806126, 881.0176653031951, 901.3870568013682, 902.566767951387, 922.3820040572832, 9376.718698439057, 9450.669226577174, 9463.43219406824, 9672.274579406572, 9703.832493721447, 353517.0, 414835.0, 417413.56466087984, 420732.0, 425481.0, 45675.543244567794, 80247.59876200698, 83870.5806470976, 85044.0, 85720.57139714262, 955.2071780422233, 973.6056896956744, 985.3644399362371, 1014.7361685961703, 1021.4637315409469, 14761.92619036898, 15017.098974061591, 15024.474143405365, 15029.398824046915, 15553.455629052929, 32727.672723272462, 33294.00117996464, 34726.652733473355, 35607.465888012215, 36747.0, 36811.44782828313, 45957.310640339754, 46601.766991164826, 49260.0, 52057.219141713664, 7239.276072392719, 7500.774976750488, 7526.623668816428, 7551.169371369255, 7718.382529397522, 5903.996320625418, 9900.158486528726, 10886.237963342806, 11014.229003969645, 12002.2198557097, 4676.766161691834, 5378.892422151614, 9607.471589062388, 9818.214542836413, 10295.764508259057, 8859.822803544022, 9738.707838764849, 10027.448490333101, 10165.390076595428, 10839.67480975572, 9930.0, 10465.215108866712, 10711.018461584632, 10711.94644026775, 10721.195910306602, 6637.6681165940545, 6692.531522793358, 6840.965795170992, 7752.496087754278, 7944.523328600302, 10096.0, 10678.0, 10750.569977200825, 10818.621348253087, 10828.620998265023], "value": 7800.36928272774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.8894582906278, 1500.3173556032002, 1600.415848215401, 1775.30763002429, 1824.2155872974631, 6709.899351509719, 7595.658195381207, 7890.40821938354, 8154.18458154185, 8165.714200003001, 8054.275115239628, 8099.109097999215, 8131.796705082361, 8136.796580085486, 8180.468269562474, 2210.2706106984697, 2242.439390152462, 2249.9437514062115, 2252.4481502031945, 2258.175765845471, 2233.9888300558555, 2244.865308081512, 2245.158065725353, 2246.4047027537717, 2254.9887250563725, 2215.1360969222014, 2217.3015500117413, 2221.833362497819, 2234.5642599693065, 2249.955000899981, 2135.9893200533897, 2155.4072630026712, 2156.8813715245656, 2158.751743549496, 2158.8596741211772, 2174.6411842046045, 2175.912963481459, 2179.4115588791096, 2181.1602533024898, 2184.0826852721893, 8096.0, 8163.142869998624, 8165.755027349189, 8174.0, 8204.507729536246, 4455.086707225011, 4585.72485650862, 4605.4933957264675, 4608.9308660370125, 4611.446626404853, 2953.7932344735877, 3082.830444325561, 3102.565640810288, 3113.112762862596, 3121.78147529673, 952.9142377186017, 960.4573416019996, 968.5351031504847, 974.2936371130944, 977.0717818072859, 10904.182186336056, 10979.011888929956, 11001.284916480483, 11017.283876548, 11070.833937490945, 4138.193052354762, 4194.6853985951175, 4207.347861081537, 4217.0, 4298.41971333866, 9451.0, 9463.053694630482, 9471.715848524418, 9481.952590237142, 9532.761680958032, 4521.231390663595, 4527.320901864681, 4538.364628951949, 4555.794989225493, 4576.58810707038, 3417.1798768295926, 3840.2127563849344, 3927.0771368728324, 4052.675785937118, 4169.874133983807, 3803.201327721154, 3853.4412510185866, 3911.3350730375905, 3937.2322397132857, 3943.2507823513442, 1257.3587470390166, 1262.7853264944981, 1263.753568054239, 1271.1610337177603, 1278.897688184943, 741.9983022919124, 767.1293082351572, 786.6302837666287, 863.3481721300378, 865.0873328638221, 4906.386701662293, 5140.254663073908, 5219.08665983459, 5332.893342133136, 5346.732663366816, 868.4832524647825, 906.8458362078462, 910.0853642089658, 913.949732764691, 917.5366439947784, 3432.673895979878, 3438.8108654023767, 3540.32733780586, 3544.592371877267, 3589.9820500897326, 9807.607695692092, 9966.40201587907, 10087.243456740774, 10260.281780275309, 10283.228757843191, 9908.504574771232, 10049.944755800536, 10060.597576097021, 10107.747306317255, 10109.393436393693, 6811.557248778813, 7171.067761191116, 7174.569525828467, 7261.237570055174, 7428.442866784904, 5615.943840561542, 5680.318361796611, 5805.390434004369, 5846.707664616837, 5856.092305692625, 8804.383693141419, 9193.310501712533, 9249.213816825377, 9288.34981551285, 9396.0, 9168.724938251864, 9343.73859528955, 9426.858597121185, 9515.33392662507, 9562.665306714232, 5753.798617048383, 6354.301026886947, 6588.967055164693, 6605.735770569124, 6778.220504641832, 7631.8855217172895, 7717.421193410404, 7722.420818438752, 7742.845143097219, 7791.727289545065, 6538.8365290868105, 6719.798406047827, 6850.177978642595, 7077.5753454792875, 7186.209516953027, 6451.645159516084, 6452.483801295791, 6513.902291465726, 6519.73921043172, 6595.736170553316, 5995.910061348996, 6019.006863867413, 6062.454379105901, 6091.208142941389, 6097.207363042776, 4310.892227694333, 4360.106178233391, 4392.780360982002, 4414.9558504414545, 4539.795709193028, 4383.408239887702, 4386.758728269976, 4466.218411777861, 4493.393391892053, 4505.707129036602], "value": 4205.645830851872, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.7850226339299, 305.7156844134954, 306.248160765321, 311.87992622840216, 312.8107494965547, 4911.926321105182, 4912.557869791718, 4925.458199598051, 4952.529509696582, 4957.62817788666, 4811.59101476375, 4817.723303324622, 4836.637252206081, 4866.566716641679, 4880.389951256093, 3628.219932714466, 3658.8595671532184, 3793.943090853639, 3795.35478968576, 3812.65686088252, 3816.0, 3822.9617703823023, 3834.1373191031935, 3839.212961342932, 3845.0964023454467, 3797.721367179684, 3816.580176180618, 3819.1406933439894, 3822.9426558601645, 3827.4832897558754, 3587.4887578694756, 3815.4276858471176, 3821.5414150302004, 3829.8468061277517, 3833.5208098987487, 3380.4422270325367, 3391.576052993376, 3397.2695870387984, 3405.8126803025825, 3406.1825161961196, 4620.330052142454, 4645.651576131803, 4678.883027924295, 4697.812087516495, 4707.105649926503, 4391.407160033418, 4411.250087485135, 4413.646908247332, 4416.2713152329825, 4427.0, 4955.603551715854, 5039.77321020555, 5041.319421878036, 5069.163588007974, 5077.882865769525, 3719.6280371962857, 3724.348239058181, 3726.4037753959237, 3726.888193354204, 3737.383331750258, 5316.963192177527, 5319.867003324909, 5383.219433182206, 5386.892262154735, 5400.351957765093, 3691.0, 3816.961830381716, 3818.770873747584, 3836.156045669948, 3836.4437156612694, 3858.6141385861188, 3889.183271513014, 3889.5138107736534, 3896.7077469189926, 3915.432262322004, 4342.500612429548, 4350.543192964757, 4359.302511598193, 4375.824967001348, 4393.472783266028, 4994.90010199794, 5063.949360506422, 5095.8980820383385, 5166.689998600096, 5168.19892916591, 1328.8405391353099, 1336.652470357714, 1343.9260840653662, 1347.4812197304109, 1348.9392977316045, 853.9743807685779, 859.9570021498901, 867.8654808504692, 888.4314039015036, 888.8444522208588, 4404.867853964386, 4463.509014008457, 4492.0, 4519.322101684774, 4522.706024108423, 5179.093658609803, 5211.218317252366, 5222.869428264248, 5239.821040265986, 5255.817441075727, 4381.474223093249, 4506.977465112654, 4532.501424843264, 4534.569215924482, 4556.157110934488, 2753.7108603596735, 2819.3656427303695, 2819.900238906828, 2828.490871643124, 2831.631887854566, 4974.701517908937, 4979.85463343433, 4986.276989836453, 4988.72562009093, 5011.198208286657, 5101.2603172539775, 5318.760655770499, 5370.516653501204, 5375.3012108425655, 5393.379761327419, 4971.732208286864, 4975.0, 4982.501749825061, 5019.3976722793495, 5027.572656324181, 5244.292020577326, 5262.684238945675, 5277.0, 5286.334804536558, 5304.655197412156, 4896.681715688469, 5149.48505149482, 5168.483151684802, 5196.454372290855, 5205.0, 5011.574016208518, 5046.016026874724, 5065.974670126626, 5067.290579318972, 5105.28526006352, 3731.0, 3750.3999360102252, 3773.1510410157493, 3783.697304215601, 3784.5458544973676, 5055.898882022412, 5283.969625922909, 5315.448584679453, 5317.112425089038, 5328.6802791832615, 5071.109467603578, 5084.339035925306, 5154.407243167084, 5155.2782610435315, 5206.323177986989, 5102.897942041212, 5128.435872053997, 5130.846074617767, 5145.61407894402, 5171.663841850268, 4905.166121759238, 4995.975020124876, 4998.725070121178, 5052.646314757932, 5056.266841307916, 4884.291777692286, 5065.0, 5097.92353114711, 5186.118359878754, 5187.2478490619405, 5006.4743201963265, 5014.122528557561, 5059.822906198266, 5062.063518249136, 5090.567301779391], "value": 3873.2126867073116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.6524276890478, 674.8650269946012, 680.9489288303379, 738.2211766586253, 751.8158051277438, 12071.21537100089, 12512.124151309412, 12554.874451255484, 12577.685557861058, 12700.872991270107, 11331.490082946266, 11358.886411135885, 11383.829242561369, 11428.885711142886, 11443.198976071679, 647.6211416321457, 790.6521130702472, 802.8675268580691, 811.5658122904248, 813.7070654564352, 803.9477433966773, 804.284187073505, 805.3516918880299, 806.4234072638092, 812.2649002652579, 855.995720021399, 861.7974775927652, 862.6980556805099, 863.4128792421151, 865.3726048614767, 848.9872651910226, 850.2347886901777, 850.3494826457795, 851.2764150472111, 855.8074433252468, 628.8742251549662, 629.2417636747708, 630.5019034962374, 632.585656395062, 635.6281575278467, 11950.46222919962, 11967.0, 11976.520939162423, 11999.580014699532, 12070.09474289423, 10268.435236062014, 10385.0, 10439.321444106108, 10473.84289235662, 10884.61903833362, 9646.565904534313, 9691.70924872248, 9825.575291582752, 9915.355501892354, 10194.9490252549, 3304.8512816923294, 3313.3870234006786, 3347.246869454353, 3359.0, 3390.643982381839, 41494.37758433626, 41700.165996680196, 42482.78758606218, 42621.57378426238, 43192.13615727699, 9483.905160948303, 9621.9037809621, 9940.701778946643, 9994.200463962865, 10282.331648442827, 16490.917545412438, 16610.335586576402, 16632.91683541599, 16753.329866805434, 16944.57638559021, 6431.421172094534, 6591.571547849375, 6608.966955165193, 6665.400113989765, 6764.425023873026, 3660.522632986532, 3707.8331475083146, 3707.8516859325323, 3723.0, 3752.3245815753426, 2627.618995245679, 2659.308579769274, 2793.608894754736, 2802.7057158998014, 2817.0985284708695, 566.3741565570068, 570.4181734630654, 572.6478215897193, 582.4815913836688, 583.7227317024465, 502.4673845723545, 567.9801206957736, 616.1527899138684, 619.3713380918372, 622.3620788691537, 7203.71185152588, 7319.74380896666, 7521.623918804038, 7533.1336896256535, 7622.847543049108, 499.8375527953357, 522.2140678279166, 540.1465684218924, 599.6701814002281, 613.7299588181186, 3623.7825730456257, 3700.5559332880225, 3704.3147017801252, 3732.9626703733156, 3775.433684947225, 53556.0, 55831.441685583435, 55849.44150558442, 55901.44098558962, 56060.719696401255, 47141.5285847144, 48546.75726621415, 48853.755731221114, 49104.75447622739, 50812.0, 44654.33018504725, 44683.436079737054, 44808.103837923714, 45222.77388613036, 45635.0, 6923.134608173978, 7063.364297213276, 7099.893501597377, 7115.181754098345, 7176.712931482891, 29395.559066614445, 29816.10551683453, 30216.395672085997, 30223.697763022967, 30468.238294042825, 36183.819080904424, 36802.63197367992, 37433.43849842309, 38053.23893522169, 40259.59740402558, 10835.566577336818, 10854.782904342026, 10869.891301087204, 10895.455227238448, 10925.890741092488, 10341.172706183637, 10728.034476897117, 11281.548738050715, 11926.344051077274, 12034.75930481403, 10391.272610917164, 10736.087432568007, 10908.072813810597, 11136.220464567403, 11734.354610496504, 10163.507711639848, 10378.584856605652, 10380.844287335545, 10405.27163098606, 11088.223824332219, 10316.27786054969, 10420.32267902584, 10559.736006599896, 10681.732956676145, 10770.407627580558, 8596.35527335465, 8811.911880881109, 8885.733427997171, 9041.276697864287, 9132.726018219464, 8977.0, 9204.631814727336, 9222.492762898106, 9285.442873427615, 9312.115349041831], "value": 5820.179872987629, "unit": "score"}], "name": "dromaeo_css", "value": 6202.224235130022, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 110.0, 117.0, 118.0, 116.0, 110.0, 116.0, 115.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 137.0, 160.0, 211.0, 149.0, 157.0, 171.0, 139.0, 186.0, 138.0], "value": 160.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 165.0, 177.0, 169.0, 165.0, 167.0, 164.0, 163.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 155.0, 78.0, 78.0, 78.0, 77.0, 152.0, 78.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 170.0, 95.0, 94.0, 95.0, 138.0, 98.0, 93.0, 137.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 120.0, 120.0, 119.0, 120.0, 120.0, 120.0, 118.0], "value": 119.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 151.0, 150.0, 150.0, 150.0, 149.0, 150.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 68.0], "value": 67.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 87.0, 91.0, 90.0, 87.0, 87.0, 86.0, 151.0, 88.0], "value": 94.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 140.0, 138.0, 148.0, 139.0, 140.0, 155.0, 155.0, 143.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 183.0, 183.0, 179.0, 179.0, 178.0, 179.0, 178.0, 182.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 71.0, 72.0, 74.0, 90.0, 72.0, 70.0, 70.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1638.8999999999999, "alertThreshold": 2.0}]} 13:34:55 INFO - Return code: 0 13:34:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:34:55 ERROR - # TBPL SUCCESS # 13:34:55 INFO - Running post-action listener: _resource_record_post_action 13:34:55 INFO - ##### 13:34:55 INFO - ##### Finished run-tests step (success) 13:34:55 INFO - ##### 13:34:55 INFO - Running post-run listener: _resource_record_post_run 13:34:56 INFO - Total resource usage - Wall time: 1194s; CPU: 26.0%; Read bytes: 4096; Write bytes: 521281536; Read time: 16; Write time: 453952 13:34:56 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 234622976; Read time: 0; Write time: 228312 13:34:56 INFO - run-tests - Wall time: 1178s; CPU: 26.0%; Read bytes: 4096; Write bytes: 286658560; Read time: 16; Write time: 225640 13:34:56 INFO - Running post-run listener: _upload_blobber_files 13:34:56 INFO - Blob upload gear active. 13:34:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:34:56 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 13:34:56 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:34:56 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:34:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:34:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:34:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:34:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:57 INFO - (blobuploader) - INFO - Done attempting. 13:34:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:34:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:34:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:34:58 INFO - (blobuploader) - INFO - Done attempting. 13:34:58 INFO - (blobuploader) - INFO - Iteration through files over. 13:34:58 INFO - Return code: 0 13:34:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:34:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:34:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/13cddb13a42acbf52b3cb379095d44aceb6a6aa491710b293f982099ed67e7863b10bd1e4710db0e0f3ff9be21833d355086d04beffeb81bce48509d376ea0cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/35dd2c6f1ddbf0448d7ed0a6e2a2e4714fd70c42d35497583df78441c941e87af1b06b5a4d946ba35a8680bda2a9ab5c38e2abc7dffca0076fa5d0f6691fca1e"} 13:34:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:34:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:34:58 INFO - Contents: 13:34:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/13cddb13a42acbf52b3cb379095d44aceb6a6aa491710b293f982099ed67e7863b10bd1e4710db0e0f3ff9be21833d355086d04beffeb81bce48509d376ea0cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/35dd2c6f1ddbf0448d7ed0a6e2a2e4714fd70c42d35497583df78441c941e87af1b06b5a4d946ba35a8680bda2a9ab5c38e2abc7dffca0076fa5d0f6691fca1e"} 13:34:58 INFO - Running post-run listener: copy_logs_to_upload_dir 13:34:58 INFO - Copying logs to upload dir... 13:34:58 INFO - mkdir: /builds/slave/test/build/upload/logs 13:34:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.749145 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-20 13:34:58.227933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 13:34:58.231861) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/13cddb13a42acbf52b3cb379095d44aceb6a6aa491710b293f982099ed67e7863b10bd1e4710db0e0f3ff9be21833d355086d04beffeb81bce48509d376ea0cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/35dd2c6f1ddbf0448d7ed0a6e2a2e4714fd70c42d35497583df78441c941e87af1b06b5a4d946ba35a8680bda2a9ab5c38e2abc7dffca0076fa5d0f6691fca1e"} build_url:https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005428 build_url: 'https://queue.taskcluster.net/v1/task/R2SWt3drTWu1f6rp3zJsng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/13cddb13a42acbf52b3cb379095d44aceb6a6aa491710b293f982099ed67e7863b10bd1e4710db0e0f3ff9be21833d355086d04beffeb81bce48509d376ea0cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/35dd2c6f1ddbf0448d7ed0a6e2a2e4714fd70c42d35497583df78441c941e87af1b06b5a4d946ba35a8680bda2a9ab5c38e2abc7dffca0076fa5d0f6691fca1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 13:34:58.245530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:34:58.245817) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1463774808.505101-910451333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002121 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 13:34:58.328049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 13:34:58.328354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 13:34:58.328639) ========= ========= Total master_lag: 0.15 =========