builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1463783658.01 results: success (0) buildid: 20160520140829 builduid: 5a00da35498647a7b497243bdef7bec1 revision: c403ac05b8f42e44a5f7a0c98c2bf190b28706b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.006037) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.006501) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.006776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.050151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.050422) ========= 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=33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 15:34:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-05-20 15:34:18 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.245021 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.349764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.350109) ========= 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=33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.400736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.401269) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c403ac05b8f42e44a5f7a0c98c2bf190b28706b1 --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 c403ac05b8f42e44a5f7a0c98c2bf190b28706b1 --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=33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 15:34:18,516 truncating revision to first 12 chars 2016-05-20 15:34:18,516 Setting DEBUG logging. 2016-05-20 15:34:18,517 attempt 1/10 2016-05-20 15:34:18,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c403ac05b8f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 15:34:18,789 unpacking tar archive at: mozilla-central-c403ac05b8f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.991884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.992408) ========= script_repo_revision: c403ac05b8f42e44a5f7a0c98c2bf190b28706b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.993070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:18.993622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 15:34:19.005295) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 51 secs) (at 2016-05-20 15:34:19.005912) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:19 INFO - MultiFileLogger online at 20160520 15:34:19 in /builds/slave/test 15:34:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:34:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:34:19 INFO - {'append_to_log': False, 15:34:19 INFO - 'base_work_dir': '/builds/slave/test', 15:34:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:34:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:34:19 INFO - 'branch': 'Firefox-Non-PGO', 15:34:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:19 INFO - 'config_files': ('talos/linux_config.py',), 15:34:19 INFO - 'default_actions': ('clobber', 15:34:19 INFO - 'read-buildbot-config', 15:34:19 INFO - 'download-and-extract', 15:34:19 INFO - 'populate-webroot', 15:34:19 INFO - 'create-virtualenv', 15:34:19 INFO - 'install', 15:34:19 INFO - 'run-tests'), 15:34:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:19 INFO - 'download_minidump_stackwalk': True, 15:34:19 INFO - 'download_symbols': 'ondemand', 15:34:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:34:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:34:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:34:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:34:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:19 INFO - 'installer_path': 'installer.exe', 15:34:19 INFO - 'log_level': 'info', 15:34:19 INFO - 'log_name': 'talos', 15:34:19 INFO - 'log_to_console': True, 15:34:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:19 INFO - 'opt_config_files': (), 15:34:19 INFO - 'pip_index': False, 15:34:19 INFO - 'sps_profile': False, 15:34:19 INFO - 'sps_profile_interval': 0, 15:34:19 INFO - 'suite': 'dromaeojs-e10s', 15:34:19 INFO - 'system_bits': '32', 15:34:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:19 INFO - 'title': 'talos-linux64-ix-063', 15:34:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:19 INFO - 'use_talos_json': True, 15:34:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:34:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:19 INFO - 'work_dir': 'build'} 15:34:19 INFO - ##### 15:34:19 INFO - ##### Running clobber step. 15:34:19 INFO - ##### 15:34:19 INFO - Running pre-action listener: _resource_record_pre_action 15:34:19 INFO - Running main action method: clobber 15:34:19 INFO - rmtree: /builds/slave/test/build 15:34:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:20 INFO - Running post-action listener: _resource_record_post_action 15:34:20 INFO - ##### 15:34:20 INFO - ##### Finished clobber step (success) 15:34:20 INFO - ##### 15:34:20 INFO - ##### 15:34:20 INFO - ##### Running read-buildbot-config step. 15:34:20 INFO - ##### 15:34:20 INFO - Running pre-action listener: _resource_record_pre_action 15:34:20 INFO - Running main action method: read_buildbot_config 15:34:20 INFO - Using buildbot properties: 15:34:20 INFO - { 15:34:20 INFO - "project": "", 15:34:20 INFO - "product": "firefox", 15:34:20 INFO - "script_repo_revision": "production", 15:34:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:34:20 INFO - "repository": "", 15:34:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:34:20 INFO - "buildid": "20160520140829", 15:34:20 INFO - "pgo_build": "False", 15:34:20 INFO - "basedir": "/builds/slave/test", 15:34:20 INFO - "buildnumber": 325, 15:34:20 INFO - "slavename": "talos-linux64-ix-063", 15:34:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:34:20 INFO - "platform": "ubuntu64_hw", 15:34:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:34:20 INFO - "branch": "mozilla-central", 15:34:20 INFO - "repo_path": "mozilla-central", 15:34:20 INFO - "revision": "c403ac05b8f42e44a5f7a0c98c2bf190b28706b1", 15:34:20 INFO - "stage_platform": "linux64", 15:34:20 INFO - "builduid": "5a00da35498647a7b497243bdef7bec1", 15:34:20 INFO - "slavebuilddir": "test" 15:34:20 INFO - } 15:34:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:34:20 INFO - Running post-action listener: _resource_record_post_action 15:34:20 INFO - ##### 15:34:20 INFO - ##### Finished read-buildbot-config step (success) 15:34:20 INFO - ##### 15:34:20 INFO - ##### 15:34:20 INFO - ##### Running download-and-extract step. 15:34:20 INFO - ##### 15:34:20 INFO - Running pre-action listener: _resource_record_pre_action 15:34:20 INFO - Running main action method: download_and_extract 15:34:20 INFO - mkdir: /builds/slave/test/build/tests 15:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:20 INFO - https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:34:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:34:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:34:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:34:22 INFO - Downloaded 1361 bytes. 15:34:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:34:22 INFO - Using the following test package requirements: 15:34:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:34:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'jsshell-linux-x86_64.zip'], 15:34:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:34:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:34:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:22 INFO - https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:34:28 INFO - Downloaded 22814329 bytes. 15:34:28 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'] 15:34:28 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 15:34:29 INFO - Return code: 0 15:34:29 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 15:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:29 INFO - https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:36:56 INFO - Downloaded 22814329 bytes. 15:36:56 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'] 15:36:56 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 15:36:58 INFO - Return code: 0 15:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:58 INFO - https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:36:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:36:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:38:58 INFO - Downloaded 10840359 bytes. 15:38:58 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'] 15:38:58 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 15:38:58 INFO - Return code: 0 15:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:58 INFO - https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:38:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:38:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:38:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmsNtxq1REaRrDf8IZFQvg/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 15:39:03 INFO - Downloaded 54811848 bytes. 15:39:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:39:03 INFO - mkdir: /builds/slave/test/properties 15:39:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:03 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:03 INFO - Contents: 15:39:03 INFO - build_url:https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:39:05 INFO - Running post-action listener: _resource_record_post_action 15:39:05 INFO - Running post-action listener: set_extra_try_arguments 15:39:05 INFO - ##### 15:39:05 INFO - ##### Finished download-and-extract step (success) 15:39:05 INFO - ##### 15:39:05 INFO - ##### 15:39:05 INFO - ##### Running populate-webroot step. 15:39:05 INFO - ##### 15:39:05 INFO - Running pre-action listener: _resource_record_pre_action 15:39:05 INFO - Running main action method: populate_webroot 15:39:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:05 INFO - '--tppagecycles', 15:39:05 INFO - '7'], 15:39:05 INFO - 'tests': ['tsvgm']}}, 15:39:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['damp', 'tps']}, 15:39:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'tests': ['damp', 'tps']}, 15:39:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['dromaeo_dom']}, 15:39:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['a11yr', 15:39:05 INFO - 'ts_paint', 15:39:05 INFO - 'tpaint', 15:39:05 INFO - 'sessionrestore', 15:39:05 INFO - 'sessionrestore_no_auto_restore', 15:39:05 INFO - 'tabpaint']}, 15:39:05 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:05 INFO - 'ts_paint', 15:39:05 INFO - 'tpaint', 15:39:05 INFO - 'sessionrestore', 15:39:05 INFO - 'sessionrestore_no_auto_restore', 15:39:05 INFO - 'tabpaint']}, 15:39:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:05 INFO - 'ts_paint', 15:39:05 INFO - 'tpaint', 15:39:05 INFO - 'sessionrestore', 15:39:05 INFO - 'sessionrestore_no_auto_restore', 15:39:05 INFO - 'tabpaint']}, 15:39:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:05 INFO - 'ts_paint', 15:39:05 INFO - 'tpaint', 15:39:05 INFO - 'sessionrestore', 15:39:05 INFO - 'sessionrestore_no_auto_restore', 15:39:05 INFO - 'tabpaint']}, 15:39:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['a11yr', 15:39:05 INFO - 'ts_paint', 15:39:05 INFO - 'tpaint', 15:39:05 INFO - 'sessionrestore', 15:39:05 INFO - 'sessionrestore_no_auto_restore', 15:39:05 INFO - 'tabpaint']}, 15:39:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['a11yr', 15:39:05 INFO - 'ts_paint', 15:39:05 INFO - 'tpaint', 15:39:05 INFO - 'sessionrestore', 15:39:05 INFO - 'sessionrestore_no_auto_restore', 15:39:05 INFO - 'tabpaint']}, 15:39:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['tsvgx', 15:39:05 INFO - 'tsvgr_opacity', 15:39:05 INFO - 'tart', 15:39:05 INFO - 'tscrollx', 15:39:05 INFO - 'cart']}, 15:39:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:05 INFO - 'tsvgr_opacity', 15:39:05 INFO - 'tart', 15:39:05 INFO - 'tscrollx', 15:39:05 INFO - 'cart']}, 15:39:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'talos_options': ['--disable-e10s'], 15:39:05 INFO - 'tests': ['tp5o']}, 15:39:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'tests': ['tp5o']}, 15:39:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'talos_options': ['--disable-e10s', 15:39:05 INFO - '--xperf_path', 15:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:05 INFO - 'tests': ['tp5n']}, 15:39:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:05 INFO - 'talos_options': ['--xperf_path', 15:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:05 INFO - 'tests': ['tp5n']}}, 15:39:05 INFO - 'talos.zip': {'path': '', 15:39:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:05 INFO - Running post-action listener: _resource_record_post_action 15:39:05 INFO - ##### 15:39:05 INFO - ##### Finished populate-webroot step (success) 15:39:05 INFO - ##### 15:39:05 INFO - ##### 15:39:05 INFO - ##### Running create-virtualenv step. 15:39:05 INFO - ##### 15:39:05 INFO - Running pre-action listener: _resource_record_pre_action 15:39:05 INFO - Running main action method: create_virtualenv 15:39:05 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:05 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 15:39:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:05 INFO - Using real prefix '/usr' 15:39:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:06 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:08 INFO - Installing pip.................done. 15:39:08 INFO - Return code: 0 15:39:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:39:08 INFO - Using env: {'DISPLAY': ':0', 15:39:08 INFO - 'HOME': '/home/cltbld', 15:39:08 INFO - 'LANG': 'en_US.UTF-8', 15:39:08 INFO - 'LANGUAGE': 'en_US:en', 15:39:08 INFO - 'LOGNAME': 'cltbld', 15:39:08 INFO - 'MAIL': '/var/mail/cltbld', 15:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:08 INFO - 'MOZ_NO_REMOTE': '1', 15:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:08 INFO - 'NO_EM_RESTART': '1', 15:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:08 INFO - 'PWD': '/builds/slave/test', 15:39:08 INFO - 'SHELL': '/bin/bash', 15:39:08 INFO - 'SHLVL': '1', 15:39:08 INFO - 'TERM': 'linux', 15:39:08 INFO - 'TMOUT': '86400', 15:39:08 INFO - 'USER': 'cltbld', 15:39:08 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:08 INFO - '_': '/tools/buildbot/bin/python'} 15:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:08 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 15:39:08 INFO - Cleaning up... 15:39:08 INFO - Return code: 0 15:39:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:39:08 INFO - Using env: {'DISPLAY': ':0', 15:39:08 INFO - 'HOME': '/home/cltbld', 15:39:08 INFO - 'LANG': 'en_US.UTF-8', 15:39:08 INFO - 'LANGUAGE': 'en_US:en', 15:39:08 INFO - 'LOGNAME': 'cltbld', 15:39:08 INFO - 'MAIL': '/var/mail/cltbld', 15:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:08 INFO - 'MOZ_NO_REMOTE': '1', 15:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:08 INFO - 'NO_EM_RESTART': '1', 15:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:08 INFO - 'PWD': '/builds/slave/test', 15:39:08 INFO - 'SHELL': '/bin/bash', 15:39:08 INFO - 'SHLVL': '1', 15:39:08 INFO - 'TERM': 'linux', 15:39:08 INFO - 'TMOUT': '86400', 15:39:08 INFO - 'USER': 'cltbld', 15:39:08 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:08 INFO - '_': '/tools/buildbot/bin/python'} 15:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:08 INFO - Downloading/unpacking psutil>=3.1.1 15:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:10 INFO - Installing collected packages: psutil 15:39:10 INFO - Running setup.py install for psutil 15:39:10 INFO - building 'psutil._psutil_linux' extension 15:39:10 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 15:39:12 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 15:39:12 INFO - building 'psutil._psutil_posix' extension 15:39:12 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 15:39:12 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 15:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:12 INFO - Successfully installed psutil 15:39:12 INFO - Cleaning up... 15:39:12 INFO - Return code: 0 15:39:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:39: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 mozsystemmonitor==0.3 15:39:12 INFO - Using env: {'DISPLAY': ':0', 15:39:12 INFO - 'HOME': '/home/cltbld', 15:39:12 INFO - 'LANG': 'en_US.UTF-8', 15:39:12 INFO - 'LANGUAGE': 'en_US:en', 15:39:12 INFO - 'LOGNAME': 'cltbld', 15:39:12 INFO - 'MAIL': '/var/mail/cltbld', 15:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:12 INFO - 'MOZ_NO_REMOTE': '1', 15:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:12 INFO - 'NO_EM_RESTART': '1', 15:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:12 INFO - 'PWD': '/builds/slave/test', 15:39:12 INFO - 'SHELL': '/bin/bash', 15:39:12 INFO - 'SHLVL': '1', 15:39:12 INFO - 'TERM': 'linux', 15:39:12 INFO - 'TMOUT': '86400', 15:39:12 INFO - 'USER': 'cltbld', 15:39:12 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:12 INFO - '_': '/tools/buildbot/bin/python'} 15:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:39:14 INFO - Installing collected packages: mozsystemmonitor 15:39:14 INFO - Running setup.py install for mozsystemmonitor 15:39:14 INFO - Successfully installed mozsystemmonitor 15:39:14 INFO - Cleaning up... 15:39:14 INFO - Return code: 0 15:39:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:14 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')]} 15:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:14 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')]} 15:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:14 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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:14 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 15:39:14 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 15:39:14 INFO - Using env: {'DISPLAY': ':0', 15:39:14 INFO - 'HOME': '/home/cltbld', 15:39:14 INFO - 'LANG': 'en_US.UTF-8', 15:39:14 INFO - 'LANGUAGE': 'en_US:en', 15:39:14 INFO - 'LOGNAME': 'cltbld', 15:39:14 INFO - 'MAIL': '/var/mail/cltbld', 15:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:14 INFO - 'MOZ_NO_REMOTE': '1', 15:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:14 INFO - 'NO_EM_RESTART': '1', 15:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:14 INFO - 'PWD': '/builds/slave/test', 15:39:14 INFO - 'SHELL': '/bin/bash', 15:39:14 INFO - 'SHLVL': '1', 15:39:14 INFO - 'TERM': 'linux', 15:39:14 INFO - 'TMOUT': '86400', 15:39:14 INFO - 'USER': 'cltbld', 15:39:14 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:14 INFO - '_': '/tools/buildbot/bin/python'} 15:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:17 INFO - Downloading docopt-0.6.1.tar.gz 15:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:17 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:17 INFO - Running setup.py install for blobuploader 15:39:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:17 INFO - Running setup.py install for requests 15:39:18 INFO - Running setup.py install for docopt 15:39:18 INFO - Successfully installed blobuploader requests docopt 15:39:18 INFO - Cleaning up... 15:39:18 INFO - Return code: 0 15:39:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:18 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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:18 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 15:39:18 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 15:39:18 INFO - Using env: {'DISPLAY': ':0', 15:39:18 INFO - 'HOME': '/home/cltbld', 15:39:18 INFO - 'LANG': 'en_US.UTF-8', 15:39:18 INFO - 'LANGUAGE': 'en_US:en', 15:39:18 INFO - 'LOGNAME': 'cltbld', 15:39:18 INFO - 'MAIL': '/var/mail/cltbld', 15:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:18 INFO - 'MOZ_NO_REMOTE': '1', 15:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:18 INFO - 'NO_EM_RESTART': '1', 15:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:18 INFO - 'PWD': '/builds/slave/test', 15:39:18 INFO - 'SHELL': '/bin/bash', 15:39:18 INFO - 'SHLVL': '1', 15:39:18 INFO - 'TERM': 'linux', 15:39:18 INFO - 'TMOUT': '86400', 15:39:18 INFO - 'USER': 'cltbld', 15:39:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:18 INFO - '_': '/tools/buildbot/bin/python'} 15:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:18 INFO - Running setup.py (path:/tmp/pip-CVoYd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:18 INFO - Running setup.py (path:/tmp/pip-NLOib_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:18 INFO - Running setup.py (path:/tmp/pip-pNVA7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:18 INFO - Running setup.py (path:/tmp/pip-ZrVkoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:18 INFO - Running setup.py (path:/tmp/pip-AVogdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:19 INFO - Running setup.py (path:/tmp/pip-Pz1Edv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:19 INFO - Running setup.py (path:/tmp/pip-oI5Q_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:19 INFO - Running setup.py (path:/tmp/pip-ne1ASf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:19 INFO - Running setup.py (path:/tmp/pip-MrYb1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:19 INFO - Running setup.py (path:/tmp/pip-1K7TkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:19 INFO - Running setup.py (path:/tmp/pip-NWBMj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:19 INFO - Running setup.py (path:/tmp/pip-K0myek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:19 INFO - Running setup.py (path:/tmp/pip-_dYsD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:19 INFO - Running setup.py (path:/tmp/pip-rG8bnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:19 INFO - Running setup.py (path:/tmp/pip-gHcChP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:19 INFO - Running setup.py (path:/tmp/pip-Hcax1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:19 INFO - Running setup.py (path:/tmp/pip-i_wdOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:19 INFO - Running setup.py install for manifestparser 15:39:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:19 INFO - Running setup.py install for mozcrash 15:39:20 INFO - Running setup.py install for mozdebug 15:39:20 INFO - Running setup.py install for mozdevice 15:39:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Running setup.py install for mozfile 15:39:20 INFO - Running setup.py install for mozhttpd 15:39:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Running setup.py install for mozinfo 15:39:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Running setup.py install for mozInstall 15:39:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Running setup.py install for mozleak 15:39:20 INFO - Running setup.py install for mozlog 15:39:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:20 INFO - Running setup.py install for moznetwork 15:39:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:21 INFO - Running setup.py install for mozprocess 15:39:21 INFO - Running setup.py install for mozprofile 15:39:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:21 INFO - Running setup.py install for mozrunner 15:39:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:21 INFO - Running setup.py install for mozscreenshot 15:39:21 INFO - Running setup.py install for moztest 15:39:21 INFO - Running setup.py install for mozversion 15:39:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:21 INFO - Cleaning up... 15:39:21 INFO - Return code: 0 15:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:21 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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:21 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 15:39:21 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 15:39:21 INFO - Using env: {'DISPLAY': ':0', 15:39:21 INFO - 'HOME': '/home/cltbld', 15:39:21 INFO - 'LANG': 'en_US.UTF-8', 15:39:21 INFO - 'LANGUAGE': 'en_US:en', 15:39:21 INFO - 'LOGNAME': 'cltbld', 15:39:21 INFO - 'MAIL': '/var/mail/cltbld', 15:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:21 INFO - 'MOZ_NO_REMOTE': '1', 15:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:21 INFO - 'NO_EM_RESTART': '1', 15:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:21 INFO - 'PWD': '/builds/slave/test', 15:39:21 INFO - 'SHELL': '/bin/bash', 15:39:21 INFO - 'SHLVL': '1', 15:39:21 INFO - 'TERM': 'linux', 15:39:21 INFO - 'TMOUT': '86400', 15:39:21 INFO - 'USER': 'cltbld', 15:39:21 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:21 INFO - '_': '/tools/buildbot/bin/python'} 15:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:21 INFO - Running setup.py (path:/tmp/pip-trZRn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:21 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)) 15:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:21 INFO - Running setup.py (path:/tmp/pip-Oi1hpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:22 INFO - Running setup.py (path:/tmp/pip-ov0hcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:22 INFO - Running setup.py (path:/tmp/pip-x2Yiie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:22 INFO - Running setup.py (path:/tmp/pip-LRtQwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:22 INFO - Running setup.py (path:/tmp/pip-kFP72h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:22 INFO - Running setup.py (path:/tmp/pip-iupJ3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:22 INFO - Running setup.py (path:/tmp/pip-ctx50A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:22 INFO - Running setup.py (path:/tmp/pip-F0n6Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:22 INFO - Running setup.py (path:/tmp/pip-uLN0m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:22 INFO - Running setup.py (path:/tmp/pip-m6YWvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:22 INFO - Running setup.py (path:/tmp/pip-Ve9tSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:22 INFO - Running setup.py (path:/tmp/pip-Lajl7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:22 INFO - Running setup.py (path:/tmp/pip-obqFOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:22 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)) 15:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:22 INFO - Running setup.py (path:/tmp/pip-1WINwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:23 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)) 15:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:23 INFO - Running setup.py (path:/tmp/pip-9_YW_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:23 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)) 15:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:23 INFO - Running setup.py (path:/tmp/pip-J2AjKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:23 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)) 15:39:23 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)) 15:39:23 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)) 15:39:23 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)) 15:39:23 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)) 15:39:23 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)) 15:39:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:25 INFO - Downloading blessings-1.6.tar.gz 15:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:25 INFO - Installing collected packages: blessings 15:39:25 INFO - Running setup.py install for blessings 15:39:27 INFO - Successfully installed blessings 15:39:27 INFO - Cleaning up... 15:39:27 INFO - Return code: 0 15:39:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:28 INFO - Reading from file tmpfile_stdout 15:39:28 INFO - Current package versions: 15:39:28 INFO - argparse == 1.2.1 15:39:28 INFO - blessings == 1.6 15:39:28 INFO - blobuploader == 1.2.4 15:39:28 INFO - docopt == 0.6.1 15:39:28 INFO - manifestparser == 1.1 15:39:28 INFO - mozInstall == 1.12 15:39:28 INFO - mozcrash == 0.17 15:39:28 INFO - mozdebug == 0.1 15:39:28 INFO - mozdevice == 0.48 15:39:28 INFO - mozfile == 1.2 15:39:28 INFO - mozhttpd == 0.7 15:39:28 INFO - mozinfo == 0.9 15:39:28 INFO - mozleak == 0.1 15:39:28 INFO - mozlog == 3.2 15:39:28 INFO - moznetwork == 0.27 15:39:28 INFO - mozprocess == 0.22 15:39:28 INFO - mozprofile == 0.28 15:39:28 INFO - mozrunner == 6.11 15:39:28 INFO - mozscreenshot == 0.1 15:39:28 INFO - mozsystemmonitor == 0.3 15:39:28 INFO - moztest == 0.7 15:39:28 INFO - mozversion == 1.4 15:39:28 INFO - psutil == 3.1.1 15:39:28 INFO - requests == 1.2.3 15:39:28 INFO - wsgiref == 0.1.2 15:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:28 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')]} 15:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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')]} 15:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:28 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 15:39:28 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 15:39:28 INFO - Using env: {'DISPLAY': ':0', 15:39:28 INFO - 'HOME': '/home/cltbld', 15:39:28 INFO - 'LANG': 'en_US.UTF-8', 15:39:28 INFO - 'LANGUAGE': 'en_US:en', 15:39:28 INFO - 'LOGNAME': 'cltbld', 15:39:28 INFO - 'MAIL': '/var/mail/cltbld', 15:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:28 INFO - 'MOZ_NO_REMOTE': '1', 15:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:28 INFO - 'NO_EM_RESTART': '1', 15:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:28 INFO - 'PWD': '/builds/slave/test', 15:39:28 INFO - 'SHELL': '/bin/bash', 15:39:28 INFO - 'SHLVL': '1', 15:39:28 INFO - 'TERM': 'linux', 15:39:28 INFO - 'TMOUT': '86400', 15:39:28 INFO - 'USER': 'cltbld', 15:39:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:28 INFO - '_': '/tools/buildbot/bin/python'} 15:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 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)) 15:39:28 INFO - Cleaning up... 15:39:28 INFO - Return code: 0 15:39:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39:28 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')]} 15:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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')]} 15:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:28 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 15:39:28 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 15:39:28 INFO - Using env: {'DISPLAY': ':0', 15:39:28 INFO - 'HOME': '/home/cltbld', 15:39:28 INFO - 'LANG': 'en_US.UTF-8', 15:39:28 INFO - 'LANGUAGE': 'en_US:en', 15:39:28 INFO - 'LOGNAME': 'cltbld', 15:39:28 INFO - 'MAIL': '/var/mail/cltbld', 15:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:28 INFO - 'MOZ_NO_REMOTE': '1', 15:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:28 INFO - 'NO_EM_RESTART': '1', 15:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:28 INFO - 'PWD': '/builds/slave/test', 15:39:28 INFO - 'SHELL': '/bin/bash', 15:39:28 INFO - 'SHLVL': '1', 15:39:28 INFO - 'TERM': 'linux', 15:39:28 INFO - 'TMOUT': '86400', 15:39:28 INFO - 'USER': 'cltbld', 15:39:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:28 INFO - '_': '/tools/buildbot/bin/python'} 15:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:28 INFO - Downloading/unpacking jsonschema 15:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:32 INFO - Downloading/unpacking functools32 (from jsonschema) 15:39:32 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 15:39:32 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 15:39:32 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 15:39:32 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 15:39:32 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 15:39:32 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 15:39:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:32 INFO - warning: no files found matching '*.txt' 15:39:32 INFO - no previously-included directories found matching 'build' 15:39:32 INFO - no previously-included directories found matching 'dist' 15:39:32 INFO - no previously-included directories found matching '.git*' 15:39:32 INFO - Installing collected packages: jsonschema, functools32 15:39:33 INFO - Running setup.py install for functools32 15:39:33 INFO - warning: no files found matching '*.txt' 15:39:33 INFO - no previously-included directories found matching 'build' 15:39:33 INFO - no previously-included directories found matching 'dist' 15:39:33 INFO - no previously-included directories found matching '.git*' 15:39:33 INFO - Successfully installed jsonschema functools32 15:39:33 INFO - Cleaning up... 15:39:33 INFO - Return code: 0 15:39:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:33 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 0x7f0d1dd1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', '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 15:39:33 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 15:39:33 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 15:39:33 INFO - Using env: {'DISPLAY': ':0', 15:39:33 INFO - 'HOME': '/home/cltbld', 15:39:33 INFO - 'LANG': 'en_US.UTF-8', 15:39:33 INFO - 'LANGUAGE': 'en_US:en', 15:39:33 INFO - 'LOGNAME': 'cltbld', 15:39:33 INFO - 'MAIL': '/var/mail/cltbld', 15:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:33 INFO - 'MOZ_NO_REMOTE': '1', 15:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:33 INFO - 'NO_EM_RESTART': '1', 15:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:33 INFO - 'PWD': '/builds/slave/test', 15:39:33 INFO - 'SHELL': '/bin/bash', 15:39:33 INFO - 'SHLVL': '1', 15:39:33 INFO - 'TERM': 'linux', 15:39:33 INFO - 'TMOUT': '86400', 15:39:33 INFO - 'USER': 'cltbld', 15:39:33 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:33 INFO - '_': '/tools/buildbot/bin/python'} 15:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:33 INFO - Downloading/unpacking flake8 15:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:39:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:39:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:35 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 15:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:39:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:36 INFO - no previously-included directories found matching 'docs/_build' 15:39:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:39:36 INFO - Running setup.py install for pep8 15:39:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:36 INFO - no previously-included directories found matching 'docs/_build' 15:39:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:39:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:39:36 INFO - Cleaning up... 15:39:36 INFO - Return code: 0 15:39:36 INFO - Running post-action listener: _resource_record_post_action 15:39:36 INFO - Running post-action listener: _start_resource_monitoring 15:39:36 INFO - Starting resource monitoring. 15:39:36 INFO - ##### 15:39:36 INFO - ##### Finished create-virtualenv step (success) 15:39:36 INFO - ##### 15:39:36 INFO - ##### 15:39:36 INFO - ##### Running install step. 15:39:36 INFO - ##### 15:39:36 INFO - Running pre-action listener: _resource_record_pre_action 15:39:36 INFO - Running main action method: install 15:39:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:36 INFO - Reading from file tmpfile_stdout 15:39:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:39:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:39:36 INFO - Reading from file tmpfile_stdout 15:39:36 INFO - Output received: 15:39:36 INFO - Usage: mozinstall [options] installer 15:39:36 INFO - Options: 15:39:36 INFO - -h, --help show this help message and exit 15:39:36 INFO - -d DEST, --destination=DEST 15:39:36 INFO - Directory to install application into. [default: 15:39:36 INFO - "/builds/slave/test"] 15:39:36 INFO - --app=APP Application being installed. [default: firefox] 15:39:36 INFO - mkdir: /builds/slave/test/build/application 15:39:36 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'] 15:39:36 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 15:39:52 INFO - Reading from file tmpfile_stdout 15:39:52 INFO - Output received: 15:39:52 INFO - /builds/slave/test/build/application/firefox/firefox 15:39:52 INFO - Running post-action listener: _resource_record_post_action 15:39:52 INFO - ##### 15:39:52 INFO - ##### Finished install step (success) 15:39:52 INFO - ##### 15:39:52 INFO - ##### 15:39:52 INFO - ##### Running run-tests step. 15:39:52 INFO - ##### 15:39:52 INFO - Running pre-action listener: _resource_record_pre_action 15:39:52 INFO - Running main action method: run_tests 15:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:39:52 INFO - Python 2.7.3 15:39:52 INFO - Return code: 0 15:39:52 INFO - grabbing minidump binary from tooltool 15:39:52 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')]} 15:39:52 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 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:39:52 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 15:39:52 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 15:39:52 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 15:39:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:39:54 INFO - Return code: 0 15:39:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:39:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:39:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:39:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:39:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:39:59 INFO - Return code: 0 15:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 15:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 15:39:59 INFO - Using env: {'DISPLAY': ':0', 15:39:59 INFO - 'HOME': '/home/cltbld', 15:39:59 INFO - 'LANG': 'en_US.UTF-8', 15:39:59 INFO - 'LANGUAGE': 'en_US:en', 15:39:59 INFO - 'LOGNAME': 'cltbld', 15:39:59 INFO - 'MAIL': '/var/mail/cltbld', 15:39:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:39:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:59 INFO - 'MOZ_NO_REMOTE': '1', 15:39:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:59 INFO - 'NO_EM_RESTART': '1', 15:39:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:59 INFO - 'PWD': '/builds/slave/test', 15:39:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:39:59 INFO - 'SHELL': '/bin/bash', 15:39:59 INFO - 'SHLVL': '1', 15:39:59 INFO - 'TERM': 'linux', 15:39:59 INFO - 'TMOUT': '86400', 15:39:59 INFO - 'USER': 'cltbld', 15:39:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401', 15:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:59 INFO - '_': '/tools/buildbot/bin/python'} 15:39:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 15:40:07 INFO - mozversion application_buildid: 20160520140829 15:40:07 INFO - mozversion application_changeset: c403ac05b8f42e44a5f7a0c98c2bf190b28706b1 15:40:07 INFO - mozversion application_display_name: Nightly 15:40:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:07 INFO - mozversion application_name: Firefox 15:40:07 INFO - mozversion application_remotingname: firefox 15:40:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:40:07 INFO - mozversion application_vendor: Mozilla 15:40:07 INFO - mozversion application_version: 49.0a1 15:40:07 INFO - mozversion platform_buildid: 20160520140829 15:40:07 INFO - mozversion platform_changeset: c403ac05b8f42e44a5f7a0c98c2bf190b28706b1 15:40:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:40:07 INFO - mozversion platform_version: 49.0a1 15:40:07 INFO - using testdate: 1463784007 15:40:07 INFO - actual date: 1463784007 15:40:07 INFO - starting webserver on 'localhost:34292' 15:40:07 INFO - SUITE-START | Running 2 tests 15:40:07 INFO - TEST-START | dromaeo_css 15:40:07 INFO - operating with platform_type : linux_ 15:40:07 INFO - Initialising browser for dromaeo_css test... 15:40:08 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5u5Yy3/profile http://localhost:34292/getInfo.html) 15:40:14 INFO - PROCESS | 3320 | 15:40:14 INFO - PROCESS | 3320 | (process:3388): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:40:15 INFO - PROCESS | 3320 | __metrics Screen width/height:1600/1200 15:40:15 INFO - PROCESS | 3320 | colorDepth:24 15:40:15 INFO - PROCESS | 3320 | Browser inner width/height: 1024/697 15:40:15 INFO - PROCESS | 3320 | __metrics 15:40:17 ERROR - PROCESS | 3320 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:40:18 INFO - TEST-INFO | 3320: exit 0 15:40:18 INFO - Browser initialized. 15:40:18 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:18 INFO - TEST-INFO | started process 3441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5u5Yy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:20 INFO - PROCESS | 3441 | 15:40:20 INFO - PROCESS | 3441 | (process:3502): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:40:30 INFO - PROCESS | 3441 | RSS: Main: 165347328 15:40:30 INFO - PROCESS | 3441 | 15:41:19 INFO - PROCESS | 3441 | 1463784079758 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] 15:43:31 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:34292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34292/tests/dromaeo/cssquery-ext.html) 15:43:32 INFO - PROCESS | 3441 | RSS: Main: 169021440 15:43:32 INFO - PROCESS | 3441 | 15:46:34 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:34292/tests/dromaeo/cssquery-ext.html (next: http://localhost:34292/tests/dromaeo/cssquery-jquery.html) 15:46:35 INFO - PROCESS | 3441 | RSS: Main: 167596032 15:46:35 INFO - PROCESS | 3441 | 15:49:37 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:34292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34292/tests/dromaeo/cssquery-mootools.html) 15:49:37 INFO - PROCESS | 3441 | RSS: Main: 168398848 15:49:37 INFO - PROCESS | 3441 | 15:52:39 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:34292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34292/tests/dromaeo/cssquery-prototype.html) 15:52:40 INFO - PROCESS | 3441 | RSS: Main: 166219776 15:52:40 INFO - PROCESS | 3441 | 15:55:43 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:34292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34292/tests/dromaeo/cssquery-yui.html) 15:55:43 INFO - PROCESS | 3441 | RSS: Main: 167841792 15:55:43 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:34292/tests/dromaeo/cssquery-yui.html (next: http://localhost:34292/tests/dromaeo/cssquery-dojo.html) 15:58:46 INFO - PROCESS | 3441 | RSS: Main: 169418752 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | __start_tp_report 15:58:46 INFO - PROCESS | 3441 | _x_x_mozilla_page_load 15:58:46 INFO - PROCESS | 3441 | _x_x_mozilla_page_load_details 15:58:46 INFO - PROCESS | 3441 | |i|pagename|runs| 15:58:46 INFO - PROCESS | 3441 | |0;dojo.html;2632.8551929643872;2698.622192892994;2706.3369474478754;2707.864606769661;2724.8092633515657;4704.247320428728;4715.717056976584;4726.172919739045;4770.713757174563;4785.234362502;4587.105514424688;4714.457837348706;4736.478987311393;4749.145153872301;4752.7148371097755;4311.288637374837;4378.8029538670835;4399.802008909607;4421.115776844644;4444.666650001247;4376.168527979674;4435.112977404532;4450.087732014946;4477.664175186857;4523.570260825233;4298.4197133387215;4318.050028993616;4336.067745434715;4375.08123294107;4383.145286669101;4297.119090586422;4308.547602501723;4347.804348804311;4378.540253273392;4394.912101757979;4335.219660461115;4352.129574085164;4360.716553424018;4363.847265345729;4412.492563355191;4561.1789877821975;4644.814207431698;4650.0932318197965;4662.417197850269;4676.298555216711;5089.134847076006;5097.929434818656;5101.948980510221;5110.054639891595;5147.202183661539;4924.679895806797;5111.642185047048;5144.536991670768;5147.974260128675;5201.297824793643;4741.288806679026;4807.206810876236;4814.325994360793;4817.253325734517;4867.415910090776;5271.262023316739;5271.341082364705;5279.841604751787;5284.445133261029;5286.735663216824;4757.09615173116;4835.347228124228;4933.679310844784;5044.092063428545;5065.594752419871;4925.1873440881855;5024.070546948826;5044.066847633199;5045.117104506697;5094.5669618082875;5053.7220452875445;5065.341505604321;5074.771635276422;5076.466970968069;5081.568066714371;4844.781984810622;4874.7562621868765;5046.268291097844;5058.190689489737;5130.358705161855;4331.371951067078;4356.956430435718;4360.934585981213;4396.208682437192;4402.405675233803;3778.508793856781;3784.5647750509042;3811.3711237646035;3830.9042273943373;3844.8462061517785;4241.7879106044575;4318.265894797892;4328.588784065509;4349.869503914888;4368.825246990084;5074.3657042869645;5081.212412076134;5083.898322033612;5090.185570308807;5133.383993920754;4330.913381732347;4347.673924455678;4357.716748411343;4361.934570981438;4389.670774691847;4363.52001279859;4525.547445255448;4554.544545545419;4590.059037897223;4593.839215627504;4772.737499437495;4774.904501909942;4775.164346239464;4775.570198682135;4811.927821082757;5084.51697088776;5118.155504341742;5118.360204974379;5127.128388173945;5173.844784656466;4606.700564463299;4738.905221895474;4757.524247575215;4779.163646361803;4783.521647835189;4990.5508504234795;4997.575206107376;5003.074431230234;5010.536408033741;5071.0872043032605;4949.183384741477;5101.0818052750865;5101.7194054327365;5123.666961647481;5155;4761.928571071506;4904.092742842586;4937.061958227925;4966.056449274626;4992.350994370709;4885.731284779371;4931.654784165074;4958.504149585013;4967.552920237196;4971.477994810492;4850.17547017015;4864.246041863516;4866.099771542276;4874.610031197567;4926.3349447824085;4798.088363210979;4998.050370429607;5011.348524691913;5015.498450154955;5058.721770302669;4851.32081508582;4902.166631672696;4906.190478571139;4932.753362331798;4960.528749768766 15:58:46 INFO - PROCESS | 3441 | |1;ext.html;568.6332315656401;591.5711109445652;605.2222893581749;619.8822223777482;626.3861415812501;35129.47305790415;39745.40381894274;39775.4202121809;39798;39908.40137397938;40183.59816401835;40477.17852696629;40659;40670.59329406713;40913.59086409135;7533.133689625681;7734;7782.883256751154;7789.10425301092;7805.492642978216;7659.808504787369;7737.032870891138;7749.070111586618;7758.844823103563;7775.883361749578;7757.883631745528;7764.689412423496;7781.610919454033;7801.726939557117;7813.02337207849;7652.808679782995;7724.073111226632;7745.961270193641;7787.649555769975;7809.531428114331;7529.661165247577;7636.694532218705;7647.617619119077;7648.2351764823625;7653.043369578802;30299.848500757354;36897.26205475876;37394.81302593497;37418.81290593557;37463.25073498515;3005.2637103909465;3027.228056845512;3095.7523398128096;3383.695467407945;3603.225306559076;27531;30056.549151762523;30727.692723072705;30790.23024424385;31059.223519412197;3425.0910848946187;3546.946795798065;3557.5730912290433;3590.910227244314;3622.2755448910325;268886;269366;272324;273504;274834;57424.42575574274;58724;58903;59115;59119;33878;34611;34877.82561087178;62798.686006569675;63178.36821631725;13236.13965092266;13311.73376532464;13313.40089695966;13334.599962001155;13336.599902002956;9877.16044136242;9951.452670103068;9953.900460995297;9961.153301969414;9979.60081596728;19053.7141942871;19352.903235484013;19393.812521494707;19423.708644370345;19486.415407537796;7484.625768711543;7581.772546823604;7699.422543309274;7755.72854950074;7850.528968261922;872.6073267029735;990.4503000834605;1001.0340021878922;1001.9198464122853;1051.9073922667333;28840.711592883803;28900.855495722386;28929.276768080967;29003.12990610285;29038.12885613435;914.7621618379136;994.2493417469908;1000.9949950250202;1044.796264728386;1059.2479339668766;15103.848961510465;15245.085294882343;15262.847371526364;15387.46143884981;15476.458323958832;386968;657468;673322;677493;677777;51537.7423112882;51935;52304.47695523072;52323.73838130785;52494.73752631212;1208.4380762945098;1212.7089498520293;1214.2046959241711;1228.3735294999435;1240.999999999982;27594;28581.714182857904;28672.85663571669;28952.855235723688;29142.417151656424;42941;43041.13917721691;43416.78291608648;43606.781966091236;43703.78148109239;339793;340694;341176;341332;344900;25451.74548254494;25687.871560642077;25715.742842572083;25826.096086636877;25851.353716156493;41126.79436602798;41413;41559.7922010388;41621.37567936544;43096.78451607847;35047.299054018265;36580;37848.24303513969;38244;38473.230535389695;33711.494327584616;37117.81441092777;37160;37258.813705931294;37519.81240093782;36412.81793591015;36895.815520922224;36962.26075478529;36965.81517092505;37029.44455833219;32808;33203.83398082994;33304.666953330154;33886.83056584701;34093.48859767155;25131.748682513673;25377.87311063433;25479.36301592475;26020.60969085503;26028.21915342467 15:58:46 INFO - PROCESS | 3441 | |2;jquery.html;359.6223964836922;362.3676684186096;367.509374984396;381.33647453431036;382.9195868867538;15687.764683529742;17061.658766824658;17121.91439042806;17472.563185920357;17536.561585960357;16076.517704468855;16206.432774852883;16347.509574712747;16507.66984660306;16521.66956660869;5067.062593420211;5201.817936372227;5246.449122842104;5254.316938797951;5265.815696450625;3825.7895815730126;5181.715005674687;5794.6523208607405;6090.695465226743;6107.938920610782;6131.969340153293;6142.109394137848;6153.723082461278;6173.845653858644;6187.164732761087;5263.447338029509;5594.468525490092;5622.578306626999;5648.293963254593;5649.435056494359;5311.548518375943;5442.428545002757;5443.564514838803;5478.068728316196;5487.6981766003255;12793.744125117446;12826;12877.549285774952;12940.935295323463;13034.217946923214;1795.3357257814562;1861.525311045688;1886.5943822078318;1938.185961896007;1957.5204075001573;9423.670171543963;11005.889941100646;12546.808053234929;12876.742465150739;12926.87073129266;1660.286076986895;1700.5068530126373;1757.3761314733213;1796.1917137288272;1827.5979284557377;72012;72281.63859180723;72388.99999999948;73181.63409182974;73878;9939.304248702667;10109.696709098738;10273.74315642115;10304.742381440525;10417.895821041693;14052.71894562103;14065.859341406454;14072.2963851807;14081.929590351983;14120.646983825487;6625.834354141089;6632.2704502504685;6676.332366763285;6737.730490780412;6831.726730930806;6047.0929360596265;6063.363346848518;6171.290301615282;6186.597871138361;6248.31268560458;4340.500842403164;4435.889102772457;4495.797689103998;4517.141743068806;4540.250858608359;1719.5701074731317;1780.1722199177445;1814.2108182940462;1860.8790428622096;1874.2877706471454;819.2913130142384;890.3189060368823;939.3940908114228;968.041638777605;983.7540614846289;15658.9217053914;16168.331112408861;16563.585910352336;16608.83391166097;16612.916935415247;917.6191880369572;919.5494207838245;929.6792606550729;933.3653115881131;945.3666043750703;9119.817603648022;9221.769455763659;9404.482753448488;9525;9588.089131532493;378533;380808;383937;388656;393700;75419.62290188624;77129;77132.22867771363;77142.6142869282;78109.60945195238;882.2544949517647;895.3061377432542;911.7766147293955;915.1809130827871;917.5504003038596;14961.40154393812;15027.248637568297;15218.695626087638;15229.923850381121;15236.3905443781;34132.488012679336;34994.300113998084;35540.111497212776;35578.64421355857;35659;47004;47374.28938565855;48278.275825861936;48642.75678621584;48738.5126148734;7617.047869016373;7623.313901748647;7896.84206315882;7941.444098913252;7945.404094692805;9434.95282523583;9985.450800205768;10789.244752867224;11626.244294120856;11986.340751258764;9710.563024664048;9712.611495540099;9907.02515350557;10146.391216527032;10356.637517686844;9422.905770942203;10194.643187488402;10204.081632653097;10258.692239232834;10369.896301037195;10105.797884042131;10290.228232882415;10293.279470436997;10359.430231337048;10383.376997380181;7770.45606807518;7800.102988156208;7849.136594974434;7854.567998759894;7855;9599.856002160113;9752.366096203725;9913.900860991298;10096.596136154765;10330.483475826028 15:58:46 INFO - PROCESS | 3441 | |3;mootools.html;1391.7494850926832;1411.2872999135434;1533.6625942292699;1711.1273250642184;1737.4700716281536;6717.529772915886;7351.852962940745;7571.545707257568;8052.63763130659;8076.636551355188;7682.731104411347;7790.220977902207;7845.960770196155;7857.057153141617;7893;2169.8155656769154;2203.427108951676;2226.6882636430914;2227.086894373307;2229.4314949687805;2183.3995651195887;2216.866987980726;2233.6314508106143;2238.9440263993447;2249.1453247765826;2195.868247905131;2217.390217690132;2218.4121207879925;2237.3064350051454;2240.361496973363;2119.42775450629;2124.787521247863;2131.9467013324715;2145.1741079684357;2146.087912637123;2119.9894000530053;2144.635411979967;2145.8305223653147;2149.140343862452;2175.434387059376;7847.9215207847765;7882.290593846581;7903.130655627876;7914.762557123296;7917.56453395063;4371.781410929472;4464.776761161929;4489.371487991683;4491.124230775;4512.796924138422;2784.4013537089622;2789.483945470074;2893.7684985201136;2912.4903141950076;2928.2532954096782;834.1033389106674;856.6230858422274;859.3984211052289;1757.8417942385247;1817.7727784026997;10699.572017119306;10814.837777433344;10842.566297348096;10864.45677716119;10923.180761442844;4086.9386959195635;4160.292750232407;4203.159368126387;4239.745615263094;4242.8727138185905;8493.27807136388;8507.914920850711;8520.70177543783;8525.65897364111;8539.14608539141;4421.9336709949375;4432.800523976429;4470.865874023784;4500.662450316239;4507.954920450819;3594.6225646307284;3974.5627980922077;4013.3979903014783;4048.473698419187;4079.469668943078;3387.5765529308837;3394.8981530554124;3468.635793241673;3469.0980345109947;3490.3542844573835;991.7818080022383;1027.060239880501;1028.876534815827;1029.7477118106112;1035.2132379391717;849.8257857139272;876.0801158783252;892.5849479991705;918.669279059538;934.6261495401758;5313.495217954288;5403.675779453245;5474.233607294982;5514.944850551443;5572.498475137257;414.4342971843412;416.0783863741766;418.11777150213027;424.09455811841326;426.75035104463615;3467.1678797088516;3557.6442355764734;3568.2685049564775;3596.946045809315;3628.8911332660064;9181.495017773954;9753.804923901624;9776.413415195111;9785.412875227366;9789.412635241908;9505.762355941157;9672.177864881563;9682.75793105164;9704.078112579293;9712.22302215821;7285.453590980697;7312.634368281671;7381.298776616213;7389.852202955911;7400.703971841173;5395.190721391823;5399.568034557147;5475.698836564027;5487.478689524489;5542.168674698666;8752.64989400417;8841.69054083104;8864.20222180007;9098.818023639358;9124.589393477178;9044.186023257938;9055.954720226357;9087.36388452802;9112;9219.585118669811;5835.56233282497;6176.197094377702;6350.523710721622;6351.364863513611;6401.487880969605;7607.619619018917;7651.043619547557;7686.116096648957;7723.691052357843;7738.071431428265;6655.534112612071;6717.395434410926;6727.125473688389;6761.290064543152;6938.722451101899;6513.73945042193;6568;6592.505562082767;6604.273529911802;6729.730810767514;6456;6528.477721782341;6574.0796288520605;6598.703058362289;6633.402993730588;4741.217699079613;4742.146413645577;4748.857534273978;4773.284007398918;4795.20879054952;4721.763911804327;4786.784594693317;4821.710697358169;4843.2250839866865;4849.369581954324 15:58:46 INFO - PROCESS | 3441 | |4;prototype.html;286.1173280429875;295.782599789155;301.0621912741809;303.2781978890241;303.6538346285235;4932.408111026682;5037.319961805155;5117.462666420023;5151.871203219916;5159.793608255665;4723.220668589687;4890.364252647159;4914.795875010618;5009.69941803492;5046.84859454217;3964.9207015859665;3989.620986006332;4005.539362973266;4015.518137823465;4026.9798651006704;4000.3199456092534;4030.9395359069636;4032.6773858091283;4034.69739769517;4034.7175697701173;3678.282734866702;3891.591382904797;3898.259330727167;3977.76133431995;4005.5193376794828;3875.61243875613;3876.7286289959716;3884.378499440076;3906.824192911326;3911.159100793343;3414.5658823294275;3422;3428.5542879425766;3450;3453.326601312745;4835.202191638376;4918.557329840296;4918.680285781413;4920.662685224525;4947.134251505972;4488.214562451558;4504.256797628387;4504.2793153095345;4515.14212299662;4517.796699148546;5292.338457692788;5299.602529810241;5309.256704061435;5314.1497360422145;5319.7340132993195;3707.8331475083687;3728.683061939711;3729.6083911189207;3735.831887565066;3764.9247015059545;5277.287566178594;5358.3837858645975;5469.331853784594;5589.329280486327;5609.49514543693;3763.9059023524633;3764.6800021997888;3788.4696142540065;3790.2040571480297;3822.2164456286396;3802.3726085196186;3808.5239345081864;3818.663467786308;3827.234553089393;3835.9041023974064;4412.852658308862;4437.400950871591;4439.911201776011;4459.0858873930765;4465.776711164429;5120.462351453044;5264.447233040552;5285.154375299933;5289.18017707256;5317.680939143664;1299.9480020799251;1335.8730920562532;1338.0633556510481;1340.4906135668577;1340.9061365704308;813.7436707437139;841.8568843296532;842.4650347029681;863.2619110660421;874.7944233105216;4123.628873401408;4130.483689538808;4131.710780245414;4137.186713035105;4147.730397524151;4826.359037927122;4877.609791216694;4878.512148785164;4897.461279259279;4898.868991988496;4111.116110036357;4115.485564304462;4119.9176016480105;4138.668906487474;4152.833886644561;2522.646829443879;2608.6347911292432;2622.5672763993725;2624.73752624736;2631.5789473684504;4501.662375321864;4538.547664747249;4559.791655211372;4595.494495605481;4603.355530225771;4909.337239472626;4912.975435122873;4927;4972.627052971042;5008.398992120969;4222.057853387415;4523.570260825217;4561.2245918193985;4568.999999999934;4593.56361145704;4816.638752093537;4845.709257444564;4867.829625963216;4892.65751397413;4893.363862697969;4768.666193366431;4776.522347765195;4792.849716068188;4795.482371754857;4813.326134341265;4359.520452750258;4554.612857906983;4559.202139625619;4607.193741095362;4612.316504475909;3426.6230714620874;3441.621421643567;3445.6037555680414;3459.68862802349;3489.354469423165;4904.730239836843;4926.3349447824085;4937.851864444073;4938.888500244822;4967.850964471072;4775.209296513807;4777.665563410528;5039.218921067094;5420.268263784339;5428.131498960305;5368.8389348319615;5414.783408663609;5418.566514678895;5431.2667789847865;5449.076664801337;5264.657797243167;5269.973650131725;5296.867578310573;5306.469353064663;5313.256144139901;5282.76227569768;5427.674339539641;5431.755570999236;5444.8366549003595;5446.972765136149;5311.194193974067;5318.03232803865;5342.278792362981;5343.9198412024625;5380.784768609368 15:58:46 INFO - PROCESS | 3441 | |5;yui.html;652.4421619515314;769.6382700130938;774.0595176860118;775.2170307988933;785.0461689047813;10924.235303528747;11437.485313160896;11447.5993340233;13796.655083622914;14283.143011419295;14248.002639815191;14256.786148207786;14280.214588197645;14285.21431321277;14301.57095287143;798.7523867601047;803.5660743198665;804.0512195609178;805.8388322335527;807.2855522862279;616.5037145098194;761.3376362564577;784.0982869699862;790.7430085222297;790.8220650353682;829.1873963515758;833.2958649940821;837.6691206973272;838.1367191792464;839.5004972041626;825.1377310710322;828.8093738440162;828.9295409890136;830.2610676497922;831.983360332796;603.3996173807091;608.8477880529867;609.6281268426256;610;611.8929187392233;12888.54890078852;12932;12933.805992910115;12944.352782360844;12994.350282485839;12135.878641213563;12187.451564679523;12209.267443953391;12374.319412432402;12528.621851596317;9644.373115747454;10129.189664826796;10260.948695256551;10329.122024627915;10348.844767328495;3281.146901805524;3299.0432774495366;3332.133645252228;3335.7998520088872;3392.1519620094978;46633.766831165965;47213.527864721254;47835;47967.28049079267;48230;9807.264455165749;9864.112229899343;9960.352577082467;9976.501174941224;9991.750206244902;16444.67110657804;16864.747028794576;17009.744853827204;17012.06433646161;17669.20488578017;6794.72821087151;6857.700231907671;6880.346367095118;6933.791986240421;7016.473764467685;3538.4869193967247;3638.581563120222;3701;3723.087843478311;3773.3585290500682;2751.6422865027816;2829.8302101873956;2830.2075418882746;2834.518131917579;2834.6031555582235;486.610711430861;491.1086378223513;501.57867391390675;507.3708601334319;507.99492005079475;560.5095541401274;584.6988800767608;599.0834023943373;600.1649459950917;605.1255935173632;7140.285971402922;7151.254793215849;7215.242399548077;7399.112106547249;7487.66305516253;498.76558017731605;546.3007350591249;551.4788524843984;574.1875246526118;595.9463648271676;3870.5548861881243;3896.9610303897166;3897.2010737798682;3995.840166393312;4062.735922165109;55458;56341.43658563444;57490.13764793531;57540;57959;50588.747056265216;50798.23802642963;52360.73819630954;53204.201936970974;53465.1980220297;47388.289175662394;47897.281540776916;48026;48343.274850877264;48679.75660121747;7316.561006339637;7467.775966721007;7558.906691800101;7615.65729542183;7735.9226407735205;31136.844315778275;31366.05901822949;31426.68573314329;31503.84248078745;32539.837300813346;37492.2501549962;38074.23851523009;39786;40599.39100913548;41446.58553414427;10275.332103413255;10591.523381448007;10638.84041739359;10723.785524289626;10726.141908647445;11574;11833;11940.880591193976;12070.396480176132;12403.503859845505;11187.216894817284;11337.773244534897;11407.144464165054;11636.825447618123;11706.063514918616;11248.156388270749;11280;11417.1437142213;11548.307101573933;11716.472758726048;11032;11048;11227.101831853268;11398.829017564578;11776.764464710486;9517.762055948657;9845.803083938137;9905.455199964072;9981.500924953578;10004.199664027006;9461.33770636049;9573.760655983657;9785.461799601091;9791.51042447889;10008.349457285252 15:58:46 INFO - PROCESS | 3441 | __end_tp_report 15:58:46 INFO - PROCESS | 3441 | __start_cc_report 15:58:46 INFO - PROCESS | 3441 | _x_x_mozilla_cycle_collect,383 15:58:46 INFO - PROCESS | 3441 | __end_cc_report 15:58:46 INFO - PROCESS | 3441 | __startTimestamp1463785126459__endTimestamp 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | ------- Summary: start ------- 15:58:46 INFO - PROCESS | 3441 | Number of tests: 6 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | [#0] dojo.html Cycles:165 Average:4691.87 Median:4798.09 stddev:485.88 (10.1%) stddev-sans-first:459.74 15:58:46 INFO - PROCESS | 3441 | Values: 2632.9 2698.6 2706.3 2707.9 2724.8 4704.2 4715.7 4726.2 4770.7 4785.2 4587.1 4714.5 4736.5 4749.1 4752.7 4311.3 4378.8 4399.8 4421.1 4444.7 4376.2 4435.1 4450.1 4477.7 4523.6 4298.4 4318.1 4336.1 4375.1 4383.1 4297.1 4308.5 4347.8 4378.5 4394.9 4335.2 4352.1 4360.7 4363.8 4412.5 4561.2 4644.8 4650.1 4662.4 4676.3 5089.1 5097.9 5101.9 5110.1 5147.2 4924.7 5111.6 5144.5 5148.0 5201.3 4741.3 4807.2 4814.3 4817.3 4867.4 5271.3 5271.3 5279.8 5284.4 5286.7 4757.1 4835.3 4933.7 5044.1 5065.6 4925.2 5024.1 5044.1 5045.1 5094.6 5053.7 5065.3 5074.8 5076.5 5081.6 4844.8 4874.8 5046.3 5058.2 5130.4 4331.4 4357.0 4360.9 4396.2 4402.4 3778.5 3784.6 3811.4 3830.9 3844.8 4241.8 4318.3 4328.6 4349.9 4368.8 5074.4 5081.2 5083.9 5090.2 5133.4 4330.9 4347.7 4357.7 4361.9 4389.7 4363.5 4525.5 4554.5 4590.1 4593.8 4772.7 4774.9 4775.2 4775.6 4811.9 5084.5 5118.2 5118.4 5127.1 5173.8 4606.7 4738.9 4757.5 4779.2 4783.5 4990.6 4997.6 5003.1 5010.5 5071.1 4949.2 5101.1 5101.7 5123.7 5155.0 4761.9 4904.1 4937.1 4966.1 4992.4 4885.7 4931.7 4958.5 4967.6 4971.5 4850.2 4864.2 4866.1 4874.6 4926.3 4798.1 4998.1 5011.3 5015.5 5058.7 4851.3 4902.2 4906.2 4932.8 4960.5 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | [#1] ext.html Cycles:180 Average:55077.99 Median:37138.91 stddev:118058.97 (317.9%) stddev-sans-first:118319.22 15:58:46 INFO - PROCESS | 3441 | Values: 568.6 591.6 605.2 619.9 626.4 35129.5 39745.4 39775.4 39798.0 39908.4 40183.6 40477.2 40659.0 40670.6 40913.6 7533.1 7734.0 7782.9 7789.1 7805.5 7659.8 7737.0 7749.1 7758.8 7775.9 7757.9 7764.7 7781.6 7801.7 7813.0 7652.8 7724.1 7746.0 7787.6 7809.5 7529.7 7636.7 7647.6 7648.2 7653.0 30299.8 36897.3 37394.8 37418.8 37463.3 3005.3 3027.2 3095.8 3383.7 3603.2 27531.0 30056.5 30727.7 30790.2 31059.2 3425.1 3546.9 3557.6 3590.9 3622.3 268886.0 269366.0 272324.0 273504.0 274834.0 57424.4 58724.0 58903.0 59115.0 59119.0 33878.0 34611.0 34877.8 62798.7 63178.4 13236.1 13311.7 13313.4 13334.6 13336.6 9877.2 9951.5 9953.9 9961.2 9979.6 19053.7 19352.9 19393.8 19423.7 19486.4 7484.6 7581.8 7699.4 7755.7 7850.5 872.6 990.5 1001.0 1001.9 1051.9 28840.7 28900.9 28929.3 29003.1 29038.1 914.8 994.2 1001.0 1044.8 1059.2 15103.8 15245.1 15262.8 15387.5 15476.5 386968.0 657468.0 673322.0 677493.0 677777.0 51537.7 51935.0 52304.5 52323.7 52494.7 1208.4 1212.7 1214.2 1228.4 1241.0 27594.0 28581.7 28672.9 28952.9 29142.4 42941.0 43041.1 43416.8 43606.8 43703.8 339793.0 340694.0 341176.0 341332.0 344900.0 25451.7 25687.9 25715.7 25826.1 25851.4 41126.8 41413.0 41559.8 41621.4 43096.8 35047.3 36580.0 37848.2 38244.0 38473.2 33711.5 37117.8 37160.0 37258.8 37519.8 36412.8 36895.8 36962.3 36965.8 37029.4 32808.0 33203.8 33304.7 33886.8 34093.5 25131.7 25377.9 25479.4 26020.6 26028.2 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | [#2] jquery.html Cycles:180 Average:23928.79 Median:47189.14 stddev:63678.30 (134.9%) stddev-sans-first:63832.34 15:58:46 INFO - PROCESS | 3441 | Values: 359.6 362.4 367.5 381.3 382.9 15687.8 17061.7 17121.9 17472.6 17536.6 16076.5 16206.4 16347.5 16507.7 16521.7 5067.1 5201.8 5246.4 5254.3 5265.8 3825.8 5181.7 5794.7 6090.7 6107.9 6132.0 6142.1 6153.7 6173.8 6187.2 5263.4 5594.5 5622.6 5648.3 5649.4 5311.5 5442.4 5443.6 5478.1 5487.7 12793.7 12826.0 12877.5 12940.9 13034.2 1795.3 1861.5 1886.6 1938.2 1957.5 9423.7 11005.9 12546.8 12876.7 12926.9 1660.3 1700.5 1757.4 1796.2 1827.6 72012.0 72281.6 72389.0 73181.6 73878.0 9939.3 10109.7 10273.7 10304.7 10417.9 14052.7 14065.9 14072.3 14081.9 14120.6 6625.8 6632.3 6676.3 6737.7 6831.7 6047.1 6063.4 6171.3 6186.6 6248.3 4340.5 4435.9 4495.8 4517.1 4540.3 1719.6 1780.2 1814.2 1860.9 1874.3 819.3 890.3 939.4 968.0 983.8 15658.9 16168.3 16563.6 16608.8 16612.9 917.6 919.5 929.7 933.4 945.4 9119.8 9221.8 9404.5 9525.0 9588.1 378533.0 380808.0 383937.0 388656.0 393700.0 75419.6 77129.0 77132.2 77142.6 78109.6 882.3 895.3 911.8 915.2 917.6 14961.4 15027.2 15218.7 15229.9 15236.4 34132.5 34994.3 35540.1 35578.6 35659.0 47004.0 47374.3 48278.3 48642.8 48738.5 7617.0 7623.3 7896.8 7941.4 7945.4 9435.0 9985.5 10789.2 11626.2 11986.3 9710.6 9712.6 9907.0 10146.4 10356.6 9422.9 10194.6 10204.1 10258.7 10369.9 10105.8 10290.2 10293.3 10359.4 10383.4 7770.5 7800.1 7849.1 7854.6 7855.0 9599.9 9752.4 9913.9 10096.6 10330.5 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | [#3] mootools.html Cycles:180 Average:5127.91 Median:5081.43 stddev:2887.76 (56.8%) stddev-sans-first:2882.21 15:58:46 INFO - PROCESS | 3441 | Values: 1391.7 1411.3 1533.7 1711.1 1737.5 6717.5 7351.9 7571.5 8052.6 8076.6 7682.7 7790.2 7846.0 7857.1 7893.0 2169.8 2203.4 2226.7 2227.1 2229.4 2183.4 2216.9 2233.6 2238.9 2249.1 2195.9 2217.4 2218.4 2237.3 2240.4 2119.4 2124.8 2131.9 2145.2 2146.1 2120.0 2144.6 2145.8 2149.1 2175.4 7847.9 7882.3 7903.1 7914.8 7917.6 4371.8 4464.8 4489.4 4491.1 4512.8 2784.4 2789.5 2893.8 2912.5 2928.3 834.1 856.6 859.4 1757.8 1817.8 10699.6 10814.8 10842.6 10864.5 10923.2 4086.9 4160.3 4203.2 4239.7 4242.9 8493.3 8507.9 8520.7 8525.7 8539.1 4421.9 4432.8 4470.9 4500.7 4508.0 3594.6 3974.6 4013.4 4048.5 4079.5 3387.6 3394.9 3468.6 3469.1 3490.4 991.8 1027.1 1028.9 1029.7 1035.2 849.8 876.1 892.6 918.7 934.6 5313.5 5403.7 5474.2 5514.9 5572.5 414.4 416.1 418.1 424.1 426.8 3467.2 3557.6 3568.3 3596.9 3628.9 9181.5 9753.8 9776.4 9785.4 9789.4 9505.8 9672.2 9682.8 9704.1 9712.2 7285.5 7312.6 7381.3 7389.9 7400.7 5395.2 5399.6 5475.7 5487.5 5542.2 8752.6 8841.7 8864.2 9098.8 9124.6 9044.2 9056.0 9087.4 9112.0 9219.6 5835.6 6176.2 6350.5 6351.4 6401.5 7607.6 7651.0 7686.1 7723.7 7738.1 6655.5 6717.4 6727.1 6761.3 6938.7 6513.7 6568.0 6592.5 6604.3 6729.7 6456.0 6528.5 6574.1 6598.7 6633.4 4741.2 4742.1 4748.9 4773.3 4795.2 4721.8 4786.8 4821.7 4843.2 4849.4 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | [#4] prototype.html Cycles:180 Average:4216.45 Median:4594.53 stddev:1229.65 (26.8%) stddev-sans-first:1197.19 15:58:46 INFO - PROCESS | 3441 | Values: 286.1 295.8 301.1 303.3 303.7 4932.4 5037.3 5117.5 5151.9 5159.8 4723.2 4890.4 4914.8 5009.7 5046.8 3964.9 3989.6 4005.5 4015.5 4027.0 4000.3 4030.9 4032.7 4034.7 4034.7 3678.3 3891.6 3898.3 3977.8 4005.5 3875.6 3876.7 3884.4 3906.8 3911.2 3414.6 3422.0 3428.6 3450.0 3453.3 4835.2 4918.6 4918.7 4920.7 4947.1 4488.2 4504.3 4504.3 4515.1 4517.8 5292.3 5299.6 5309.3 5314.1 5319.7 3707.8 3728.7 3729.6 3735.8 3764.9 5277.3 5358.4 5469.3 5589.3 5609.5 3763.9 3764.7 3788.5 3790.2 3822.2 3802.4 3808.5 3818.7 3827.2 3835.9 4412.9 4437.4 4439.9 4459.1 4465.8 5120.5 5264.4 5285.2 5289.2 5317.7 1299.9 1335.9 1338.1 1340.5 1340.9 813.7 841.9 842.5 863.3 874.8 4123.6 4130.5 4131.7 4137.2 4147.7 4826.4 4877.6 4878.5 4897.5 4898.9 4111.1 4115.5 4119.9 4138.7 4152.8 2522.6 2608.6 2622.6 2624.7 2631.6 4501.7 4538.5 4559.8 4595.5 4603.4 4909.3 4913.0 4927.0 4972.6 5008.4 4222.1 4523.6 4561.2 4569.0 4593.6 4816.6 4845.7 4867.8 4892.7 4893.4 4768.7 4776.5 4792.8 4795.5 4813.3 4359.5 4554.6 4559.2 4607.2 4612.3 3426.6 3441.6 3445.6 3459.7 3489.4 4904.7 4926.3 4937.9 4938.9 4967.9 4775.2 4777.7 5039.2 5420.3 5428.1 5368.8 5414.8 5418.6 5431.3 5449.1 5264.7 5270.0 5296.9 5306.5 5313.3 5282.8 5427.7 5431.8 5444.8 5447.0 5311.2 5318.0 5342.3 5343.9 5380.8 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | [#5] yui.html Cycles:180 Average:13408.90 Median:47932.28 stddev:15709.35 (32.8%) stddev-sans-first:15724.21 15:58:46 INFO - PROCESS | 3441 | Values: 652.4 769.6 774.1 775.2 785.0 10924.2 11437.5 11447.6 13796.7 14283.1 14248.0 14256.8 14280.2 14285.2 14301.6 798.8 803.6 804.1 805.8 807.3 616.5 761.3 784.1 790.7 790.8 829.2 833.3 837.7 838.1 839.5 825.1 828.8 828.9 830.3 832.0 603.4 608.8 609.6 610.0 611.9 12888.5 12932.0 12933.8 12944.4 12994.4 12135.9 12187.5 12209.3 12374.3 12528.6 9644.4 10129.2 10260.9 10329.1 10348.8 3281.1 3299.0 3332.1 3335.8 3392.2 46633.8 47213.5 47835.0 47967.3 48230.0 9807.3 9864.1 9960.4 9976.5 9991.8 16444.7 16864.7 17009.7 17012.1 17669.2 6794.7 6857.7 6880.3 6933.8 7016.5 3538.5 3638.6 3701.0 3723.1 3773.4 2751.6 2829.8 2830.2 2834.5 2834.6 486.6 491.1 501.6 507.4 508.0 560.5 584.7 599.1 600.2 605.1 7140.3 7151.3 7215.2 7399.1 7487.7 498.8 546.3 551.5 574.2 595.9 3870.6 3897.0 3897.2 3995.8 4062.7 55458.0 56341.4 57490.1 57540.0 57959.0 50588.7 50798.2 52360.7 53204.2 53465.2 47388.3 47897.3 48026.0 48343.3 48679.8 7316.6 7467.8 7558.9 7615.7 7735.9 31136.8 31366.1 31426.7 31503.8 32539.8 37492.3 38074.2 39786.0 40599.4 41446.6 10275.3 10591.5 10638.8 10723.8 10726.1 11574.0 11833.0 11940.9 12070.4 12403.5 11187.2 11337.8 11407.1 11636.8 11706.1 11248.2 11280.0 11417.1 11548.3 11716.5 11032.0 11048.0 11227.1 11398.8 11776.8 9517.8 9845.8 9905.5 9981.5 10004.2 9461.3 9573.8 9785.5 9791.5 10008.3 15:58:46 INFO - PROCESS | 3441 | -------- Summary: end -------- 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | 15:58:46 INFO - PROCESS | 3441 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:58:46 INFO - PROCESS | 3441 | 15:58:47 INFO - TEST-INFO | 3441: exit 0 15:58:47 INFO - TEST-OK | dromaeo_css | took 1119349ms 15:58:47 INFO - TEST-START | kraken 15:58:47 INFO - operating with platform_type : linux_ 15:58:47 INFO - Initialising browser for kraken test... 15:58:47 INFO - TEST-INFO | started process 3670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKoClN/profile http://localhost:34292/getInfo.html) 15:58:52 INFO - PROCESS | 3670 | 15:58:52 INFO - PROCESS | 3670 | (process:3736): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:58:54 INFO - PROCESS | 3670 | __metrics Screen width/height:1600/1200 15:58:54 INFO - PROCESS | 3670 | colorDepth:24 15:58:54 INFO - PROCESS | 3670 | Browser inner width/height: 1024/697 15:58:54 INFO - PROCESS | 3670 | __metrics 15:58:55 ERROR - PROCESS | 3670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:58:56 INFO - TEST-INFO | 3670: exit 0 15:58:56 INFO - Browser initialized. 15:58:56 INFO - Running cycle 1/1 for kraken test... 15:58:56 INFO - TEST-INFO | started process 3789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKoClN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:58 INFO - PROCESS | 3789 | 15:58:58 INFO - PROCESS | 3789 | (process:3851): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:59:08 INFO - PROCESS | 3789 | RSS: Main: 165552128 15:59:08 INFO - PROCESS | 3789 | 15:59:11 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34292/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:12 INFO - PROCESS | 3789 | RSS: Main: 169746432 15:59:12 INFO - PROCESS | 3789 | 15:59:15 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34292/tests/kraken/driver.html?testName=audio-dft) 15:59:15 INFO - PROCESS | 3789 | RSS: Main: 170524672 15:59:15 INFO - PROCESS | 3789 | 15:59:18 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34292/tests/kraken/driver.html?testName=audio-fft) 15:59:19 INFO - PROCESS | 3789 | RSS: Main: 165335040 15:59:19 INFO - PROCESS | 3789 | 15:59:21 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34292/tests/kraken/driver.html?testName=audio-oscillator) 15:59:22 INFO - PROCESS | 3789 | RSS: Main: 165195776 15:59:22 INFO - PROCESS | 3789 | 15:59:24 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:25 INFO - PROCESS | 3789 | RSS: Main: 165351424 15:59:25 INFO - PROCESS | 3789 | 15:59:28 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34292/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:29 INFO - PROCESS | 3789 | RSS: Main: 165601280 15:59:29 INFO - PROCESS | 3789 | 15:59:32 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34292/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:33 INFO - PROCESS | 3789 | RSS: Main: 163483648 15:59:33 INFO - PROCESS | 3789 | 15:59:38 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34292/tests/kraken/driver.html?testName=json-parse-financial) 15:59:38 INFO - PROCESS | 3789 | RSS: Main: 164708352 15:59:38 INFO - PROCESS | 3789 | 15:59:40 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:40 INFO - PROCESS | 3789 | RSS: Main: 165232640 15:59:40 INFO - PROCESS | 3789 | 15:59:42 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:43 INFO - PROCESS | 3789 | RSS: Main: 165568512 15:59:43 INFO - PROCESS | 3789 | 15:59:52 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:53 INFO - PROCESS | 3789 | RSS: Main: 165412864 15:59:53 INFO - PROCESS | 3789 | 15:59:56 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:56 INFO - PROCESS | 3789 | RSS: Main: 165687296 15:59:56 INFO - PROCESS | 3789 | 15:59:58 INFO - PROCESS | 3789 | 1463785198129 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] 15:59:59 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:00 INFO - PROCESS | 3789 | RSS: Main: 168734720 16:00:00 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | Cycle 1(1): loaded http://localhost:34292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34292/tests/kraken/driver.html?testName=ai-astar) 16:00:02 INFO - PROCESS | 3789 | RSS: Main: 170504192 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | __start_tp_report 16:00:02 INFO - PROCESS | 3789 | _x_x_mozilla_page_load 16:00:02 INFO - PROCESS | 3789 | _x_x_mozilla_page_load_details 16:00:02 INFO - PROCESS | 3789 | |i|pagename|runs| 16:00:02 INFO - PROCESS | 3789 | |0;ai-astar;118;114;114;114;116;115;115;114;113;114 16:00:02 INFO - PROCESS | 3789 | |1;audio-beat-detection;153;139;155;221;138;160;153;133;187;142 16:00:02 INFO - PROCESS | 3789 | |2;audio-dft;164;165;165;169;161;165;163;162;160;164 16:00:02 INFO - PROCESS | 3789 | |3;audio-fft;76;75;76;171;78;75;76;76;160;77 16:00:02 INFO - PROCESS | 3789 | |4;audio-oscillator;93;94;181;94;94;94;137;93;93;151 16:00:02 INFO - PROCESS | 3789 | |5;imaging-gaussian-blur;118;118;118;119;118;118;119;118;118;119 16:00:02 INFO - PROCESS | 3789 | |6;imaging-darkroom;150;148;149;148;148;148;148;148;147;149 16:00:02 INFO - PROCESS | 3789 | |7;imaging-desaturate;99;100;98;100;100;100;100;96;97;99 16:00:02 INFO - PROCESS | 3789 | |8;json-parse-financial;65;68;65;65;64;64;65;65;64;65 16:00:02 INFO - PROCESS | 3789 | |9;json-stringify-tinderbox;65;65;65;66;65;64;65;65;65;69 16:00:02 INFO - PROCESS | 3789 | |10;stanford-crypto-aes;84;89;90;86;85;85;85;84;139;82 16:00:02 INFO - PROCESS | 3789 | |11;stanford-crypto-ccm;138;130;132;136;134;131;138;137;149;141 16:00:02 INFO - PROCESS | 3789 | |12;stanford-crypto-pbkdf2;171;168;179;177;178;170;171;176;171;170 16:00:02 INFO - PROCESS | 3789 | |13;stanford-crypto-sha256-iterative;67;68;68;67;67;66;70;67;65;66 16:00:02 INFO - PROCESS | 3789 | __end_tp_report 16:00:02 INFO - PROCESS | 3789 | __start_cc_report 16:00:02 INFO - PROCESS | 3789 | _x_x_mozilla_cycle_collect,931 16:00:02 INFO - PROCESS | 3789 | __end_cc_report 16:00:02 INFO - PROCESS | 3789 | __startTimestamp1463785202470__endTimestamp 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | ------- Summary: start ------- 16:00:02 INFO - PROCESS | 3789 | Number of tests: 14 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:1.42 (1.2%) stddev-sans-first:0.87 16:00:02 INFO - PROCESS | 3789 | Values: 118.0 114.0 114.0 114.0 116.0 115.0 115.0 114.0 113.0 114.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:154.00 stddev:26.90 (17.5%) stddev-sans-first:28.47 16:00:02 INFO - PROCESS | 3789 | Values: 153.0 139.0 155.0 221.0 138.0 160.0 153.0 133.0 187.0 142.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.50 stddev:2.53 (1.5%) stddev-sans-first:2.68 16:00:02 INFO - PROCESS | 3789 | Values: 164.0 165.0 165.0 169.0 161.0 165.0 163.0 162.0 160.0 164.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.78 (49.7%) stddev-sans-first:39.51 16:00:02 INFO - PROCESS | 3789 | Values: 76.0 75.0 76.0 171.0 78.0 75.0 76.0 76.0 160.0 77.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:93.50 stddev:32.12 (34.4%) stddev-sans-first:33.29 16:00:02 INFO - PROCESS | 3789 | Values: 93.0 94.0 181.0 94.0 94.0 94.0 137.0 93.0 93.0 151.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:00:02 INFO - PROCESS | 3789 | Values: 118.0 118.0 118.0 119.0 118.0 118.0 119.0 118.0 118.0 119.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 16:00:02 INFO - PROCESS | 3789 | Values: 150.0 148.0 149.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#7] imaging-desaturate Cycles:10 Average:98.90 Median:96.50 stddev:1.45 (1.5%) stddev-sans-first:1.54 16:00:02 INFO - PROCESS | 3789 | Values: 99.0 100.0 98.0 100.0 100.0 100.0 100.0 96.0 97.0 99.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.15 (1.8%) stddev-sans-first:1.22 16:00:02 INFO - PROCESS | 3789 | Values: 65.0 68.0 65.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 16:00:02 INFO - PROCESS | 3789 | Values: 65.0 65.0 65.0 66.0 65.0 64.0 65.0 65.0 65.0 69.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:85.00 stddev:17.06 (20.1%) stddev-sans-first:17.92 16:00:02 INFO - PROCESS | 3789 | Values: 84.0 89.0 90.0 86.0 85.0 85.0 85.0 84.0 139.0 82.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:137.50 stddev:5.58 (4.1%) stddev-sans-first:5.90 16:00:02 INFO - PROCESS | 3789 | Values: 138.0 130.0 132.0 136.0 134.0 131.0 138.0 137.0 149.0 141.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.50 stddev:3.96 (2.3%) stddev-sans-first:4.12 16:00:02 INFO - PROCESS | 3789 | Values: 171.0 168.0 179.0 177.0 178.0 170.0 171.0 176.0 171.0 170.0 16:00:02 INFO - PROCESS | 3789 | 16:00:02 INFO - PROCESS | 3789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 16:00:02 INFO - PROCESS | 3789 | Values: 67.0 68.0 68.0 67.0 67.0 66.0 70.0 67.0 65.0 66.0 16:00:02 INFO - PROCESS | 3789 | -------- Summary: end -------- 16:00:02 INFO - PROCESS | 3789 | 16:00:03 INFO - TEST-INFO | 3789: exit 0 16:00:03 INFO - TEST-OK | kraken | took 76085ms 16:00:03 INFO - SUITE-END | took 1195s 16:00:03 INFO - Completed test suite (00:19:55) 16:00:03 INFO - javascript benchmark 16:00:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6326.481192099868, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.8551929643872, 2698.622192892994, 2706.3369474478754, 2707.864606769661, 2724.8092633515657, 4704.247320428728, 4715.717056976584, 4726.172919739045, 4770.713757174563, 4785.234362502, 4587.105514424688, 4714.457837348706, 4736.478987311393, 4749.145153872301, 4752.7148371097755, 4311.288637374837, 4378.8029538670835, 4399.802008909607, 4421.115776844644, 4444.666650001247, 4376.168527979674, 4435.112977404532, 4450.087732014946, 4477.664175186857, 4523.570260825233, 4298.4197133387215, 4318.050028993616, 4336.067745434715, 4375.08123294107, 4383.145286669101, 4297.119090586422, 4308.547602501723, 4347.804348804311, 4378.540253273392, 4394.912101757979, 4335.219660461115, 4352.129574085164, 4360.716553424018, 4363.847265345729, 4412.492563355191, 4561.1789877821975, 4644.814207431698, 4650.0932318197965, 4662.417197850269, 4676.298555216711, 5089.134847076006, 5097.929434818656, 5101.948980510221, 5110.054639891595, 5147.202183661539, 4924.679895806797, 5111.642185047048, 5144.536991670768, 5147.974260128675, 5201.297824793643, 4741.288806679026, 4807.206810876236, 4814.325994360793, 4817.253325734517, 4867.415910090776, 5271.262023316739, 5271.341082364705, 5279.841604751787, 5284.445133261029, 5286.735663216824, 4757.09615173116, 4835.347228124228, 4933.679310844784, 5044.092063428545, 5065.594752419871, 4925.1873440881855, 5024.070546948826, 5044.066847633199, 5045.117104506697, 5094.5669618082875, 5053.7220452875445, 5065.341505604321, 5074.771635276422, 5076.466970968069, 5081.568066714371, 4844.781984810622, 4874.7562621868765, 5046.268291097844, 5058.190689489737, 5130.358705161855, 4331.371951067078, 4356.956430435718, 4360.934585981213, 4396.208682437192, 4402.405675233803, 3778.508793856781, 3784.5647750509042, 3811.3711237646035, 3830.9042273943373, 3844.8462061517785, 4241.7879106044575, 4318.265894797892, 4328.588784065509, 4349.869503914888, 4368.825246990084, 5074.3657042869645, 5081.212412076134, 5083.898322033612, 5090.185570308807, 5133.383993920754, 4330.913381732347, 4347.673924455678, 4357.716748411343, 4361.934570981438, 4389.670774691847, 4363.52001279859, 4525.547445255448, 4554.544545545419, 4590.059037897223, 4593.839215627504, 4772.737499437495, 4774.904501909942, 4775.164346239464, 4775.570198682135, 4811.927821082757, 5084.51697088776, 5118.155504341742, 5118.360204974379, 5127.128388173945, 5173.844784656466, 4606.700564463299, 4738.905221895474, 4757.524247575215, 4779.163646361803, 4783.521647835189, 4990.5508504234795, 4997.575206107376, 5003.074431230234, 5010.536408033741, 5071.0872043032605, 4949.183384741477, 5101.0818052750865, 5101.7194054327365, 5123.666961647481, 5155.0, 4761.928571071506, 4904.092742842586, 4937.061958227925, 4966.056449274626, 4992.350994370709, 4885.731284779371, 4931.654784165074, 4958.504149585013, 4967.552920237196, 4971.477994810492, 4850.17547017015, 4864.246041863516, 4866.099771542276, 4874.610031197567, 4926.3349447824085, 4798.088363210979, 4998.050370429607, 5011.348524691913, 5015.498450154955, 5058.721770302669, 4851.32081508582, 4902.166631672696, 4906.190478571139, 4932.753362331798, 4960.528749768766], "value": 4661.66230367459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.6332315656401, 591.5711109445652, 605.2222893581749, 619.8822223777482, 626.3861415812501, 35129.47305790415, 39745.40381894274, 39775.4202121809, 39798.0, 39908.40137397938, 40183.59816401835, 40477.17852696629, 40659.0, 40670.59329406713, 40913.59086409135, 7533.133689625681, 7734.0, 7782.883256751154, 7789.10425301092, 7805.492642978216, 7659.808504787369, 7737.032870891138, 7749.070111586618, 7758.844823103563, 7775.883361749578, 7757.883631745528, 7764.689412423496, 7781.610919454033, 7801.726939557117, 7813.02337207849, 7652.808679782995, 7724.073111226632, 7745.961270193641, 7787.649555769975, 7809.531428114331, 7529.661165247577, 7636.694532218705, 7647.617619119077, 7648.2351764823625, 7653.043369578802, 30299.848500757354, 36897.26205475876, 37394.81302593497, 37418.81290593557, 37463.25073498515, 3005.2637103909465, 3027.228056845512, 3095.7523398128096, 3383.695467407945, 3603.225306559076, 27531.0, 30056.549151762523, 30727.692723072705, 30790.23024424385, 31059.223519412197, 3425.0910848946187, 3546.946795798065, 3557.5730912290433, 3590.910227244314, 3622.2755448910325, 268886.0, 269366.0, 272324.0, 273504.0, 274834.0, 57424.42575574274, 58724.0, 58903.0, 59115.0, 59119.0, 33878.0, 34611.0, 34877.82561087178, 62798.686006569675, 63178.36821631725, 13236.13965092266, 13311.73376532464, 13313.40089695966, 13334.599962001155, 13336.599902002956, 9877.16044136242, 9951.452670103068, 9953.900460995297, 9961.153301969414, 9979.60081596728, 19053.7141942871, 19352.903235484013, 19393.812521494707, 19423.708644370345, 19486.415407537796, 7484.625768711543, 7581.772546823604, 7699.422543309274, 7755.72854950074, 7850.528968261922, 872.6073267029735, 990.4503000834605, 1001.0340021878922, 1001.9198464122853, 1051.9073922667333, 28840.711592883803, 28900.855495722386, 28929.276768080967, 29003.12990610285, 29038.12885613435, 914.7621618379136, 994.2493417469908, 1000.9949950250202, 1044.796264728386, 1059.2479339668766, 15103.848961510465, 15245.085294882343, 15262.847371526364, 15387.46143884981, 15476.458323958832, 386968.0, 657468.0, 673322.0, 677493.0, 677777.0, 51537.7423112882, 51935.0, 52304.47695523072, 52323.73838130785, 52494.73752631212, 1208.4380762945098, 1212.7089498520293, 1214.2046959241711, 1228.3735294999435, 1240.999999999982, 27594.0, 28581.714182857904, 28672.85663571669, 28952.855235723688, 29142.417151656424, 42941.0, 43041.13917721691, 43416.78291608648, 43606.781966091236, 43703.78148109239, 339793.0, 340694.0, 341176.0, 341332.0, 344900.0, 25451.74548254494, 25687.871560642077, 25715.742842572083, 25826.096086636877, 25851.353716156493, 41126.79436602798, 41413.0, 41559.7922010388, 41621.37567936544, 43096.78451607847, 35047.299054018265, 36580.0, 37848.24303513969, 38244.0, 38473.230535389695, 33711.494327584616, 37117.81441092777, 37160.0, 37258.813705931294, 37519.81240093782, 36412.81793591015, 36895.815520922224, 36962.26075478529, 36965.81517092505, 37029.44455833219, 32808.0, 33203.83398082994, 33304.666953330154, 33886.83056584701, 34093.48859767155, 25131.748682513673, 25377.87311063433, 25479.36301592475, 26020.60969085503, 26028.21915342467], "value": 18000.298329390116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6223964836922, 362.3676684186096, 367.509374984396, 381.33647453431036, 382.9195868867538, 15687.764683529742, 17061.658766824658, 17121.91439042806, 17472.563185920357, 17536.561585960357, 16076.517704468855, 16206.432774852883, 16347.509574712747, 16507.66984660306, 16521.66956660869, 5067.062593420211, 5201.817936372227, 5246.449122842104, 5254.316938797951, 5265.815696450625, 3825.7895815730126, 5181.715005674687, 5794.6523208607405, 6090.695465226743, 6107.938920610782, 6131.969340153293, 6142.109394137848, 6153.723082461278, 6173.845653858644, 6187.164732761087, 5263.447338029509, 5594.468525490092, 5622.578306626999, 5648.293963254593, 5649.435056494359, 5311.548518375943, 5442.428545002757, 5443.564514838803, 5478.068728316196, 5487.6981766003255, 12793.744125117446, 12826.0, 12877.549285774952, 12940.935295323463, 13034.217946923214, 1795.3357257814562, 1861.525311045688, 1886.5943822078318, 1938.185961896007, 1957.5204075001573, 9423.670171543963, 11005.889941100646, 12546.808053234929, 12876.742465150739, 12926.87073129266, 1660.286076986895, 1700.5068530126373, 1757.3761314733213, 1796.1917137288272, 1827.5979284557377, 72012.0, 72281.63859180723, 72388.99999999948, 73181.63409182974, 73878.0, 9939.304248702667, 10109.696709098738, 10273.74315642115, 10304.742381440525, 10417.895821041693, 14052.71894562103, 14065.859341406454, 14072.2963851807, 14081.929590351983, 14120.646983825487, 6625.834354141089, 6632.2704502504685, 6676.332366763285, 6737.730490780412, 6831.726730930806, 6047.0929360596265, 6063.363346848518, 6171.290301615282, 6186.597871138361, 6248.31268560458, 4340.500842403164, 4435.889102772457, 4495.797689103998, 4517.141743068806, 4540.250858608359, 1719.5701074731317, 1780.1722199177445, 1814.2108182940462, 1860.8790428622096, 1874.2877706471454, 819.2913130142384, 890.3189060368823, 939.3940908114228, 968.041638777605, 983.7540614846289, 15658.9217053914, 16168.331112408861, 16563.585910352336, 16608.83391166097, 16612.916935415247, 917.6191880369572, 919.5494207838245, 929.6792606550729, 933.3653115881131, 945.3666043750703, 9119.817603648022, 9221.769455763659, 9404.482753448488, 9525.0, 9588.089131532493, 378533.0, 380808.0, 383937.0, 388656.0, 393700.0, 75419.62290188624, 77129.0, 77132.22867771363, 77142.6142869282, 78109.60945195238, 882.2544949517647, 895.3061377432542, 911.7766147293955, 915.1809130827871, 917.5504003038596, 14961.40154393812, 15027.248637568297, 15218.695626087638, 15229.923850381121, 15236.3905443781, 34132.488012679336, 34994.300113998084, 35540.111497212776, 35578.64421355857, 35659.0, 47004.0, 47374.28938565855, 48278.275825861936, 48642.75678621584, 48738.5126148734, 7617.047869016373, 7623.313901748647, 7896.84206315882, 7941.444098913252, 7945.404094692805, 9434.95282523583, 9985.450800205768, 10789.244752867224, 11626.244294120856, 11986.340751258764, 9710.563024664048, 9712.611495540099, 9907.02515350557, 10146.391216527032, 10356.637517686844, 9422.905770942203, 10194.643187488402, 10204.081632653097, 10258.692239232834, 10369.896301037195, 10105.797884042131, 10290.228232882415, 10293.279470436997, 10359.430231337048, 10383.376997380181, 7770.45606807518, 7800.102988156208, 7849.136594974434, 7854.567998759894, 7855.0, 9599.856002160113, 9752.366096203725, 9913.900860991298, 10096.596136154765, 10330.483475826028], "value": 8126.200102568217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.7494850926832, 1411.2872999135434, 1533.6625942292699, 1711.1273250642184, 1737.4700716281536, 6717.529772915886, 7351.852962940745, 7571.545707257568, 8052.63763130659, 8076.636551355188, 7682.731104411347, 7790.220977902207, 7845.960770196155, 7857.057153141617, 7893.0, 2169.8155656769154, 2203.427108951676, 2226.6882636430914, 2227.086894373307, 2229.4314949687805, 2183.3995651195887, 2216.866987980726, 2233.6314508106143, 2238.9440263993447, 2249.1453247765826, 2195.868247905131, 2217.390217690132, 2218.4121207879925, 2237.3064350051454, 2240.361496973363, 2119.42775450629, 2124.787521247863, 2131.9467013324715, 2145.1741079684357, 2146.087912637123, 2119.9894000530053, 2144.635411979967, 2145.8305223653147, 2149.140343862452, 2175.434387059376, 7847.9215207847765, 7882.290593846581, 7903.130655627876, 7914.762557123296, 7917.56453395063, 4371.781410929472, 4464.776761161929, 4489.371487991683, 4491.124230775, 4512.796924138422, 2784.4013537089622, 2789.483945470074, 2893.7684985201136, 2912.4903141950076, 2928.2532954096782, 834.1033389106674, 856.6230858422274, 859.3984211052289, 1757.8417942385247, 1817.7727784026997, 10699.572017119306, 10814.837777433344, 10842.566297348096, 10864.45677716119, 10923.180761442844, 4086.9386959195635, 4160.292750232407, 4203.159368126387, 4239.745615263094, 4242.8727138185905, 8493.27807136388, 8507.914920850711, 8520.70177543783, 8525.65897364111, 8539.14608539141, 4421.9336709949375, 4432.800523976429, 4470.865874023784, 4500.662450316239, 4507.954920450819, 3594.6225646307284, 3974.5627980922077, 4013.3979903014783, 4048.473698419187, 4079.469668943078, 3387.5765529308837, 3394.8981530554124, 3468.635793241673, 3469.0980345109947, 3490.3542844573835, 991.7818080022383, 1027.060239880501, 1028.876534815827, 1029.7477118106112, 1035.2132379391717, 849.8257857139272, 876.0801158783252, 892.5849479991705, 918.669279059538, 934.6261495401758, 5313.495217954288, 5403.675779453245, 5474.233607294982, 5514.944850551443, 5572.498475137257, 414.4342971843412, 416.0783863741766, 418.11777150213027, 424.09455811841326, 426.75035104463615, 3467.1678797088516, 3557.6442355764734, 3568.2685049564775, 3596.946045809315, 3628.8911332660064, 9181.495017773954, 9753.804923901624, 9776.413415195111, 9785.412875227366, 9789.412635241908, 9505.762355941157, 9672.177864881563, 9682.75793105164, 9704.078112579293, 9712.22302215821, 7285.453590980697, 7312.634368281671, 7381.298776616213, 7389.852202955911, 7400.703971841173, 5395.190721391823, 5399.568034557147, 5475.698836564027, 5487.478689524489, 5542.168674698666, 8752.64989400417, 8841.69054083104, 8864.20222180007, 9098.818023639358, 9124.589393477178, 9044.186023257938, 9055.954720226357, 9087.36388452802, 9112.0, 9219.585118669811, 5835.56233282497, 6176.197094377702, 6350.523710721622, 6351.364863513611, 6401.487880969605, 7607.619619018917, 7651.043619547557, 7686.116096648957, 7723.691052357843, 7738.071431428265, 6655.534112612071, 6717.395434410926, 6727.125473688389, 6761.290064543152, 6938.722451101899, 6513.73945042193, 6568.0, 6592.505562082767, 6604.273529911802, 6729.730810767514, 6456.0, 6528.477721782341, 6574.0796288520605, 6598.703058362289, 6633.402993730588, 4741.217699079613, 4742.146413645577, 4748.857534273978, 4773.284007398918, 4795.20879054952, 4721.763911804327, 4786.784594693317, 4821.710697358169, 4843.2250839866865, 4849.369581954324], "value": 4081.0419208732055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1173280429875, 295.782599789155, 301.0621912741809, 303.2781978890241, 303.6538346285235, 4932.408111026682, 5037.319961805155, 5117.462666420023, 5151.871203219916, 5159.793608255665, 4723.220668589687, 4890.364252647159, 4914.795875010618, 5009.69941803492, 5046.84859454217, 3964.9207015859665, 3989.620986006332, 4005.539362973266, 4015.518137823465, 4026.9798651006704, 4000.3199456092534, 4030.9395359069636, 4032.6773858091283, 4034.69739769517, 4034.7175697701173, 3678.282734866702, 3891.591382904797, 3898.259330727167, 3977.76133431995, 4005.5193376794828, 3875.61243875613, 3876.7286289959716, 3884.378499440076, 3906.824192911326, 3911.159100793343, 3414.5658823294275, 3422.0, 3428.5542879425766, 3450.0, 3453.326601312745, 4835.202191638376, 4918.557329840296, 4918.680285781413, 4920.662685224525, 4947.134251505972, 4488.214562451558, 4504.256797628387, 4504.2793153095345, 4515.14212299662, 4517.796699148546, 5292.338457692788, 5299.602529810241, 5309.256704061435, 5314.1497360422145, 5319.7340132993195, 3707.8331475083687, 3728.683061939711, 3729.6083911189207, 3735.831887565066, 3764.9247015059545, 5277.287566178594, 5358.3837858645975, 5469.331853784594, 5589.329280486327, 5609.49514543693, 3763.9059023524633, 3764.6800021997888, 3788.4696142540065, 3790.2040571480297, 3822.2164456286396, 3802.3726085196186, 3808.5239345081864, 3818.663467786308, 3827.234553089393, 3835.9041023974064, 4412.852658308862, 4437.400950871591, 4439.911201776011, 4459.0858873930765, 4465.776711164429, 5120.462351453044, 5264.447233040552, 5285.154375299933, 5289.18017707256, 5317.680939143664, 1299.9480020799251, 1335.8730920562532, 1338.0633556510481, 1340.4906135668577, 1340.9061365704308, 813.7436707437139, 841.8568843296532, 842.4650347029681, 863.2619110660421, 874.7944233105216, 4123.628873401408, 4130.483689538808, 4131.710780245414, 4137.186713035105, 4147.730397524151, 4826.359037927122, 4877.609791216694, 4878.512148785164, 4897.461279259279, 4898.868991988496, 4111.116110036357, 4115.485564304462, 4119.9176016480105, 4138.668906487474, 4152.833886644561, 2522.646829443879, 2608.6347911292432, 2622.5672763993725, 2624.73752624736, 2631.5789473684504, 4501.662375321864, 4538.547664747249, 4559.791655211372, 4595.494495605481, 4603.355530225771, 4909.337239472626, 4912.975435122873, 4927.0, 4972.627052971042, 5008.398992120969, 4222.057853387415, 4523.570260825217, 4561.2245918193985, 4568.999999999934, 4593.56361145704, 4816.638752093537, 4845.709257444564, 4867.829625963216, 4892.65751397413, 4893.363862697969, 4768.666193366431, 4776.522347765195, 4792.849716068188, 4795.482371754857, 4813.326134341265, 4359.520452750258, 4554.612857906983, 4559.202139625619, 4607.193741095362, 4612.316504475909, 3426.6230714620874, 3441.621421643567, 3445.6037555680414, 3459.68862802349, 3489.354469423165, 4904.730239836843, 4926.3349447824085, 4937.851864444073, 4938.888500244822, 4967.850964471072, 4775.209296513807, 4777.665563410528, 5039.218921067094, 5420.268263784339, 5428.131498960305, 5368.8389348319615, 5414.783408663609, 5418.566514678895, 5431.2667789847865, 5449.076664801337, 5264.657797243167, 5269.973650131725, 5296.867578310573, 5306.469353064663, 5313.256144139901, 5282.76227569768, 5427.674339539641, 5431.755570999236, 5444.8366549003595, 5446.972765136149, 5311.194193974067, 5318.03232803865, 5342.278792362981, 5343.9198412024625, 5380.784768609368], "value": 3825.4306001960945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4421619515314, 769.6382700130938, 774.0595176860118, 775.2170307988933, 785.0461689047813, 10924.235303528747, 11437.485313160896, 11447.5993340233, 13796.655083622914, 14283.143011419295, 14248.002639815191, 14256.786148207786, 14280.214588197645, 14285.21431321277, 14301.57095287143, 798.7523867601047, 803.5660743198665, 804.0512195609178, 805.8388322335527, 807.2855522862279, 616.5037145098194, 761.3376362564577, 784.0982869699862, 790.7430085222297, 790.8220650353682, 829.1873963515758, 833.2958649940821, 837.6691206973272, 838.1367191792464, 839.5004972041626, 825.1377310710322, 828.8093738440162, 828.9295409890136, 830.2610676497922, 831.983360332796, 603.3996173807091, 608.8477880529867, 609.6281268426256, 610.0, 611.8929187392233, 12888.54890078852, 12932.0, 12933.805992910115, 12944.352782360844, 12994.350282485839, 12135.878641213563, 12187.451564679523, 12209.267443953391, 12374.319412432402, 12528.621851596317, 9644.373115747454, 10129.189664826796, 10260.948695256551, 10329.122024627915, 10348.844767328495, 3281.146901805524, 3299.0432774495366, 3332.133645252228, 3335.7998520088872, 3392.1519620094978, 46633.766831165965, 47213.527864721254, 47835.0, 47967.28049079267, 48230.0, 9807.264455165749, 9864.112229899343, 9960.352577082467, 9976.501174941224, 9991.750206244902, 16444.67110657804, 16864.747028794576, 17009.744853827204, 17012.06433646161, 17669.20488578017, 6794.72821087151, 6857.700231907671, 6880.346367095118, 6933.791986240421, 7016.473764467685, 3538.4869193967247, 3638.581563120222, 3701.0, 3723.087843478311, 3773.3585290500682, 2751.6422865027816, 2829.8302101873956, 2830.2075418882746, 2834.518131917579, 2834.6031555582235, 486.610711430861, 491.1086378223513, 501.57867391390675, 507.3708601334319, 507.99492005079475, 560.5095541401274, 584.6988800767608, 599.0834023943373, 600.1649459950917, 605.1255935173632, 7140.285971402922, 7151.254793215849, 7215.242399548077, 7399.112106547249, 7487.66305516253, 498.76558017731605, 546.3007350591249, 551.4788524843984, 574.1875246526118, 595.9463648271676, 3870.5548861881243, 3896.9610303897166, 3897.2010737798682, 3995.840166393312, 4062.735922165109, 55458.0, 56341.43658563444, 57490.13764793531, 57540.0, 57959.0, 50588.747056265216, 50798.23802642963, 52360.73819630954, 53204.201936970974, 53465.1980220297, 47388.289175662394, 47897.281540776916, 48026.0, 48343.274850877264, 48679.75660121747, 7316.561006339637, 7467.775966721007, 7558.906691800101, 7615.65729542183, 7735.9226407735205, 31136.844315778275, 31366.05901822949, 31426.68573314329, 31503.84248078745, 32539.837300813346, 37492.2501549962, 38074.23851523009, 39786.0, 40599.39100913548, 41446.58553414427, 10275.332103413255, 10591.523381448007, 10638.84041739359, 10723.785524289626, 10726.141908647445, 11574.0, 11833.0, 11940.880591193976, 12070.396480176132, 12403.503859845505, 11187.216894817284, 11337.773244534897, 11407.144464165054, 11636.825447618123, 11706.063514918616, 11248.156388270749, 11280.0, 11417.1437142213, 11548.307101573933, 11716.472758726048, 11032.0, 11048.0, 11227.101831853268, 11398.829017564578, 11776.764464710486, 9517.762055948657, 9845.803083938137, 9905.455199964072, 9981.500924953578, 10004.199664027006, 9461.33770636049, 9573.760655983657, 9785.461799601091, 9791.51042447889, 10008.349457285252], "value": 6022.308835267911, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1606.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 114.0, 116.0, 115.0, 115.0, 114.0, 113.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 139.0, 155.0, 221.0, 138.0, 160.0, 153.0, 133.0, 187.0, 142.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 169.0, 161.0, 165.0, 163.0, 162.0, 160.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 171.0, 78.0, 75.0, 76.0, 76.0, 160.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 181.0, 94.0, 94.0, 94.0, 137.0, 93.0, 93.0, 151.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 98.0, 100.0, 100.0, 100.0, 100.0, 96.0, 97.0, 99.0], "value": 98.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 69.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 90.0, 86.0, 85.0, 85.0, 85.0, 84.0, 139.0, 82.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 132.0, 136.0, 134.0, 131.0, 138.0, 137.0, 149.0, 141.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 179.0, 177.0, 178.0, 170.0, 171.0, 176.0, 171.0, 170.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 66.0, 70.0, 67.0, 65.0, 66.0], "value": 67.1, "unit": "score"}]}]} 16:00:03 INFO - Return code: 0 16:00:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:00:03 ERROR - # TBPL SUCCESS # 16:00:03 INFO - Running post-action listener: _resource_record_post_action 16:00:03 INFO - ##### 16:00:03 INFO - ##### Finished run-tests step (success) 16:00:03 INFO - ##### 16:00:03 INFO - Running post-run listener: _resource_record_post_run 16:00:03 INFO - Total resource usage - Wall time: 1227s; CPU: 14.0%; Read bytes: 7806976; Write bytes: 406687744; Read time: 6620; Write time: 2589156 16:00:03 INFO - TinderboxPrint: CPU usage
13.6% 16:00:03 INFO - TinderboxPrint: I/O read bytes / time
7,806,976 / 6,620 16:00:03 INFO - TinderboxPrint: I/O write bytes / time
406,687,744 / 2,589,156 16:00:03 INFO - TinderboxPrint: CPU idle
8,458.6 (86.4%) 16:00:03 INFO - TinderboxPrint: CPU user
1,233.6 (12.6%) 16:00:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9052160; Read time: 0; Write time: 3180 16:00:03 INFO - run-tests - Wall time: 1211s; CPU: 14.0%; Read bytes: 7806976; Write bytes: 387805184; Read time: 6620; Write time: 2564820 16:00:04 INFO - Running post-run listener: _upload_blobber_files 16:00:04 INFO - Blob upload gear active. 16:00:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:04 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 16:00:04 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:00:04 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:00:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:09 INFO - (blobuploader) - INFO - Done attempting. 16:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:10 INFO - (blobuploader) - INFO - Done attempting. 16:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:10 INFO - (blobuploader) - INFO - Done attempting. 16:00:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:10 INFO - Return code: 0 16:00:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12eef2325a70e1f27c51b49a812d7a416ef2b67b63b88c7f29e3cde794901d997e8a001c9ace3ebaa8c5c7ba29570269682715a5f0c179f073aa4c91f820f84f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33130c654c9ffedde3d37f4a6d047bb98a09bd9099204c03241128b716c65cebf36d1e224135432889638e0bbec777a674a33384cab171941d126d59d2e7e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a915834878683e2f2e5ed370f0d64cf29c6f74c570fcc5c86aa678a7215b350d04de2fd5258eed8ff7a7a4e76e1497f7616a4ddf2f296a2a88eb1921cd3574a"} 16:00:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:10 INFO - Contents: 16:00:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12eef2325a70e1f27c51b49a812d7a416ef2b67b63b88c7f29e3cde794901d997e8a001c9ace3ebaa8c5c7ba29570269682715a5f0c179f073aa4c91f820f84f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33130c654c9ffedde3d37f4a6d047bb98a09bd9099204c03241128b716c65cebf36d1e224135432889638e0bbec777a674a33384cab171941d126d59d2e7e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a915834878683e2f2e5ed370f0d64cf29c6f74c570fcc5c86aa678a7215b350d04de2fd5258eed8ff7a7a4e76e1497f7616a4ddf2f296a2a88eb1921cd3574a"} 16:00:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:10 INFO - Copying logs to upload dir... 16:00:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1551.843379 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 51 secs) (at 2016-05-20 16:00:10.848195) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:00:10.851948) ========= 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=33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401 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-Non-PGO/sha512/12eef2325a70e1f27c51b49a812d7a416ef2b67b63b88c7f29e3cde794901d997e8a001c9ace3ebaa8c5c7ba29570269682715a5f0c179f073aa4c91f820f84f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33130c654c9ffedde3d37f4a6d047bb98a09bd9099204c03241128b716c65cebf36d1e224135432889638e0bbec777a674a33384cab171941d126d59d2e7e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a915834878683e2f2e5ed370f0d64cf29c6f74c570fcc5c86aa678a7215b350d04de2fd5258eed8ff7a7a4e76e1497f7616a4ddf2f296a2a88eb1921cd3574a"} build_url:https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/CmsNtxq1REaRrDf8IZFQvg/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-Non-PGO/sha512/12eef2325a70e1f27c51b49a812d7a416ef2b67b63b88c7f29e3cde794901d997e8a001c9ace3ebaa8c5c7ba29570269682715a5f0c179f073aa4c91f820f84f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33130c654c9ffedde3d37f4a6d047bb98a09bd9099204c03241128b716c65cebf36d1e224135432889638e0bbec777a674a33384cab171941d126d59d2e7e1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a915834878683e2f2e5ed370f0d64cf29c6f74c570fcc5c86aa678a7215b350d04de2fd5258eed8ff7a7a4e76e1497f7616a4ddf2f296a2a88eb1921cd3574a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:00:10.876381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:00:10.876727) ========= 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=33d5923976266a1c518c4bf7000001ab-1463780864.328575-330591401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:00:10.958130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:00:10.958444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:00:10.958721) ========= ========= Total master_lag: 0.19 =========