builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1464275644.83 results: success (0) buildid: 20160526053014 builduid: 684441f92296439991a46d17c61de514 revision: a33592050e2465ea62f9d62c42623c9c88b9808f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.827527) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.828504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.829123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.846728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.847303) ========= 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=41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 08:14:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-05-26 08:14:05 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.950681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:04.951415) ========= 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=41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018472 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.005153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.005895) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a33592050e2465ea62f9d62c42623c9c88b9808f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a33592050e2465ea62f9d62c42623c9c88b9808f --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=41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 08:14:05,264 truncating revision to first 12 chars 2016-05-26 08:14:05,264 Setting DEBUG logging. 2016-05-26 08:14:05,264 attempt 1/10 2016-05-26 08:14:05,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a33592050e24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 08:14:05,642 unpacking tar archive at: fx-team-a33592050e24/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.745879) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.746667) ========= script_repo_revision: a33592050e2465ea62f9d62c42623c9c88b9808f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.747618) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.748055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 08:14:05.759747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-26 08:14:05.760379) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:06 INFO - MultiFileLogger online at 20160526 08:14:06 in /builds/slave/test 08:14:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:14:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:06 INFO - {'append_to_log': False, 08:14:06 INFO - 'base_work_dir': '/builds/slave/test', 08:14:06 INFO - 'blob_upload_branch': 'Fx-Team', 08:14:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:06 INFO - 'branch': 'Fx-Team', 08:14:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:06 INFO - 'config_files': ('talos/linux_config.py',), 08:14:06 INFO - 'default_actions': ('clobber', 08:14:06 INFO - 'read-buildbot-config', 08:14:06 INFO - 'download-and-extract', 08:14:06 INFO - 'populate-webroot', 08:14:06 INFO - 'create-virtualenv', 08:14:06 INFO - 'install', 08:14:06 INFO - 'run-tests'), 08:14:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:06 INFO - 'download_minidump_stackwalk': True, 08:14:06 INFO - 'download_symbols': 'ondemand', 08:14:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:06 INFO - 'installer_path': 'installer.exe', 08:14:06 INFO - 'log_level': 'info', 08:14:06 INFO - 'log_name': 'talos', 08:14:06 INFO - 'log_to_console': True, 08:14:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:06 INFO - 'opt_config_files': (), 08:14:06 INFO - 'pip_index': False, 08:14:06 INFO - 'sps_profile': False, 08:14:06 INFO - 'sps_profile_interval': 0, 08:14:06 INFO - 'suite': 'dromaeojs', 08:14:06 INFO - 'system_bits': '32', 08:14:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:06 INFO - 'title': 'talos-linux64-ix-026', 08:14:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:06 INFO - 'use_talos_json': True, 08:14:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:06 INFO - 'work_dir': 'build'} 08:14:06 INFO - ##### 08:14:06 INFO - ##### Running clobber step. 08:14:06 INFO - ##### 08:14:06 INFO - Running pre-action listener: _resource_record_pre_action 08:14:06 INFO - Running main action method: clobber 08:14:06 INFO - rmtree: /builds/slave/test/build 08:14:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:06 INFO - Running post-action listener: _resource_record_post_action 08:14:06 INFO - ##### 08:14:06 INFO - ##### Finished clobber step (success) 08:14:06 INFO - ##### 08:14:06 INFO - ##### 08:14:06 INFO - ##### Running read-buildbot-config step. 08:14:06 INFO - ##### 08:14:06 INFO - Running pre-action listener: _resource_record_pre_action 08:14:06 INFO - Running main action method: read_buildbot_config 08:14:06 INFO - Using buildbot properties: 08:14:06 INFO - { 08:14:06 INFO - "project": "", 08:14:06 INFO - "product": "firefox", 08:14:06 INFO - "script_repo_revision": "production", 08:14:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:14:06 INFO - "repository": "", 08:14:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:14:06 INFO - "buildid": "20160526053014", 08:14:06 INFO - "pgo_build": "True", 08:14:06 INFO - "basedir": "/builds/slave/test", 08:14:06 INFO - "buildnumber": 718, 08:14:06 INFO - "slavename": "talos-linux64-ix-026", 08:14:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:14:06 INFO - "platform": "ubuntu64_hw", 08:14:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:14:06 INFO - "branch": "fx-team", 08:14:06 INFO - "repo_path": "integration/fx-team", 08:14:06 INFO - "revision": "a33592050e2465ea62f9d62c42623c9c88b9808f", 08:14:06 INFO - "stage_platform": "linux64-pgo", 08:14:06 INFO - "builduid": "684441f92296439991a46d17c61de514", 08:14:06 INFO - "slavebuilddir": "test" 08:14:06 INFO - } 08:14:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:14:06 INFO - Running post-action listener: _resource_record_post_action 08:14:06 INFO - ##### 08:14:06 INFO - ##### Finished read-buildbot-config step (success) 08:14:06 INFO - ##### 08:14:06 INFO - ##### 08:14:06 INFO - ##### Running download-and-extract step. 08:14:06 INFO - ##### 08:14:06 INFO - Running pre-action listener: _resource_record_pre_action 08:14:06 INFO - Running main action method: download_and_extract 08:14:06 INFO - mkdir: /builds/slave/test/build/tests 08:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:06 INFO - https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:07 INFO - Downloaded 1361 bytes. 08:14:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:14:07 INFO - Using the following test package requirements: 08:14:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:14:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'jsshell-linux-x86_64.zip'], 08:14:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:14:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:14:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:07 INFO - https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:08 INFO - Downloaded 24408714 bytes. 08:14:08 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'] 08:14:08 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 08:14:09 INFO - Return code: 0 08:14:09 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 08:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:09 INFO - https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:10 INFO - Downloaded 24408714 bytes. 08:14:10 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'] 08:14:10 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 08:14:12 INFO - Return code: 0 08:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:12 INFO - https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:13 INFO - Downloaded 10834034 bytes. 08:14:13 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'] 08:14:13 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 08:14:13 INFO - Return code: 0 08:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:13 INFO - https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhUblcxmROS34_QJon-tuw/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 08:14:15 INFO - Downloaded 58653494 bytes. 08:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:14:15 INFO - mkdir: /builds/slave/test/properties 08:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:15 INFO - Contents: 08:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:14:15 INFO - Running post-action listener: _resource_record_post_action 08:14:15 INFO - Running post-action listener: set_extra_try_arguments 08:14:15 INFO - ##### 08:14:15 INFO - ##### Finished download-and-extract step (success) 08:14:15 INFO - ##### 08:14:15 INFO - ##### 08:14:15 INFO - ##### Running populate-webroot step. 08:14:15 INFO - ##### 08:14:15 INFO - Running pre-action listener: _resource_record_pre_action 08:14:15 INFO - Running main action method: populate_webroot 08:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:15 INFO - '--tppagecycles', 08:14:15 INFO - '7'], 08:14:15 INFO - 'tests': ['tsvgm']}}, 08:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['damp', 'tps']}, 08:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'tests': ['damp', 'tps']}, 08:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['dromaeo_dom']}, 08:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tsvgx', 08:14:15 INFO - 'tsvgr_opacity', 08:14:15 INFO - 'tart', 08:14:15 INFO - 'tscrollx', 08:14:15 INFO - 'cart']}, 08:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:15 INFO - 'tsvgr_opacity', 08:14:15 INFO - 'tart', 08:14:15 INFO - 'tscrollx', 08:14:15 INFO - 'cart']}, 08:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tp5o']}, 08:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'tests': ['tp5o']}, 08:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s', 08:14:15 INFO - '--xperf_path', 08:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:15 INFO - 'tests': ['tp5n']}, 08:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--xperf_path', 08:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:15 INFO - 'tests': ['tp5n']}}, 08:14:15 INFO - 'talos.zip': {'path': '', 08:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:15 INFO - Running post-action listener: _resource_record_post_action 08:14:15 INFO - ##### 08:14:15 INFO - ##### Finished populate-webroot step (success) 08:14:15 INFO - ##### 08:14:15 INFO - ##### 08:14:15 INFO - ##### Running create-virtualenv step. 08:14:15 INFO - ##### 08:14:15 INFO - Running pre-action listener: _resource_record_pre_action 08:14:15 INFO - Running main action method: create_virtualenv 08:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:15 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 08:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:15 INFO - Using real prefix '/usr' 08:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:18 INFO - Installing pip.................done. 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:18 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')]} 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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')]} 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:18 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 08:14:18 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 08:14:18 INFO - Using env: {'DISPLAY': ':0', 08:14:18 INFO - 'HOME': '/home/cltbld', 08:14:18 INFO - 'LANG': 'en_US.UTF-8', 08:14:18 INFO - 'LANGUAGE': 'en_US:en', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MAIL': '/var/mail/cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SHLVL': '1', 08:14:18 INFO - 'TERM': 'linux', 08:14:18 INFO - 'TMOUT': '86400', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 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 08:14:18 INFO - Cleaning up... 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:18 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')]} 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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')]} 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:18 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>=3.1.1'] in /builds/slave/test/build 08:14:18 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>=3.1.1 08:14:18 INFO - Using env: {'DISPLAY': ':0', 08:14:18 INFO - 'HOME': '/home/cltbld', 08:14:18 INFO - 'LANG': 'en_US.UTF-8', 08:14:18 INFO - 'LANGUAGE': 'en_US:en', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MAIL': '/var/mail/cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SHLVL': '1', 08:14:18 INFO - 'TERM': 'linux', 08:14:18 INFO - 'TMOUT': '86400', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Downloading/unpacking psutil>=3.1.1 08:14:18 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 08:14:18 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 08:14:18 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 08:14:18 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 08:14:18 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 08:14:18 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 08:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:20 INFO - Installing collected packages: psutil 08:14:20 INFO - Running setup.py install for psutil 08:14:20 INFO - building 'psutil._psutil_linux' extension 08:14:20 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 08:14:21 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 08:14:21 INFO - building 'psutil._psutil_posix' extension 08:14:21 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 08:14:21 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 08:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:21 INFO - Successfully installed psutil 08:14:21 INFO - Cleaning up... 08:14:21 INFO - Return code: 0 08:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:21 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')]} 08:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:21 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')]} 08:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:21 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:21 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.3'] in /builds/slave/test/build 08:14:21 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.3 08:14:21 INFO - Using env: {'DISPLAY': ':0', 08:14:21 INFO - 'HOME': '/home/cltbld', 08:14:21 INFO - 'LANG': 'en_US.UTF-8', 08:14:21 INFO - 'LANGUAGE': 'en_US:en', 08:14:21 INFO - 'LOGNAME': 'cltbld', 08:14:21 INFO - 'MAIL': '/var/mail/cltbld', 08:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:21 INFO - 'MOZ_NO_REMOTE': '1', 08:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:21 INFO - 'NO_EM_RESTART': '1', 08:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:21 INFO - 'PWD': '/builds/slave/test', 08:14:21 INFO - 'SHELL': '/bin/bash', 08:14:21 INFO - 'SHLVL': '1', 08:14:21 INFO - 'TERM': 'linux', 08:14:21 INFO - 'TMOUT': '86400', 08:14:21 INFO - 'USER': 'cltbld', 08:14:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:21 INFO - '_': '/tools/buildbot/bin/python'} 08:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:21 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 08:14:21 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 08:14:21 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 08:14:21 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 08:14:21 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 08:14:21 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 08:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:23 INFO - Installing collected packages: mozsystemmonitor 08:14:23 INFO - Running setup.py install for mozsystemmonitor 08:14:23 INFO - Successfully installed mozsystemmonitor 08:14:23 INFO - Cleaning up... 08:14:23 INFO - Return code: 0 08:14:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:23 INFO - Using env: {'DISPLAY': ':0', 08:14:23 INFO - 'HOME': '/home/cltbld', 08:14:23 INFO - 'LANG': 'en_US.UTF-8', 08:14:23 INFO - 'LANGUAGE': 'en_US:en', 08:14:23 INFO - 'LOGNAME': 'cltbld', 08:14:23 INFO - 'MAIL': '/var/mail/cltbld', 08:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:23 INFO - 'MOZ_NO_REMOTE': '1', 08:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:23 INFO - 'NO_EM_RESTART': '1', 08:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:23 INFO - 'PWD': '/builds/slave/test', 08:14:23 INFO - 'SHELL': '/bin/bash', 08:14:23 INFO - 'SHLVL': '1', 08:14:23 INFO - 'TERM': 'linux', 08:14:23 INFO - 'TMOUT': '86400', 08:14:23 INFO - 'USER': 'cltbld', 08:14:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:23 INFO - '_': '/tools/buildbot/bin/python'} 08:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 INFO - Downloading docopt-0.6.1.tar.gz 08:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:26 INFO - Running setup.py install for blobuploader 08:14:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:26 INFO - Running setup.py install for requests 08:14:27 INFO - Running setup.py install for docopt 08:14:27 INFO - Successfully installed blobuploader requests docopt 08:14:27 INFO - Cleaning up... 08:14:27 INFO - Return code: 0 08:14:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:27 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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:27 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 08:14:27 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 08:14:27 INFO - Using env: {'DISPLAY': ':0', 08:14:27 INFO - 'HOME': '/home/cltbld', 08:14:27 INFO - 'LANG': 'en_US.UTF-8', 08:14:27 INFO - 'LANGUAGE': 'en_US:en', 08:14:27 INFO - 'LOGNAME': 'cltbld', 08:14:27 INFO - 'MAIL': '/var/mail/cltbld', 08:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:27 INFO - 'MOZ_NO_REMOTE': '1', 08:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:27 INFO - 'NO_EM_RESTART': '1', 08:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:27 INFO - 'PWD': '/builds/slave/test', 08:14:27 INFO - 'SHELL': '/bin/bash', 08:14:27 INFO - 'SHLVL': '1', 08:14:27 INFO - 'TERM': 'linux', 08:14:27 INFO - 'TMOUT': '86400', 08:14:27 INFO - 'USER': 'cltbld', 08:14:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:27 INFO - '_': '/tools/buildbot/bin/python'} 08:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:27 INFO - Running setup.py (path:/tmp/pip-g0zPFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:27 INFO - Running setup.py (path:/tmp/pip-QIedbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:27 INFO - Running setup.py (path:/tmp/pip-wYWDfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:27 INFO - Running setup.py (path:/tmp/pip-1dYdA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:27 INFO - Running setup.py (path:/tmp/pip-v3LbBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:27 INFO - Running setup.py (path:/tmp/pip-n69KTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:27 INFO - Running setup.py (path:/tmp/pip-SD8ExJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:28 INFO - Running setup.py (path:/tmp/pip-HAoA3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:28 INFO - Running setup.py (path:/tmp/pip-PbvbYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:28 INFO - Running setup.py (path:/tmp/pip-rNR1Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:28 INFO - Running setup.py (path:/tmp/pip-cq0uWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:28 INFO - Running setup.py (path:/tmp/pip-JNYjLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:28 INFO - Running setup.py (path:/tmp/pip-DIcTEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:28 INFO - Running setup.py (path:/tmp/pip-48PL37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:28 INFO - Running setup.py (path:/tmp/pip-GScfip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:28 INFO - Running setup.py (path:/tmp/pip-kQYzVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:28 INFO - Running setup.py (path:/tmp/pip-DoYdJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:28 INFO - Running setup.py install for manifestparser 08:14:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:28 INFO - Running setup.py install for mozcrash 08:14:28 INFO - Running setup.py install for mozdebug 08:14:29 INFO - Running setup.py install for mozdevice 08:14:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozfile 08:14:29 INFO - Running setup.py install for mozhttpd 08:14:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozinfo 08:14:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozInstall 08:14:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozleak 08:14:29 INFO - Running setup.py install for mozlog 08:14:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for moznetwork 08:14:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:29 INFO - Running setup.py install for mozprocess 08:14:29 INFO - Running setup.py install for mozprofile 08:14:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:30 INFO - Running setup.py install for mozrunner 08:14:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:30 INFO - Running setup.py install for mozscreenshot 08:14:30 INFO - Running setup.py install for moztest 08:14:30 INFO - Running setup.py install for mozversion 08:14:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:30 INFO - Cleaning up... 08:14:30 INFO - Return code: 0 08:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:30 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')]} 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 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')]} 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:30 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 08:14:30 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 08:14:30 INFO - Using env: {'DISPLAY': ':0', 08:14:30 INFO - 'HOME': '/home/cltbld', 08:14:30 INFO - 'LANG': 'en_US.UTF-8', 08:14:30 INFO - 'LANGUAGE': 'en_US:en', 08:14:30 INFO - 'LOGNAME': 'cltbld', 08:14:30 INFO - 'MAIL': '/var/mail/cltbld', 08:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:30 INFO - 'MOZ_NO_REMOTE': '1', 08:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:30 INFO - 'NO_EM_RESTART': '1', 08:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:30 INFO - 'PWD': '/builds/slave/test', 08:14:30 INFO - 'SHELL': '/bin/bash', 08:14:30 INFO - 'SHLVL': '1', 08:14:30 INFO - 'TERM': 'linux', 08:14:30 INFO - 'TMOUT': '86400', 08:14:30 INFO - 'USER': 'cltbld', 08:14:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:30 INFO - '_': '/tools/buildbot/bin/python'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 INFO - Running setup.py (path:/tmp/pip-iq0AFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 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)) 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 INFO - Running setup.py (path:/tmp/pip-HtCyT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 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)) 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:30 INFO - Running setup.py (path:/tmp/pip-xF39ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:30 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)) 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:30 INFO - Running setup.py (path:/tmp/pip-QKWd39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:31 INFO - Running setup.py (path:/tmp/pip-MAV6HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:31 INFO - Running setup.py (path:/tmp/pip-PipgM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:31 INFO - Running setup.py (path:/tmp/pip-0hx2bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:31 INFO - Running setup.py (path:/tmp/pip-zDtGVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:31 INFO - Running setup.py (path:/tmp/pip-7TgesL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Running setup.py (path:/tmp/pip-oqIP7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:31 INFO - Running setup.py (path:/tmp/pip-Z11HFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:31 INFO - Running setup.py (path:/tmp/pip-OsQL1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:31 INFO - Running setup.py (path:/tmp/pip-lbY3dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:31 INFO - Running setup.py (path:/tmp/pip-gUGcVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:31 INFO - Running setup.py (path:/tmp/pip-b57Ubq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:31 INFO - Running setup.py (path:/tmp/pip-u3Avgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:31 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)) 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:31 INFO - Running setup.py (path:/tmp/pip-Adm76g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:31 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)) 08:14:31 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)) 08:14:31 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)) 08:14:31 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)) 08:14:31 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)) 08:14:31 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)) 08:14:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:31 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 08:14:31 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 08:14:31 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 08:14:31 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 08:14:31 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 08:14:31 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 08:14:33 INFO - Downloading blessings-1.6.tar.gz 08:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:33 INFO - Installing collected packages: blessings 08:14:33 INFO - Running setup.py install for blessings 08:14:34 INFO - Successfully installed blessings 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:34 INFO - Reading from file tmpfile_stdout 08:14:34 INFO - Current package versions: 08:14:34 INFO - argparse == 1.2.1 08:14:34 INFO - blessings == 1.6 08:14:34 INFO - blobuploader == 1.2.4 08:14:34 INFO - docopt == 0.6.1 08:14:34 INFO - manifestparser == 1.1 08:14:34 INFO - mozInstall == 1.12 08:14:34 INFO - mozcrash == 0.17 08:14:34 INFO - mozdebug == 0.1 08:14:34 INFO - mozdevice == 0.48 08:14:34 INFO - mozfile == 1.2 08:14:34 INFO - mozhttpd == 0.7 08:14:34 INFO - mozinfo == 0.9 08:14:34 INFO - mozleak == 0.1 08:14:34 INFO - mozlog == 3.2 08:14:34 INFO - moznetwork == 0.27 08:14:34 INFO - mozprocess == 0.22 08:14:34 INFO - mozprofile == 0.28 08:14:34 INFO - mozrunner == 6.11 08:14:34 INFO - mozscreenshot == 0.1 08:14:34 INFO - mozsystemmonitor == 0.3 08:14:34 INFO - moztest == 0.7 08:14:34 INFO - mozversion == 1.4 08:14:34 INFO - psutil == 3.1.1 08:14:34 INFO - requests == 1.2.3 08:14:34 INFO - wsgiref == 0.1.2 08:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:34 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 08:14:34 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 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08: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')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:34 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 08:14:34 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 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 INFO - Downloading/unpacking jsonschema 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:36 INFO - Downloading/unpacking functools32 (from jsonschema) 08:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:36 INFO - warning: no files found matching '*.txt' 08:14:36 INFO - no previously-included directories found matching 'build' 08:14:36 INFO - no previously-included directories found matching 'dist' 08:14:36 INFO - no previously-included directories found matching '.git*' 08:14:36 INFO - Installing collected packages: jsonschema, functools32 08:14:36 INFO - Running setup.py install for functools32 08:14:37 INFO - warning: no files found matching '*.txt' 08:14:37 INFO - no previously-included directories found matching 'build' 08:14:37 INFO - no previously-included directories found matching 'dist' 08:14:37 INFO - no previously-included directories found matching '.git*' 08:14:37 INFO - Successfully installed jsonschema functools32 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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 0x7f43c4716f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1629770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, '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': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', '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 08:14:37 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 08:14:37 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 08:14:37 INFO - Using env: {'DISPLAY': ':0', 08:14:37 INFO - 'HOME': '/home/cltbld', 08:14:37 INFO - 'LANG': 'en_US.UTF-8', 08:14:37 INFO - 'LANGUAGE': 'en_US:en', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MAIL': '/var/mail/cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SHLVL': '1', 08:14:37 INFO - 'TERM': 'linux', 08:14:37 INFO - 'TMOUT': '86400', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - '_': '/tools/buildbot/bin/python'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 INFO - Downloading/unpacking flake8 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:37 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 08:14:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:14:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:14:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:39 INFO - no previously-included directories found matching 'docs/_build' 08:14:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:40 INFO - Running setup.py install for pep8 08:14:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:40 INFO - no previously-included directories found matching 'docs/_build' 08:14:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:40 INFO - Cleaning up... 08:14:40 INFO - Return code: 0 08:14:40 INFO - Running post-action listener: _resource_record_post_action 08:14:40 INFO - Running post-action listener: _start_resource_monitoring 08:14:40 INFO - Starting resource monitoring. 08:14:40 INFO - ##### 08:14:40 INFO - ##### Finished create-virtualenv step (success) 08:14:40 INFO - ##### 08:14:40 INFO - ##### 08:14:40 INFO - ##### Running install step. 08:14:40 INFO - ##### 08:14:40 INFO - Running pre-action listener: _resource_record_pre_action 08:14:40 INFO - Running main action method: install 08:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:40 INFO - Reading from file tmpfile_stdout 08:14:40 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:40 INFO - Reading from file tmpfile_stdout 08:14:40 INFO - Output received: 08:14:40 INFO - Usage: mozinstall [options] installer 08:14:40 INFO - Options: 08:14:40 INFO - -h, --help show this help message and exit 08:14:40 INFO - -d DEST, --destination=DEST 08:14:40 INFO - Directory to install application into. [default: 08:14:40 INFO - "/builds/slave/test"] 08:14:40 INFO - --app=APP Application being installed. [default: firefox] 08:14:40 INFO - mkdir: /builds/slave/test/build/application 08:14:40 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'] 08:14:40 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 08:14:57 INFO - Reading from file tmpfile_stdout 08:14:57 INFO - Output received: 08:14:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:57 INFO - Running post-action listener: _resource_record_post_action 08:14:57 INFO - ##### 08:14:57 INFO - ##### Finished install step (success) 08:14:57 INFO - ##### 08:14:57 INFO - ##### 08:14:57 INFO - ##### Running run-tests step. 08:14:57 INFO - ##### 08:14:57 INFO - Running pre-action listener: _resource_record_pre_action 08:14:57 INFO - Running main action method: run_tests 08:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:57 INFO - Python 2.7.3 08:14:57 INFO - Return code: 0 08:14:57 INFO - grabbing minidump binary from tooltool 08: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')]} 08:14:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b89c0>, '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 0x16b98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b9d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:14:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:14:57 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 08:14:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:57 INFO - Return code: 0 08:14:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:14:58 INFO - Return code: 0 08:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:14:58 INFO - Using env: {'DISPLAY': ':0', 08:14:58 INFO - 'HOME': '/home/cltbld', 08:14:58 INFO - 'LANG': 'en_US.UTF-8', 08:14:58 INFO - 'LANGUAGE': 'en_US:en', 08:14:58 INFO - 'LOGNAME': 'cltbld', 08:14:58 INFO - 'MAIL': '/var/mail/cltbld', 08:14:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:58 INFO - 'MOZ_NO_REMOTE': '1', 08:14:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:58 INFO - 'NO_EM_RESTART': '1', 08:14:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:58 INFO - 'PWD': '/builds/slave/test', 08:14:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:58 INFO - 'SHELL': '/bin/bash', 08:14:58 INFO - 'SHLVL': '1', 08:14:58 INFO - 'TERM': 'linux', 08:14:58 INFO - 'TMOUT': '86400', 08:14:58 INFO - 'USER': 'cltbld', 08:14:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428', 08:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:58 INFO - '_': '/tools/buildbot/bin/python'} 08:14:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:14:58 INFO - mozversion application_buildid: 20160526053014 08:14:58 INFO - mozversion application_changeset: a33592050e2465ea62f9d62c42623c9c88b9808f 08:14:58 INFO - mozversion application_display_name: Nightly 08:14:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:58 INFO - mozversion application_name: Firefox 08:14:58 INFO - mozversion application_remotingname: firefox 08:14:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:58 INFO - mozversion application_vendor: Mozilla 08:14:58 INFO - mozversion application_version: 49.0a1 08:14:58 INFO - mozversion platform_buildid: 20160526053014 08:14:58 INFO - mozversion platform_changeset: a33592050e2465ea62f9d62c42623c9c88b9808f 08:14:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:58 INFO - mozversion platform_version: 49.0a1 08:14:58 INFO - using testdate: 1464275698 08:14:58 INFO - actual date: 1464275698 08:14:58 INFO - starting webserver on 'localhost:45266' 08:14:58 INFO - SUITE-START | Running 2 tests 08:14:58 INFO - TEST-START | dromaeo_css 08:14:58 INFO - operating with platform_type : linux_ 08:14:58 INFO - Initialising browser for dromaeo_css test... 08:14:58 INFO - TEST-INFO | started process 30099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxqYQVE/profile http://localhost:45266/getInfo.html) 08:15:02 INFO - PROCESS | 30099 | __metrics Screen width/height:1600/1200 08:15:02 INFO - PROCESS | 30099 | colorDepth:24 08:15:02 INFO - PROCESS | 30099 | Browser inner width/height: 1024/697 08:15:02 INFO - PROCESS | 30099 | __metrics 08:15:03 ERROR - PROCESS | 30099 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:04 INFO - TEST-INFO | 30099: exit 0 08:15:04 INFO - Browser initialized. 08:15:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:04 INFO - TEST-INFO | started process 30181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxqYQVE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:16 INFO - PROCESS | 30181 | RSS: Main: 154955776 08:15:16 INFO - PROCESS | 30181 | 08:16:07 INFO - PROCESS | 30181 | 1464275767238 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] 08:18:14 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:45266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45266/tests/dromaeo/cssquery-ext.html) 08:18:15 INFO - PROCESS | 30181 | RSS: Main: 241369088 08:18:15 INFO - PROCESS | 30181 | 08:21:18 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:45266/tests/dromaeo/cssquery-ext.html (next: http://localhost:45266/tests/dromaeo/cssquery-jquery.html) 08:21:18 INFO - PROCESS | 30181 | RSS: Main: 246951936 08:21:18 INFO - PROCESS | 30181 | 08:24:20 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:45266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45266/tests/dromaeo/cssquery-mootools.html) 08:24:21 INFO - PROCESS | 30181 | RSS: Main: 251777024 08:24:21 INFO - PROCESS | 30181 | 08:27:23 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:45266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45266/tests/dromaeo/cssquery-prototype.html) 08:27:23 INFO - PROCESS | 30181 | RSS: Main: 239902720 08:27:23 INFO - PROCESS | 30181 | 08:30:26 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:45266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45266/tests/dromaeo/cssquery-yui.html) 08:30:27 INFO - PROCESS | 30181 | RSS: Main: 200028160 08:30:27 INFO - PROCESS | 30181 | 08:33:29 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:45266/tests/dromaeo/cssquery-yui.html (next: http://localhost:45266/tests/dromaeo/cssquery-dojo.html) 08:33:29 INFO - PROCESS | 30181 | RSS: Main: 272838656 08:33:29 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | __start_tp_report 08:33:30 INFO - PROCESS | 30181 | _x_x_mozilla_page_load 08:33:30 INFO - PROCESS | 30181 | _x_x_mozilla_page_load_details 08:33:30 INFO - PROCESS | 30181 | |i|pagename|runs| 08:33:30 INFO - PROCESS | 30181 | |0;dojo.html;3057.9388412231756;3063.9080827575167;3091.397177550378;3106.782525223235;3125.046860707483;5195.532402083812;5201.2458193561915;5268.789248430058;5328.6269961102735;5367.302250707407;5257.316548848654;5259.552938000265;5263.710495922723;5283.365996080466;5341.973290133554;4724.031573527427;4757.26262429324;4806.7836947337455;4815.855524334258;4972.627052971024;4876.390451193601;4902.681325713817;4930.728809915453;4941.357623508939;4970.627202959774;4714.952850471503;4727;4778.450478195;4782.928256076127;4848.5151484851585;4775.331453596499;4776.665633405663;4777.355057067321;4840.201366774478;4843.273508973647;4775.2598347256235;4794.880127996793;4813.590844778198;4822.252550854623;4833.419989601271;5085.79656813727;5156.793728250903;5239.266502689588;5278.445763194848;5285.2600635911;5714.200011998323;5722.341930677983;5733.197352370671;5734.455226753452;5737.139429085671;5693.459121383504;5728.541716662657;5732.197492351074;5773.076307790775;5809.331926828427;5179.456157103487;5229.294045303874;5283.894322113536;5289.629725919187;5368.91946620801;5842.211301474246;5844.853878653068;5845.444682755132;5848.678322692293;5855.004649209644;5599.188117722989;5616.213730077792;5618.97190514053;5620.072688006515;5623.353314368818;5465.098258787335;5602.299712535933;5674.00704876645;5687.090065589568;5702.914456283159;5673.461021202979;5674.886502269931;5674.914876276859;5678.205051292823;5679.574031947621;5502.064649009678;5686.061799803069;5687.004774164505;5688.8862222755315;5702.201691763156;4287.442632457823;4289.33515305122;4319.784010799511;4322.027543802619;4322.37325587788;3851.730378873508;3853.2100919311474;3859.826307816155;3877.86427475037;3893.0656642406184;5243.475652434726;5243.711595862264;5415.48552887475;5417.729113544307;5482.369527504308;5679.914801277984;5714.0571805652435;5728.427157284322;5745.253117094751;5762.049261871744;5454.59090568209;5457.045017121988;5461.01701693691;5464.863378415492;5466.972665136649;4819.084373969004;4883.243097319921;4956.083124621957;4956.157453232959;5008.248762685554;5871.970640146772;5938.317093534212;5943.762249510058;5955.67243801595;5998.430149135826;5746.683932383676;5749.223854779551;5750.7987220447085;5754.51086657622;5758.107493338539;5791.739371728367;5819.82540523785;5872.94127058741;5941.494972927177;5956.987312157031;5608.018596745635;5619.943800562106;5625.971870140623;5626.85932851682;5665.858353541194;5658.773649053992;5687.857803554944;5705.315362156568;5712.65724056558;5713.685747283773;5425.565954723692;5462.617616766788;5478;5489.039418101896;5560.471755183413;5503.091989821634;5503.862403439946;5514.448555144453;5518.724063796874;5519.089350257163;5361.651492652965;5392.029434701634;5409.053415652324;5409.269748583891;5446.591505637014;5454.481824226692;5501.477359650827;5603.831885043455;5610.074337734228;5690.829275121753;5447.891042179213;5448.918266226089;5464.562834973272;5480.616356854982;5501.944980550304 08:33:30 INFO - PROCESS | 30181 | |1;ext.html;606.4602503771644;623.049848980305;636.4113195294354;647.3882181338631;667.0694381338034;41873.371899421494;42435.99999999992;42505.57494425051;42520.57479425205;46145.07709845801;44384.55615443845;45032.32451513222;45038.54961450385;45075.32387014189;45110;8743.213110820025;8955.19403253707;8959.731208063737;8964.910350896473;8966.775830604221;8778.868316975251;8861.202491775739;8871.866921996176;8876.6005529751;8877.334199934998;8863.734087977371;8909.198172164504;8918.866217006751;8927.687530936419;8929.330300227477;8879.245264152523;8889.466632002068;8906.821863562725;8917.375783695144;8928.73213803587;8762.079981601968;8835.337349698733;8855.24730397917;8859.645614175426;8860.911390886073;41116;41263.58736412627;41507.377389339184;41547.792261038805;41569.168616627496;3490.8778192763384;3624.4925710400566;3722.497462842509;3736.794476303802;3888.786116763577;31877;32099.83950080258;32123.51814722781;32495.350092998244;33082.66917330844;4334.631556317717;4386.8025938832825;4418.491873434564;4429.092036132585;4468.396766436522;322476.9999999977;322532;322672;323727;326261;56491;57024.42975570191;57051.42948570544;57089.71455142698;57114.42885571174;50781.492185078416;57787.711061444425;58963;58965.70517147387;64460.677696611216;15887.761683574756;15906;15973.440929567409;16000.279987400594;16002.679946401007;12300.507979680891;12380.752384952251;12385.318807465495;12385.814212786816;12411.875881241072;14331;15710.528684139494;15904.091509018992;15979.440719574992;16156.192190390433;6570.5729127606555;6665.866682666319;6692.765753198614;6739.831504212434;6774.966125169342;1009.1129587670955;1012.4836333469983;1042.5673345561506;1075.370908018802;1139.7207684117445;29098;29714.662840172245;30500.54249186264;30611.697104057122;30921.226969325497;1129.9943500282611;1144.1247445704043;1180.734334774686;1201.645514573203;1298.6040754807366;17336.65326693484;17995.820041799416;18033.278668853098;18900.62198756017;19009.239630414628;530302;532412;532871;535248;537206;56555.71722141445;56661.7166914171;56743;56761;56765.43234567684;1232.556279739311;1376.215557132445;1379.3103448275863;1389.0970868935274;1413.6465883529117;30935.535966960964;31917.68082319147;32384.67615323911;32436.83781581077;33177.668223318426;55301;55314.44685553093;55883.44116558782;55900;55976.720116399156;497956;503316;504021;504515;505705;24294.51410971806;45573;45714;46639.53360466352;47199;46884;47125.528744712115;47557.524424756695;50877.23684144667;51166.876285162136;42863.571364285955;43063;44094;44157.55842441534;45035.774821125684;38707.61292387153;39075.80462097671;39688.60311396849;40703.982400440225;41033.794831025654;41900.85080659253;41990.38032429192;42530.5746942539;42799.35800962926;42968;37122.25755484929;37957;38097;38579.80710096432;38956;28539.28651783722;29095.418091638472;29335.853320734113;29558.261043474085;29562.852185738935 08:33:30 INFO - PROCESS | 30181 | |2;jquery.html;387.5814120749591;390.2857770280385;391.2825427406662;393.1606021144856;412.6306955275029;14265.71468570628;17461.3015479381;18295.359662411818;19946.401607951768;19966.50083747907;15049.62375940602;18438;19205.615887682237;19262.325818596353;20146.697799532983;5681.545476361892;5770.567207459437;5819.24349834523;5819.447152520525;5871.266091738533;4168;5785.739641716133;5791.681457519835;6204.472619827297;6542.1495205623205;6438.742450301982;6442.80671579851;6495.512836537255;6505.902411463831;6512.641804700739;6264;6427.357264273559;6440.4525615322755;6503.674816259192;6504.60972341661;5422.40353561108;5639.774409023634;5659.688717120598;5661.433856614347;5748.626339287975;23411.531769364687;24096.638550421758;24105;24432.755672443225;24488.877555612107;2338.8245881558782;2434.257551446808;2450.718167410753;2661.334666333417;2685.2481305234564;9632.181264592518;10018.549165287579;10216.182705383551;10499.63251286209;14110.717785644332;1871.8221768932067;1949.7757757857887;1999.4501512084148;2002.4493264352275;2010.1858747207405;74150.25849741488;75212.62393688051;75779;79112.20887791106;82061;9183.58673859678;9604.279679024101;9872;9986.400815951067;10169.644062457779;13120.671983200305;13177.407016684272;13191.538296159588;13259.734805304033;13259.734805304033;7510.361619262315;7756.844863102707;7763.107242667165;7776.339011184113;7941.960290198512;6031.336552979169;7799.688012479551;7853.450258481851;7947.880781788278;7994.920050799534;4433.379326894237;4702.177119004161;4732.503087175865;4755.144074066632;4801.423829140525;1892.5552495163627;1926.4605910345126;1976.4959935216716;1984.28565716342;2035.4199053269747;879.4767113567417;922.5710044829186;949.0746522140995;951.2057432044182;958.8705524754208;18124.27502899869;18143.909280453514;18451.81548184528;18523.44429667112;18840.05799710009;978.6721448314894;1000.7498125468633;1029.9073083422527;1032.390889375272;1045.7072019834459;10681.83977240342;10951.561937522569;10980.231383803217;10996.745667138377;11067.446627668583;461100;469891;474262;476756;477512;96801;103616.48191759143;104978.47510762398;105096;105243;1067.514281002142;1069.187417562658;1076;1080.9567617295377;1082.350589646206;17149.57126071858;17286.740698889276;17504.737428938322;17573.560660983065;17820;36726.816365918;42227.788861055495;42382.1523569533;43165.78417107894;44042;60251.39748602633;60553;60970.390296098245;61820;62174.689126554076;8608.698695545625;8733.30133589324;8733.91266087331;8794.648214071622;8990.640374384951;12503;13099.148555343872;13175.802362964372;13681.863181368059;13973.930130349283;11685.182037257311;11826.76346473083;11972.221805582609;12129.514819407477;12135.150539462153;11537.653870383901;11677.532898683958;11712.004479619327;11776;12012.75974480488;6513.4463570595135;10032.548535316075;12214.450349734105;12262.080343974416;12313.26120432777;8611.75718977394;8641.654333826576;8730.607122679621;8842.292616590787;8889.688860889837;8968.86546701787;11232.66302010941;12016.75966480683;12044.75910481803;12117.939410302892 08:33:30 INFO - PROCESS | 30181 | |3;mootools.html;1297.4939773488336;1489.4340150742719;1515.0985163827522;1693.4327000454848;1858.8884666919978;8325.292350150237;8667.263282620977;8715.869261961068;8909.465432074065;8919.108089191077;8640.611172497236;8856.380053396264;8860.822783544325;8863.867041994376;8864.335174861879;2071.409648250249;2125.744910610721;2127.4149608857533;2345.4605440748637;2386.78518933296;2327.7439481657;2398.46034642205;2399.3761621978238;2411.3489357873364;2415.770501802326;2280.908763649452;2288.347820871052;2304.758000409958;2305.619572770491;2317.385892738426;1998.060911371653;2057.249104077016;2291.679164916913;2318.918837840676;2319.791218790317;2057.794220577945;2259.378670865509;2314.8148148148275;2316.0851463671756;2324.32594547581;8650.394472386935;8744.562771861381;8744.606492707844;8749.868751968726;8755.168259015383;5005.1491246488185;5129.153689641204;5133.922991155136;5135.897282054375;5139.15203991341;3092.134202423325;3231.079142444392;3234.757393195496;3244.3186930744573;3291.4075466416034;1038.584566173529;1045.2421994054325;1048.7483004078965;1059.798638258736;1076.1229597877782;12287.385630718429;12448.75102497945;12449.875501244962;12460.376981150906;12476.251424914533;4252.4259225004225;4306.181825453154;4349.673774466928;4362.825486980485;4476.37330773692;9833.065858743408;9840.311178217598;9840.950795245977;9842.311038227399;9845.064718851698;5076.390833100052;5127.589792816566;5134.87162820925;5146.716930568855;5153.510416510426;4294.312909934458;4676.438827340741;4753.667243293005;4784.114938736345;4791.496892826272;3740.925181496355;3801.923961520754;3849.9807500962315;3861.2084522672785;4016.7188296819527;1125.4372813593204;1127.0701671121358;1129.0797999630274;1130.519529200103;1137.5392965848844;907.3013779389833;908.096444038173;918.8575770755543;927.939683920543;953.0517135450272;5946;6019.367966363468;6061.575689701766;6219.440250377488;6238.719257633417;416.7041400605543;421.35039835416035;426.74608607878264;430.9784510774449;436.12992080798375;4074.9796251018556;4106.199291138199;4133.7106402551535;4137.586241375899;4179.12238429927;10796.460176991119;11134.443277836075;11200.159988000933;11205.159613029055;11241.60654377093;10944.562217511211;11056.170787190993;11078.169137314733;11086.334819910831;11089.667309980714;7936.206379362133;8237.258646721944;8259.587020649064;8354.45696029756;8371.623276952552;5960.433758792908;6061.454469097803;6137.294211165773;6202.81391558254;6343.904841427475;9856.507174641383;9982.850257246293;10069.19446444268;10097.798044039226;10104;9859.408435493893;9925.950370248103;10211.642592509226;10245;10278.383297002203;6989.965050174716;7653.19641437641;7659.770206893802;7856.292933636;8025.9197408025175;8718.564071796513;8720.91279087201;8741.256993155399;8775.254103401283;8785.209331160226;7616.619169041415;7824.061112666516;7825.843483130419;7843.058832940083;7884.408669349937;7506.211847755907;7609.847803044019;7637.88543171864;7710.498817577064;7755.2632499912415;7034.788956331318;7084.57492550428;7092.042574252616;7107.82230444243;7113.324234197743;5127.2565478004735;5152.9742351288005;5184.662996905189;5247.08176069194;5338.252644629677;5225.930264436947;5306.787728490817;5316.202569614588;5358.410574836843;5395.244665746877 08:33:30 INFO - PROCESS | 30181 | |4;prototype.html;307.2840282142608;316.3057089688134;322.9790063645864;324.542395222736;325.8403382342651;5355.544778693811;5371.919421208685;5376.381716102649;5415.620906536544;5421.430749771276;4986.77559509822;5088.313077734505;5219.921701174476;5285.207218917164;5325;4075.510938687362;4118.279301122292;4136.710430269883;4140.896477588054;4141.523724771652;4093.713440059197;4114.218298523286;4137.400076988834;4140.772257525835;4151.190517849021;3872.9806350968206;3972.7417717848393;4094.8943785177985;4105.158442519291;4110.4656394668655;4072.796360182009;4092.897677558055;4096.180763847243;4096.689059500961;4111.629953304187;3621.963780362189;3627.7097832173363;3633.128049268183;3640.4175331946763;3643.872464463731;5054.69671819692;5090.796368145269;5098.439171691111;5107.284980102789;5217.713025783581;4652.441706995149;4677.292788132341;4692.460367057798;4722;4737.2420412734145;5464.781408743645;5474.479924407175;5479.917801232985;5486.149646804752;5495.065838807413;3797.867074652374;3933.1347103637154;3938.448617193595;3941.467901833273;3992.3811809169333;5627.943720562783;5678.488935995781;5682.687452190128;5687.999999999958;5692.7153642318135;4071.898202544901;4085.549629881349;4106.938395924063;4110.691698122653;4116.938245926313;4014.8594799181888;4069.9389509157386;4092.2224777292217;4148.688848336386;4156.9792151039655;4620.2607582786595;4679.953200467951;4681.625469962463;4690.273007683814;4694.36626055485;5478.753456094485;5531.225628412026;5552.944470555323;5558.166275058774;5582.665040097607;1353.282760137129;1380.6962468256968;1395.2744572822075;1401.9369128389246;1411.830580330367;908.7818923458323;909.8589718593629;909.9044600317004;911.6809116809196;915.771057235691;4786;4846.248831431134;4851.636127290467;4874.8537543873745;4878.804847806048;5080.796768129233;5117.488251174853;5117.71852548106;5122.820701275437;5122.974385128051;4517.593416592456;4733.668643194943;4832.395950506187;4861.416630004422;4871.7089971157675;2695.582184761365;2705.5535836587137;2753.697093319773;2755.256080858157;2758.4758895810132;5260.00059988601;5270.815521456807;5300.3639563252655;5306.97346513265;5338.279332290091;4912.312276281324;4971.619678998614;5142.537171654494;5174.508421699932;5174.611904107207;5184.533391994663;5233.345831771105;5245.6852588844795;5296.781740199775;5305.381858533185;5026.5727413168825;5051.217061355495;5080.155113136655;5093;5105.387353517602;4973.502649735142;5014.674046186986;5270.23581580661;5741.540676745767;5745.1956726059225;5921.6743079131065;5923.703814809329;5945.473173901161;5979.491743201703;5984.880302393841;3765.755225910307;4026.3356546169553;4051.1897620475434;4072.837086516506;4081.653059489977;5571.13647384656;5690.9430905690415;5703.258576385043;5730.598858079894;5767.480926716616;5590.049691552527;5597.356304024926;5602.299712535933;5630.4369563043365;5651.180578816131;5340.279062326692;5591.692456914909;5604.607677462702;5620.4660557247;5621.690807005654;5458.863528411822;5471.671699698031;5534.363548192009;5573.581981351496;5602.971985140048;5633.1831884375715;5650.830475085754;5652.915206271991;5665.886682266249;5687.289088863892;5286.762095705625;5483.616146869681;5487.780488780564;5497.47773961473;5531.8893622128135 08:33:30 INFO - PROCESS | 30181 | |5;yui.html;746.8431629357835;751.3432880498501;761.8323968726882;769.4037121231045;809.7206463769999;13842.792358114624;14723.779143312846;14732.55802325932;14742;14757.409703611842;13584.592462226148;13701.109427887206;13723.794143087862;13732.244726540037;13733.58799236022;645.9192600924885;781.1056340490136;789.0531362365156;799.7640695994695;802.8715405535115;806.4435539477771;806.4878801960767;810.5663470043528;810.9716159934403;811.0713233347814;857.0700789643245;857.2156476823699;858.1161403754144;859.1236938322907;859.4714250735815;671.610465929762;818.979525511864;835.8119423129808;837.660747397299;851.9488830670149;619.3032838057186;619.306376857922;619.464163498575;619.4796371048296;619.4920165464321;12696.619101426879;12703;12725.30010849403;12729.618111456672;12762.042846786528;13407.195568265935;13689.589312320646;13804.723905521832;13830.585082447542;14093.506727264497;12329.753404931851;12379;12413;12447.491044791022;12493.50025998968;4370.956290437087;4400.515943246241;4415.448068991376;4427.5572442755465;4518.615917647004;55357.446425536036;56423.43576564223;57946.42053579495;58475.70762146205;59122.40877591212;10178.592856285666;10341.276110672181;10767.3539587625;11464.082873370111;11491.253068550517;19226.423207303804;19283.22867085301;19523.707144392847;19576.8042319575;19591.60816783685;8212.712555060663;8267.503949763033;8304.297618988094;8350.373721970876;8364.623591938378;4402.075564131568;4428.579284967923;4591.586757191869;4750.904981900343;4878.975605121952;3244.156519304998;3300.339932013607;3308.454105072636;3312.006398080566;3313.2048308406293;584.7164125399178;590.1560768101656;598.8472939400425;601.8705978214705;618.7494064903722;728.4172661870589;742.2874040920668;754.5698951597647;760.9885851712229;780.2548566119342;9357.39176953496;9804.607815687436;9863.210943124677;9967.152792012615;10081.19350451962;740.5038624121852;750.1823012915947;757.121738783009;758.2569082299377;764.4266799900075;4695.859124226278;4730.550597693214;4734.171519984058;4745.715257084586;4752.643551733634;62865.37134628595;63858;65471.34528654652;65517.672411637635;66846.66576667182;55797;56548.71725641345;56761;56950;57549.712251438476;52192.73903630458;52876;53842.46157538374;54801.1779823295;55866;9648.951755241178;10073.496325183858;10114.241431892491;10164.898351016394;10168.135708464863;37172.62827371692;37213;37324;37495;38379.424308634836;46180;47681;48490.27264591104;48532.93338332709;49385.25922111243;13239.139455935334;13374.264415457243;13393.531226407029;13417.396217170055;13715;10788.892111078789;13558.86441135576;14456.566303010926;15314.310856011729;15322.616934576725;13429.328533573478;13645.727085458037;13949.721005580035;14059.367328470038;14439.278036098363;13555.322233888463;14101.435942562182;14261.358238879067;14573.344199511259;14619.92690036543;13597.456101755819;13931.58205253844;14470.782938256145;14504.129752214902;14505.927470362582;10939.453027348442;11178.608748693756;11195.44022798873;11394.715132121763;11444.313341199555;10627.309224900357;10785;11432.028277596497;11567.421628918688;11638.88361116412 08:33:30 INFO - PROCESS | 30181 | __end_tp_report 08:33:30 INFO - PROCESS | 30181 | __start_cc_report 08:33:30 INFO - PROCESS | 30181 | _x_x_mozilla_cycle_collect,992 08:33:30 INFO - PROCESS | 30181 | __end_cc_report 08:33:30 INFO - PROCESS | 30181 | __startTimestamp1464276809999__endTimestamp 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | ------- Summary: start ------- 08:33:30 INFO - PROCESS | 30181 | Number of tests: 6 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | [#0] dojo.html Cycles:165 Average:5276.32 Median:5464.56 stddev:606.15 (11.1%) stddev-sans-first:582.49 08:33:30 INFO - PROCESS | 30181 | Values: 3057.9 3063.9 3091.4 3106.8 3125.0 5195.5 5201.2 5268.8 5328.6 5367.3 5257.3 5259.6 5263.7 5283.4 5342.0 4724.0 4757.3 4806.8 4815.9 4972.6 4876.4 4902.7 4930.7 4941.4 4970.6 4715.0 4727.0 4778.5 4782.9 4848.5 4775.3 4776.7 4777.4 4840.2 4843.3 4775.3 4794.9 4813.6 4822.3 4833.4 5085.8 5156.8 5239.3 5278.4 5285.3 5714.2 5722.3 5733.2 5734.5 5737.1 5693.5 5728.5 5732.2 5773.1 5809.3 5179.5 5229.3 5283.9 5289.6 5368.9 5842.2 5844.9 5845.4 5848.7 5855.0 5599.2 5616.2 5619.0 5620.1 5623.4 5465.1 5602.3 5674.0 5687.1 5702.9 5673.5 5674.9 5674.9 5678.2 5679.6 5502.1 5686.1 5687.0 5688.9 5702.2 4287.4 4289.3 4319.8 4322.0 4322.4 3851.7 3853.2 3859.8 3877.9 3893.1 5243.5 5243.7 5415.5 5417.7 5482.4 5679.9 5714.1 5728.4 5745.3 5762.0 5454.6 5457.0 5461.0 5464.9 5467.0 4819.1 4883.2 4956.1 4956.2 5008.2 5872.0 5938.3 5943.8 5955.7 5998.4 5746.7 5749.2 5750.8 5754.5 5758.1 5791.7 5819.8 5872.9 5941.5 5957.0 5608.0 5619.9 5626.0 5626.9 5665.9 5658.8 5687.9 5705.3 5712.7 5713.7 5425.6 5462.6 5478.0 5489.0 5560.5 5503.1 5503.9 5514.4 5518.7 5519.1 5361.7 5392.0 5409.1 5409.3 5446.6 5454.5 5501.5 5603.8 5610.1 5690.8 5447.9 5448.9 5464.6 5480.6 5501.9 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | [#1] ext.html Cycles:180 Average:61711.13 Median:43015.50 stddev:122848.24 (285.6%) stddev-sans-first:123107.19 08:33:30 INFO - PROCESS | 30181 | Values: 606.5 623.0 636.4 647.4 667.1 41873.4 42436.0 42505.6 42520.6 46145.1 44384.6 45032.3 45038.5 45075.3 45110.0 8743.2 8955.2 8959.7 8964.9 8966.8 8778.9 8861.2 8871.9 8876.6 8877.3 8863.7 8909.2 8918.9 8927.7 8929.3 8879.2 8889.5 8906.8 8917.4 8928.7 8762.1 8835.3 8855.2 8859.6 8860.9 41116.0 41263.6 41507.4 41547.8 41569.2 3490.9 3624.5 3722.5 3736.8 3888.8 31877.0 32099.8 32123.5 32495.4 33082.7 4334.6 4386.8 4418.5 4429.1 4468.4 322477.0 322532.0 322672.0 323727.0 326261.0 56491.0 57024.4 57051.4 57089.7 57114.4 50781.5 57787.7 58963.0 58965.7 64460.7 15887.8 15906.0 15973.4 16000.3 16002.7 12300.5 12380.8 12385.3 12385.8 12411.9 14331.0 15710.5 15904.1 15979.4 16156.2 6570.6 6665.9 6692.8 6739.8 6775.0 1009.1 1012.5 1042.6 1075.4 1139.7 29098.0 29714.7 30500.5 30611.7 30921.2 1130.0 1144.1 1180.7 1201.6 1298.6 17336.7 17995.8 18033.3 18900.6 19009.2 530302.0 532412.0 532871.0 535248.0 537206.0 56555.7 56661.7 56743.0 56761.0 56765.4 1232.6 1376.2 1379.3 1389.1 1413.6 30935.5 31917.7 32384.7 32436.8 33177.7 55301.0 55314.4 55883.4 55900.0 55976.7 497956.0 503316.0 504021.0 504515.0 505705.0 24294.5 45573.0 45714.0 46639.5 47199.0 46884.0 47125.5 47557.5 50877.2 51166.9 42863.6 43063.0 44094.0 44157.6 45035.8 38707.6 39075.8 39688.6 40704.0 41033.8 41900.9 41990.4 42530.6 42799.4 42968.0 37122.3 37957.0 38097.0 38579.8 38956.0 28539.3 29095.4 29335.9 29558.3 29562.9 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | [#2] jquery.html Cycles:180 Average:28684.94 Median:19706.03 stddev:78182.19 (396.7%) stddev-sans-first:78372.64 08:33:30 INFO - PROCESS | 30181 | Values: 387.6 390.3 391.3 393.2 412.6 14265.7 17461.3 18295.4 19946.4 19966.5 15049.6 18438.0 19205.6 19262.3 20146.7 5681.5 5770.6 5819.2 5819.4 5871.3 4168.0 5785.7 5791.7 6204.5 6542.1 6438.7 6442.8 6495.5 6505.9 6512.6 6264.0 6427.4 6440.5 6503.7 6504.6 5422.4 5639.8 5659.7 5661.4 5748.6 23411.5 24096.6 24105.0 24432.8 24488.9 2338.8 2434.3 2450.7 2661.3 2685.2 9632.2 10018.5 10216.2 10499.6 14110.7 1871.8 1949.8 1999.5 2002.4 2010.2 74150.3 75212.6 75779.0 79112.2 82061.0 9183.6 9604.3 9872.0 9986.4 10169.6 13120.7 13177.4 13191.5 13259.7 13259.7 7510.4 7756.8 7763.1 7776.3 7942.0 6031.3 7799.7 7853.5 7947.9 7994.9 4433.4 4702.2 4732.5 4755.1 4801.4 1892.6 1926.5 1976.5 1984.3 2035.4 879.5 922.6 949.1 951.2 958.9 18124.3 18143.9 18451.8 18523.4 18840.1 978.7 1000.7 1029.9 1032.4 1045.7 10681.8 10951.6 10980.2 10996.7 11067.4 461100.0 469891.0 474262.0 476756.0 477512.0 96801.0 103616.5 104978.5 105096.0 105243.0 1067.5 1069.2 1076.0 1081.0 1082.4 17149.6 17286.7 17504.7 17573.6 17820.0 36726.8 42227.8 42382.2 43165.8 44042.0 60251.4 60553.0 60970.4 61820.0 62174.7 8608.7 8733.3 8733.9 8794.6 8990.6 12503.0 13099.1 13175.8 13681.9 13973.9 11685.2 11826.8 11972.2 12129.5 12135.2 11537.7 11677.5 11712.0 11776.0 12012.8 6513.4 10032.5 12214.5 12262.1 12313.3 8611.8 8641.7 8730.6 8842.3 8889.7 8968.9 11232.7 12016.8 12044.8 12117.9 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | [#3] mootools.html Cycles:180 Average:5767.45 Median:4898.32 stddev:3349.10 (68.4%) stddev-sans-first:3341.65 08:33:30 INFO - PROCESS | 30181 | Values: 1297.5 1489.4 1515.1 1693.4 1858.9 8325.3 8667.3 8715.9 8909.5 8919.1 8640.6 8856.4 8860.8 8863.9 8864.3 2071.4 2125.7 2127.4 2345.5 2386.8 2327.7 2398.5 2399.4 2411.3 2415.8 2280.9 2288.3 2304.8 2305.6 2317.4 1998.1 2057.2 2291.7 2318.9 2319.8 2057.8 2259.4 2314.8 2316.1 2324.3 8650.4 8744.6 8744.6 8749.9 8755.2 5005.1 5129.2 5133.9 5135.9 5139.2 3092.1 3231.1 3234.8 3244.3 3291.4 1038.6 1045.2 1048.7 1059.8 1076.1 12287.4 12448.8 12449.9 12460.4 12476.3 4252.4 4306.2 4349.7 4362.8 4476.4 9833.1 9840.3 9841.0 9842.3 9845.1 5076.4 5127.6 5134.9 5146.7 5153.5 4294.3 4676.4 4753.7 4784.1 4791.5 3740.9 3801.9 3850.0 3861.2 4016.7 1125.4 1127.1 1129.1 1130.5 1137.5 907.3 908.1 918.9 927.9 953.1 5946.0 6019.4 6061.6 6219.4 6238.7 416.7 421.4 426.7 431.0 436.1 4075.0 4106.2 4133.7 4137.6 4179.1 10796.5 11134.4 11200.2 11205.2 11241.6 10944.6 11056.2 11078.2 11086.3 11089.7 7936.2 8237.3 8259.6 8354.5 8371.6 5960.4 6061.5 6137.3 6202.8 6343.9 9856.5 9982.9 10069.2 10097.8 10104.0 9859.4 9926.0 10211.6 10245.0 10278.4 6990.0 7653.2 7659.8 7856.3 8025.9 8718.6 8720.9 8741.3 8775.3 8785.2 7616.6 7824.1 7825.8 7843.1 7884.4 7506.2 7609.8 7637.9 7710.5 7755.3 7034.8 7084.6 7092.0 7107.8 7113.3 5127.3 5153.0 5184.7 5247.1 5338.3 5225.9 5306.8 5316.2 5358.4 5395.2 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | [#4] prototype.html Cycles:180 Average:4540.25 Median:5089.55 stddev:1327.84 (26.1%) stddev-sans-first:1293.00 08:33:30 INFO - PROCESS | 30181 | Values: 307.3 316.3 323.0 324.5 325.8 5355.5 5371.9 5376.4 5415.6 5421.4 4986.8 5088.3 5219.9 5285.2 5325.0 4075.5 4118.3 4136.7 4140.9 4141.5 4093.7 4114.2 4137.4 4140.8 4151.2 3873.0 3972.7 4094.9 4105.2 4110.5 4072.8 4092.9 4096.2 4096.7 4111.6 3622.0 3627.7 3633.1 3640.4 3643.9 5054.7 5090.8 5098.4 5107.3 5217.7 4652.4 4677.3 4692.5 4722.0 4737.2 5464.8 5474.5 5479.9 5486.1 5495.1 3797.9 3933.1 3938.4 3941.5 3992.4 5627.9 5678.5 5682.7 5688.0 5692.7 4071.9 4085.5 4106.9 4110.7 4116.9 4014.9 4069.9 4092.2 4148.7 4157.0 4620.3 4680.0 4681.6 4690.3 4694.4 5478.8 5531.2 5552.9 5558.2 5582.7 1353.3 1380.7 1395.3 1401.9 1411.8 908.8 909.9 909.9 911.7 915.8 4786.0 4846.2 4851.6 4874.9 4878.8 5080.8 5117.5 5117.7 5122.8 5123.0 4517.6 4733.7 4832.4 4861.4 4871.7 2695.6 2705.6 2753.7 2755.3 2758.5 5260.0 5270.8 5300.4 5307.0 5338.3 4912.3 4971.6 5142.5 5174.5 5174.6 5184.5 5233.3 5245.7 5296.8 5305.4 5026.6 5051.2 5080.2 5093.0 5105.4 4973.5 5014.7 5270.2 5741.5 5745.2 5921.7 5923.7 5945.5 5979.5 5984.9 3765.8 4026.3 4051.2 4072.8 4081.7 5571.1 5690.9 5703.3 5730.6 5767.5 5590.0 5597.4 5602.3 5630.4 5651.2 5340.3 5591.7 5604.6 5620.5 5621.7 5458.9 5471.7 5534.4 5573.6 5603.0 5633.2 5650.8 5652.9 5665.9 5687.3 5286.8 5483.6 5487.8 5497.5 5531.9 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - PROCESS | 30181 | [#5] yui.html Cycles:180 Average:15557.10 Median:4473.60 stddev:18018.61 (402.8%) stddev-sans-first:18034.83 08:33:30 INFO - PROCESS | 30181 | Values: 746.8 751.3 761.8 769.4 809.7 13842.8 14723.8 14732.6 14742.0 14757.4 13584.6 13701.1 13723.8 13732.2 13733.6 645.9 781.1 789.1 799.8 802.9 806.4 806.5 810.6 811.0 811.1 857.1 857.2 858.1 859.1 859.5 671.6 819.0 835.8 837.7 851.9 619.3 619.3 619.5 619.5 619.5 12696.6 12703.0 12725.3 12729.6 12762.0 13407.2 13689.6 13804.7 13830.6 14093.5 12329.8 12379.0 12413.0 12447.5 12493.5 4371.0 4400.5 4415.4 4427.6 4518.6 55357.4 56423.4 57946.4 58475.7 59122.4 10178.6 10341.3 10767.4 11464.1 11491.3 19226.4 19283.2 19523.7 19576.8 19591.6 8212.7 8267.5 8304.3 8350.4 8364.6 4402.1 4428.6 4591.6 4750.9 4879.0 3244.2 3300.3 3308.5 3312.0 3313.2 584.7 590.2 598.8 601.9 618.7 728.4 742.3 754.6 761.0 780.3 9357.4 9804.6 9863.2 9967.2 10081.2 740.5 750.2 757.1 758.3 764.4 4695.9 4730.6 4734.2 4745.7 4752.6 62865.4 63858.0 65471.3 65517.7 66846.7 55797.0 56548.7 56761.0 56950.0 57549.7 52192.7 52876.0 53842.5 54801.2 55866.0 9649.0 10073.5 10114.2 10164.9 10168.1 37172.6 37213.0 37324.0 37495.0 38379.4 46180.0 47681.0 48490.3 48532.9 49385.3 13239.1 13374.3 13393.5 13417.4 13715.0 10788.9 13558.9 14456.6 15314.3 15322.6 13429.3 13645.7 13949.7 14059.4 14439.3 13555.3 14101.4 14261.4 14573.3 14619.9 13597.5 13931.6 14470.8 14504.1 14505.9 10939.5 11178.6 11195.4 11394.7 11444.3 10627.3 10785.0 11432.0 11567.4 11638.9 08:33:30 INFO - PROCESS | 30181 | -------- Summary: end -------- 08:33:30 INFO - PROCESS | 30181 | 08:33:30 INFO - TEST-INFO | 30181: exit 0 08:33:30 INFO - TEST-OK | dromaeo_css | took 1112312ms 08:33:30 INFO - TEST-START | kraken 08:33:30 INFO - operating with platform_type : linux_ 08:33:30 INFO - Initialising browser for kraken test... 08:33:30 INFO - TEST-INFO | started process 30368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplng7i/profile http://localhost:45266/getInfo.html) 08:33:34 INFO - PROCESS | 30368 | __metrics Screen width/height:1600/1200 08:33:34 INFO - PROCESS | 30368 | colorDepth:24 08:33:34 INFO - PROCESS | 30368 | Browser inner width/height: 1024/697 08:33:34 INFO - PROCESS | 30368 | __metrics 08:33:35 ERROR - PROCESS | 30368 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:33:36 INFO - TEST-INFO | 30368: exit 0 08:33:36 INFO - Browser initialized. 08:33:36 INFO - Running cycle 1/1 for kraken test... 08:33:36 INFO - TEST-INFO | started process 30451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpplng7i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:48 INFO - PROCESS | 30451 | RSS: Main: 155344896 08:33:48 INFO - PROCESS | 30451 | 08:33:50 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45266/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:51 INFO - PROCESS | 30451 | RSS: Main: 211316736 08:33:51 INFO - PROCESS | 30451 | 08:33:54 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45266/tests/kraken/driver.html?testName=audio-dft) 08:33:54 INFO - PROCESS | 30451 | RSS: Main: 199688192 08:33:54 INFO - PROCESS | 30451 | 08:33:58 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45266/tests/kraken/driver.html?testName=audio-fft) 08:33:58 INFO - PROCESS | 30451 | RSS: Main: 268439552 08:33:58 INFO - PROCESS | 30451 | 08:34:00 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45266/tests/kraken/driver.html?testName=audio-oscillator) 08:34:01 INFO - PROCESS | 30451 | RSS: Main: 177053696 08:34:01 INFO - PROCESS | 30451 | 08:34:03 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:04 INFO - PROCESS | 30451 | RSS: Main: 181354496 08:34:04 INFO - PROCESS | 30451 | 08:34:07 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45266/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:07 INFO - PROCESS | 30451 | RSS: Main: 217522176 08:34:07 INFO - PROCESS | 30451 | 08:34:10 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45266/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:11 INFO - PROCESS | 30451 | RSS: Main: 217800704 08:34:11 INFO - PROCESS | 30451 | 08:34:14 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45266/tests/kraken/driver.html?testName=json-parse-financial) 08:34:14 INFO - PROCESS | 30451 | RSS: Main: 218329088 08:34:14 INFO - PROCESS | 30451 | 08:34:16 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:17 INFO - PROCESS | 30451 | RSS: Main: 209117184 08:34:17 INFO - PROCESS | 30451 | 08:34:18 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:19 INFO - PROCESS | 30451 | RSS: Main: 207687680 08:34:19 INFO - PROCESS | 30451 | 08:34:21 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:22 INFO - PROCESS | 30451 | RSS: Main: 219136000 08:34:22 INFO - PROCESS | 30451 | 08:34:24 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:25 INFO - PROCESS | 30451 | RSS: Main: 227389440 08:34:25 INFO - PROCESS | 30451 | 08:34:28 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:28 INFO - PROCESS | 30451 | RSS: Main: 223719424 08:34:28 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | Cycle 1(1): loaded http://localhost:45266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45266/tests/kraken/driver.html?testName=ai-astar) 08:34:30 INFO - PROCESS | 30451 | RSS: Main: 269824000 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | __start_tp_report 08:34:30 INFO - PROCESS | 30451 | _x_x_mozilla_page_load 08:34:30 INFO - PROCESS | 30451 | _x_x_mozilla_page_load_details 08:34:30 INFO - PROCESS | 30451 | |i|pagename|runs| 08:34:30 INFO - PROCESS | 30451 | |0;ai-astar;112;106;111;110;112;111;112;109;111;110 08:34:30 INFO - PROCESS | 30451 | |1;audio-beat-detection;156;125;129;175;129;125;152;128;176;131 08:34:30 INFO - PROCESS | 30451 | |2;audio-dft;162;160;160;161;161;160;159;163;161;160 08:34:30 INFO - PROCESS | 30451 | |3;audio-fft;75;74;74;106;75;75;75;75;100;75 08:34:30 INFO - PROCESS | 30451 | |4;audio-oscillator;82;87;122;83;83;84;113;84;84;131 08:34:30 INFO - PROCESS | 30451 | |5;imaging-gaussian-blur;117;119;116;117;117;118;117;116;117;117 08:34:30 INFO - PROCESS | 30451 | |6;imaging-darkroom;146;145;146;145;145;145;145;145;146;145 08:34:30 INFO - PROCESS | 30451 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;96 08:34:30 INFO - PROCESS | 30451 | |8;json-parse-financial;55;54;54;53;54;54;55;71;52;51 08:34:30 INFO - PROCESS | 30451 | |9;json-stringify-tinderbox;60;62;62;62;62;62;62;62;61;61 08:34:30 INFO - PROCESS | 30451 | |10;stanford-crypto-aes;79;78;79;78;79;79;81;81;82;80 08:34:30 INFO - PROCESS | 30451 | |11;stanford-crypto-ccm;131;122;123;119;118;120;119;122;166;121 08:34:30 INFO - PROCESS | 30451 | |12;stanford-crypto-pbkdf2;163;159;166;159;159;163;169;160;160;164 08:34:30 INFO - PROCESS | 30451 | |13;stanford-crypto-sha256-iterative;63;63;64;62;63;66;66;62;62;64 08:34:30 INFO - PROCESS | 30451 | __end_tp_report 08:34:30 INFO - PROCESS | 30451 | __start_cc_report 08:34:30 INFO - PROCESS | 30451 | _x_x_mozilla_cycle_collect,1687 08:34:30 INFO - PROCESS | 30451 | __end_cc_report 08:34:30 INFO - PROCESS | 30451 | __startTimestamp1464276870569__endTimestamp 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | ------- Summary: start ------- 08:34:30 INFO - PROCESS | 30451 | Number of tests: 14 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.86 08:34:30 INFO - PROCESS | 30451 | Values: 112.0 106.0 111.0 110.0 112.0 111.0 112.0 109.0 111.0 110.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:141.50 stddev:20.47 (14.5%) stddev-sans-first:21.13 08:34:30 INFO - PROCESS | 30451 | Values: 156.0 125.0 129.0 175.0 129.0 125.0 152.0 128.0 176.0 131.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 08:34:30 INFO - PROCESS | 30451 | Values: 162.0 160.0 160.0 161.0 161.0 160.0 159.0 163.0 161.0 160.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.00 (16.0%) stddev-sans-first:12.57 08:34:30 INFO - PROCESS | 30451 | Values: 75.0 74.0 74.0 106.0 75.0 75.0 75.0 75.0 100.0 75.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:83.50 stddev:18.95 (22.7%) stddev-sans-first:19.48 08:34:30 INFO - PROCESS | 30451 | Values: 82.0 87.0 122.0 83.0 83.0 84.0 113.0 84.0 84.0 131.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 08:34:30 INFO - PROCESS | 30451 | Values: 117.0 119.0 116.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:34:30 INFO - PROCESS | 30451 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:34:30 INFO - PROCESS | 30451 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:5.66 (10.5%) stddev-sans-first:6.00 08:34:30 INFO - PROCESS | 30451 | Values: 55.0 54.0 54.0 53.0 54.0 54.0 55.0 71.0 52.0 51.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.44 08:34:30 INFO - PROCESS | 30451 | Values: 60.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 61.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:1.35 (1.7%) stddev-sans-first:1.41 08:34:30 INFO - PROCESS | 30451 | Values: 79.0 78.0 79.0 78.0 79.0 79.0 81.0 81.0 82.0 80.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:122.00 stddev:14.49 (11.9%) stddev-sans-first:15.26 08:34:30 INFO - PROCESS | 30451 | Values: 131.0 122.0 123.0 119.0 118.0 120.0 119.0 122.0 166.0 121.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:3.43 (2.1%) stddev-sans-first:3.62 08:34:30 INFO - PROCESS | 30451 | Values: 163.0 159.0 166.0 159.0 159.0 163.0 169.0 160.0 160.0 164.0 08:34:30 INFO - PROCESS | 30451 | 08:34:30 INFO - PROCESS | 30451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.51 (2.4%) stddev-sans-first:1.59 08:34:30 INFO - PROCESS | 30451 | Values: 63.0 63.0 64.0 62.0 63.0 66.0 66.0 62.0 62.0 64.0 08:34:30 INFO - PROCESS | 30451 | -------- Summary: end -------- 08:34:30 INFO - PROCESS | 30451 | 08:34:31 INFO - TEST-INFO | 30451: exit 0 08:34:31 INFO - TEST-OK | kraken | took 60910ms 08:34:31 INFO - SUITE-END | took 1173s 08:34:31 INFO - Completed test suite (00:19:33) 08:34:31 INFO - javascript benchmark 08:34:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.9388412231756, 3063.9080827575167, 3091.397177550378, 3106.782525223235, 3125.046860707483, 5195.532402083812, 5201.2458193561915, 5268.789248430058, 5328.6269961102735, 5367.302250707407, 5257.316548848654, 5259.552938000265, 5263.710495922723, 5283.365996080466, 5341.973290133554, 4724.031573527427, 4757.26262429324, 4806.7836947337455, 4815.855524334258, 4972.627052971024, 4876.390451193601, 4902.681325713817, 4930.728809915453, 4941.357623508939, 4970.627202959774, 4714.952850471503, 4727.0, 4778.450478195, 4782.928256076127, 4848.5151484851585, 4775.331453596499, 4776.665633405663, 4777.355057067321, 4840.201366774478, 4843.273508973647, 4775.2598347256235, 4794.880127996793, 4813.590844778198, 4822.252550854623, 4833.419989601271, 5085.79656813727, 5156.793728250903, 5239.266502689588, 5278.445763194848, 5285.2600635911, 5714.200011998323, 5722.341930677983, 5733.197352370671, 5734.455226753452, 5737.139429085671, 5693.459121383504, 5728.541716662657, 5732.197492351074, 5773.076307790775, 5809.331926828427, 5179.456157103487, 5229.294045303874, 5283.894322113536, 5289.629725919187, 5368.91946620801, 5842.211301474246, 5844.853878653068, 5845.444682755132, 5848.678322692293, 5855.004649209644, 5599.188117722989, 5616.213730077792, 5618.97190514053, 5620.072688006515, 5623.353314368818, 5465.098258787335, 5602.299712535933, 5674.00704876645, 5687.090065589568, 5702.914456283159, 5673.461021202979, 5674.886502269931, 5674.914876276859, 5678.205051292823, 5679.574031947621, 5502.064649009678, 5686.061799803069, 5687.004774164505, 5688.8862222755315, 5702.201691763156, 4287.442632457823, 4289.33515305122, 4319.784010799511, 4322.027543802619, 4322.37325587788, 3851.730378873508, 3853.2100919311474, 3859.826307816155, 3877.86427475037, 3893.0656642406184, 5243.475652434726, 5243.711595862264, 5415.48552887475, 5417.729113544307, 5482.369527504308, 5679.914801277984, 5714.0571805652435, 5728.427157284322, 5745.253117094751, 5762.049261871744, 5454.59090568209, 5457.045017121988, 5461.01701693691, 5464.863378415492, 5466.972665136649, 4819.084373969004, 4883.243097319921, 4956.083124621957, 4956.157453232959, 5008.248762685554, 5871.970640146772, 5938.317093534212, 5943.762249510058, 5955.67243801595, 5998.430149135826, 5746.683932383676, 5749.223854779551, 5750.7987220447085, 5754.51086657622, 5758.107493338539, 5791.739371728367, 5819.82540523785, 5872.94127058741, 5941.494972927177, 5956.987312157031, 5608.018596745635, 5619.943800562106, 5625.971870140623, 5626.85932851682, 5665.858353541194, 5658.773649053992, 5687.857803554944, 5705.315362156568, 5712.65724056558, 5713.685747283773, 5425.565954723692, 5462.617616766788, 5478.0, 5489.039418101896, 5560.471755183413, 5503.091989821634, 5503.862403439946, 5514.448555144453, 5518.724063796874, 5519.089350257163, 5361.651492652965, 5392.029434701634, 5409.053415652324, 5409.269748583891, 5446.591505637014, 5454.481824226692, 5501.477359650827, 5603.831885043455, 5610.074337734228, 5690.829275121753, 5447.891042179213, 5448.918266226089, 5464.562834973272, 5480.616356854982, 5501.944980550304], "value": 5235.157111127001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.4602503771644, 623.049848980305, 636.4113195294354, 647.3882181338631, 667.0694381338034, 41873.371899421494, 42435.99999999992, 42505.57494425051, 42520.57479425205, 46145.07709845801, 44384.55615443845, 45032.32451513222, 45038.54961450385, 45075.32387014189, 45110.0, 8743.213110820025, 8955.19403253707, 8959.731208063737, 8964.910350896473, 8966.775830604221, 8778.868316975251, 8861.202491775739, 8871.866921996176, 8876.6005529751, 8877.334199934998, 8863.734087977371, 8909.198172164504, 8918.866217006751, 8927.687530936419, 8929.330300227477, 8879.245264152523, 8889.466632002068, 8906.821863562725, 8917.375783695144, 8928.73213803587, 8762.079981601968, 8835.337349698733, 8855.24730397917, 8859.645614175426, 8860.911390886073, 41116.0, 41263.58736412627, 41507.377389339184, 41547.792261038805, 41569.168616627496, 3490.8778192763384, 3624.4925710400566, 3722.497462842509, 3736.794476303802, 3888.786116763577, 31877.0, 32099.83950080258, 32123.51814722781, 32495.350092998244, 33082.66917330844, 4334.631556317717, 4386.8025938832825, 4418.491873434564, 4429.092036132585, 4468.396766436522, 322476.9999999977, 322532.0, 322672.0, 323727.0, 326261.0, 56491.0, 57024.42975570191, 57051.42948570544, 57089.71455142698, 57114.42885571174, 50781.492185078416, 57787.711061444425, 58963.0, 58965.70517147387, 64460.677696611216, 15887.761683574756, 15906.0, 15973.440929567409, 16000.279987400594, 16002.679946401007, 12300.507979680891, 12380.752384952251, 12385.318807465495, 12385.814212786816, 12411.875881241072, 14331.0, 15710.528684139494, 15904.091509018992, 15979.440719574992, 16156.192190390433, 6570.5729127606555, 6665.866682666319, 6692.765753198614, 6739.831504212434, 6774.966125169342, 1009.1129587670955, 1012.4836333469983, 1042.5673345561506, 1075.370908018802, 1139.7207684117445, 29098.0, 29714.662840172245, 30500.54249186264, 30611.697104057122, 30921.226969325497, 1129.9943500282611, 1144.1247445704043, 1180.734334774686, 1201.645514573203, 1298.6040754807366, 17336.65326693484, 17995.820041799416, 18033.278668853098, 18900.62198756017, 19009.239630414628, 530302.0, 532412.0, 532871.0, 535248.0, 537206.0, 56555.71722141445, 56661.7166914171, 56743.0, 56761.0, 56765.43234567684, 1232.556279739311, 1376.215557132445, 1379.3103448275863, 1389.0970868935274, 1413.6465883529117, 30935.535966960964, 31917.68082319147, 32384.67615323911, 32436.83781581077, 33177.668223318426, 55301.0, 55314.44685553093, 55883.44116558782, 55900.0, 55976.720116399156, 497956.0, 503316.0, 504021.0, 504515.0, 505705.0, 24294.51410971806, 45573.0, 45714.0, 46639.53360466352, 47199.0, 46884.0, 47125.528744712115, 47557.524424756695, 50877.23684144667, 51166.876285162136, 42863.571364285955, 43063.0, 44094.0, 44157.55842441534, 45035.774821125684, 38707.61292387153, 39075.80462097671, 39688.60311396849, 40703.982400440225, 41033.794831025654, 41900.85080659253, 41990.38032429192, 42530.5746942539, 42799.35800962926, 42968.0, 37122.25755484929, 37957.0, 38097.0, 38579.80710096432, 38956.0, 28539.28651783722, 29095.418091638472, 29335.853320734113, 29558.261043474085, 29562.852185738935], "value": 20409.454308088065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.5814120749591, 390.2857770280385, 391.2825427406662, 393.1606021144856, 412.6306955275029, 14265.71468570628, 17461.3015479381, 18295.359662411818, 19946.401607951768, 19966.50083747907, 15049.62375940602, 18438.0, 19205.615887682237, 19262.325818596353, 20146.697799532983, 5681.545476361892, 5770.567207459437, 5819.24349834523, 5819.447152520525, 5871.266091738533, 4168.0, 5785.739641716133, 5791.681457519835, 6204.472619827297, 6542.1495205623205, 6438.742450301982, 6442.80671579851, 6495.512836537255, 6505.902411463831, 6512.641804700739, 6264.0, 6427.357264273559, 6440.4525615322755, 6503.674816259192, 6504.60972341661, 5422.40353561108, 5639.774409023634, 5659.688717120598, 5661.433856614347, 5748.626339287975, 23411.531769364687, 24096.638550421758, 24105.0, 24432.755672443225, 24488.877555612107, 2338.8245881558782, 2434.257551446808, 2450.718167410753, 2661.334666333417, 2685.2481305234564, 9632.181264592518, 10018.549165287579, 10216.182705383551, 10499.63251286209, 14110.717785644332, 1871.8221768932067, 1949.7757757857887, 1999.4501512084148, 2002.4493264352275, 2010.1858747207405, 74150.25849741488, 75212.62393688051, 75779.0, 79112.20887791106, 82061.0, 9183.58673859678, 9604.279679024101, 9872.0, 9986.400815951067, 10169.644062457779, 13120.671983200305, 13177.407016684272, 13191.538296159588, 13259.734805304033, 13259.734805304033, 7510.361619262315, 7756.844863102707, 7763.107242667165, 7776.339011184113, 7941.960290198512, 6031.336552979169, 7799.688012479551, 7853.450258481851, 7947.880781788278, 7994.920050799534, 4433.379326894237, 4702.177119004161, 4732.503087175865, 4755.144074066632, 4801.423829140525, 1892.5552495163627, 1926.4605910345126, 1976.4959935216716, 1984.28565716342, 2035.4199053269747, 879.4767113567417, 922.5710044829186, 949.0746522140995, 951.2057432044182, 958.8705524754208, 18124.27502899869, 18143.909280453514, 18451.81548184528, 18523.44429667112, 18840.05799710009, 978.6721448314894, 1000.7498125468633, 1029.9073083422527, 1032.390889375272, 1045.7072019834459, 10681.83977240342, 10951.561937522569, 10980.231383803217, 10996.745667138377, 11067.446627668583, 461100.0, 469891.0, 474262.0, 476756.0, 477512.0, 96801.0, 103616.48191759143, 104978.47510762398, 105096.0, 105243.0, 1067.514281002142, 1069.187417562658, 1076.0, 1080.9567617295377, 1082.350589646206, 17149.57126071858, 17286.740698889276, 17504.737428938322, 17573.560660983065, 17820.0, 36726.816365918, 42227.788861055495, 42382.1523569533, 43165.78417107894, 44042.0, 60251.39748602633, 60553.0, 60970.390296098245, 61820.0, 62174.689126554076, 8608.698695545625, 8733.30133589324, 8733.91266087331, 8794.648214071622, 8990.640374384951, 12503.0, 13099.148555343872, 13175.802362964372, 13681.863181368059, 13973.930130349283, 11685.182037257311, 11826.76346473083, 11972.221805582609, 12129.514819407477, 12135.150539462153, 11537.653870383901, 11677.532898683958, 11712.004479619327, 11776.0, 12012.75974480488, 6513.4463570595135, 10032.548535316075, 12214.450349734105, 12262.080343974416, 12313.26120432777, 8611.75718977394, 8641.654333826576, 8730.607122679621, 8842.292616590787, 8889.688860889837, 8968.86546701787, 11232.66302010941, 12016.75966480683, 12044.75910481803, 12117.939410302892], "value": 9221.72790127855, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.4939773488336, 1489.4340150742719, 1515.0985163827522, 1693.4327000454848, 1858.8884666919978, 8325.292350150237, 8667.263282620977, 8715.869261961068, 8909.465432074065, 8919.108089191077, 8640.611172497236, 8856.380053396264, 8860.822783544325, 8863.867041994376, 8864.335174861879, 2071.409648250249, 2125.744910610721, 2127.4149608857533, 2345.4605440748637, 2386.78518933296, 2327.7439481657, 2398.46034642205, 2399.3761621978238, 2411.3489357873364, 2415.770501802326, 2280.908763649452, 2288.347820871052, 2304.758000409958, 2305.619572770491, 2317.385892738426, 1998.060911371653, 2057.249104077016, 2291.679164916913, 2318.918837840676, 2319.791218790317, 2057.794220577945, 2259.378670865509, 2314.8148148148275, 2316.0851463671756, 2324.32594547581, 8650.394472386935, 8744.562771861381, 8744.606492707844, 8749.868751968726, 8755.168259015383, 5005.1491246488185, 5129.153689641204, 5133.922991155136, 5135.897282054375, 5139.15203991341, 3092.134202423325, 3231.079142444392, 3234.757393195496, 3244.3186930744573, 3291.4075466416034, 1038.584566173529, 1045.2421994054325, 1048.7483004078965, 1059.798638258736, 1076.1229597877782, 12287.385630718429, 12448.75102497945, 12449.875501244962, 12460.376981150906, 12476.251424914533, 4252.4259225004225, 4306.181825453154, 4349.673774466928, 4362.825486980485, 4476.37330773692, 9833.065858743408, 9840.311178217598, 9840.950795245977, 9842.311038227399, 9845.064718851698, 5076.390833100052, 5127.589792816566, 5134.87162820925, 5146.716930568855, 5153.510416510426, 4294.312909934458, 4676.438827340741, 4753.667243293005, 4784.114938736345, 4791.496892826272, 3740.925181496355, 3801.923961520754, 3849.9807500962315, 3861.2084522672785, 4016.7188296819527, 1125.4372813593204, 1127.0701671121358, 1129.0797999630274, 1130.519529200103, 1137.5392965848844, 907.3013779389833, 908.096444038173, 918.8575770755543, 927.939683920543, 953.0517135450272, 5946.0, 6019.367966363468, 6061.575689701766, 6219.440250377488, 6238.719257633417, 416.7041400605543, 421.35039835416035, 426.74608607878264, 430.9784510774449, 436.12992080798375, 4074.9796251018556, 4106.199291138199, 4133.7106402551535, 4137.586241375899, 4179.12238429927, 10796.460176991119, 11134.443277836075, 11200.159988000933, 11205.159613029055, 11241.60654377093, 10944.562217511211, 11056.170787190993, 11078.169137314733, 11086.334819910831, 11089.667309980714, 7936.206379362133, 8237.258646721944, 8259.587020649064, 8354.45696029756, 8371.623276952552, 5960.433758792908, 6061.454469097803, 6137.294211165773, 6202.81391558254, 6343.904841427475, 9856.507174641383, 9982.850257246293, 10069.19446444268, 10097.798044039226, 10104.0, 9859.408435493893, 9925.950370248103, 10211.642592509226, 10245.0, 10278.383297002203, 6989.965050174716, 7653.19641437641, 7659.770206893802, 7856.292933636, 8025.9197408025175, 8718.564071796513, 8720.91279087201, 8741.256993155399, 8775.254103401283, 8785.209331160226, 7616.619169041415, 7824.061112666516, 7825.843483130419, 7843.058832940083, 7884.408669349937, 7506.211847755907, 7609.847803044019, 7637.88543171864, 7710.498817577064, 7755.2632499912415, 7034.788956331318, 7084.57492550428, 7092.042574252616, 7107.82230444243, 7113.324234197743, 5127.2565478004735, 5152.9742351288005, 5184.662996905189, 5247.08176069194, 5338.252644629677, 5225.930264436947, 5306.787728490817, 5316.202569614588, 5358.410574836843, 5395.244665746877], "value": 4487.7899106721525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.2840282142608, 316.3057089688134, 322.9790063645864, 324.542395222736, 325.8403382342651, 5355.544778693811, 5371.919421208685, 5376.381716102649, 5415.620906536544, 5421.430749771276, 4986.77559509822, 5088.313077734505, 5219.921701174476, 5285.207218917164, 5325.0, 4075.510938687362, 4118.279301122292, 4136.710430269883, 4140.896477588054, 4141.523724771652, 4093.713440059197, 4114.218298523286, 4137.400076988834, 4140.772257525835, 4151.190517849021, 3872.9806350968206, 3972.7417717848393, 4094.8943785177985, 4105.158442519291, 4110.4656394668655, 4072.796360182009, 4092.897677558055, 4096.180763847243, 4096.689059500961, 4111.629953304187, 3621.963780362189, 3627.7097832173363, 3633.128049268183, 3640.4175331946763, 3643.872464463731, 5054.69671819692, 5090.796368145269, 5098.439171691111, 5107.284980102789, 5217.713025783581, 4652.441706995149, 4677.292788132341, 4692.460367057798, 4722.0, 4737.2420412734145, 5464.781408743645, 5474.479924407175, 5479.917801232985, 5486.149646804752, 5495.065838807413, 3797.867074652374, 3933.1347103637154, 3938.448617193595, 3941.467901833273, 3992.3811809169333, 5627.943720562783, 5678.488935995781, 5682.687452190128, 5687.999999999958, 5692.7153642318135, 4071.898202544901, 4085.549629881349, 4106.938395924063, 4110.691698122653, 4116.938245926313, 4014.8594799181888, 4069.9389509157386, 4092.2224777292217, 4148.688848336386, 4156.9792151039655, 4620.2607582786595, 4679.953200467951, 4681.625469962463, 4690.273007683814, 4694.36626055485, 5478.753456094485, 5531.225628412026, 5552.944470555323, 5558.166275058774, 5582.665040097607, 1353.282760137129, 1380.6962468256968, 1395.2744572822075, 1401.9369128389246, 1411.830580330367, 908.7818923458323, 909.8589718593629, 909.9044600317004, 911.6809116809196, 915.771057235691, 4786.0, 4846.248831431134, 4851.636127290467, 4874.8537543873745, 4878.804847806048, 5080.796768129233, 5117.488251174853, 5117.71852548106, 5122.820701275437, 5122.974385128051, 4517.593416592456, 4733.668643194943, 4832.395950506187, 4861.416630004422, 4871.7089971157675, 2695.582184761365, 2705.5535836587137, 2753.697093319773, 2755.256080858157, 2758.4758895810132, 5260.00059988601, 5270.815521456807, 5300.3639563252655, 5306.97346513265, 5338.279332290091, 4912.312276281324, 4971.619678998614, 5142.537171654494, 5174.508421699932, 5174.611904107207, 5184.533391994663, 5233.345831771105, 5245.6852588844795, 5296.781740199775, 5305.381858533185, 5026.5727413168825, 5051.217061355495, 5080.155113136655, 5093.0, 5105.387353517602, 4973.502649735142, 5014.674046186986, 5270.23581580661, 5741.540676745767, 5745.1956726059225, 5921.6743079131065, 5923.703814809329, 5945.473173901161, 5979.491743201703, 5984.880302393841, 3765.755225910307, 4026.3356546169553, 4051.1897620475434, 4072.837086516506, 4081.653059489977, 5571.13647384656, 5690.9430905690415, 5703.258576385043, 5730.598858079894, 5767.480926716616, 5590.049691552527, 5597.356304024926, 5602.299712535933, 5630.4369563043365, 5651.180578816131, 5340.279062326692, 5591.692456914909, 5604.607677462702, 5620.4660557247, 5621.690807005654, 5458.863528411822, 5471.671699698031, 5534.363548192009, 5573.581981351496, 5602.971985140048, 5633.1831884375715, 5650.830475085754, 5652.915206271991, 5665.886682266249, 5687.289088863892, 5286.762095705625, 5483.616146869681, 5487.780488780564, 5497.47773961473, 5531.8893622128135], "value": 4115.027277719482, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.8431629357835, 751.3432880498501, 761.8323968726882, 769.4037121231045, 809.7206463769999, 13842.792358114624, 14723.779143312846, 14732.55802325932, 14742.0, 14757.409703611842, 13584.592462226148, 13701.109427887206, 13723.794143087862, 13732.244726540037, 13733.58799236022, 645.9192600924885, 781.1056340490136, 789.0531362365156, 799.7640695994695, 802.8715405535115, 806.4435539477771, 806.4878801960767, 810.5663470043528, 810.9716159934403, 811.0713233347814, 857.0700789643245, 857.2156476823699, 858.1161403754144, 859.1236938322907, 859.4714250735815, 671.610465929762, 818.979525511864, 835.8119423129808, 837.660747397299, 851.9488830670149, 619.3032838057186, 619.306376857922, 619.464163498575, 619.4796371048296, 619.4920165464321, 12696.619101426879, 12703.0, 12725.30010849403, 12729.618111456672, 12762.042846786528, 13407.195568265935, 13689.589312320646, 13804.723905521832, 13830.585082447542, 14093.506727264497, 12329.753404931851, 12379.0, 12413.0, 12447.491044791022, 12493.50025998968, 4370.956290437087, 4400.515943246241, 4415.448068991376, 4427.5572442755465, 4518.615917647004, 55357.446425536036, 56423.43576564223, 57946.42053579495, 58475.70762146205, 59122.40877591212, 10178.592856285666, 10341.276110672181, 10767.3539587625, 11464.082873370111, 11491.253068550517, 19226.423207303804, 19283.22867085301, 19523.707144392847, 19576.8042319575, 19591.60816783685, 8212.712555060663, 8267.503949763033, 8304.297618988094, 8350.373721970876, 8364.623591938378, 4402.075564131568, 4428.579284967923, 4591.586757191869, 4750.904981900343, 4878.975605121952, 3244.156519304998, 3300.339932013607, 3308.454105072636, 3312.006398080566, 3313.2048308406293, 584.7164125399178, 590.1560768101656, 598.8472939400425, 601.8705978214705, 618.7494064903722, 728.4172661870589, 742.2874040920668, 754.5698951597647, 760.9885851712229, 780.2548566119342, 9357.39176953496, 9804.607815687436, 9863.210943124677, 9967.152792012615, 10081.19350451962, 740.5038624121852, 750.1823012915947, 757.121738783009, 758.2569082299377, 764.4266799900075, 4695.859124226278, 4730.550597693214, 4734.171519984058, 4745.715257084586, 4752.643551733634, 62865.37134628595, 63858.0, 65471.34528654652, 65517.672411637635, 66846.66576667182, 55797.0, 56548.71725641345, 56761.0, 56950.0, 57549.712251438476, 52192.73903630458, 52876.0, 53842.46157538374, 54801.1779823295, 55866.0, 9648.951755241178, 10073.496325183858, 10114.241431892491, 10164.898351016394, 10168.135708464863, 37172.62827371692, 37213.0, 37324.0, 37495.0, 38379.424308634836, 46180.0, 47681.0, 48490.27264591104, 48532.93338332709, 49385.25922111243, 13239.139455935334, 13374.264415457243, 13393.531226407029, 13417.396217170055, 13715.0, 10788.892111078789, 13558.86441135576, 14456.566303010926, 15314.310856011729, 15322.616934576725, 13429.328533573478, 13645.727085458037, 13949.721005580035, 14059.367328470038, 14439.278036098363, 13555.322233888463, 14101.435942562182, 14261.358238879067, 14573.344199511259, 14619.92690036543, 13597.456101755819, 13931.58205253844, 14470.782938256145, 14504.129752214902, 14505.927470362582, 10939.453027348442, 11178.608748693756, 11195.44022798873, 11394.715132121763, 11444.313341199555, 10627.309224900357, 10785.0, 11432.028277596497, 11567.421628918688, 11638.88361116412], "value": 6967.588466978479, "unit": "score"}], "name": "dromaeo_css", "value": 7087.910822521819, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 112.0, 111.0, 112.0, 109.0, 111.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 129.0, 175.0, 129.0, 125.0, 152.0, 128.0, 176.0, 131.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 161.0, 160.0, 159.0, 163.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 106.0, 75.0, 75.0, 75.0, 75.0, 100.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 122.0, 83.0, 83.0, 84.0, 113.0, 84.0, 84.0, 131.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 71.0, 52.0, 51.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 78.0, 79.0, 79.0, 81.0, 81.0, 82.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 123.0, 119.0, 118.0, 120.0, 119.0, 122.0, 166.0, 121.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 166.0, 159.0, 159.0, 163.0, 169.0, 160.0, 160.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 66.0, 66.0, 62.0, 62.0, 64.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1494.9999999999998, "alertThreshold": 2.0}]} 08:34:31 INFO - Return code: 0 08:34:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:34:31 ERROR - # TBPL SUCCESS # 08:34:31 INFO - Running post-action listener: _resource_record_post_action 08:34:31 INFO - ##### 08:34:31 INFO - ##### Finished run-tests step (success) 08:34:31 INFO - ##### 08:34:31 INFO - Running post-run listener: _resource_record_post_run 08:34:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 550014976; Read time: 24; Write time: 420088 08:34:31 INFO - TinderboxPrint: CPU usage
13.2% 08:34:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 08:34:31 INFO - TinderboxPrint: I/O write bytes / time
550,014,976 / 420,088 08:34:31 INFO - TinderboxPrint: CPU idle
8,254.4 (86.8%) 08:34:31 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 08:34:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254402560; Read time: 0; Write time: 240368 08:34:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289931264; Read time: 24; Write time: 178768 08:34:32 INFO - Running post-run listener: _upload_blobber_files 08:34:32 INFO - Blob upload gear active. 08:34:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:32 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 08:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:33 INFO - (blobuploader) - INFO - Done attempting. 08:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:34 INFO - (blobuploader) - INFO - Done attempting. 08:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:39 INFO - (blobuploader) - INFO - Done attempting. 08:34:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:39 INFO - Return code: 0 08:34:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2919e6e5fb619e3e33a40b1d69e90d4b00d4484f1f66d3fcc7bba5c1e8a75b38bf104315e4910332e839eba042bb431c4e538fe30f258f9056849da922ef7e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b91fa1c611f8d93e8222bb5695a52c04837f83ce50087203a19f4415c14416e4fc6e68f1c6914957020cb43d7c734256924c4e558a14c30b5dc45edd359224ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/181d85123606e3d221095d1d78731e85cc48aad2d4e9bfed482614b085f8c962035575c4e1035fb90f31771260897e50d141bce14e675262dc9a7cd37c72c24b"} 08:34:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:39 INFO - Contents: 08:34:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2919e6e5fb619e3e33a40b1d69e90d4b00d4484f1f66d3fcc7bba5c1e8a75b38bf104315e4910332e839eba042bb431c4e538fe30f258f9056849da922ef7e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b91fa1c611f8d93e8222bb5695a52c04837f83ce50087203a19f4415c14416e4fc6e68f1c6914957020cb43d7c734256924c4e558a14c30b5dc45edd359224ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/181d85123606e3d221095d1d78731e85cc48aad2d4e9bfed482614b085f8c962035575c4e1035fb90f31771260897e50d141bce14e675262dc9a7cd37c72c24b"} 08:34:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:39 INFO - Copying logs to upload dir... 08:34:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.769144 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-26 08:34:39.548223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 08:34:39.551933) ========= 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=41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2919e6e5fb619e3e33a40b1d69e90d4b00d4484f1f66d3fcc7bba5c1e8a75b38bf104315e4910332e839eba042bb431c4e538fe30f258f9056849da922ef7e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b91fa1c611f8d93e8222bb5695a52c04837f83ce50087203a19f4415c14416e4fc6e68f1c6914957020cb43d7c734256924c4e558a14c30b5dc45edd359224ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/181d85123606e3d221095d1d78731e85cc48aad2d4e9bfed482614b085f8c962035575c4e1035fb90f31771260897e50d141bce14e675262dc9a7cd37c72c24b"} build_url:https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/QhUblcxmROS34_QJon-tuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2919e6e5fb619e3e33a40b1d69e90d4b00d4484f1f66d3fcc7bba5c1e8a75b38bf104315e4910332e839eba042bb431c4e538fe30f258f9056849da922ef7e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b91fa1c611f8d93e8222bb5695a52c04837f83ce50087203a19f4415c14416e4fc6e68f1c6914957020cb43d7c734256924c4e558a14c30b5dc45edd359224ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/181d85123606e3d221095d1d78731e85cc48aad2d4e9bfed482614b085f8c962035575c4e1035fb90f31771260897e50d141bce14e675262dc9a7cd37c72c24b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 08:34:39.581711) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:34:39.582400) ========= 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=41bf3e9aed84707956354da8000001c5-1464275644.303933-1755270428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:34:39.666152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 08:34:39.666882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 08:34:39.667497) ========= ========= Total master_lag: 0.19 =========