builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1464401313.02 results: success (0) buildid: 20160527163016 builduid: e3a90a9ab7a94d4687c08932281d39ba revision: ea15028498ed95677844fb7f30be5efcaf8b2621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.019119) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.020147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.020413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.073536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.073793) ========= 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-1464396637.609654-864232418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 19:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 87.9M=0s 2016-05-27 19:08:33 (87.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.178568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.178865) ========= 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-1464396637.609654-864232418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022826 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.229161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.229482) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea15028498ed95677844fb7f30be5efcaf8b2621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ea15028498ed95677844fb7f30be5efcaf8b2621 --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-1464396637.609654-864232418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 19:08:33,673 truncating revision to first 12 chars 2016-05-27 19:08:33,673 Setting DEBUG logging. 2016-05-27 19:08:33,674 attempt 1/10 2016-05-27 19:08:33,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea15028498ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 19:08:34,035 unpacking tar archive at: mozilla-central-ea15028498ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.931910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.932214) ========= script_repo_revision: ea15028498ed95677844fb7f30be5efcaf8b2621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.932614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.932886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 19:08:33.943415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-27 19:08:33.943710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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-1464396637.609654-864232418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:34 INFO - MultiFileLogger online at 20160527 19:08:34 in /builds/slave/test 19:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:34 INFO - {'append_to_log': False, 19:08:34 INFO - 'base_work_dir': '/builds/slave/test', 19:08:34 INFO - 'blob_upload_branch': 'Firefox', 19:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:34 INFO - 'branch': 'Firefox', 19:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:34 INFO - 'config_files': ('talos/linux_config.py',), 19:08:34 INFO - 'default_actions': ('clobber', 19:08:34 INFO - 'read-buildbot-config', 19:08:34 INFO - 'download-and-extract', 19:08:34 INFO - 'populate-webroot', 19:08:34 INFO - 'create-virtualenv', 19:08:34 INFO - 'install', 19:08:34 INFO - 'run-tests'), 19:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:34 INFO - 'download_minidump_stackwalk': True, 19:08:34 INFO - 'download_symbols': 'ondemand', 19:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:34 INFO - 'installer_path': 'installer.exe', 19:08:34 INFO - 'log_level': 'info', 19:08:34 INFO - 'log_name': 'talos', 19:08:34 INFO - 'log_to_console': True, 19:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:34 INFO - 'opt_config_files': (), 19:08:34 INFO - 'pip_index': False, 19:08:34 INFO - 'sps_profile': False, 19:08:34 INFO - 'sps_profile_interval': 0, 19:08:34 INFO - 'suite': 'dromaeojs-e10s', 19:08:34 INFO - 'system_bits': '32', 19:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:34 INFO - 'title': 'talos-linux64-ix-026', 19:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:34 INFO - 'use_talos_json': True, 19:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:34 INFO - 'work_dir': 'build'} 19:08:34 INFO - ##### 19:08:34 INFO - ##### Running clobber step. 19:08:34 INFO - ##### 19:08:34 INFO - Running pre-action listener: _resource_record_pre_action 19:08:34 INFO - Running main action method: clobber 19:08:34 INFO - rmtree: /builds/slave/test/build 19:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:34 INFO - Running post-action listener: _resource_record_post_action 19:08:34 INFO - ##### 19:08:34 INFO - ##### Finished clobber step (success) 19:08:34 INFO - ##### 19:08:34 INFO - ##### 19:08:34 INFO - ##### Running read-buildbot-config step. 19:08:34 INFO - ##### 19:08:34 INFO - Running pre-action listener: _resource_record_pre_action 19:08:34 INFO - Running main action method: read_buildbot_config 19:08:34 INFO - Using buildbot properties: 19:08:34 INFO - { 19:08:34 INFO - "project": "", 19:08:34 INFO - "product": "firefox", 19:08:34 INFO - "script_repo_revision": "production", 19:08:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:08:34 INFO - "repository": "", 19:08:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:08:34 INFO - "buildid": "20160527163016", 19:08:34 INFO - "pgo_build": "True", 19:08:34 INFO - "basedir": "/builds/slave/test", 19:08:34 INFO - "buildnumber": 44, 19:08:34 INFO - "slavename": "talos-linux64-ix-026", 19:08:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:08:34 INFO - "platform": "ubuntu64_hw", 19:08:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:08:34 INFO - "branch": "mozilla-central", 19:08:34 INFO - "repo_path": "mozilla-central", 19:08:34 INFO - "revision": "ea15028498ed95677844fb7f30be5efcaf8b2621", 19:08:34 INFO - "stage_platform": "linux64-pgo", 19:08:34 INFO - "builduid": "e3a90a9ab7a94d4687c08932281d39ba", 19:08:34 INFO - "slavebuilddir": "test" 19:08:34 INFO - } 19:08:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:08:34 INFO - Running post-action listener: _resource_record_post_action 19:08:34 INFO - ##### 19:08:34 INFO - ##### Finished read-buildbot-config step (success) 19:08:34 INFO - ##### 19:08:34 INFO - ##### 19:08:34 INFO - ##### Running download-and-extract step. 19:08:34 INFO - ##### 19:08:34 INFO - Running pre-action listener: _resource_record_pre_action 19:08:34 INFO - Running main action method: download_and_extract 19:08:34 INFO - mkdir: /builds/slave/test/build/tests 19:08: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')]} 19:08:34 INFO - https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:38 INFO - Downloaded 1361 bytes. 19:08:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:08:38 INFO - Using the following test package requirements: 19:08:38 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:38 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:38 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:38 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'jsshell-linux-x86_64.zip'], 19:08:38 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:38 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:38 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:38 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:38 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:38 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:38 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:38 INFO - https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:42 INFO - Downloaded 24410694 bytes. 19:08:42 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'] 19:08:42 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 19:08:43 INFO - Return code: 0 19:08:43 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 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:43 INFO - https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:48 INFO - Downloaded 24410694 bytes. 19:08:48 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'] 19:08:48 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 19:08:49 INFO - Return code: 0 19:08:49 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')]} 19:08:49 INFO - https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:50 INFO - Downloaded 10834034 bytes. 19:08:50 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'] 19:08:50 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 19:08:50 INFO - Return code: 0 19:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:50 INFO - https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSctqcqIQAG94_36ePbnPw/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 19:08:53 INFO - Downloaded 58743615 bytes. 19:08:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:53 INFO - mkdir: /builds/slave/test/properties 19:08:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:53 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:53 INFO - Contents: 19:08:53 INFO - build_url:https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:08:54 INFO - Running post-action listener: _resource_record_post_action 19:08:54 INFO - Running post-action listener: set_extra_try_arguments 19:08:54 INFO - ##### 19:08:54 INFO - ##### Finished download-and-extract step (success) 19:08:54 INFO - ##### 19:08:54 INFO - ##### 19:08:54 INFO - ##### Running populate-webroot step. 19:08:54 INFO - ##### 19:08:54 INFO - Running pre-action listener: _resource_record_pre_action 19:08:54 INFO - Running main action method: populate_webroot 19:08:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:54 INFO - '--tppagecycles', 19:08:54 INFO - '7'], 19:08:54 INFO - 'tests': ['tsvgm']}}, 19:08:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['damp', 'tps']}, 19:08:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'tests': ['damp', 'tps']}, 19:08:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['dromaeo_dom']}, 19:08:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['a11yr', 19:08:54 INFO - 'ts_paint', 19:08:54 INFO - 'tpaint', 19:08:54 INFO - 'sessionrestore', 19:08:54 INFO - 'sessionrestore_no_auto_restore', 19:08:54 INFO - 'tabpaint']}, 19:08:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:54 INFO - 'ts_paint', 19:08:54 INFO - 'tpaint', 19:08:54 INFO - 'sessionrestore', 19:08:54 INFO - 'sessionrestore_no_auto_restore', 19:08:54 INFO - 'tabpaint']}, 19:08:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:54 INFO - 'ts_paint', 19:08:54 INFO - 'tpaint', 19:08:54 INFO - 'sessionrestore', 19:08:54 INFO - 'sessionrestore_no_auto_restore', 19:08:54 INFO - 'tabpaint']}, 19:08:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:54 INFO - 'ts_paint', 19:08:54 INFO - 'tpaint', 19:08:54 INFO - 'sessionrestore', 19:08:54 INFO - 'sessionrestore_no_auto_restore', 19:08:54 INFO - 'tabpaint']}, 19:08:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['a11yr', 19:08:54 INFO - 'ts_paint', 19:08:54 INFO - 'tpaint', 19:08:54 INFO - 'sessionrestore', 19:08:54 INFO - 'sessionrestore_no_auto_restore', 19:08:54 INFO - 'tabpaint']}, 19:08:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['a11yr', 19:08:54 INFO - 'ts_paint', 19:08:54 INFO - 'tpaint', 19:08:54 INFO - 'sessionrestore', 19:08:54 INFO - 'sessionrestore_no_auto_restore', 19:08:54 INFO - 'tabpaint']}, 19:08:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['tsvgx', 19:08:54 INFO - 'tsvgr_opacity', 19:08:54 INFO - 'tart', 19:08:54 INFO - 'tscrollx', 19:08:54 INFO - 'cart']}, 19:08:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:54 INFO - 'tsvgr_opacity', 19:08:54 INFO - 'tart', 19:08:54 INFO - 'tscrollx', 19:08:54 INFO - 'cart']}, 19:08:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'talos_options': ['--disable-e10s'], 19:08:54 INFO - 'tests': ['tp5o']}, 19:08:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'tests': ['tp5o']}, 19:08:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'talos_options': ['--disable-e10s', 19:08:54 INFO - '--xperf_path', 19:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:54 INFO - 'tests': ['tp5n']}, 19:08:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:54 INFO - 'talos_options': ['--xperf_path', 19:08:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:54 INFO - 'tests': ['tp5n']}}, 19:08:54 INFO - 'talos.zip': {'path': '', 19:08:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:54 INFO - Running post-action listener: _resource_record_post_action 19:08:54 INFO - ##### 19:08:54 INFO - ##### Finished populate-webroot step (success) 19:08:54 INFO - ##### 19:08:54 INFO - ##### 19:08:54 INFO - ##### Running create-virtualenv step. 19:08:54 INFO - ##### 19:08:54 INFO - Running pre-action listener: _resource_record_pre_action 19:08:54 INFO - Running main action method: create_virtualenv 19:08:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:54 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 19:08:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:54 INFO - Using real prefix '/usr' 19:08:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:56 INFO - Installing pip.................done. 19:08:56 INFO - Return code: 0 19:08:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:56 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:08:56 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 19:08:56 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 19:08:56 INFO - Using env: {'DISPLAY': ':0', 19:08:56 INFO - 'HOME': '/home/cltbld', 19:08:56 INFO - 'LANG': 'en_US.UTF-8', 19:08:56 INFO - 'LANGUAGE': 'en_US:en', 19:08:56 INFO - 'LOGNAME': 'cltbld', 19:08:56 INFO - 'MAIL': '/var/mail/cltbld', 19:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:56 INFO - 'MOZ_NO_REMOTE': '1', 19:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:56 INFO - 'NO_EM_RESTART': '1', 19:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:56 INFO - 'PWD': '/builds/slave/test', 19:08:56 INFO - 'SHELL': '/bin/bash', 19:08:56 INFO - 'SHLVL': '1', 19:08:56 INFO - 'TERM': 'linux', 19:08:56 INFO - 'TMOUT': '86400', 19:08:56 INFO - 'USER': 'cltbld', 19:08:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:56 INFO - '_': '/tools/buildbot/bin/python'} 19:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:56 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 19:08:56 INFO - Cleaning up... 19:08:56 INFO - Return code: 0 19:08:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:56 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:08:56 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 19:08:56 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 19:08:56 INFO - Using env: {'DISPLAY': ':0', 19:08:56 INFO - 'HOME': '/home/cltbld', 19:08:56 INFO - 'LANG': 'en_US.UTF-8', 19:08:56 INFO - 'LANGUAGE': 'en_US:en', 19:08:56 INFO - 'LOGNAME': 'cltbld', 19:08:56 INFO - 'MAIL': '/var/mail/cltbld', 19:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:56 INFO - 'MOZ_NO_REMOTE': '1', 19:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:56 INFO - 'NO_EM_RESTART': '1', 19:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:56 INFO - 'PWD': '/builds/slave/test', 19:08:56 INFO - 'SHELL': '/bin/bash', 19:08:56 INFO - 'SHLVL': '1', 19:08:56 INFO - 'TERM': 'linux', 19:08:56 INFO - 'TMOUT': '86400', 19:08:56 INFO - 'USER': 'cltbld', 19:08:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:56 INFO - '_': '/tools/buildbot/bin/python'} 19:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:57 INFO - Downloading/unpacking psutil>=3.1.1 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:59 INFO - Installing collected packages: psutil 19:08:59 INFO - Running setup.py install for psutil 19:08:59 INFO - building 'psutil._psutil_linux' extension 19:08:59 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 19:08:59 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 19:08:59 INFO - building 'psutil._psutil_posix' extension 19:08:59 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 19:08:59 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 19:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:59 INFO - Successfully installed psutil 19:08:59 INFO - Cleaning up... 19:08:59 INFO - Return code: 0 19:08:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:59 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')]} 19:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:59 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')]} 19:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:59 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:08:59 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 19:08:59 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 19:08:59 INFO - Using env: {'DISPLAY': ':0', 19:08:59 INFO - 'HOME': '/home/cltbld', 19:08:59 INFO - 'LANG': 'en_US.UTF-8', 19:08:59 INFO - 'LANGUAGE': 'en_US:en', 19:08:59 INFO - 'LOGNAME': 'cltbld', 19:08:59 INFO - 'MAIL': '/var/mail/cltbld', 19:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:59 INFO - 'MOZ_NO_REMOTE': '1', 19:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:59 INFO - 'NO_EM_RESTART': '1', 19:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:59 INFO - 'PWD': '/builds/slave/test', 19:08:59 INFO - 'SHELL': '/bin/bash', 19:08:59 INFO - 'SHLVL': '1', 19:08:59 INFO - 'TERM': 'linux', 19:08:59 INFO - 'TMOUT': '86400', 19:08:59 INFO - 'USER': 'cltbld', 19:08:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:59 INFO - '_': '/tools/buildbot/bin/python'} 19:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:09:01 INFO - Installing collected packages: mozsystemmonitor 19:09:01 INFO - Running setup.py install for mozsystemmonitor 19:09:01 INFO - Successfully installed mozsystemmonitor 19:09:01 INFO - Cleaning up... 19:09:02 INFO - Return code: 0 19:09:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:02 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:09:02 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 19:09:02 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 19:09:02 INFO - Using env: {'DISPLAY': ':0', 19:09:02 INFO - 'HOME': '/home/cltbld', 19:09:02 INFO - 'LANG': 'en_US.UTF-8', 19:09:02 INFO - 'LANGUAGE': 'en_US:en', 19:09:02 INFO - 'LOGNAME': 'cltbld', 19:09:02 INFO - 'MAIL': '/var/mail/cltbld', 19:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:02 INFO - 'MOZ_NO_REMOTE': '1', 19:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:02 INFO - 'NO_EM_RESTART': '1', 19:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:02 INFO - 'PWD': '/builds/slave/test', 19:09:02 INFO - 'SHELL': '/bin/bash', 19:09:02 INFO - 'SHLVL': '1', 19:09:02 INFO - 'TERM': 'linux', 19:09:02 INFO - 'TMOUT': '86400', 19:09:02 INFO - 'USER': 'cltbld', 19:09:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:02 INFO - '_': '/tools/buildbot/bin/python'} 19:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:09:02 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 19:09:02 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 19:09:02 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 19:09:02 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 19:09:02 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 19:09:02 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 19:09:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 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 19:09:04 INFO - Downloading docopt-0.6.1.tar.gz 19:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:04 INFO - Running setup.py install for blobuploader 19:09:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:05 INFO - Running setup.py install for requests 19:09:05 INFO - Running setup.py install for docopt 19:09:05 INFO - Successfully installed blobuploader requests docopt 19:09:05 INFO - Cleaning up... 19:09:05 INFO - Return code: 0 19:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:05 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:09:05 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 19:09:05 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 19:09:05 INFO - Using env: {'DISPLAY': ':0', 19:09:05 INFO - 'HOME': '/home/cltbld', 19:09:05 INFO - 'LANG': 'en_US.UTF-8', 19:09:05 INFO - 'LANGUAGE': 'en_US:en', 19:09:05 INFO - 'LOGNAME': 'cltbld', 19:09:05 INFO - 'MAIL': '/var/mail/cltbld', 19:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:05 INFO - 'MOZ_NO_REMOTE': '1', 19:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:05 INFO - 'NO_EM_RESTART': '1', 19:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:05 INFO - 'PWD': '/builds/slave/test', 19:09:05 INFO - 'SHELL': '/bin/bash', 19:09:05 INFO - 'SHLVL': '1', 19:09:05 INFO - 'TERM': 'linux', 19:09:05 INFO - 'TMOUT': '86400', 19:09:05 INFO - 'USER': 'cltbld', 19:09:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:05 INFO - '_': '/tools/buildbot/bin/python'} 19:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:05 INFO - Running setup.py (path:/tmp/pip-iezIAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:05 INFO - Running setup.py (path:/tmp/pip-xJOfk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:05 INFO - Running setup.py (path:/tmp/pip-WA89LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:05 INFO - Running setup.py (path:/tmp/pip-6OtXL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:06 INFO - Running setup.py (path:/tmp/pip-1YCcJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:06 INFO - Running setup.py (path:/tmp/pip-02LtTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:06 INFO - Running setup.py (path:/tmp/pip-qDSWRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:06 INFO - Running setup.py (path:/tmp/pip-Cbi4vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:06 INFO - Running setup.py (path:/tmp/pip-eizDtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:06 INFO - Running setup.py (path:/tmp/pip-eAK4Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:06 INFO - Running setup.py (path:/tmp/pip-88Bi5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:06 INFO - Running setup.py (path:/tmp/pip-dlX0Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:06 INFO - Running setup.py (path:/tmp/pip-wfiTSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:06 INFO - Running setup.py (path:/tmp/pip-qjuBYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:06 INFO - Running setup.py (path:/tmp/pip-xQXS9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:06 INFO - Running setup.py (path:/tmp/pip-WsssMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:06 INFO - Running setup.py (path:/tmp/pip-BgKO_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:06 INFO - Running setup.py install for manifestparser 19:09:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Running setup.py install for mozcrash 19:09:07 INFO - Running setup.py install for mozdebug 19:09:07 INFO - Running setup.py install for mozdevice 19:09:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Running setup.py install for mozfile 19:09:07 INFO - Running setup.py install for mozhttpd 19:09:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Running setup.py install for mozinfo 19:09:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Running setup.py install for mozInstall 19:09:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Running setup.py install for mozleak 19:09:07 INFO - Running setup.py install for mozlog 19:09:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:07 INFO - Running setup.py install for moznetwork 19:09:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:08 INFO - Running setup.py install for mozprocess 19:09:08 INFO - Running setup.py install for mozprofile 19:09:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:08 INFO - Running setup.py install for mozrunner 19:09:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:08 INFO - Running setup.py install for mozscreenshot 19:09:08 INFO - Running setup.py install for moztest 19:09:08 INFO - Running setup.py install for mozversion 19:09:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:08 INFO - Cleaning up... 19:09:08 INFO - Return code: 0 19:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:08 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:09:08 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 19:09:08 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 19:09:08 INFO - Using env: {'DISPLAY': ':0', 19:09:08 INFO - 'HOME': '/home/cltbld', 19:09:08 INFO - 'LANG': 'en_US.UTF-8', 19:09:08 INFO - 'LANGUAGE': 'en_US:en', 19:09:08 INFO - 'LOGNAME': 'cltbld', 19:09:08 INFO - 'MAIL': '/var/mail/cltbld', 19:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:08 INFO - 'MOZ_NO_REMOTE': '1', 19:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:08 INFO - 'NO_EM_RESTART': '1', 19:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:08 INFO - 'PWD': '/builds/slave/test', 19:09:08 INFO - 'SHELL': '/bin/bash', 19:09:08 INFO - 'SHLVL': '1', 19:09:08 INFO - 'TERM': 'linux', 19:09:08 INFO - 'TMOUT': '86400', 19:09:08 INFO - 'USER': 'cltbld', 19:09:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:08 INFO - '_': '/tools/buildbot/bin/python'} 19:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:08 INFO - Running setup.py (path:/tmp/pip-HetMcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:09 INFO - Running setup.py (path:/tmp/pip-idVHzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:09 INFO - Running setup.py (path:/tmp/pip-Ul3ABR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:09 INFO - Running setup.py (path:/tmp/pip-rJQnpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:09 INFO - Running setup.py (path:/tmp/pip-RN3CZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:09 INFO - Running setup.py (path:/tmp/pip-LeV8Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:09 INFO - Running setup.py (path:/tmp/pip-PC73Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:09 INFO - Running setup.py (path:/tmp/pip-1Zv42K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:09 INFO - Running setup.py (path:/tmp/pip-qqfody-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:09 INFO - Running setup.py (path:/tmp/pip-_wIPoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:09 INFO - Running setup.py (path:/tmp/pip-CsMRzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:09 INFO - Running setup.py (path:/tmp/pip-xeTnd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:09 INFO - Running setup.py (path:/tmp/pip-WGCTb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:09 INFO - Running setup.py (path:/tmp/pip-O851bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:09 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)) 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:09 INFO - Running setup.py (path:/tmp/pip-54zBKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:10 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)) 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:10 INFO - Running setup.py (path:/tmp/pip-N3MCN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:10 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)) 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:10 INFO - Running setup.py (path:/tmp/pip-TJNczF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:10 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)) 19:09:10 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)) 19:09:10 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)) 19:09:10 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)) 19:09:10 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)) 19:09:10 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)) 19:09:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:12 INFO - Downloading blessings-1.6.tar.gz 19:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:12 INFO - Installing collected packages: blessings 19:09:12 INFO - Running setup.py install for blessings 19:09:12 INFO - Successfully installed blessings 19:09:12 INFO - Cleaning up... 19:09:12 INFO - Return code: 0 19:09:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:12 INFO - Reading from file tmpfile_stdout 19:09:12 INFO - Current package versions: 19:09:12 INFO - argparse == 1.2.1 19:09:12 INFO - blessings == 1.6 19:09:12 INFO - blobuploader == 1.2.4 19:09:12 INFO - docopt == 0.6.1 19:09:12 INFO - manifestparser == 1.1 19:09:12 INFO - mozInstall == 1.12 19:09:12 INFO - mozcrash == 0.17 19:09:12 INFO - mozdebug == 0.1 19:09:12 INFO - mozdevice == 0.48 19:09:12 INFO - mozfile == 1.2 19:09:12 INFO - mozhttpd == 0.7 19:09:12 INFO - mozinfo == 0.9 19:09:12 INFO - mozleak == 0.1 19:09:12 INFO - mozlog == 3.2 19:09:12 INFO - moznetwork == 0.27 19:09:12 INFO - mozprocess == 0.22 19:09:12 INFO - mozprofile == 0.28 19:09:12 INFO - mozrunner == 6.11 19:09:12 INFO - mozscreenshot == 0.1 19:09:12 INFO - mozsystemmonitor == 0.3 19:09:12 INFO - moztest == 0.7 19:09:12 INFO - mozversion == 1.4 19:09:12 INFO - psutil == 3.1.1 19:09:12 INFO - requests == 1.2.3 19:09:12 INFO - wsgiref == 0.1.2 19:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:12 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:09:12 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 19:09:12 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 19:09:12 INFO - Using env: {'DISPLAY': ':0', 19:09:12 INFO - 'HOME': '/home/cltbld', 19:09:12 INFO - 'LANG': 'en_US.UTF-8', 19:09:12 INFO - 'LANGUAGE': 'en_US:en', 19:09:12 INFO - 'LOGNAME': 'cltbld', 19:09:12 INFO - 'MAIL': '/var/mail/cltbld', 19:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:12 INFO - 'MOZ_NO_REMOTE': '1', 19:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:12 INFO - 'NO_EM_RESTART': '1', 19:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:12 INFO - 'PWD': '/builds/slave/test', 19:09:12 INFO - 'SHELL': '/bin/bash', 19:09:12 INFO - 'SHLVL': '1', 19:09:12 INFO - 'TERM': 'linux', 19:09:12 INFO - 'TMOUT': '86400', 19:09:12 INFO - 'USER': 'cltbld', 19:09:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:12 INFO - '_': '/tools/buildbot/bin/python'} 19:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 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)) 19:09:12 INFO - Cleaning up... 19:09:12 INFO - Return code: 0 19:09:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:12 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:09:12 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 19:09:12 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 19:09:12 INFO - Using env: {'DISPLAY': ':0', 19:09:12 INFO - 'HOME': '/home/cltbld', 19:09:12 INFO - 'LANG': 'en_US.UTF-8', 19:09:12 INFO - 'LANGUAGE': 'en_US:en', 19:09:12 INFO - 'LOGNAME': 'cltbld', 19:09:12 INFO - 'MAIL': '/var/mail/cltbld', 19:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:12 INFO - 'MOZ_NO_REMOTE': '1', 19:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:12 INFO - 'NO_EM_RESTART': '1', 19:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:12 INFO - 'PWD': '/builds/slave/test', 19:09:12 INFO - 'SHELL': '/bin/bash', 19:09:12 INFO - 'SHLVL': '1', 19:09:12 INFO - 'TERM': 'linux', 19:09:12 INFO - 'TMOUT': '86400', 19:09:12 INFO - 'USER': 'cltbld', 19:09:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:12 INFO - '_': '/tools/buildbot/bin/python'} 19:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:12 INFO - Downloading/unpacking jsonschema 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:12 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 19:09:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:14 INFO - Downloading/unpacking functools32 (from jsonschema) 19:09:14 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 19:09:14 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 19:09:14 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 19:09:14 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 19:09:14 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 19:09:14 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 19:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:15 INFO - warning: no files found matching '*.txt' 19:09:15 INFO - no previously-included directories found matching 'build' 19:09:15 INFO - no previously-included directories found matching 'dist' 19:09:15 INFO - no previously-included directories found matching '.git*' 19:09:15 INFO - Installing collected packages: jsonschema, functools32 19:09:15 INFO - Running setup.py install for functools32 19:09:15 INFO - warning: no files found matching '*.txt' 19:09:15 INFO - no previously-included directories found matching 'build' 19:09:15 INFO - no previously-included directories found matching 'dist' 19:09:15 INFO - no previously-included directories found matching '.git*' 19:09:15 INFO - Successfully installed jsonschema functools32 19:09:15 INFO - Cleaning up... 19:09:15 INFO - Return code: 0 19:09:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:15 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 0x7f679d321f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd71770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, '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-1464396637.609654-864232418', '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 19:09:15 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 19:09:15 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 19:09:15 INFO - Using env: {'DISPLAY': ':0', 19:09:15 INFO - 'HOME': '/home/cltbld', 19:09:15 INFO - 'LANG': 'en_US.UTF-8', 19:09:15 INFO - 'LANGUAGE': 'en_US:en', 19:09:15 INFO - 'LOGNAME': 'cltbld', 19:09:15 INFO - 'MAIL': '/var/mail/cltbld', 19:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:15 INFO - 'MOZ_NO_REMOTE': '1', 19:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:15 INFO - 'NO_EM_RESTART': '1', 19:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:15 INFO - 'PWD': '/builds/slave/test', 19:09:15 INFO - 'SHELL': '/bin/bash', 19:09:15 INFO - 'SHLVL': '1', 19:09:15 INFO - 'TERM': 'linux', 19:09:15 INFO - 'TMOUT': '86400', 19:09:15 INFO - 'USER': 'cltbld', 19:09:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:15 INFO - '_': '/tools/buildbot/bin/python'} 19:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:15 INFO - Downloading/unpacking flake8 19:09:15 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 19:09:15 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 19:09:15 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 19:09:15 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 19:09:15 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 19:09:15 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 19:09:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:09:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:09:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:18 INFO - no previously-included directories found matching 'docs/_build' 19:09:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:09:18 INFO - Running setup.py install for pep8 19:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:18 INFO - no previously-included directories found matching 'docs/_build' 19:09:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:09:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:09:18 INFO - Cleaning up... 19:09:18 INFO - Return code: 0 19:09:18 INFO - Running post-action listener: _resource_record_post_action 19:09:18 INFO - Running post-action listener: _start_resource_monitoring 19:09:18 INFO - Starting resource monitoring. 19:09:18 INFO - ##### 19:09:18 INFO - ##### Finished create-virtualenv step (success) 19:09:18 INFO - ##### 19:09:18 INFO - ##### 19:09:18 INFO - ##### Running install step. 19:09:18 INFO - ##### 19:09:18 INFO - Running pre-action listener: _resource_record_pre_action 19:09:18 INFO - Running main action method: install 19:09:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:18 INFO - Reading from file tmpfile_stdout 19:09:18 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:18 INFO - Reading from file tmpfile_stdout 19:09:18 INFO - Output received: 19:09:18 INFO - Usage: mozinstall [options] installer 19:09:18 INFO - Options: 19:09:18 INFO - -h, --help show this help message and exit 19:09:18 INFO - -d DEST, --destination=DEST 19:09:18 INFO - Directory to install application into. [default: 19:09:18 INFO - "/builds/slave/test"] 19:09:18 INFO - --app=APP Application being installed. [default: firefox] 19:09:18 INFO - mkdir: /builds/slave/test/build/application 19:09:18 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'] 19:09:18 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 19:09:35 INFO - Reading from file tmpfile_stdout 19:09:35 INFO - Output received: 19:09:35 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:35 INFO - Running post-action listener: _resource_record_post_action 19:09:35 INFO - ##### 19:09:35 INFO - ##### Finished install step (success) 19:09:35 INFO - ##### 19:09:35 INFO - ##### 19:09:35 INFO - ##### Running run-tests step. 19:09:35 INFO - ##### 19:09:35 INFO - Running pre-action listener: _resource_record_pre_action 19:09:35 INFO - Running main action method: run_tests 19:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:35 INFO - Python 2.7.3 19:09:35 INFO - Return code: 0 19:09:35 INFO - grabbing minidump binary from tooltool 19:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:35 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 0xe009c0>, '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 0xe018c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe01d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:35 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 19:09:35 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 19:09:35 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 19:09:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:35 INFO - Return code: 0 19:09:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:09:36 INFO - Return code: 0 19:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:09:36 INFO - Using env: {'DISPLAY': ':0', 19:09:36 INFO - 'HOME': '/home/cltbld', 19:09:36 INFO - 'LANG': 'en_US.UTF-8', 19:09:36 INFO - 'LANGUAGE': 'en_US:en', 19:09:36 INFO - 'LOGNAME': 'cltbld', 19:09:36 INFO - 'MAIL': '/var/mail/cltbld', 19:09:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:36 INFO - 'MOZ_NO_REMOTE': '1', 19:09:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:36 INFO - 'NO_EM_RESTART': '1', 19:09:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:36 INFO - 'PWD': '/builds/slave/test', 19:09:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:36 INFO - 'SHELL': '/bin/bash', 19:09:36 INFO - 'SHLVL': '1', 19:09:36 INFO - 'TERM': 'linux', 19:09:36 INFO - 'TMOUT': '86400', 19:09:36 INFO - 'USER': 'cltbld', 19:09:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464396637.609654-864232418', 19:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:36 INFO - '_': '/tools/buildbot/bin/python'} 19:09:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:09:36 INFO - mozversion application_buildid: 20160527163016 19:09:36 INFO - mozversion application_changeset: ea15028498ed95677844fb7f30be5efcaf8b2621 19:09:36 INFO - mozversion application_display_name: Nightly 19:09:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:36 INFO - mozversion application_name: Firefox 19:09:36 INFO - mozversion application_remotingname: firefox 19:09:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:09:36 INFO - mozversion application_vendor: Mozilla 19:09:36 INFO - mozversion application_version: 49.0a1 19:09:36 INFO - mozversion platform_buildid: 20160527163016 19:09:36 INFO - mozversion platform_changeset: ea15028498ed95677844fb7f30be5efcaf8b2621 19:09:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:09:36 INFO - mozversion platform_version: 49.0a1 19:09:36 INFO - using testdate: 1464401376 19:09:36 INFO - actual date: 1464401376 19:09:36 INFO - starting webserver on 'localhost:50239' 19:09:36 INFO - SUITE-START | Running 2 tests 19:09:36 INFO - TEST-START | dromaeo_css 19:09:36 INFO - operating with platform_type : linux_ 19:09:36 INFO - Initialising browser for dromaeo_css test... 19:09:36 INFO - TEST-INFO | started process 11636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgkco3y/profile http://localhost:50239/getInfo.html) 19:09:40 INFO - PROCESS | 11636 | 19:09:40 INFO - PROCESS | 11636 | (process:11702): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:41 INFO - PROCESS | 11636 | __metrics Screen width/height:1600/1200 19:09:41 INFO - PROCESS | 11636 | colorDepth:24 19:09:41 INFO - PROCESS | 11636 | Browser inner width/height: 1024/697 19:09:41 INFO - PROCESS | 11636 | __metrics 19:09:41 ERROR - PROCESS | 11636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:09:42 INFO - TEST-INFO | 11636: exit 0 19:09:42 INFO - Browser initialized. 19:09:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:42 INFO - TEST-INFO | started process 11753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgkco3y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:44 INFO - PROCESS | 11753 | 19:09:44 INFO - PROCESS | 11753 | (process:11814): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:54 INFO - PROCESS | 11753 | RSS: Main: 166395904 19:09:54 INFO - PROCESS | 11753 | 19:10:44 INFO - PROCESS | 11753 | 1464401444013 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] 19:12:51 INFO - PROCESS | 11753 | Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50239/tests/dromaeo/cssquery-ext.html) 19:12:52 INFO - PROCESS | 11753 | RSS: Main: 170848256 19:12:52 INFO - PROCESS | 11753 | 19:15:54 INFO - PROCESS | 11753 | Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-ext.html (next: http://localhost:50239/tests/dromaeo/cssquery-jquery.html) 19:15:55 INFO - PROCESS | 11753 | RSS: Main: 169390080 19:15:55 INFO - PROCESS | 11753 | 19:18:57 INFO - PROCESS | 11753 | Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50239/tests/dromaeo/cssquery-mootools.html) 19:18:57 INFO - PROCESS | 11753 | RSS: Main: 170393600 19:18:57 INFO - PROCESS | 11753 | 19:21:59 INFO - PROCESS | 11753 | Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50239/tests/dromaeo/cssquery-prototype.html) 19:21:59 INFO - PROCESS | 11753 | RSS: Main: 168120320 19:21:59 INFO - PROCESS | 11753 | 19:25:02 INFO - PROCESS | 11753 | Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50239/tests/dromaeo/cssquery-yui.html) 19:25:03 INFO - PROCESS | 11753 | RSS: Main: 170663936 19:25:03 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-yui.html (next: http://localhost:50239/tests/dromaeo/cssquery-dojo.html) 19:28:05 INFO - PROCESS | 11753 | RSS: Main: 171548672 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | __start_tp_report 19:28:05 INFO - PROCESS | 11753 | _x_x_mozilla_page_load 19:28:05 INFO - PROCESS | 11753 | _x_x_mozilla_page_load_details 19:28:05 INFO - PROCESS | 11753 | |i|pagename|runs| 19:28:05 INFO - PROCESS | 11753 | |0;dojo.html;3134.2791158033656;3165.4460469417845;3178.094243140705;3184.3472088221915;3189.984050079749;5475.589330800191;5482.671039737618;5527.944720552799;5534.916976245359;5536.114221724525;5392.541633961108;5453.427390124039;5456.427075157111;5457.072297709389;5555.111182210837;4895.388076490448;4919.016196760645;5010.398752149747;5058.165402708567;5113.258577506259;941.8410727540899;5044.949550504503;5054.898902021957;5056.3173971513925;5084.135696931512;4945.8268960586565;4979.153543897546;4982.701037937717;4986.75066246688;5033.018561380532;4861.319415281863;4991.376077990251;5000.574951129159;5013.849584512471;5044.949550504484;4936.4076310842565;4936.629752768521;4937.7777999990085;4991.076650819574;5016.924746128811;5452.754626041798;5485.286912701324;5494.203340515643;5495.642783219078;5508.531774799147;5760;5810.128480727883;5926.170336152942;5926.822195334147;5931.199288096138;5854.063349864001;5871.266091738533;5893.263342082239;5916.171735956969;5953.3748956359395;5499.697516636584;5508.3114610673665;5516.393196748354;5520.530754885839;5530.059889818741;5903.0260007099205;5954.910676339859;5996.880062398727;6012.038073908241;6027.7890273841085;5804.767809287581;5810.215620891126;5810.331811841692;5811.3316968548315;5821.476067153976;5894.67579283135;5902.055671092605;5904.7342869570975;5908.172855800191;5919.585629006015;5703.201551782754;5746.827595172152;5801.680907550125;5850.385709500441;5883.411658834082;5706.9714651426475;5823.88352232953;5836.708164591753;5882.441168089024;5895.498882594941;4475.70907890986;4480.39514665516;4491.371208030879;4499.280115181556;4539.523350048197;3871.845126194977;3913.1977944521304;3927.155661532784;3930.76415415076;3950.841966321315;5636.04187288162;5646.3224413069875;5657.8019769307875;5687.601867869293;5734.713264336767;5887.35239123696;5913.704314784243;5928.0515117581845;5961.940380596226;5966;5510.9448905510435;5551.694656793915;5566.832995010156;5601.551875849922;5634.774609015593;5051.444341122474;5056.6713163644245;5071.670341427869;5087.592992560586;5090.567301779316;6050.54620903434;6083.270007599116;6089.441462180385;6100.847478813065;6108.541859360477;5781.017227071324;5829.47534721877;5894.086416605433;5902.085176797603;5949.25634295713;6099.634021958696;6120.418560236771;6141.416565426277;6142.293636231711;6144.907826382697;5642.689652069012;5778.595498315078;5832.387599302012;5837;5846.649201047951;5820.417958204315;5844.532437404912;5871.647701137946;5900.881982360243;5929.703514824155;5701.800436984851;5727.455891690282;5748.109043098327;5751.712414379348;5758.913616295843;5652.745626446737;5664.943350566607;5740.3685594585395;5762.5389968801555;5771.769129234784;5571.05292100352;5583.35791383996;5610.691411972381;5656.915146272727;5772.826815195551;5783.334916484658;5795.9277533656405;5809.419058094157;5817.272840894888;5821.98115329824;5558.861028474159;5609.102543593006;5680.545556355564;5688.77244910199;5704.942950570441 19:28:05 INFO - PROCESS | 11753 | |1;ext.html;596.7941060334183;640.6764583885138;641.5060403489316;658.1148355461903;659.2715049869894;32863.67136328636;35648.108797280045;42563.57436425635;43091.35362969558;43177.784111079476;44554.55445445544;45283.09433811322;45473;45508.3173752394;45752.77123614385;8544.060153383123;8686.609102590399;8687.695930642429;8691.087435819243;8724.127587241288;8686.305095592337;8746.825063498727;8778.780530486756;8805.295576353908;8811.295096392305;8904.554772261394;8963.820723585557;8971.282297416225;8983.460992340448;9019.864702029441;8798.120187981214;8804.559772011375;8815.118488151198;8837.867431988494;8847.159519845669;8655.783605409852;8697.478151310941;8781.429207101519;8793.956030219872;8804.955975220148;41269;41689.37465938013;41776.37335439971;41886.371704424455;42015.36976945318;3427.8286085695863;3542.6103128655827;4126.401671757609;4157.896052598679;4223.387608796707;32176.35647287041;32624.83687581547;32967.3406531868;33054.669453305396;34321.31357372839;4301.763403012833;4428.092241090569;4531.320301954733;4557.521460246693;4643.117807616542;239177;241418;241476;242429;243312.99999999822;59439;60125;60359.396406035376;60502.39497605056;60504.69747651234;62981;63001.6448601874;63182;63515.364846350945;63859;17287.222075006655;17401.390951316644;17427.47717568475;17477.7378339325;17509.474715758548;13349.532766353132;13417.66455838612;13497.527586534425;13618.455261789615;13627.182369057888;15682.294296756674;17259;17261.136943153044;17265.654686906193;17268.395606153976;6177.413145751147;6259.561830671901;6314.400131987454;6319.526035547352;6393.648349340738;946.2099147212017;1045.132539991805;1052.3002203534563;1061.867266591676;1132.2074547816562;32994.67005329964;33007.66992330094;33272.3345533088;33670;33902.66097338995;1064.409252864652;1074.9462526873624;1098.1783393789656;1125.5272785429975;1218.9268643881396;17299.13504324779;17627.911860440872;17759.898833498653;17849.018303993147;17971.460856174337;511744;514969;517038;517975;519007;58044.70977645085;58599;58731;58966;59140.04299784994;1328.4154971812372;1364.2019418640207;1384.3424373422745;1395.699924516234;1398.6223719595855;31655.52516712205;32962.17594560155;33161.83419082889;33277;33807.830960845036;52617.47382526126;52626.21060684016;52951.20573191482;53215.4678453226;53289;351893;352745;450251;457310;459576;42304.78847605865;42458.57541424546;43573.78213109041;43699.78150109229;43740.562594374926;48406.757966209945;49009.26486102783;49155.508444915096;50149.24776128434;50292.24561631505;41282.793586031876;42351;42579;43082.353764692925;43141.3528797062;41713.79143104265;42012.57987420087;42294.78852605717;42323.153536928476;42474.78762606167;36484.08789780277;40462.797686011385;40626;41624.79187604043;42330.576694233896;35229.647703522634;36692;36784.44823327599;37001.259974800894;38186.61813381831;28431.28921776972;28882;28893.855530723053;28952;29028 19:28:05 INFO - PROCESS | 11753 | |2;jquery.html;391.8824352694191;394.96247856453624;400.21358031468156;402.70602460204054;418.88994165461526;13976.301184940738;17981.550461238458;18827.341043063494;19268.90365548172;19299.13153908074;17728.82271177288;17840.55398615032;18560.443186704422;18637.347692830754;18712.157952892117;5502.669839809604;5636.830895073154;5653.575981801361;5686;5702.486776190142;5573.526250268732;5653.6607803531715;5677.37548869624;5686.061799803048;5718.857028574298;5522.66863988162;5576.498115169634;5586.24585680934;5621.241132447109;5652.152177173416;5514.228008078872;5560.6941618210985;5624.943750562483;5629.971850140743;5677.40387259336;4879.780409881564;5026.246063090565;5054.545090941796;5070.062038522885;5090.694558326475;22539;22540.77459225403;22728.545429091326;22999.425014374607;23069.846507674716;2426.3570153909227;2447.155731272708;2462.372095115734;2559.1810620601414;2862.427514497088;14188.85811141896;14234.217118058503;14403.351849166813;14882;15188.392464301414;1948.5518330783857;1956.0904179556574;1971.5071232191951;2022.4741567192636;2026.7973202679761;81182;82373;84403.5779821103;84498.15501844964;85221.57389213076;10255.435951022766;10388.844167337496;10648.574057037631;10698.572057117784;10835.803437985813;14821.629459263604;14828.481003164838;14828.70342593142;14861.331240094221;14916.925415372854;7995.360371170293;8059.597020148969;8069.838603227902;8295.751127466187;8341.5412152331;7564.092308922965;7601.923980760122;7627.656755445907;7676.692932282758;8097.878531822027;6430.48556115519;6524.608523488606;6549.279579246279;6601.636909969998;6689.799306020827;1910.245453046039;1930.5559721263908;1937.428458604715;1946.673311736855;1961.9901900490693;1018.8064267789097;1023.9795204095876;1045.1951996962448;1048.926575139733;1081.588996181446;18648.627027459373;19536.60926781485;19645.901770491342;19894.403167904988;20111;1017.3997341568362;1047.6280920273346;1050.8896565860628;1138.2544433396138;1158.6212407235364;10898.237123401286;11495.712607184887;11498.137639677057;11528.077753779846;11579.421028948518;448841;449877;464954;464984;469210;84258.15741842503;84516.15483845084;85913;87144;87152;1056.0548309263168;1079.6167360587035;1112.3048094940661;1125.2292179856825;1139.7207684117445;17162.485125446256;17225.22486488086;17288.913555432144;17312.134393280536;17572.82427175712;39546.60453395544;40289;40343.1931361377;40576.59423405728;40900.386494202015;52750.362481876524;53139.46860531345;53155.468445315055;53265.73367133139;54520.45479545154;8322.50064996102;8588.184122508352;8753.255973242345;8757.90526184227;8797.516136612292;13126.803097953347;13163.341832908125;13201.933990329986;13391.933040335125;13558.118722283414;11874.82187767167;11970.58102966392;11977.64067077989;12013.219140755822;12224.327661978676;5343.866403339947;8379.916200837913;9343.626254949997;11770.17608767378;11962.401879905796;8372.539510326991;8459.746207613782;8573.74278771638;8674.956625217086;8941.865872012055;12039.33783641873;13087.738245235232;13210.273434960785;13311.800322995357;13476.865231347561;11903.047756179312;12278.85120103996;12400;12538.847180305644;12659.430325635552 19:28:05 INFO - PROCESS | 11753 | |3;mootools.html;1489.3000289863764;1536;1664.7763893538247;1789.6152327249638;1796.3173993882324;7656.885146722803;8249.752507424771;8277.710280140196;8867.55662216889;8870.157335053167;8374.91625083749;8570;8644.827103457927;8657.74026779196;8662.480251184934;2310.202979971907;2333.136739406422;2363.5627408929317;2363.7872591466767;2369.9052037918464;2229.7881701238357;2277.2598905355744;2282.7260728712577;2286.737025242102;2318.455163036685;2254.4814692620707;2269.466675331296;2270.2735124760084;2314.155333303349;2323.1172154581236;2207.7681843406453;2246.516998845248;2248.2468373095035;2250.2574150530286;2279.1567120165478;2281.327008532487;2284.9657255141187;2295.908163673451;2296.024189719379;2298.793108620232;8641.481511109354;8647.524386158759;8654.394192406535;8702.477851328877;8725.694600689008;4928.088303663798;5110.565601923841;5144.4083930348115;5146.099432599318;5148.3821941366905;3338.2322065924973;3353.84907679155;3469.028671971852;3559.0212691509782;3574.267275208576;1096.3038470571244;1102.1568500097433;1105.9723506912392;1115.7433790228292;1125.7016890524017;11894.940525297317;12019.759604807943;12081.637550873487;12085.577004804789;12109.333986630732;4541.227991241497;4542.727436353829;4653.883652908705;4660.1145782301255;4678.438587369537;10207.387556746618;10220.744481387876;10240.897591024144;10242.692719218287;10245.129164020993;5249.895002100013;5286;5294.391145018295;5296.3909150447425;5312.73436328182;4145.108801607669;4667.673262871566;4808.3027960945465;4817.373741413594;4825.083234185494;3845.134844659929;3893.6885049196;3969.384745364473;3971.3645816669195;3994.08136128692;1202.8255902894032;1268.505282939636;1272.204871955028;1274.3755559775643;1281.2440660010639;943.7734943613483;1006.884208316053;1019.7246743379246;1028.8148133336072;1040.1626690514058;5991;6057.182280392179;6139.26328840542;6145.354737752561;6153.7230824613;431.0839466134464;438.69949084876964;443.4346208584081;450.79038247215203;452.83924206906073;4197.874063778091;4208.452901122834;4250.872473825791;4268.893277668021;4296.76367799774;10178.389296642225;10450.843237351446;10500.107490863209;10525.736856578493;10589.9470502647;10260.538275777608;10338.689839304832;10415;10425.895741042645;10444;7627.161012288644;7895.131535531087;7946.960265198637;7952;8005.479643823133;5872.911906321323;5882.441168089024;6011.068284415923;6031.4270144336215;6188.58206608806;9523.142917137491;9763.121319081316;9794.363366381162;9962.900370996487;10031.247656425943;9766.36518626287;9988.650397236062;10294.639687610897;10311.845322320321;10354.534045968101;7535.962320188583;7940.16628254025;8028.237317454832;8254.793630159294;8296.340731853532;8243.83512329762;8421.32629389635;8549.444286121383;8577.65689372443;8673.479591224546;7602.3537999268465;7843.21567843234;7891.053073630971;7920.287174154123;7940.444168908121;7459.552426854406;7762.5730584818375;7815.218478152139;7848.529088254723;7855.7250496232355;7069.116360454943;7157.64211789398;7168.713251470092;7189.496735228693;7211.278872112956;4988.575971042502;5024.397072351341;5102.4897510248675;5235.240890070994;5274.89450210986;5117.5650069743;5195.5843532518065;5210.97394513025;5236.266922630759;5299.364076310867 19:28:05 INFO - PROCESS | 11753 | |4;prototype.html;321.5514357471326;331.79594549352146;332.4000179675686;336.36930754834685;338.6545723362172;5511.319047690457;5696;5722.256106706122;5730.512906402951;5753.913691294629;5584.888302233963;5597.404739649201;5600.103983362663;5602.7758889644465;5602.943970560294;4378.934315985262;4380.430544029272;4390.319500477431;4416.094700586372;4428.247197976351;4211.747295162285;4338.609525142737;4345.826166953334;4354.716943398685;4400.515943246241;4302;4312.266914624505;4344.1311737652595;4358.368036634686;4368.344748287751;4351.825926962918;4357.128574285156;4360.607545320905;4369.51436511586;4403.361512580658;3736.823699855129;3818.8090595470117;3863.7295389322476;3900.804959752001;3925;5446.8910621787345;5482.698451585161;5485.232067510552;5491.752871120809;5527.281453411031;4988.406028865006;4990.451050384491;5012.72430016349;5032.320636714034;5044.243363495469;5593.860153496154;5860.622753652889;5869.413058694139;5892.9374718848485;5938.257717785277;4132.566080561528;4138.461999939988;4156.423017729027;4157.812898419578;4173.728707633994;5868.530517558585;5985.4912332451795;6211.3167551569295;6223.533235007392;6245.500359971192;4210.820970128369;4217.587108318687;4223;4227.661787057028;4231.30183519722;4270.914581708348;4292.3561465780385;4296.710986703976;4308.590683885089;4310.620601407582;4841.782119804618;4882.511748825089;4889.755512224375;4943.134951383494;4981.576565991859;5926.67403292823;5949.881002379928;5950.31571369298;5990.4908082813445;6004.699765011732;1424.155718344746;1440.171901156839;1440.6110350205386;1443.6607397261635;1447.5006122887587;870.6115854623148;908.8000639859221;909.0500875621887;914.0996118822954;923.6443969071955;5142.30578871855;5144.045262800112;5208.7916483341;5239.428171548597;5247.606429517801;5403.729813509309;5495.450454954553;5507.586930980193;5542.422773410383;5547;4979.900401992012;5046;5124.48755124492;5164.147915593885;5217.973910130501;2870.1533047750963;2893.85530723463;2906.956395654067;2942.4556457055514;2948.4225939122466;5470.890582188334;5524.756929690868;5532.695701736443;5588.441155884379;5651.717414129277;5197.974010129925;5367.35591728995;5390.733177703237;5399.568034557226;5478.369987451414;5595.972020139873;5636.633618814846;5661.2923384576925;5666.291713535808;5670.971645141748;5297.54970827484;5304.655197412156;5430.212619170277;5472.288602481652;5477.000894673336;5262.3951144183875;5302.03824584906;5330;5386.272853164773;5421.2681288025615;6160;6362.268339141058;6373.298937117006;6390.712417941111;6391.616503009835;4083.428320035138;4133.7106402551535;4133.731307465006;4145.316022856195;4181.289180839325;5956.583039187215;6098.390160983866;6129.651476675124;6162.876742465215;6196.566240363131;5879.176915231957;5917.9347717409555;5919.437653422918;5955.612885162451;5959.642421454727;5952.196453478725;5955.493783028491;5987.5808693391045;5991.700414979146;5995.970020149872;5639.238702775237;5807.883842323045;5825.912611310749;5850.2102216200265;5899.675517846388;6048.969755151196;6062.393760624079;6089.208402907594;6093.725782339717;6126.835901178762;5694.288213973254;5739.110437882135;5853.531717462508;5897.469227769521;5932.79235226765 19:28:05 INFO - PROCESS | 11753 | |5;yui.html;835.9205875441833;855.9358048146389;867.4361664917807;874.1215078845763;878.4158534574508;14028.789568156473;14864.554063378117;14920.104793712384;14996.475123370685;15018;13530.594082177551;13544.796828047587;13555.11891727037;13585.72828543431;13617.45530178794;662.7845950066223;791.6951973490219;801.7274126796902;811.2576992052265;815.7919730468723;814.1166833985134;814.4583851738587;814.698561532234;819.397742659145;821.8438496685641;862.7325529085972;867.9262262707646;869.443556124081;871.3900269811126;871.6339137562207;853.2235665544325;857.7598272483715;859.0250066174905;862.3273846399818;863.2317237658489;623.5323507369473;623.9032949892774;627.1533429869685;628.136312570216;630.7224821078711;13844.861551384458;13846.515371961934;13884.166949982933;13899.86100139006;13956.2324072176;14401;14785.112893226333;14896.478623248242;14917.925410372987;14970.925145374313;11943.402829858473;11961.64115076549;12015.699607509794;12018.4591693374;12266.570670026505;3950.6839452843706;3953.2686453006286;3964.7422917510557;3971.3050216212046;4097.836086556564;55005.44994550043;55137.172942405894;55323.9999999996;56026;56072;10437.686869393778;10704.89295107039;11052.171087168495;11064.612738554111;11243.325400475835;19772.901135494518;19823.207071717257;19943.800561994485;20048.89975550142;20051.498712532302;8435;8442.915570844336;8495.532745699045;8542.615582298811;8609.096044915193;4649.930251046237;4728.787204575802;4772.427308722976;4798.184308667535;4889.804407823718;3347.8995630131135;3422.743294252941;3431.571053618298;3434.690877820958;3435.4159792835276;645.3772109913956;650.9414152726278;654.9586158008789;657.2244751193542;658.785894584262;736.580333604108;755.4900442201492;755.9319661230516;759.4721668440492;776.0997243197863;9917.15704165154;9936.453495057842;10080.193584513221;10166.898331016742;10167.796644067077;672.4217173231017;717.4726575966661;718.9600897707111;724.9456290778107;733.4902242941105;4608.470025946992;4674.929876051862;4686.5782079613;4689.859304220879;4734.857954261378;70725.2927470729;70754.64622676956;71598.28401715917;72196;72611;62349.37650623436;63447.68276158682;63590.68204658947;63945.36054639487;64608.676956614916;58216.41783582194;58636;58663.413365865796;58825.705871471226;59513.70243148757;9074.410163339362;9074.682386116454;9084.818303634023;9122;9152.58813353414;33993.83003084969;34137.82931085329;34731.30537389289;38411.6158838408;39079.609203907596;50322.245166323264;50428.74785626195;51082.74458627683;51138.488615113376;51687.74156129195;12969.286689232184;13005.934970325088;13157.34213289351;13207.66980825487;13233.661976737698;13464.461421543421;13865.861341386457;13897.72204555883;14159.787603186167;14661.340239689027;12998.740025199631;13234;13338.466461341437;13724;13782.379792909143;12817.615471535868;13003.154794938677;13364.799528006894;13367.264800436069;13453.394597243343;13396.531121410704;13409.128406653535;13507.72984540284;13688.110272832633;14039.578812635636;11062.280951738112;11181.32912025281;11378.829317560409;11451.942740286246;11824.349660768741;11255.774884502427;11282.94358528202;11516.884831151581;11559.76880462403;11783.764324713286 19:28:05 INFO - PROCESS | 11753 | __end_tp_report 19:28:05 INFO - PROCESS | 11753 | __start_cc_report 19:28:05 INFO - PROCESS | 11753 | _x_x_mozilla_cycle_collect,352 19:28:05 INFO - PROCESS | 11753 | __end_cc_report 19:28:05 INFO - PROCESS | 11753 | __startTimestamp1464402485706__endTimestamp 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | ------- Summary: start ------- 19:28:05 INFO - PROCESS | 11753 | Number of tests: 6 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | [#0] dojo.html Cycles:165 Average:5435.38 Median:5687.60 stddev:719.25 (12.6%) stddev-sans-first:698.44 19:28:05 INFO - PROCESS | 11753 | Values: 3134.3 3165.4 3178.1 3184.3 3190.0 5475.6 5482.7 5527.9 5534.9 5536.1 5392.5 5453.4 5456.4 5457.1 5555.1 4895.4 4919.0 5010.4 5058.2 5113.3 941.8 5044.9 5054.9 5056.3 5084.1 4945.8 4979.2 4982.7 4986.8 5033.0 4861.3 4991.4 5000.6 5013.8 5044.9 4936.4 4936.6 4937.8 4991.1 5016.9 5452.8 5485.3 5494.2 5495.6 5508.5 5760.0 5810.1 5926.2 5926.8 5931.2 5854.1 5871.3 5893.3 5916.2 5953.4 5499.7 5508.3 5516.4 5520.5 5530.1 5903.0 5954.9 5996.9 6012.0 6027.8 5804.8 5810.2 5810.3 5811.3 5821.5 5894.7 5902.1 5904.7 5908.2 5919.6 5703.2 5746.8 5801.7 5850.4 5883.4 5707.0 5823.9 5836.7 5882.4 5895.5 4475.7 4480.4 4491.4 4499.3 4539.5 3871.8 3913.2 3927.2 3930.8 3950.8 5636.0 5646.3 5657.8 5687.6 5734.7 5887.4 5913.7 5928.1 5961.9 5966.0 5510.9 5551.7 5566.8 5601.6 5634.8 5051.4 5056.7 5071.7 5087.6 5090.6 6050.5 6083.3 6089.4 6100.8 6108.5 5781.0 5829.5 5894.1 5902.1 5949.3 6099.6 6120.4 6141.4 6142.3 6144.9 5642.7 5778.6 5832.4 5837.0 5846.6 5820.4 5844.5 5871.6 5900.9 5929.7 5701.8 5727.5 5748.1 5751.7 5758.9 5652.7 5664.9 5740.4 5762.5 5771.8 5571.1 5583.4 5610.7 5656.9 5772.8 5783.3 5795.9 5809.4 5817.3 5822.0 5558.9 5609.1 5680.5 5688.8 5704.9 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | [#1] ext.html Cycles:180 Average:56794.59 Median:42466.68 stddev:108146.98 (254.7%) stddev-sans-first:108368.05 19:28:05 INFO - PROCESS | 11753 | Values: 596.8 640.7 641.5 658.1 659.3 32863.7 35648.1 42563.6 43091.4 43177.8 44554.6 45283.1 45473.0 45508.3 45752.8 8544.1 8686.6 8687.7 8691.1 8724.1 8686.3 8746.8 8778.8 8805.3 8811.3 8904.6 8963.8 8971.3 8983.5 9019.9 8798.1 8804.6 8815.1 8837.9 8847.2 8655.8 8697.5 8781.4 8794.0 8805.0 41269.0 41689.4 41776.4 41886.4 42015.4 3427.8 3542.6 4126.4 4157.9 4223.4 32176.4 32624.8 32967.3 33054.7 34321.3 4301.8 4428.1 4531.3 4557.5 4643.1 239177.0 241418.0 241476.0 242429.0 243313.0 59439.0 60125.0 60359.4 60502.4 60504.7 62981.0 63001.6 63182.0 63515.4 63859.0 17287.2 17401.4 17427.5 17477.7 17509.5 13349.5 13417.7 13497.5 13618.5 13627.2 15682.3 17259.0 17261.1 17265.7 17268.4 6177.4 6259.6 6314.4 6319.5 6393.6 946.2 1045.1 1052.3 1061.9 1132.2 32994.7 33007.7 33272.3 33670.0 33902.7 1064.4 1074.9 1098.2 1125.5 1218.9 17299.1 17627.9 17759.9 17849.0 17971.5 511744.0 514969.0 517038.0 517975.0 519007.0 58044.7 58599.0 58731.0 58966.0 59140.0 1328.4 1364.2 1384.3 1395.7 1398.6 31655.5 32962.2 33161.8 33277.0 33807.8 52617.5 52626.2 52951.2 53215.5 53289.0 351893.0 352745.0 450251.0 457310.0 459576.0 42304.8 42458.6 43573.8 43699.8 43740.6 48406.8 49009.3 49155.5 50149.2 50292.2 41282.8 42351.0 42579.0 43082.4 43141.4 41713.8 42012.6 42294.8 42323.2 42474.8 36484.1 40462.8 40626.0 41624.8 42330.6 35229.6 36692.0 36784.4 37001.3 38186.6 28431.3 28882.0 28893.9 28952.0 29028.0 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | [#2] jquery.html Cycles:180 Average:27976.57 Median:23034.64 stddev:75797.53 (329.1%) stddev-sans-first:75981.87 19:28:05 INFO - PROCESS | 11753 | Values: 391.9 395.0 400.2 402.7 418.9 13976.3 17981.6 18827.3 19268.9 19299.1 17728.8 17840.6 18560.4 18637.3 18712.2 5502.7 5636.8 5653.6 5686.0 5702.5 5573.5 5653.7 5677.4 5686.1 5718.9 5522.7 5576.5 5586.2 5621.2 5652.2 5514.2 5560.7 5624.9 5630.0 5677.4 4879.8 5026.2 5054.5 5070.1 5090.7 22539.0 22540.8 22728.5 22999.4 23069.8 2426.4 2447.2 2462.4 2559.2 2862.4 14188.9 14234.2 14403.4 14882.0 15188.4 1948.6 1956.1 1971.5 2022.5 2026.8 81182.0 82373.0 84403.6 84498.2 85221.6 10255.4 10388.8 10648.6 10698.6 10835.8 14821.6 14828.5 14828.7 14861.3 14916.9 7995.4 8059.6 8069.8 8295.8 8341.5 7564.1 7601.9 7627.7 7676.7 8097.9 6430.5 6524.6 6549.3 6601.6 6689.8 1910.2 1930.6 1937.4 1946.7 1962.0 1018.8 1024.0 1045.2 1048.9 1081.6 18648.6 19536.6 19645.9 19894.4 20111.0 1017.4 1047.6 1050.9 1138.3 1158.6 10898.2 11495.7 11498.1 11528.1 11579.4 448841.0 449877.0 464954.0 464984.0 469210.0 84258.2 84516.2 85913.0 87144.0 87152.0 1056.1 1079.6 1112.3 1125.2 1139.7 17162.5 17225.2 17288.9 17312.1 17572.8 39546.6 40289.0 40343.2 40576.6 40900.4 52750.4 53139.5 53155.5 53265.7 54520.5 8322.5 8588.2 8753.3 8757.9 8797.5 13126.8 13163.3 13201.9 13391.9 13558.1 11874.8 11970.6 11977.6 12013.2 12224.3 5343.9 8379.9 9343.6 11770.2 11962.4 8372.5 8459.7 8573.7 8675.0 8941.9 12039.3 13087.7 13210.3 13311.8 13476.9 11903.0 12278.9 12400.0 12538.8 12659.4 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | [#3] mootools.html Cycles:180 Average:5735.52 Median:4598.31 stddev:3233.87 (70.3%) stddev-sans-first:3227.20 19:28:05 INFO - PROCESS | 11753 | Values: 1489.3 1536.0 1664.8 1789.6 1796.3 7656.9 8249.8 8277.7 8867.6 8870.2 8374.9 8570.0 8644.8 8657.7 8662.5 2310.2 2333.1 2363.6 2363.8 2369.9 2229.8 2277.3 2282.7 2286.7 2318.5 2254.5 2269.5 2270.3 2314.2 2323.1 2207.8 2246.5 2248.2 2250.3 2279.2 2281.3 2285.0 2295.9 2296.0 2298.8 8641.5 8647.5 8654.4 8702.5 8725.7 4928.1 5110.6 5144.4 5146.1 5148.4 3338.2 3353.8 3469.0 3559.0 3574.3 1096.3 1102.2 1106.0 1115.7 1125.7 11894.9 12019.8 12081.6 12085.6 12109.3 4541.2 4542.7 4653.9 4660.1 4678.4 10207.4 10220.7 10240.9 10242.7 10245.1 5249.9 5286.0 5294.4 5296.4 5312.7 4145.1 4667.7 4808.3 4817.4 4825.1 3845.1 3893.7 3969.4 3971.4 3994.1 1202.8 1268.5 1272.2 1274.4 1281.2 943.8 1006.9 1019.7 1028.8 1040.2 5991.0 6057.2 6139.3 6145.4 6153.7 431.1 438.7 443.4 450.8 452.8 4197.9 4208.5 4250.9 4268.9 4296.8 10178.4 10450.8 10500.1 10525.7 10589.9 10260.5 10338.7 10415.0 10425.9 10444.0 7627.2 7895.1 7947.0 7952.0 8005.5 5872.9 5882.4 6011.1 6031.4 6188.6 9523.1 9763.1 9794.4 9962.9 10031.2 9766.4 9988.7 10294.6 10311.8 10354.5 7536.0 7940.2 8028.2 8254.8 8296.3 8243.8 8421.3 8549.4 8577.7 8673.5 7602.4 7843.2 7891.1 7920.3 7940.4 7459.6 7762.6 7815.2 7848.5 7855.7 7069.1 7157.6 7168.7 7189.5 7211.3 4988.6 5024.4 5102.5 5235.2 5274.9 5117.6 5195.6 5211.0 5236.3 5299.4 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | [#4] prototype.html Cycles:180 Average:4817.61 Median:5412.50 stddev:1425.41 (26.3%) stddev-sans-first:1388.89 19:28:05 INFO - PROCESS | 11753 | Values: 321.6 331.8 332.4 336.4 338.7 5511.3 5696.0 5722.3 5730.5 5753.9 5584.9 5597.4 5600.1 5602.8 5602.9 4378.9 4380.4 4390.3 4416.1 4428.2 4211.7 4338.6 4345.8 4354.7 4400.5 4302.0 4312.3 4344.1 4358.4 4368.3 4351.8 4357.1 4360.6 4369.5 4403.4 3736.8 3818.8 3863.7 3900.8 3925.0 5446.9 5482.7 5485.2 5491.8 5527.3 4988.4 4990.5 5012.7 5032.3 5044.2 5593.9 5860.6 5869.4 5892.9 5938.3 4132.6 4138.5 4156.4 4157.8 4173.7 5868.5 5985.5 6211.3 6223.5 6245.5 4210.8 4217.6 4223.0 4227.7 4231.3 4270.9 4292.4 4296.7 4308.6 4310.6 4841.8 4882.5 4889.8 4943.1 4981.6 5926.7 5949.9 5950.3 5990.5 6004.7 1424.2 1440.2 1440.6 1443.7 1447.5 870.6 908.8 909.1 914.1 923.6 5142.3 5144.0 5208.8 5239.4 5247.6 5403.7 5495.5 5507.6 5542.4 5547.0 4979.9 5046.0 5124.5 5164.1 5218.0 2870.2 2893.9 2907.0 2942.5 2948.4 5470.9 5524.8 5532.7 5588.4 5651.7 5198.0 5367.4 5390.7 5399.6 5478.4 5596.0 5636.6 5661.3 5666.3 5671.0 5297.5 5304.7 5430.2 5472.3 5477.0 5262.4 5302.0 5330.0 5386.3 5421.3 6160.0 6362.3 6373.3 6390.7 6391.6 4083.4 4133.7 4133.7 4145.3 4181.3 5956.6 6098.4 6129.7 6162.9 6196.6 5879.2 5917.9 5919.4 5955.6 5959.6 5952.2 5955.5 5987.6 5991.7 5996.0 5639.2 5807.9 5825.9 5850.2 5899.7 6049.0 6062.4 6089.2 6093.7 6126.8 5694.3 5739.1 5853.5 5897.5 5932.8 19:28:05 INFO - PROCESS | 11753 | 19:28:05 INFO - PROCESS | 11753 | [#5] yui.html Cycles:180 Average:16055.20 Median:4680.75 stddev:19276.68 (411.8%) stddev-sans-first:19296.87 19:28:05 INFO - PROCESS | 11753 | Values: 835.9 855.9 867.4 874.1 878.4 14028.8 14864.6 14920.1 14996.5 15018.0 13530.6 13544.8 13555.1 13585.7 13617.5 662.8 791.7 801.7 811.3 815.8 814.1 814.5 814.7 819.4 821.8 862.7 867.9 869.4 871.4 871.6 853.2 857.8 859.0 862.3 863.2 623.5 623.9 627.2 628.1 630.7 13844.9 13846.5 13884.2 13899.9 13956.2 14401.0 14785.1 14896.5 14917.9 14970.9 11943.4 11961.6 12015.7 12018.5 12266.6 3950.7 3953.3 3964.7 3971.3 4097.8 55005.4 55137.2 55324.0 56026.0 56072.0 10437.7 10704.9 11052.2 11064.6 11243.3 19772.9 19823.2 19943.8 20048.9 20051.5 8435.0 8442.9 8495.5 8542.6 8609.1 4649.9 4728.8 4772.4 4798.2 4889.8 3347.9 3422.7 3431.6 3434.7 3435.4 645.4 650.9 655.0 657.2 658.8 736.6 755.5 755.9 759.5 776.1 9917.2 9936.5 10080.2 10166.9 10167.8 672.4 717.5 719.0 724.9 733.5 4608.5 4674.9 4686.6 4689.9 4734.9 70725.3 70754.6 71598.3 72196.0 72611.0 62349.4 63447.7 63590.7 63945.4 64608.7 58216.4 58636.0 58663.4 58825.7 59513.7 9074.4 9074.7 9084.8 9122.0 9152.6 33993.8 34137.8 34731.3 38411.6 39079.6 50322.2 50428.7 51082.7 51138.5 51687.7 12969.3 13005.9 13157.3 13207.7 13233.7 13464.5 13865.9 13897.7 14159.8 14661.3 12998.7 13234.0 13338.5 13724.0 13782.4 12817.6 13003.2 13364.8 13367.3 13453.4 13396.5 13409.1 13507.7 13688.1 14039.6 11062.3 11181.3 11378.8 11451.9 11824.3 11255.8 11282.9 11516.9 11559.8 11783.8 19:28:05 INFO - PROCESS | 11753 | -------- Summary: end -------- 19:28:05 INFO - PROCESS | 11753 | 19:28:06 INFO - TEST-INFO | 11753: exit 0 19:28:06 INFO - TEST-OK | dromaeo_css | took 1109792ms 19:28:06 INFO - TEST-START | kraken 19:28:06 INFO - operating with platform_type : linux_ 19:28:06 INFO - Initialising browser for kraken test... 19:28:06 INFO - TEST-INFO | started process 11988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgYHOe/profile http://localhost:50239/getInfo.html) 19:28:10 INFO - PROCESS | 11988 | 19:28:10 INFO - PROCESS | 11988 | (process:12057): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:10 INFO - PROCESS | 11988 | __metrics Screen width/height:1600/1200 19:28:10 INFO - PROCESS | 11988 | colorDepth:24 19:28:10 INFO - PROCESS | 11988 | Browser inner width/height: 1024/697 19:28:10 INFO - PROCESS | 11988 | __metrics 19:28:11 ERROR - PROCESS | 11988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:28:12 INFO - TEST-INFO | 11988: exit 0 19:28:12 INFO - Browser initialized. 19:28:12 INFO - Running cycle 1/1 for kraken test... 19:28:12 INFO - TEST-INFO | started process 12108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWgYHOe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:14 INFO - PROCESS | 12108 | 19:28:14 INFO - PROCESS | 12108 | (process:12168): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:24 INFO - PROCESS | 12108 | RSS: Main: 166010880 19:28:24 INFO - PROCESS | 12108 | 19:28:26 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-beat-detection) 19:28:27 INFO - PROCESS | 12108 | RSS: Main: 171491328 19:28:27 INFO - PROCESS | 12108 | 19:28:30 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-dft) 19:28:30 INFO - PROCESS | 12108 | RSS: Main: 170852352 19:28:30 INFO - PROCESS | 12108 | 19:28:33 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-fft) 19:28:34 INFO - PROCESS | 12108 | RSS: Main: 165371904 19:28:34 INFO - PROCESS | 12108 | 19:28:36 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-oscillator) 19:28:37 INFO - PROCESS | 12108 | RSS: Main: 166481920 19:28:37 INFO - PROCESS | 12108 | 19:28:39 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:39 INFO - PROCESS | 12108 | RSS: Main: 167034880 19:28:39 INFO - PROCESS | 12108 | 19:28:42 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50239/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:43 INFO - PROCESS | 12108 | RSS: Main: 166858752 19:28:43 INFO - PROCESS | 12108 | 19:28:46 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50239/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:47 INFO - PROCESS | 12108 | RSS: Main: 167002112 19:28:47 INFO - PROCESS | 12108 | 19:28:50 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50239/tests/kraken/driver.html?testName=json-parse-financial) 19:28:51 INFO - PROCESS | 12108 | RSS: Main: 167890944 19:28:51 INFO - PROCESS | 12108 | 19:28:52 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:53 INFO - PROCESS | 12108 | RSS: Main: 167735296 19:28:53 INFO - PROCESS | 12108 | 19:28:54 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:55 INFO - PROCESS | 12108 | RSS: Main: 168177664 19:28:55 INFO - PROCESS | 12108 | 19:28:57 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:58 INFO - PROCESS | 12108 | RSS: Main: 167976960 19:28:58 INFO - PROCESS | 12108 | 19:29:00 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:29:01 INFO - PROCESS | 12108 | RSS: Main: 168419328 19:29:01 INFO - PROCESS | 12108 | 19:29:04 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:29:04 INFO - PROCESS | 12108 | RSS: Main: 168230912 19:29:04 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50239/tests/kraken/driver.html?testName=ai-astar) 19:29:06 INFO - PROCESS | 12108 | RSS: Main: 169111552 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | __start_tp_report 19:29:06 INFO - PROCESS | 12108 | _x_x_mozilla_page_load 19:29:06 INFO - PROCESS | 12108 | _x_x_mozilla_page_load_details 19:29:06 INFO - PROCESS | 12108 | |i|pagename|runs| 19:29:06 INFO - PROCESS | 12108 | |0;ai-astar;112;106;111;112;111;114;114;110;112;117 19:29:06 INFO - PROCESS | 12108 | |1;audio-beat-detection;157;125;157;182;127;157;157;126;185;128 19:29:06 INFO - PROCESS | 12108 | |2;audio-dft;162;164;162;162;163;163;169;167;162;161 19:29:06 INFO - PROCESS | 12108 | |3;audio-fft;77;76;75;160;76;75;75;75;167;76 19:29:06 INFO - PROCESS | 12108 | |4;audio-oscillator;84;84;158;83;86;83;140;84;83;136 19:29:06 INFO - PROCESS | 12108 | |5;imaging-gaussian-blur;118;117;117;121;117;117;117;117;117;117 19:29:06 INFO - PROCESS | 12108 | |6;imaging-darkroom;146;148;148;146;146;147;146;146;145;147 19:29:06 INFO - PROCESS | 12108 | |7;imaging-desaturate;96;96;97;95;95;96;95;96;95;96 19:29:06 INFO - PROCESS | 12108 | |8;json-parse-financial;54;56;52;53;55;59;54;53;53;54 19:29:06 INFO - PROCESS | 12108 | |9;json-stringify-tinderbox;62;63;62;61;62;62;62;63;61;61 19:29:06 INFO - PROCESS | 12108 | |10;stanford-crypto-aes;79;79;80;86;81;81;80;81;112;78 19:29:06 INFO - PROCESS | 12108 | |11;stanford-crypto-ccm;120;139;126;119;127;121;131;137;130;132 19:29:06 INFO - PROCESS | 12108 | |12;stanford-crypto-pbkdf2;162;166;161;161;164;158;162;166;161;158 19:29:06 INFO - PROCESS | 12108 | |13;stanford-crypto-sha256-iterative;63;65;65;62;62;63;62;62;62;63 19:29:06 INFO - PROCESS | 12108 | __end_tp_report 19:29:06 INFO - PROCESS | 12108 | __start_cc_report 19:29:06 INFO - PROCESS | 12108 | _x_x_mozilla_cycle_collect,886 19:29:06 INFO - PROCESS | 12108 | __end_cc_report 19:29:06 INFO - PROCESS | 12108 | __startTimestamp1464402546805__endTimestamp 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | ------- Summary: start ------- 19:29:06 INFO - PROCESS | 12108 | Number of tests: 14 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:2.88 (2.6%) stddev-sans-first:3.06 19:29:06 INFO - PROCESS | 12108 | Values: 112.0 106.0 111.0 112.0 111.0 114.0 114.0 110.0 112.0 117.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.00 stddev:22.75 (14.5%) stddev-sans-first:23.99 19:29:06 INFO - PROCESS | 12108 | Values: 157.0 125.0 157.0 182.0 127.0 157.0 157.0 126.0 185.0 128.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.55 (1.6%) stddev-sans-first:2.65 19:29:06 INFO - PROCESS | 12108 | Values: 162.0 164.0 162.0 162.0 163.0 163.0 169.0 167.0 162.0 161.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:37.09 (49.1%) stddev-sans-first:38.88 19:29:06 INFO - PROCESS | 12108 | Values: 77.0 76.0 75.0 160.0 76.0 75.0 75.0 75.0 167.0 76.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.50 stddev:29.90 (35.8%) stddev-sans-first:30.99 19:29:06 INFO - PROCESS | 12108 | Values: 84.0 84.0 158.0 83.0 86.0 83.0 140.0 84.0 83.0 136.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.27 (1.1%) stddev-sans-first:1.33 19:29:06 INFO - PROCESS | 12108 | Values: 118.0 117.0 117.0 121.0 117.0 117.0 117.0 117.0 117.0 117.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 19:29:06 INFO - PROCESS | 12108 | Values: 146.0 148.0 148.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:29:06 INFO - PROCESS | 12108 | Values: 96.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:2.00 (3.7%) stddev-sans-first:2.12 19:29:06 INFO - PROCESS | 12108 | Values: 54.0 56.0 52.0 53.0 55.0 59.0 54.0 53.0 53.0 54.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 19:29:06 INFO - PROCESS | 12108 | Values: 62.0 63.0 62.0 61.0 62.0 62.0 62.0 63.0 61.0 61.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:80.50 stddev:10.18 (12.6%) stddev-sans-first:10.65 19:29:06 INFO - PROCESS | 12108 | Values: 79.0 79.0 80.0 86.0 81.0 81.0 80.0 81.0 112.0 78.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:130.50 stddev:6.91 (5.3%) stddev-sans-first:6.66 19:29:06 INFO - PROCESS | 12108 | Values: 120.0 139.0 126.0 119.0 127.0 121.0 131.0 137.0 130.0 132.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:2.81 (1.7%) stddev-sans-first:2.98 19:29:06 INFO - PROCESS | 12108 | Values: 162.0 166.0 161.0 161.0 164.0 158.0 162.0 166.0 161.0 158.0 19:29:06 INFO - PROCESS | 12108 | 19:29:06 INFO - PROCESS | 12108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 19:29:06 INFO - PROCESS | 12108 | Values: 63.0 65.0 65.0 62.0 62.0 63.0 62.0 62.0 62.0 63.0 19:29:06 INFO - PROCESS | 12108 | -------- Summary: end -------- 19:29:06 INFO - PROCESS | 12108 | 19:29:07 INFO - TEST-INFO | 12108: exit 0 19:29:07 INFO - TEST-OK | kraken | took 61402ms 19:29:07 INFO - SUITE-END | took 1171s 19:29:07 INFO - Completed test suite (00:19:31) 19:29:07 INFO - javascript benchmark 19:29:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7224.215480520144, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.2791158033656, 3165.4460469417845, 3178.094243140705, 3184.3472088221915, 3189.984050079749, 5475.589330800191, 5482.671039737618, 5527.944720552799, 5534.916976245359, 5536.114221724525, 5392.541633961108, 5453.427390124039, 5456.427075157111, 5457.072297709389, 5555.111182210837, 4895.388076490448, 4919.016196760645, 5010.398752149747, 5058.165402708567, 5113.258577506259, 941.8410727540899, 5044.949550504503, 5054.898902021957, 5056.3173971513925, 5084.135696931512, 4945.8268960586565, 4979.153543897546, 4982.701037937717, 4986.75066246688, 5033.018561380532, 4861.319415281863, 4991.376077990251, 5000.574951129159, 5013.849584512471, 5044.949550504484, 4936.4076310842565, 4936.629752768521, 4937.7777999990085, 4991.076650819574, 5016.924746128811, 5452.754626041798, 5485.286912701324, 5494.203340515643, 5495.642783219078, 5508.531774799147, 5760.0, 5810.128480727883, 5926.170336152942, 5926.822195334147, 5931.199288096138, 5854.063349864001, 5871.266091738533, 5893.263342082239, 5916.171735956969, 5953.3748956359395, 5499.697516636584, 5508.3114610673665, 5516.393196748354, 5520.530754885839, 5530.059889818741, 5903.0260007099205, 5954.910676339859, 5996.880062398727, 6012.038073908241, 6027.7890273841085, 5804.767809287581, 5810.215620891126, 5810.331811841692, 5811.3316968548315, 5821.476067153976, 5894.67579283135, 5902.055671092605, 5904.7342869570975, 5908.172855800191, 5919.585629006015, 5703.201551782754, 5746.827595172152, 5801.680907550125, 5850.385709500441, 5883.411658834082, 5706.9714651426475, 5823.88352232953, 5836.708164591753, 5882.441168089024, 5895.498882594941, 4475.70907890986, 4480.39514665516, 4491.371208030879, 4499.280115181556, 4539.523350048197, 3871.845126194977, 3913.1977944521304, 3927.155661532784, 3930.76415415076, 3950.841966321315, 5636.04187288162, 5646.3224413069875, 5657.8019769307875, 5687.601867869293, 5734.713264336767, 5887.35239123696, 5913.704314784243, 5928.0515117581845, 5961.940380596226, 5966.0, 5510.9448905510435, 5551.694656793915, 5566.832995010156, 5601.551875849922, 5634.774609015593, 5051.444341122474, 5056.6713163644245, 5071.670341427869, 5087.592992560586, 5090.567301779316, 6050.54620903434, 6083.270007599116, 6089.441462180385, 6100.847478813065, 6108.541859360477, 5781.017227071324, 5829.47534721877, 5894.086416605433, 5902.085176797603, 5949.25634295713, 6099.634021958696, 6120.418560236771, 6141.416565426277, 6142.293636231711, 6144.907826382697, 5642.689652069012, 5778.595498315078, 5832.387599302012, 5837.0, 5846.649201047951, 5820.417958204315, 5844.532437404912, 5871.647701137946, 5900.881982360243, 5929.703514824155, 5701.800436984851, 5727.455891690282, 5748.109043098327, 5751.712414379348, 5758.913616295843, 5652.745626446737, 5664.943350566607, 5740.3685594585395, 5762.5389968801555, 5771.769129234784, 5571.05292100352, 5583.35791383996, 5610.691411972381, 5656.915146272727, 5772.826815195551, 5783.334916484658, 5795.9277533656405, 5809.419058094157, 5817.272840894888, 5821.98115329824, 5558.861028474159, 5609.102543593006, 5680.545556355564, 5688.77244910199, 5704.942950570441], "value": 5388.024060218915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7941060334183, 640.6764583885138, 641.5060403489316, 658.1148355461903, 659.2715049869894, 32863.67136328636, 35648.108797280045, 42563.57436425635, 43091.35362969558, 43177.784111079476, 44554.55445445544, 45283.09433811322, 45473.0, 45508.3173752394, 45752.77123614385, 8544.060153383123, 8686.609102590399, 8687.695930642429, 8691.087435819243, 8724.127587241288, 8686.305095592337, 8746.825063498727, 8778.780530486756, 8805.295576353908, 8811.295096392305, 8904.554772261394, 8963.820723585557, 8971.282297416225, 8983.460992340448, 9019.864702029441, 8798.120187981214, 8804.559772011375, 8815.118488151198, 8837.867431988494, 8847.159519845669, 8655.783605409852, 8697.478151310941, 8781.429207101519, 8793.956030219872, 8804.955975220148, 41269.0, 41689.37465938013, 41776.37335439971, 41886.371704424455, 42015.36976945318, 3427.8286085695863, 3542.6103128655827, 4126.401671757609, 4157.896052598679, 4223.387608796707, 32176.35647287041, 32624.83687581547, 32967.3406531868, 33054.669453305396, 34321.31357372839, 4301.763403012833, 4428.092241090569, 4531.320301954733, 4557.521460246693, 4643.117807616542, 239177.0, 241418.0, 241476.0, 242429.0, 243312.99999999822, 59439.0, 60125.0, 60359.396406035376, 60502.39497605056, 60504.69747651234, 62981.0, 63001.6448601874, 63182.0, 63515.364846350945, 63859.0, 17287.222075006655, 17401.390951316644, 17427.47717568475, 17477.7378339325, 17509.474715758548, 13349.532766353132, 13417.66455838612, 13497.527586534425, 13618.455261789615, 13627.182369057888, 15682.294296756674, 17259.0, 17261.136943153044, 17265.654686906193, 17268.395606153976, 6177.413145751147, 6259.561830671901, 6314.400131987454, 6319.526035547352, 6393.648349340738, 946.2099147212017, 1045.132539991805, 1052.3002203534563, 1061.867266591676, 1132.2074547816562, 32994.67005329964, 33007.66992330094, 33272.3345533088, 33670.0, 33902.66097338995, 1064.409252864652, 1074.9462526873624, 1098.1783393789656, 1125.5272785429975, 1218.9268643881396, 17299.13504324779, 17627.911860440872, 17759.898833498653, 17849.018303993147, 17971.460856174337, 511744.0, 514969.0, 517038.0, 517975.0, 519007.0, 58044.70977645085, 58599.0, 58731.0, 58966.0, 59140.04299784994, 1328.4154971812372, 1364.2019418640207, 1384.3424373422745, 1395.699924516234, 1398.6223719595855, 31655.52516712205, 32962.17594560155, 33161.83419082889, 33277.0, 33807.830960845036, 52617.47382526126, 52626.21060684016, 52951.20573191482, 53215.4678453226, 53289.0, 351893.0, 352745.0, 450251.0, 457310.0, 459576.0, 42304.78847605865, 42458.57541424546, 43573.78213109041, 43699.78150109229, 43740.562594374926, 48406.757966209945, 49009.26486102783, 49155.508444915096, 50149.24776128434, 50292.24561631505, 41282.793586031876, 42351.0, 42579.0, 43082.353764692925, 43141.3528797062, 41713.79143104265, 42012.57987420087, 42294.78852605717, 42323.153536928476, 42474.78762606167, 36484.08789780277, 40462.797686011385, 40626.0, 41624.79187604043, 42330.576694233896, 35229.647703522634, 36692.0, 36784.44823327599, 37001.259974800894, 38186.61813381831, 28431.28921776972, 28882.0, 28893.855530723053, 28952.0, 29028.0], "value": 20283.971372318414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.8824352694191, 394.96247856453624, 400.21358031468156, 402.70602460204054, 418.88994165461526, 13976.301184940738, 17981.550461238458, 18827.341043063494, 19268.90365548172, 19299.13153908074, 17728.82271177288, 17840.55398615032, 18560.443186704422, 18637.347692830754, 18712.157952892117, 5502.669839809604, 5636.830895073154, 5653.575981801361, 5686.0, 5702.486776190142, 5573.526250268732, 5653.6607803531715, 5677.37548869624, 5686.061799803048, 5718.857028574298, 5522.66863988162, 5576.498115169634, 5586.24585680934, 5621.241132447109, 5652.152177173416, 5514.228008078872, 5560.6941618210985, 5624.943750562483, 5629.971850140743, 5677.40387259336, 4879.780409881564, 5026.246063090565, 5054.545090941796, 5070.062038522885, 5090.694558326475, 22539.0, 22540.77459225403, 22728.545429091326, 22999.425014374607, 23069.846507674716, 2426.3570153909227, 2447.155731272708, 2462.372095115734, 2559.1810620601414, 2862.427514497088, 14188.85811141896, 14234.217118058503, 14403.351849166813, 14882.0, 15188.392464301414, 1948.5518330783857, 1956.0904179556574, 1971.5071232191951, 2022.4741567192636, 2026.7973202679761, 81182.0, 82373.0, 84403.5779821103, 84498.15501844964, 85221.57389213076, 10255.435951022766, 10388.844167337496, 10648.574057037631, 10698.572057117784, 10835.803437985813, 14821.629459263604, 14828.481003164838, 14828.70342593142, 14861.331240094221, 14916.925415372854, 7995.360371170293, 8059.597020148969, 8069.838603227902, 8295.751127466187, 8341.5412152331, 7564.092308922965, 7601.923980760122, 7627.656755445907, 7676.692932282758, 8097.878531822027, 6430.48556115519, 6524.608523488606, 6549.279579246279, 6601.636909969998, 6689.799306020827, 1910.245453046039, 1930.5559721263908, 1937.428458604715, 1946.673311736855, 1961.9901900490693, 1018.8064267789097, 1023.9795204095876, 1045.1951996962448, 1048.926575139733, 1081.588996181446, 18648.627027459373, 19536.60926781485, 19645.901770491342, 19894.403167904988, 20111.0, 1017.3997341568362, 1047.6280920273346, 1050.8896565860628, 1138.2544433396138, 1158.6212407235364, 10898.237123401286, 11495.712607184887, 11498.137639677057, 11528.077753779846, 11579.421028948518, 448841.0, 449877.0, 464954.0, 464984.0, 469210.0, 84258.15741842503, 84516.15483845084, 85913.0, 87144.0, 87152.0, 1056.0548309263168, 1079.6167360587035, 1112.3048094940661, 1125.2292179856825, 1139.7207684117445, 17162.485125446256, 17225.22486488086, 17288.913555432144, 17312.134393280536, 17572.82427175712, 39546.60453395544, 40289.0, 40343.1931361377, 40576.59423405728, 40900.386494202015, 52750.362481876524, 53139.46860531345, 53155.468445315055, 53265.73367133139, 54520.45479545154, 8322.50064996102, 8588.184122508352, 8753.255973242345, 8757.90526184227, 8797.516136612292, 13126.803097953347, 13163.341832908125, 13201.933990329986, 13391.933040335125, 13558.118722283414, 11874.82187767167, 11970.58102966392, 11977.64067077989, 12013.219140755822, 12224.327661978676, 5343.866403339947, 8379.916200837913, 9343.626254949997, 11770.17608767378, 11962.401879905796, 8372.539510326991, 8459.746207613782, 8573.74278771638, 8674.956625217086, 8941.865872012055, 12039.33783641873, 13087.738245235232, 13210.273434960785, 13311.800322995357, 13476.865231347561, 11903.047756179312, 12278.85120103996, 12400.0, 12538.847180305644, 12659.430325635552], "value": 9339.124689778557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.3000289863764, 1536.0, 1664.7763893538247, 1789.6152327249638, 1796.3173993882324, 7656.885146722803, 8249.752507424771, 8277.710280140196, 8867.55662216889, 8870.157335053167, 8374.91625083749, 8570.0, 8644.827103457927, 8657.74026779196, 8662.480251184934, 2310.202979971907, 2333.136739406422, 2363.5627408929317, 2363.7872591466767, 2369.9052037918464, 2229.7881701238357, 2277.2598905355744, 2282.7260728712577, 2286.737025242102, 2318.455163036685, 2254.4814692620707, 2269.466675331296, 2270.2735124760084, 2314.155333303349, 2323.1172154581236, 2207.7681843406453, 2246.516998845248, 2248.2468373095035, 2250.2574150530286, 2279.1567120165478, 2281.327008532487, 2284.9657255141187, 2295.908163673451, 2296.024189719379, 2298.793108620232, 8641.481511109354, 8647.524386158759, 8654.394192406535, 8702.477851328877, 8725.694600689008, 4928.088303663798, 5110.565601923841, 5144.4083930348115, 5146.099432599318, 5148.3821941366905, 3338.2322065924973, 3353.84907679155, 3469.028671971852, 3559.0212691509782, 3574.267275208576, 1096.3038470571244, 1102.1568500097433, 1105.9723506912392, 1115.7433790228292, 1125.7016890524017, 11894.940525297317, 12019.759604807943, 12081.637550873487, 12085.577004804789, 12109.333986630732, 4541.227991241497, 4542.727436353829, 4653.883652908705, 4660.1145782301255, 4678.438587369537, 10207.387556746618, 10220.744481387876, 10240.897591024144, 10242.692719218287, 10245.129164020993, 5249.895002100013, 5286.0, 5294.391145018295, 5296.3909150447425, 5312.73436328182, 4145.108801607669, 4667.673262871566, 4808.3027960945465, 4817.373741413594, 4825.083234185494, 3845.134844659929, 3893.6885049196, 3969.384745364473, 3971.3645816669195, 3994.08136128692, 1202.8255902894032, 1268.505282939636, 1272.204871955028, 1274.3755559775643, 1281.2440660010639, 943.7734943613483, 1006.884208316053, 1019.7246743379246, 1028.8148133336072, 1040.1626690514058, 5991.0, 6057.182280392179, 6139.26328840542, 6145.354737752561, 6153.7230824613, 431.0839466134464, 438.69949084876964, 443.4346208584081, 450.79038247215203, 452.83924206906073, 4197.874063778091, 4208.452901122834, 4250.872473825791, 4268.893277668021, 4296.76367799774, 10178.389296642225, 10450.843237351446, 10500.107490863209, 10525.736856578493, 10589.9470502647, 10260.538275777608, 10338.689839304832, 10415.0, 10425.895741042645, 10444.0, 7627.161012288644, 7895.131535531087, 7946.960265198637, 7952.0, 8005.479643823133, 5872.911906321323, 5882.441168089024, 6011.068284415923, 6031.4270144336215, 6188.58206608806, 9523.142917137491, 9763.121319081316, 9794.363366381162, 9962.900370996487, 10031.247656425943, 9766.36518626287, 9988.650397236062, 10294.639687610897, 10311.845322320321, 10354.534045968101, 7535.962320188583, 7940.16628254025, 8028.237317454832, 8254.793630159294, 8296.340731853532, 8243.83512329762, 8421.32629389635, 8549.444286121383, 8577.65689372443, 8673.479591224546, 7602.3537999268465, 7843.21567843234, 7891.053073630971, 7920.287174154123, 7940.444168908121, 7459.552426854406, 7762.5730584818375, 7815.218478152139, 7848.529088254723, 7855.7250496232355, 7069.116360454943, 7157.64211789398, 7168.713251470092, 7189.496735228693, 7211.278872112956, 4988.575971042502, 5024.397072351341, 5102.4897510248675, 5235.240890070994, 5274.89450210986, 5117.5650069743, 5195.5843532518065, 5210.97394513025, 5236.266922630759, 5299.364076310867], "value": 4528.962419684699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.5514357471326, 331.79594549352146, 332.4000179675686, 336.36930754834685, 338.6545723362172, 5511.319047690457, 5696.0, 5722.256106706122, 5730.512906402951, 5753.913691294629, 5584.888302233963, 5597.404739649201, 5600.103983362663, 5602.7758889644465, 5602.943970560294, 4378.934315985262, 4380.430544029272, 4390.319500477431, 4416.094700586372, 4428.247197976351, 4211.747295162285, 4338.609525142737, 4345.826166953334, 4354.716943398685, 4400.515943246241, 4302.0, 4312.266914624505, 4344.1311737652595, 4358.368036634686, 4368.344748287751, 4351.825926962918, 4357.128574285156, 4360.607545320905, 4369.51436511586, 4403.361512580658, 3736.823699855129, 3818.8090595470117, 3863.7295389322476, 3900.804959752001, 3925.0, 5446.8910621787345, 5482.698451585161, 5485.232067510552, 5491.752871120809, 5527.281453411031, 4988.406028865006, 4990.451050384491, 5012.72430016349, 5032.320636714034, 5044.243363495469, 5593.860153496154, 5860.622753652889, 5869.413058694139, 5892.9374718848485, 5938.257717785277, 4132.566080561528, 4138.461999939988, 4156.423017729027, 4157.812898419578, 4173.728707633994, 5868.530517558585, 5985.4912332451795, 6211.3167551569295, 6223.533235007392, 6245.500359971192, 4210.820970128369, 4217.587108318687, 4223.0, 4227.661787057028, 4231.30183519722, 4270.914581708348, 4292.3561465780385, 4296.710986703976, 4308.590683885089, 4310.620601407582, 4841.782119804618, 4882.511748825089, 4889.755512224375, 4943.134951383494, 4981.576565991859, 5926.67403292823, 5949.881002379928, 5950.31571369298, 5990.4908082813445, 6004.699765011732, 1424.155718344746, 1440.171901156839, 1440.6110350205386, 1443.6607397261635, 1447.5006122887587, 870.6115854623148, 908.8000639859221, 909.0500875621887, 914.0996118822954, 923.6443969071955, 5142.30578871855, 5144.045262800112, 5208.7916483341, 5239.428171548597, 5247.606429517801, 5403.729813509309, 5495.450454954553, 5507.586930980193, 5542.422773410383, 5547.0, 4979.900401992012, 5046.0, 5124.48755124492, 5164.147915593885, 5217.973910130501, 2870.1533047750963, 2893.85530723463, 2906.956395654067, 2942.4556457055514, 2948.4225939122466, 5470.890582188334, 5524.756929690868, 5532.695701736443, 5588.441155884379, 5651.717414129277, 5197.974010129925, 5367.35591728995, 5390.733177703237, 5399.568034557226, 5478.369987451414, 5595.972020139873, 5636.633618814846, 5661.2923384576925, 5666.291713535808, 5670.971645141748, 5297.54970827484, 5304.655197412156, 5430.212619170277, 5472.288602481652, 5477.000894673336, 5262.3951144183875, 5302.03824584906, 5330.0, 5386.272853164773, 5421.2681288025615, 6160.0, 6362.268339141058, 6373.298937117006, 6390.712417941111, 6391.616503009835, 4083.428320035138, 4133.7106402551535, 4133.731307465006, 4145.316022856195, 4181.289180839325, 5956.583039187215, 6098.390160983866, 6129.651476675124, 6162.876742465215, 6196.566240363131, 5879.176915231957, 5917.9347717409555, 5919.437653422918, 5955.612885162451, 5959.642421454727, 5952.196453478725, 5955.493783028491, 5987.5808693391045, 5991.700414979146, 5995.970020149872, 5639.238702775237, 5807.883842323045, 5825.912611310749, 5850.2102216200265, 5899.675517846388, 6048.969755151196, 6062.393760624079, 6089.208402907594, 6093.725782339717, 6126.835901178762, 5694.288213973254, 5739.110437882135, 5853.531717462508, 5897.469227769521, 5932.79235226765], "value": 4353.430778994265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.9205875441833, 855.9358048146389, 867.4361664917807, 874.1215078845763, 878.4158534574508, 14028.789568156473, 14864.554063378117, 14920.104793712384, 14996.475123370685, 15018.0, 13530.594082177551, 13544.796828047587, 13555.11891727037, 13585.72828543431, 13617.45530178794, 662.7845950066223, 791.6951973490219, 801.7274126796902, 811.2576992052265, 815.7919730468723, 814.1166833985134, 814.4583851738587, 814.698561532234, 819.397742659145, 821.8438496685641, 862.7325529085972, 867.9262262707646, 869.443556124081, 871.3900269811126, 871.6339137562207, 853.2235665544325, 857.7598272483715, 859.0250066174905, 862.3273846399818, 863.2317237658489, 623.5323507369473, 623.9032949892774, 627.1533429869685, 628.136312570216, 630.7224821078711, 13844.861551384458, 13846.515371961934, 13884.166949982933, 13899.86100139006, 13956.2324072176, 14401.0, 14785.112893226333, 14896.478623248242, 14917.925410372987, 14970.925145374313, 11943.402829858473, 11961.64115076549, 12015.699607509794, 12018.4591693374, 12266.570670026505, 3950.6839452843706, 3953.2686453006286, 3964.7422917510557, 3971.3050216212046, 4097.836086556564, 55005.44994550043, 55137.172942405894, 55323.9999999996, 56026.0, 56072.0, 10437.686869393778, 10704.89295107039, 11052.171087168495, 11064.612738554111, 11243.325400475835, 19772.901135494518, 19823.207071717257, 19943.800561994485, 20048.89975550142, 20051.498712532302, 8435.0, 8442.915570844336, 8495.532745699045, 8542.615582298811, 8609.096044915193, 4649.930251046237, 4728.787204575802, 4772.427308722976, 4798.184308667535, 4889.804407823718, 3347.8995630131135, 3422.743294252941, 3431.571053618298, 3434.690877820958, 3435.4159792835276, 645.3772109913956, 650.9414152726278, 654.9586158008789, 657.2244751193542, 658.785894584262, 736.580333604108, 755.4900442201492, 755.9319661230516, 759.4721668440492, 776.0997243197863, 9917.15704165154, 9936.453495057842, 10080.193584513221, 10166.898331016742, 10167.796644067077, 672.4217173231017, 717.4726575966661, 718.9600897707111, 724.9456290778107, 733.4902242941105, 4608.470025946992, 4674.929876051862, 4686.5782079613, 4689.859304220879, 4734.857954261378, 70725.2927470729, 70754.64622676956, 71598.28401715917, 72196.0, 72611.0, 62349.37650623436, 63447.68276158682, 63590.68204658947, 63945.36054639487, 64608.676956614916, 58216.41783582194, 58636.0, 58663.413365865796, 58825.705871471226, 59513.70243148757, 9074.410163339362, 9074.682386116454, 9084.818303634023, 9122.0, 9152.58813353414, 33993.83003084969, 34137.82931085329, 34731.30537389289, 38411.6158838408, 39079.609203907596, 50322.245166323264, 50428.74785626195, 51082.74458627683, 51138.488615113376, 51687.74156129195, 12969.286689232184, 13005.934970325088, 13157.34213289351, 13207.66980825487, 13233.661976737698, 13464.461421543421, 13865.861341386457, 13897.72204555883, 14159.787603186167, 14661.340239689027, 12998.740025199631, 13234.0, 13338.466461341437, 13724.0, 13782.379792909143, 12817.615471535868, 13003.154794938677, 13364.799528006894, 13367.264800436069, 13453.394597243343, 13396.531121410704, 13409.128406653535, 13507.72984540284, 13688.110272832633, 14039.578812635636, 11062.280951738112, 11181.32912025281, 11378.829317560409, 11451.942740286246, 11824.349660768741, 11255.774884502427, 11282.94358528202, 11516.884831151581, 11559.76880462403, 11783.764324713286], "value": 7062.852733743757, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.4000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 112.0, 111.0, 114.0, 114.0, 110.0, 112.0, 117.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 157.0, 182.0, 127.0, 157.0, 157.0, 126.0, 185.0, 128.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 163.0, 163.0, 169.0, 167.0, 162.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 160.0, 76.0, 75.0, 75.0, 75.0, 167.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 158.0, 83.0, 86.0, 83.0, 140.0, 84.0, 83.0, 136.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 121.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 52.0, 53.0, 55.0, 59.0, 54.0, 53.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 86.0, 81.0, 81.0, 80.0, 81.0, 112.0, 78.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 139.0, 126.0, 119.0, 127.0, 121.0, 131.0, 137.0, 130.0, 132.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 161.0, 161.0, 164.0, 158.0, 162.0, 166.0, 161.0, 158.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.9, "unit": "score"}]}]} 19:29:08 INFO - Return code: 0 19:29:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:29:08 ERROR - # TBPL SUCCESS # 19:29:08 INFO - Running post-action listener: _resource_record_post_action 19:29:08 INFO - ##### 19:29:08 INFO - ##### Finished run-tests step (success) 19:29:08 INFO - ##### 19:29:08 INFO - Running post-run listener: _resource_record_post_run 19:29:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 537530368; Read time: 0; Write time: 425376 19:29:08 INFO - TinderboxPrint: CPU usage
13.5% 19:29:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:29:08 INFO - TinderboxPrint: I/O write bytes / time
537,530,368 / 425,376 19:29:08 INFO - TinderboxPrint: CPU idle
8,206.8 (86.5%) 19:29:08 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 19:29:08 INFO - TinderboxPrint: Swap in / out
0 / 0 19:29:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244248576; Read time: 0; Write time: 227428 19:29:08 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 293203968; Read time: 0; Write time: 197948 19:29:08 INFO - Running post-run listener: _upload_blobber_files 19:29:08 INFO - Blob upload gear active. 19:29:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:29:08 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 19:29:08 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:29:08 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:29:09 INFO - (blobuploader) - INFO - Open directory for files ... 19:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:09 INFO - (blobuploader) - INFO - Done attempting. 19:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:29:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:11 INFO - (blobuploader) - INFO - Done attempting. 19:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:29:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:15 INFO - (blobuploader) - INFO - Done attempting. 19:29:15 INFO - (blobuploader) - INFO - Iteration through files over. 19:29:15 INFO - Return code: 0 19:29:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:29:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:29:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12521378511c118aef7a1ae1e6f8d93ac01c9f5adb4afac318b5406ec33ee441bc5c9e1b3a2f384deabe5febb7aca2f264c7d1c09b29523a7fcaa9f10960b56f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ec8b8ad02c28ea2713bd47633f9926724a38e7f6a7893d4d0cfc6307b9a676408a35446621e2abbac90dfdc21048cc572b9f49eed3fa71ba20a7678590e6f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26fecb269732137ad4d159763a837a0ad908cb8d6f3fe5ffe1dbd442cdd568e991e9723cd14317c57f1c28f899a41c6cc5e02a5d18e8d6b7dba91a244b50d399"} 19:29:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:29:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:29:15 INFO - Contents: 19:29:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12521378511c118aef7a1ae1e6f8d93ac01c9f5adb4afac318b5406ec33ee441bc5c9e1b3a2f384deabe5febb7aca2f264c7d1c09b29523a7fcaa9f10960b56f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ec8b8ad02c28ea2713bd47633f9926724a38e7f6a7893d4d0cfc6307b9a676408a35446621e2abbac90dfdc21048cc572b9f49eed3fa71ba20a7678590e6f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26fecb269732137ad4d159763a837a0ad908cb8d6f3fe5ffe1dbd442cdd568e991e9723cd14317c57f1c28f899a41c6cc5e02a5d18e8d6b7dba91a244b50d399"} 19:29:15 INFO - Running post-run listener: copy_logs_to_upload_dir 19:29:15 INFO - Copying logs to upload dir... 19:29:15 INFO - mkdir: /builds/slave/test/build/upload/logs 19:29:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.626215 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-27 19:29:15.588627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 19:29:15.592010) ========= 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-1464396637.609654-864232418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12521378511c118aef7a1ae1e6f8d93ac01c9f5adb4afac318b5406ec33ee441bc5c9e1b3a2f384deabe5febb7aca2f264c7d1c09b29523a7fcaa9f10960b56f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ec8b8ad02c28ea2713bd47633f9926724a38e7f6a7893d4d0cfc6307b9a676408a35446621e2abbac90dfdc21048cc572b9f49eed3fa71ba20a7678590e6f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26fecb269732137ad4d159763a837a0ad908cb8d6f3fe5ffe1dbd442cdd568e991e9723cd14317c57f1c28f899a41c6cc5e02a5d18e8d6b7dba91a244b50d399"} build_url:https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/OSctqcqIQAG94_36ePbnPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12521378511c118aef7a1ae1e6f8d93ac01c9f5adb4afac318b5406ec33ee441bc5c9e1b3a2f384deabe5febb7aca2f264c7d1c09b29523a7fcaa9f10960b56f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ec8b8ad02c28ea2713bd47633f9926724a38e7f6a7893d4d0cfc6307b9a676408a35446621e2abbac90dfdc21048cc572b9f49eed3fa71ba20a7678590e6f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26fecb269732137ad4d159763a837a0ad908cb8d6f3fe5ffe1dbd442cdd568e991e9723cd14317c57f1c28f899a41c6cc5e02a5d18e8d6b7dba91a244b50d399"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 19:29:15.619292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:29:15.619818) ========= 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-1464396637.609654-864232418 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 19:29:15.703928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 19:29:15.704636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 19:29:15.705294) ========= ========= Total master_lag: 0.17 =========