builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1463710218.08 results: success (0) buildid: 20160519184214 builduid: 4f59cb535d784b79bd21e16870009839 revision: 466d5c96f43964d4122959e5ab19131237bdc6fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.077362) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.077780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.078074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.132834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.133109) ========= 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=232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 19:10: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-19 19:10:18 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.253419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.253716) ========= 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=232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020165 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:18.302923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 19:10:18.303232) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 466d5c96f43964d4122959e5ab19131237bdc6fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 466d5c96f43964d4122959e5ab19131237bdc6fa --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=232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 19:10:19,060 truncating revision to first 12 chars 2016-05-19 19:10:19,060 Setting DEBUG logging. 2016-05-19 19:10:19,060 attempt 1/10 2016-05-19 19:10:19,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/466d5c96f439?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 19:10:20,138 unpacking tar archive at: fx-team-466d5c96f439/testing/mozharness/ program finished with exit code 0 elapsedTime=1.671362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 19:10:19.987378) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:19.987712) ========= script_repo_revision: 466d5c96f43964d4122959e5ab19131237bdc6fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:19.988127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:19.988396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 19:10:19.998243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-19 19:10:19.998591) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:20 INFO - MultiFileLogger online at 20160519 19:10:20 in /builds/slave/test 19:10:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:10:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:20 INFO - {'append_to_log': False, 19:10:20 INFO - 'base_work_dir': '/builds/slave/test', 19:10:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:10:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:20 INFO - 'branch': 'Fx-Team-Non-PGO', 19:10:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:20 INFO - 'config_files': ('talos/linux_config.py',), 19:10:20 INFO - 'default_actions': ('clobber', 19:10:20 INFO - 'read-buildbot-config', 19:10:20 INFO - 'download-and-extract', 19:10:20 INFO - 'populate-webroot', 19:10:20 INFO - 'create-virtualenv', 19:10:20 INFO - 'install', 19:10:20 INFO - 'run-tests'), 19:10:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:20 INFO - 'download_minidump_stackwalk': True, 19:10:20 INFO - 'download_symbols': 'ondemand', 19:10:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:20 INFO - 'installer_path': 'installer.exe', 19:10:20 INFO - 'log_level': 'info', 19:10:20 INFO - 'log_name': 'talos', 19:10:20 INFO - 'log_to_console': True, 19:10:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:20 INFO - 'opt_config_files': (), 19:10:20 INFO - 'pip_index': False, 19:10:20 INFO - 'sps_profile': False, 19:10:20 INFO - 'sps_profile_interval': 0, 19:10:20 INFO - 'suite': 'dromaeojs-e10s', 19:10:20 INFO - 'system_bits': '32', 19:10:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:20 INFO - 'title': 'talos-linux64-ix-025', 19:10:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:20 INFO - 'use_talos_json': True, 19:10:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:20 INFO - 'work_dir': 'build'} 19:10:20 INFO - ##### 19:10:20 INFO - ##### Running clobber step. 19:10:20 INFO - ##### 19:10:20 INFO - Running pre-action listener: _resource_record_pre_action 19:10:20 INFO - Running main action method: clobber 19:10:20 INFO - rmtree: /builds/slave/test/build 19:10:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:21 INFO - Running post-action listener: _resource_record_post_action 19:10:21 INFO - ##### 19:10:21 INFO - ##### Finished clobber step (success) 19:10:21 INFO - ##### 19:10:21 INFO - ##### 19:10:21 INFO - ##### Running read-buildbot-config step. 19:10:21 INFO - ##### 19:10:21 INFO - Running pre-action listener: _resource_record_pre_action 19:10:21 INFO - Running main action method: read_buildbot_config 19:10:21 INFO - Using buildbot properties: 19:10:21 INFO - { 19:10:21 INFO - "project": "", 19:10:21 INFO - "product": "firefox", 19:10:21 INFO - "script_repo_revision": "production", 19:10:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:10:21 INFO - "repository": "", 19:10:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:10:21 INFO - "buildid": "20160519184214", 19:10:21 INFO - "pgo_build": "False", 19:10:21 INFO - "basedir": "/builds/slave/test", 19:10:21 INFO - "buildnumber": 1281, 19:10:21 INFO - "slavename": "talos-linux64-ix-025", 19:10:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:10:21 INFO - "platform": "ubuntu64_hw", 19:10:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:10:21 INFO - "branch": "fx-team", 19:10:21 INFO - "repo_path": "integration/fx-team", 19:10:21 INFO - "revision": "466d5c96f43964d4122959e5ab19131237bdc6fa", 19:10:21 INFO - "stage_platform": "linux64", 19:10:21 INFO - "builduid": "4f59cb535d784b79bd21e16870009839", 19:10:21 INFO - "slavebuilddir": "test" 19:10:21 INFO - } 19:10:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:10:21 INFO - Running post-action listener: _resource_record_post_action 19:10:21 INFO - ##### 19:10:21 INFO - ##### Finished read-buildbot-config step (success) 19:10:21 INFO - ##### 19:10:21 INFO - ##### 19:10:21 INFO - ##### Running download-and-extract step. 19:10:21 INFO - ##### 19:10:21 INFO - Running pre-action listener: _resource_record_pre_action 19:10:21 INFO - Running main action method: download_and_extract 19:10:21 INFO - mkdir: /builds/slave/test/build/tests 19:10: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')]} 19:10:21 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:10:22 INFO - Downloaded 1361 bytes. 19:10:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:22 INFO - Using the following test package requirements: 19:10:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:10:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'jsshell-linux-x86_64.zip'], 19:10:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:10:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:10:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10: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')]} 19:10:22 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:10:27 INFO - Downloaded 22813669 bytes. 19:10:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:10:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:10:28 INFO - Return code: 0 19:10:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:10: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')]} 19:10:28 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:10:42 INFO - Downloaded 22813669 bytes. 19:10:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:10:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:10:43 INFO - Return code: 0 19:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:43 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:10:44 INFO - Downloaded 10840359 bytes. 19:10:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:10:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:10:45 INFO - Return code: 0 19:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:45 INFO - https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:10:47 INFO - Downloaded 54814434 bytes. 19:10:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:47 INFO - mkdir: /builds/slave/test/properties 19:10:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:47 INFO - Contents: 19:10:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:10:47 INFO - Running post-action listener: _resource_record_post_action 19:10:47 INFO - Running post-action listener: set_extra_try_arguments 19:10:47 INFO - ##### 19:10:47 INFO - ##### Finished download-and-extract step (success) 19:10:47 INFO - ##### 19:10:47 INFO - ##### 19:10:47 INFO - ##### Running populate-webroot step. 19:10:47 INFO - ##### 19:10:47 INFO - Running pre-action listener: _resource_record_pre_action 19:10:47 INFO - Running main action method: populate_webroot 19:10:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:47 INFO - '--tppagecycles', 19:10:47 INFO - '7'], 19:10:47 INFO - 'tests': ['tsvgm']}}, 19:10:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['damp', 'tps']}, 19:10:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'tests': ['damp', 'tps']}, 19:10:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['dromaeo_dom']}, 19:10:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['a11yr', 19:10:47 INFO - 'ts_paint', 19:10:47 INFO - 'tpaint', 19:10:47 INFO - 'sessionrestore', 19:10:47 INFO - 'sessionrestore_no_auto_restore', 19:10:47 INFO - 'tabpaint']}, 19:10:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:47 INFO - 'ts_paint', 19:10:47 INFO - 'tpaint', 19:10:47 INFO - 'sessionrestore', 19:10:47 INFO - 'sessionrestore_no_auto_restore', 19:10:47 INFO - 'tabpaint']}, 19:10:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:47 INFO - 'ts_paint', 19:10:47 INFO - 'tpaint', 19:10:47 INFO - 'sessionrestore', 19:10:47 INFO - 'sessionrestore_no_auto_restore', 19:10:47 INFO - 'tabpaint']}, 19:10:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:47 INFO - 'ts_paint', 19:10:47 INFO - 'tpaint', 19:10:47 INFO - 'sessionrestore', 19:10:47 INFO - 'sessionrestore_no_auto_restore', 19:10:47 INFO - 'tabpaint']}, 19:10:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['a11yr', 19:10:47 INFO - 'ts_paint', 19:10:47 INFO - 'tpaint', 19:10:47 INFO - 'sessionrestore', 19:10:47 INFO - 'sessionrestore_no_auto_restore', 19:10:47 INFO - 'tabpaint']}, 19:10:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['a11yr', 19:10:47 INFO - 'ts_paint', 19:10:47 INFO - 'tpaint', 19:10:47 INFO - 'sessionrestore', 19:10:47 INFO - 'sessionrestore_no_auto_restore', 19:10:47 INFO - 'tabpaint']}, 19:10:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['tsvgx', 19:10:47 INFO - 'tsvgr_opacity', 19:10:47 INFO - 'tart', 19:10:47 INFO - 'tscrollx', 19:10:47 INFO - 'cart']}, 19:10:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:47 INFO - 'tsvgr_opacity', 19:10:47 INFO - 'tart', 19:10:47 INFO - 'tscrollx', 19:10:47 INFO - 'cart']}, 19:10:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'talos_options': ['--disable-e10s'], 19:10:47 INFO - 'tests': ['tp5o']}, 19:10:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'tests': ['tp5o']}, 19:10:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'talos_options': ['--disable-e10s', 19:10:47 INFO - '--xperf_path', 19:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:47 INFO - 'tests': ['tp5n']}, 19:10:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:47 INFO - 'talos_options': ['--xperf_path', 19:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:47 INFO - 'tests': ['tp5n']}}, 19:10:47 INFO - 'talos.zip': {'path': '', 19:10:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:47 INFO - Running post-action listener: _resource_record_post_action 19:10:47 INFO - ##### 19:10:47 INFO - ##### Finished populate-webroot step (success) 19:10:47 INFO - ##### 19:10:47 INFO - ##### 19:10:47 INFO - ##### Running create-virtualenv step. 19:10:47 INFO - ##### 19:10:47 INFO - Running pre-action listener: _resource_record_pre_action 19:10:47 INFO - Running main action method: create_virtualenv 19:10:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:10:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:47 INFO - Using real prefix '/usr' 19:10:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:50 INFO - Installing pip.................done. 19:10:50 INFO - Return code: 0 19:10:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:10:50 INFO - Using env: {'DISPLAY': ':0', 19:10:50 INFO - 'HOME': '/home/cltbld', 19:10:50 INFO - 'LANG': 'en_US.UTF-8', 19:10:50 INFO - 'LANGUAGE': 'en_US:en', 19:10:50 INFO - 'LOGNAME': 'cltbld', 19:10:50 INFO - 'MAIL': '/var/mail/cltbld', 19:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:50 INFO - 'MOZ_NO_REMOTE': '1', 19:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:50 INFO - 'NO_EM_RESTART': '1', 19:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:50 INFO - 'PWD': '/builds/slave/test', 19:10:50 INFO - 'SHELL': '/bin/bash', 19:10:50 INFO - 'SHLVL': '1', 19:10:50 INFO - 'TERM': 'linux', 19:10:50 INFO - 'TMOUT': '86400', 19:10:50 INFO - 'USER': 'cltbld', 19:10:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:50 INFO - '_': '/tools/buildbot/bin/python'} 19:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:10:50 INFO - Cleaning up... 19:10:50 INFO - Return code: 0 19:10:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:10:50 INFO - Using env: {'DISPLAY': ':0', 19:10:50 INFO - 'HOME': '/home/cltbld', 19:10:50 INFO - 'LANG': 'en_US.UTF-8', 19:10:50 INFO - 'LANGUAGE': 'en_US:en', 19:10:50 INFO - 'LOGNAME': 'cltbld', 19:10:50 INFO - 'MAIL': '/var/mail/cltbld', 19:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:50 INFO - 'MOZ_NO_REMOTE': '1', 19:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:50 INFO - 'NO_EM_RESTART': '1', 19:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:50 INFO - 'PWD': '/builds/slave/test', 19:10:50 INFO - 'SHELL': '/bin/bash', 19:10:50 INFO - 'SHLVL': '1', 19:10:50 INFO - 'TERM': 'linux', 19:10:50 INFO - 'TMOUT': '86400', 19:10:50 INFO - 'USER': 'cltbld', 19:10:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:50 INFO - '_': '/tools/buildbot/bin/python'} 19:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:50 INFO - Downloading/unpacking psutil>=3.1.1 19:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:52 INFO - Installing collected packages: psutil 19:10:52 INFO - Running setup.py install for psutil 19:10:52 INFO - building 'psutil._psutil_linux' extension 19:10:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:10:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:10:53 INFO - building 'psutil._psutil_posix' extension 19:10:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:10:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:10:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:53 INFO - Successfully installed psutil 19:10:53 INFO - Cleaning up... 19:10:53 INFO - Return code: 0 19:10:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:10:53 INFO - Using env: {'DISPLAY': ':0', 19:10:53 INFO - 'HOME': '/home/cltbld', 19:10:53 INFO - 'LANG': 'en_US.UTF-8', 19:10:53 INFO - 'LANGUAGE': 'en_US:en', 19:10:53 INFO - 'LOGNAME': 'cltbld', 19:10:53 INFO - 'MAIL': '/var/mail/cltbld', 19:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:53 INFO - 'MOZ_NO_REMOTE': '1', 19:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:53 INFO - 'NO_EM_RESTART': '1', 19:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:53 INFO - 'PWD': '/builds/slave/test', 19:10:53 INFO - 'SHELL': '/bin/bash', 19:10:53 INFO - 'SHLVL': '1', 19:10:53 INFO - 'TERM': 'linux', 19:10:53 INFO - 'TMOUT': '86400', 19:10:53 INFO - 'USER': 'cltbld', 19:10:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:53 INFO - '_': '/tools/buildbot/bin/python'} 19:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:55 INFO - Installing collected packages: mozsystemmonitor 19:10:55 INFO - Running setup.py install for mozsystemmonitor 19:10:55 INFO - Successfully installed mozsystemmonitor 19:10:55 INFO - Cleaning up... 19:10:55 INFO - Return code: 0 19:10:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:10:55 INFO - Using env: {'DISPLAY': ':0', 19:10:55 INFO - 'HOME': '/home/cltbld', 19:10:55 INFO - 'LANG': 'en_US.UTF-8', 19:10:55 INFO - 'LANGUAGE': 'en_US:en', 19:10:55 INFO - 'LOGNAME': 'cltbld', 19:10:55 INFO - 'MAIL': '/var/mail/cltbld', 19:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:55 INFO - 'MOZ_NO_REMOTE': '1', 19:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:55 INFO - 'NO_EM_RESTART': '1', 19:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:55 INFO - 'PWD': '/builds/slave/test', 19:10:55 INFO - 'SHELL': '/bin/bash', 19:10:55 INFO - 'SHLVL': '1', 19:10:55 INFO - 'TERM': 'linux', 19:10:55 INFO - 'TMOUT': '86400', 19:10:55 INFO - 'USER': 'cltbld', 19:10:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:55 INFO - '_': '/tools/buildbot/bin/python'} 19:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:55 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:58 INFO - Downloading docopt-0.6.1.tar.gz 19:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:58 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:58 INFO - Running setup.py install for blobuploader 19:10:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:58 INFO - Running setup.py install for requests 19:10:59 INFO - Running setup.py install for docopt 19:10:59 INFO - Successfully installed blobuploader requests docopt 19:10:59 INFO - Cleaning up... 19:10:59 INFO - Return code: 0 19:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:59 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 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:10:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:59 INFO - Using env: {'DISPLAY': ':0', 19:10:59 INFO - 'HOME': '/home/cltbld', 19:10:59 INFO - 'LANG': 'en_US.UTF-8', 19:10:59 INFO - 'LANGUAGE': 'en_US:en', 19:10:59 INFO - 'LOGNAME': 'cltbld', 19:10:59 INFO - 'MAIL': '/var/mail/cltbld', 19:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:59 INFO - 'MOZ_NO_REMOTE': '1', 19:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:59 INFO - 'NO_EM_RESTART': '1', 19:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:59 INFO - 'PWD': '/builds/slave/test', 19:10:59 INFO - 'SHELL': '/bin/bash', 19:10:59 INFO - 'SHLVL': '1', 19:10:59 INFO - 'TERM': 'linux', 19:10:59 INFO - 'TMOUT': '86400', 19:10:59 INFO - 'USER': 'cltbld', 19:10:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:59 INFO - '_': '/tools/buildbot/bin/python'} 19:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:59 INFO - Running setup.py (path:/tmp/pip-HFqoqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:59 INFO - Running setup.py (path:/tmp/pip-6ni6_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:59 INFO - Running setup.py (path:/tmp/pip-zZV_cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:59 INFO - Running setup.py (path:/tmp/pip-nN8C41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:59 INFO - Running setup.py (path:/tmp/pip-C0_60F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:59 INFO - Running setup.py (path:/tmp/pip-qDxMdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:59 INFO - Running setup.py (path:/tmp/pip-sujSD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:59 INFO - Running setup.py (path:/tmp/pip-QrTW3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:59 INFO - Running setup.py (path:/tmp/pip-6zDLsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:00 INFO - Running setup.py (path:/tmp/pip-0EFBuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:00 INFO - Running setup.py (path:/tmp/pip-x6lFHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:00 INFO - Running setup.py (path:/tmp/pip-6AqTYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:00 INFO - Running setup.py (path:/tmp/pip-YxLgqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:00 INFO - Running setup.py (path:/tmp/pip-Gb4jYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:00 INFO - Running setup.py (path:/tmp/pip-2VqIp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:00 INFO - Running setup.py (path:/tmp/pip-svVE5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:00 INFO - Running setup.py (path:/tmp/pip-ZRLBqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:00 INFO - Running setup.py install for manifestparser 19:11:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Running setup.py install for mozcrash 19:11:00 INFO - Running setup.py install for mozdebug 19:11:00 INFO - Running setup.py install for mozdevice 19:11:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozfile 19:11:01 INFO - Running setup.py install for mozhttpd 19:11:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozinfo 19:11:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozInstall 19:11:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozleak 19:11:01 INFO - Running setup.py install for mozlog 19:11:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for moznetwork 19:11:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozprocess 19:11:01 INFO - Running setup.py install for mozprofile 19:11:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozrunner 19:11:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:02 INFO - Running setup.py install for mozscreenshot 19:11:02 INFO - Running setup.py install for moztest 19:11:02 INFO - Running setup.py install for mozversion 19:11:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:02 INFO - Cleaning up... 19:11:02 INFO - Return code: 0 19:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:02 INFO - Using env: {'DISPLAY': ':0', 19:11:02 INFO - 'HOME': '/home/cltbld', 19:11:02 INFO - 'LANG': 'en_US.UTF-8', 19:11:02 INFO - 'LANGUAGE': 'en_US:en', 19:11:02 INFO - 'LOGNAME': 'cltbld', 19:11:02 INFO - 'MAIL': '/var/mail/cltbld', 19:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:02 INFO - 'MOZ_NO_REMOTE': '1', 19:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:02 INFO - 'NO_EM_RESTART': '1', 19:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:02 INFO - 'PWD': '/builds/slave/test', 19:11:02 INFO - 'SHELL': '/bin/bash', 19:11:02 INFO - 'SHLVL': '1', 19:11:02 INFO - 'TERM': 'linux', 19:11:02 INFO - 'TMOUT': '86400', 19:11:02 INFO - 'USER': 'cltbld', 19:11:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:02 INFO - '_': '/tools/buildbot/bin/python'} 19:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:02 INFO - Running setup.py (path:/tmp/pip-ClNx57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:02 INFO - Running setup.py (path:/tmp/pip-mrxW1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:02 INFO - Running setup.py (path:/tmp/pip-c3YE7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:02 INFO - Running setup.py (path:/tmp/pip-8mJDG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:02 INFO - Running setup.py (path:/tmp/pip-jolY9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:03 INFO - Running setup.py (path:/tmp/pip-_Hs5dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:03 INFO - Running setup.py (path:/tmp/pip-KuCoD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:03 INFO - Running setup.py (path:/tmp/pip-IO8H1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:03 INFO - Running setup.py (path:/tmp/pip-AIcSOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:03 INFO - Running setup.py (path:/tmp/pip-IK1Oc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:03 INFO - Running setup.py (path:/tmp/pip-qoxU9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:03 INFO - Running setup.py (path:/tmp/pip-gSvGQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:03 INFO - Running setup.py (path:/tmp/pip-Y36RVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:03 INFO - Running setup.py (path:/tmp/pip-NZGtag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:03 INFO - Running setup.py (path:/tmp/pip-3mkRHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:03 INFO - Running setup.py (path:/tmp/pip-vEZzDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:03 INFO - Running setup.py (path:/tmp/pip-rMihCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:05 INFO - Downloading blessings-1.6.tar.gz 19:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:05 INFO - Installing collected packages: blessings 19:11:05 INFO - Running setup.py install for blessings 19:11:05 INFO - Successfully installed blessings 19:11:05 INFO - Cleaning up... 19:11:05 INFO - Return code: 0 19:11:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:06 INFO - Reading from file tmpfile_stdout 19:11:06 INFO - Current package versions: 19:11:06 INFO - argparse == 1.2.1 19:11:06 INFO - blessings == 1.6 19:11:06 INFO - blobuploader == 1.2.4 19:11:06 INFO - docopt == 0.6.1 19:11:06 INFO - manifestparser == 1.1 19:11:06 INFO - mozInstall == 1.12 19:11:06 INFO - mozcrash == 0.17 19:11:06 INFO - mozdebug == 0.1 19:11:06 INFO - mozdevice == 0.48 19:11:06 INFO - mozfile == 1.2 19:11:06 INFO - mozhttpd == 0.7 19:11:06 INFO - mozinfo == 0.9 19:11:06 INFO - mozleak == 0.1 19:11:06 INFO - mozlog == 3.2 19:11:06 INFO - moznetwork == 0.27 19:11:06 INFO - mozprocess == 0.22 19:11:06 INFO - mozprofile == 0.28 19:11:06 INFO - mozrunner == 6.11 19:11:06 INFO - mozscreenshot == 0.1 19:11:06 INFO - mozsystemmonitor == 0.3 19:11:06 INFO - moztest == 0.7 19:11:06 INFO - mozversion == 1.4 19:11:06 INFO - psutil == 3.1.1 19:11:06 INFO - requests == 1.2.3 19:11:06 INFO - wsgiref == 0.1.2 19:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 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 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:06 INFO - Using env: {'DISPLAY': ':0', 19:11:06 INFO - 'HOME': '/home/cltbld', 19:11:06 INFO - 'LANG': 'en_US.UTF-8', 19:11:06 INFO - 'LANGUAGE': 'en_US:en', 19:11:06 INFO - 'LOGNAME': 'cltbld', 19:11:06 INFO - 'MAIL': '/var/mail/cltbld', 19:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:06 INFO - 'MOZ_NO_REMOTE': '1', 19:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:06 INFO - 'NO_EM_RESTART': '1', 19:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:06 INFO - 'PWD': '/builds/slave/test', 19:11:06 INFO - 'SHELL': '/bin/bash', 19:11:06 INFO - 'SHLVL': '1', 19:11:06 INFO - 'TERM': 'linux', 19:11:06 INFO - 'TMOUT': '86400', 19:11:06 INFO - 'USER': 'cltbld', 19:11:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:06 INFO - '_': '/tools/buildbot/bin/python'} 19:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:11:06 INFO - Cleaning up... 19:11:06 INFO - Return code: 0 19:11:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:11:06 INFO - Using env: {'DISPLAY': ':0', 19:11:06 INFO - 'HOME': '/home/cltbld', 19:11:06 INFO - 'LANG': 'en_US.UTF-8', 19:11:06 INFO - 'LANGUAGE': 'en_US:en', 19:11:06 INFO - 'LOGNAME': 'cltbld', 19:11:06 INFO - 'MAIL': '/var/mail/cltbld', 19:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:06 INFO - 'MOZ_NO_REMOTE': '1', 19:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:06 INFO - 'NO_EM_RESTART': '1', 19:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:06 INFO - 'PWD': '/builds/slave/test', 19:11:06 INFO - 'SHELL': '/bin/bash', 19:11:06 INFO - 'SHLVL': '1', 19:11:06 INFO - 'TERM': 'linux', 19:11:06 INFO - 'TMOUT': '86400', 19:11:06 INFO - 'USER': 'cltbld', 19:11:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:06 INFO - '_': '/tools/buildbot/bin/python'} 19:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:06 INFO - Downloading/unpacking jsonschema 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:08 INFO - Downloading/unpacking functools32 (from jsonschema) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:08 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:08 INFO - warning: no files found matching '*.txt' 19:11:08 INFO - no previously-included directories found matching 'build' 19:11:08 INFO - no previously-included directories found matching 'dist' 19:11:08 INFO - no previously-included directories found matching '.git*' 19:11:08 INFO - Installing collected packages: jsonschema, functools32 19:11:08 INFO - Running setup.py install for functools32 19:11:08 INFO - warning: no files found matching '*.txt' 19:11:08 INFO - no previously-included directories found matching 'build' 19:11:08 INFO - no previously-included directories found matching 'dist' 19:11:08 INFO - no previously-included directories found matching '.git*' 19:11:08 INFO - Successfully installed jsonschema functools32 19:11:08 INFO - Cleaning up... 19:11:09 INFO - Return code: 0 19:11:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:09 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 0x7f9dca66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfc770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, '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': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:11:09 INFO - Using env: {'DISPLAY': ':0', 19:11:09 INFO - 'HOME': '/home/cltbld', 19:11:09 INFO - 'LANG': 'en_US.UTF-8', 19:11:09 INFO - 'LANGUAGE': 'en_US:en', 19:11:09 INFO - 'LOGNAME': 'cltbld', 19:11:09 INFO - 'MAIL': '/var/mail/cltbld', 19:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:09 INFO - 'MOZ_NO_REMOTE': '1', 19:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:09 INFO - 'NO_EM_RESTART': '1', 19:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:09 INFO - 'PWD': '/builds/slave/test', 19:11:09 INFO - 'SHELL': '/bin/bash', 19:11:09 INFO - 'SHLVL': '1', 19:11:09 INFO - 'TERM': 'linux', 19:11:09 INFO - 'TMOUT': '86400', 19:11:09 INFO - 'USER': 'cltbld', 19:11:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:09 INFO - '_': '/tools/buildbot/bin/python'} 19:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:09 INFO - Downloading/unpacking flake8 19:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:11 INFO - no previously-included directories found matching 'docs/_build' 19:11:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:11:11 INFO - Running setup.py install for pep8 19:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:11 INFO - no previously-included directories found matching 'docs/_build' 19:11:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:11:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:11:11 INFO - Cleaning up... 19:11:12 INFO - Return code: 0 19:11:12 INFO - Running post-action listener: _resource_record_post_action 19:11:12 INFO - Running post-action listener: _start_resource_monitoring 19:11:12 INFO - Starting resource monitoring. 19:11:12 INFO - ##### 19:11:12 INFO - ##### Finished create-virtualenv step (success) 19:11:12 INFO - ##### 19:11:12 INFO - ##### 19:11:12 INFO - ##### Running install step. 19:11:12 INFO - ##### 19:11:12 INFO - Running pre-action listener: _resource_record_pre_action 19:11:12 INFO - Running main action method: install 19:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:12 INFO - Reading from file tmpfile_stdout 19:11:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:12 INFO - Reading from file tmpfile_stdout 19:11:12 INFO - Output received: 19:11:12 INFO - Usage: mozinstall [options] installer 19:11:12 INFO - Options: 19:11:12 INFO - -h, --help show this help message and exit 19:11:12 INFO - -d DEST, --destination=DEST 19:11:12 INFO - Directory to install application into. [default: 19:11:12 INFO - "/builds/slave/test"] 19:11:12 INFO - --app=APP Application being installed. [default: firefox] 19:11:12 INFO - mkdir: /builds/slave/test/build/application 19:11:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:11:28 INFO - Reading from file tmpfile_stdout 19:11:28 INFO - Output received: 19:11:28 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:28 INFO - Running post-action listener: _resource_record_post_action 19:11:28 INFO - ##### 19:11:28 INFO - ##### Finished install step (success) 19:11:28 INFO - ##### 19:11:28 INFO - ##### 19:11:28 INFO - ##### Running run-tests step. 19:11:28 INFO - ##### 19:11:28 INFO - Running pre-action listener: _resource_record_pre_action 19:11:28 INFO - Running main action method: run_tests 19:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:28 INFO - Python 2.7.3 19:11:28 INFO - Return code: 0 19:11:28 INFO - grabbing minidump binary from tooltool 19:11: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')]} 19:11:28 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 0xd8b9c0>, '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 0xd8c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:11:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:11:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:11:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:28 INFO - Return code: 0 19:11:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:11:29 INFO - Return code: 0 19:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:11:29 INFO - Using env: {'DISPLAY': ':0', 19:11:29 INFO - 'HOME': '/home/cltbld', 19:11:29 INFO - 'LANG': 'en_US.UTF-8', 19:11:29 INFO - 'LANGUAGE': 'en_US:en', 19:11:29 INFO - 'LOGNAME': 'cltbld', 19:11:29 INFO - 'MAIL': '/var/mail/cltbld', 19:11:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:29 INFO - 'MOZ_NO_REMOTE': '1', 19:11:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:29 INFO - 'NO_EM_RESTART': '1', 19:11:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:29 INFO - 'PWD': '/builds/slave/test', 19:11:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:29 INFO - 'SHELL': '/bin/bash', 19:11:29 INFO - 'SHLVL': '1', 19:11:29 INFO - 'TERM': 'linux', 19:11:29 INFO - 'TMOUT': '86400', 19:11:29 INFO - 'USER': 'cltbld', 19:11:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568', 19:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:29 INFO - '_': '/tools/buildbot/bin/python'} 19:11:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:11:29 INFO - mozversion application_buildid: 20160519184214 19:11:29 INFO - mozversion application_changeset: 466d5c96f43964d4122959e5ab19131237bdc6fa 19:11:29 INFO - mozversion application_display_name: Nightly 19:11:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:29 INFO - mozversion application_name: Firefox 19:11:29 INFO - mozversion application_remotingname: firefox 19:11:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:11:29 INFO - mozversion application_vendor: Mozilla 19:11:29 INFO - mozversion application_version: 49.0a1 19:11:29 INFO - mozversion platform_buildid: 20160519184214 19:11:29 INFO - mozversion platform_changeset: 466d5c96f43964d4122959e5ab19131237bdc6fa 19:11:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:11:29 INFO - mozversion platform_version: 49.0a1 19:11:29 INFO - using testdate: 1463710289 19:11:29 INFO - actual date: 1463710289 19:11:29 INFO - starting webserver on 'localhost:40495' 19:11:29 INFO - SUITE-START | Running 2 tests 19:11:29 INFO - TEST-START | dromaeo_css 19:11:29 INFO - operating with platform_type : linux_ 19:11:29 INFO - Initialising browser for dromaeo_css test... 19:11:29 INFO - TEST-INFO | started process 4897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtERxg/profile http://localhost:40495/getInfo.html) 19:11:33 INFO - PROCESS | 4897 | 19:11:33 INFO - PROCESS | 4897 | (process:4963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:11:34 INFO - PROCESS | 4897 | __metrics Screen width/height:1600/1200 19:11:34 INFO - PROCESS | 4897 | colorDepth:24 19:11:34 INFO - PROCESS | 4897 | Browser inner width/height: 1024/697 19:11:34 INFO - PROCESS | 4897 | __metrics 19:11:34 ERROR - PROCESS | 4897 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:11:36 INFO - TEST-INFO | 4897: exit 0 19:11:36 INFO - Browser initialized. 19:11:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:36 INFO - TEST-INFO | started process 5014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtERxg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:38 INFO - PROCESS | 5014 | 19:11:38 INFO - PROCESS | 5014 | (process:5074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:11:48 INFO - PROCESS | 5014 | RSS: Main: 165478400 19:11:48 INFO - PROCESS | 5014 | 19:12:37 INFO - PROCESS | 5014 | 1463710357823 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:14:49 INFO - PROCESS | 5014 | Cycle 1(1): loaded http://localhost:40495/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40495/tests/dromaeo/cssquery-ext.html) 19:14:50 INFO - PROCESS | 5014 | RSS: Main: 168202240 19:14:50 INFO - PROCESS | 5014 | 19:17:52 INFO - PROCESS | 5014 | Cycle 1(1): loaded http://localhost:40495/tests/dromaeo/cssquery-ext.html (next: http://localhost:40495/tests/dromaeo/cssquery-jquery.html) 19:17:52 INFO - PROCESS | 5014 | RSS: Main: 166998016 19:17:52 INFO - PROCESS | 5014 | 19:20:54 INFO - PROCESS | 5014 | Cycle 1(1): loaded http://localhost:40495/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40495/tests/dromaeo/cssquery-mootools.html) 19:20:55 INFO - PROCESS | 5014 | RSS: Main: 167948288 19:20:55 INFO - PROCESS | 5014 | 19:23:57 INFO - PROCESS | 5014 | Cycle 1(1): loaded http://localhost:40495/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40495/tests/dromaeo/cssquery-prototype.html) 19:23:58 INFO - PROCESS | 5014 | RSS: Main: 166113280 19:23:58 INFO - PROCESS | 5014 | 19:27:00 INFO - PROCESS | 5014 | Cycle 1(1): loaded http://localhost:40495/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40495/tests/dromaeo/cssquery-yui.html) 19:27:01 INFO - PROCESS | 5014 | RSS: Main: 167751680 19:27:01 INFO - PROCESS | 5014 | 19:30:03 INFO - PROCESS | 5014 | Cycle 1(1): loaded http://localhost:40495/tests/dromaeo/cssquery-yui.html (next: http://localhost:40495/tests/dromaeo/cssquery-dojo.html) 19:30:04 INFO - PROCESS | 5014 | RSS: Main: 169574400 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | __start_tp_report 19:30:04 INFO - PROCESS | 5014 | _x_x_mozilla_page_load 19:30:04 INFO - PROCESS | 5014 | _x_x_mozilla_page_load_details 19:30:04 INFO - PROCESS | 5014 | |i|pagename|runs| 19:30:04 INFO - PROCESS | 5014 | |0;dojo.html;2648.0996461203185;2686.7313268673133;2691.0850310894293;2699.851508167051;2721.4285000149957;4620.376249206356;4673.766311684415;4689.5310468953085;4763.714177149373;4768.141734487799;4631.305304204371;4641.048585040067;4647.7443740594335;4657.86026419208;4721.3390125382475;4307.741535507872;4360.97819510902;4420.8010639521135;4426.2254105531565;4450.5104438511735;663.9878473072963;4291.8497852575165;4293.313069908815;4346.391505189276;4415.911681766363;4335;4369.956300436987;4392.428984232061;4405.911881762347;4424.867253982386;4357.782110894443;4388.605025547684;4393.384926110347;4396.164728701537;4425.491068527129;4270.636995855356;4339.761313127777;4371.540988196225;4383.846565370229;4387.056782791683;4671.392718946515;4684.086603112394;4694.906101877978;4702.435707715096;4707.71753694776;4970.552650261494;5013.298138260647;5080.263361812554;5119.052975199563;5120.92318615221;5075.0611136939415;5094.159463688524;5097.464766199532;5099.643024988252;5150;4732.337472753818;4761.52384761528;4764.475907650121;4767.570918617341;4820.903581928342;5126.487351264844;5180.818671346485;5187.429382767892;5201.375834899836;5265.947340526545;4884.462709101996;4898.289747986522;4941.579965702956;4960.032793605213;4961.131801934647;5071.41678706946;5082.923756143661;5082.949170508247;5086.262491938648;5126.179811230185;4929.482404347564;4979.402471703346;5000.749962501933;5000.799968001312;5002.074616196015;4993.600511959107;5025.723585202776;5054.7472626368535;5058.291839142523;5065.898682026413;4341.587549182823;4349.217140914666;4349.391085248068;4351.06452112791;4393.890152746207;3699.3341198583976;3715.4241092630687;3785.886423407302;3837.9040523987123;3847.3844184930276;4340.804663790137;4343.739375637472;4358.956410435919;4368.432103826546;4415.116976604692;5115.309433226466;5119.0529751996;5125.077486052546;5129.794808207705;5171.3535808024;4291.356296555479;4352.151330490524;4354.586314300136;4365.476142862877;4384.254676704968;4577.610903073276;4619.815207391666;4631.8378856739855;4648.279516674921;4665.626749860003;4745.193317136095;4772.570468657698;4772.6420518461255;4773.9045219096115;4824.300476430898;4888.169011268022;4998.2752500886445;5014.247862820606;5047.646664733434;5078.669886457516;4723.338732577373;4725.527447255247;4726.905461890812;4743.857684269477;4783.449903261169;4905.1416002200185;4967.3542439482635;4971.080350135237;4979.975100124476;5019.698818070928;4953.133201689762;4966.130927087817;4994.925076123934;4995.200767877122;5018.974905125597;4833.32333473307;4837.685550439211;4847.612191024639;4850.1997170466475;4889.877753056202;4809.398825146856;4857.927131093107;4861.368022157097;4875.585575226146;4909.852704418873;4771.880702982453;4775.283707443911;4842;4845.297431872288;4894.632902532396;4974.253861920741;4977.726225057657;4988.476209997898;4993.101241776515;5010.774515146754;4745.976270118627;4880.80476780939;4892.874638833017;4893.143699852582;4893.877653058559 19:30:04 INFO - PROCESS | 5014 | |1;ext.html;553.5073784331945;596.7434003378551;599.9730012149453;614.2352770800354;624.8437890527371;39361.40957885634;40118.59881401185;40306.798466007705;40734.79632601833;43947;39644.60355396452;40363.39454908171;40487.59512404875;40495.79752101243;40496.797516012455;7683.999999999986;7785.883211751829;7858.646360913744;7869.291763741262;7874.527528348317;7653.15815260321;7689;7749.728759493419;7753.185915478878;7756.0692716874055;7756.728514501993;7793;7834.72578459754;7838.333741631968;7843.294103530681;7733.304002639761;7777.611119444034;7795.727149549795;7810.648520816577;7816.53100813953;7673.539587624705;7766.417518686065;7769.456138070337;7802.33680137189;7829.060512738508;37607.435888461696;37750.811245943594;37876.43185352222;38048.42927356092;38052;3090.242890491844;3194.4090343286334;3218.5494030835703;3378.9155271118175;3718.0890681782867;28320.858395708095;28680;28714;28813.279668008257;29002.27494312638;3052.893148739806;3091.0881290019497;3092.8144311341393;3132.749380049613;3170.381775553768;256786;257231;257513;258157;258455;31571.842140789147;51396.74301628543;51441.22838157431;51474.74262628663;51627.74186129045;31949.840250798596;33857.83071084629;33879.32241355209;34095.488567671506;34159.97520074402;12652.493900243888;12753.553625623059;12820.93589532065;12922.676933076747;13041.282729449971;10493.26547141708;10658.573657053787;10660.786784264426;10771.515281812337;10869.619563315246;7866.292033716879;7875.291223789886;7889.447738658238;7915.683372665029;7932.841343173104;3201.327721178532;3201.6798320168264;3207.903762887117;3228.596425446819;3272.967270327314;852.3096292003497;892.4823602310644;908.4776253654176;937.1612406895927;985.4924713772413;27360.726392735818;27923;27971.16086517408;28139.155825325273;28405.147845564665;948.6489998700387;980.9509524523888;984.4339504784778;1031.7317497450567;1113.881132828078;14557.927210364092;14942.40230390794;15036.774448383283;15215.31531081104;15236.162011089496;402269;405539;406156;406996;409349;48496;48925;49152.75423622859;49159;49172.75413622909;1186.507599346279;1206.6561030106377;1208.1241100202458;1227.5396726227664;1235.2032938754633;25855;27371.72628273692;27387.80322103709;27836.44327113406;28137.296567585974;41172.38241426441;41350.9662258446;41853.37219941642;41912.58087419087;41968.79015604902;345221;346560;347226;347339;349318;24608.908242799564;24879;25012;25055.87472062628;25235.369115772253;41775.58224417717;42167.57832421637;42381.57618423776;42689.146217074864;42745.35881961711;36063;36757.63242367542;36802.07994800044;37086.814565927;37275.25449491049;36021.63978360183;36390.818045909604;36830.263394732494;37155.6284437163;37198.814005929795;31258;34884.476732849536;35305.293894122486;35424;38094;31255.687443125276;32504.674953250164;32953.34093318168;33186.66813331836;33253.50119748254;24545.14092006771;24723.381915451537;25256.494870102862;25382.873085634452;25533.48933021292 19:30:04 INFO - PROCESS | 5014 | |2;jquery.html;374.6478310388235;378.37945768938937;380.27557502956876;380.57185666125594;394.33554460733666;10498.737531561705;11125.332480051202;11143.72140696483;11163.330200187995;16000.839991600094;16162.83837161628;16714.83285167148;16837.242324095416;16958.576035599115;17845.46463606094;5764.538836893039;5778.682172480522;6968.825779355506;7038.788836334918;7149.606771627558;7055.435565154801;7101.89347159793;7118.964405177967;7118.964405177967;7156.7852964410895;6852.109225800664;7076.398506126985;7143.142822861264;7151.141862976424;7185.568865868038;6871.587704737682;7030.121234845645;7031.6484175791;7056.223815380304;7056.858862822741;6584.572002819801;6812.14848143982;6846.5892046477375;6939.965300173517;6950.235474097845;19307.4207773767;19467.610647787107;19621.215151393928;23667.76332236673;23810.880945595334;1995.4412764425983;2093.72781538399;2430.708315002211;2522.0794410040203;2684.5570480870633;14168.787468187986;14737.410503579951;14783.482578109715;14996.550103496913;15139.697206055927;1833.2575307000686;1848.4639454558296;1859.8140185981429;1924.7786504552016;1935.7483527141521;56272.59318517029;64794.676026620036;70919.29080709179;79263.6036819818;79453.60273198655;15232.543023709306;16815.411460599065;16957.15214239283;16976.660466790596;17110.914445427694;29519.55720664149;29536;29759.404811904074;29762.553561696594;29945.550816737767;8409.369297302726;8644.178803013703;8726.956365218133;8782.253508451726;8809.955950220208;6937.306269373023;6937.479689023344;6947.305269473012;7045.436365090781;7107.609081500567;8579.399442038997;8579.485230886166;8603.397762156588;8707.651693932172;8765.342599305077;3364.915877103092;3416.982915085409;3451.8243216241117;3533.4876442915634;3584.874529391511;818.3698552114838;857.3098655582316;909.1906010427809;919.1406035356963;923.8198551282435;16772.161391930356;17170.141492925304;17276.654466910844;17309.7403538947;17372.82627173712;830.8836762853206;862.8791969124328;863.7711006583261;864.8745931839974;887.5784002598843;9269.490178040138;9655.517224138765;9682.467464289532;9747.61009559624;9792.951035244778;404999;407416;409522;409560;415931;79004;79138;79558;79678;80964;922.9077092290852;923.8660394242797;938.6761567259284;943.6649989253854;945.054945054945;15063.623409414415;15145.318460669516;15286.847131528542;15303.540893773205;15605.687886242438;34001.31997360088;34004.319913601095;34435.31129377449;34890.82554587211;35644.46533301951;47566;49188.26217606667;49544.256836148204;49580.25629615631;49606.751966239935;7406.888896666662;7605.277498637621;7705.22947705225;7793.493422927491;7842.764717058498;6930.930690693029;9771.462569558742;11512.82730759056;11644.417779110841;11860.584879529175;5005;6896.896546551706;8378.371622128243;9985.087271664457;10140.949295253477;10276.845847312446;10301;10461.9476902615;10465.68602941913;10542.156627469938;10086.747831304276;10148.54331555067;10289.639862604772;10527.937806630027;10638.946805266234;7846.5292082475235;8006.479578827358;8018.398620103399;8223.629936652984;8245.340372770044;9362.953185234303;10447.84328235062;10541;10637.521311540844;10768.946155269174 19:30:04 INFO - PROCESS | 5014 | |3;mootools.html;1445.6241377241918;1460.9926950365248;1575.747880339146;1783.5184500184957;1786.6783978883805;6785.1518560179975;7496.92503074969;7519.812004699886;8021.037475502941;8067.91932080679;7575.393968482522;7667.961660191705;7772.300492955633;7778.5721785301785;7787.065552133752;2215.8338124640636;2248.808851247646;2258.1757658454626;2259.0850705464313;2262.988685056572;2196.2093646287326;2208.326460429568;2234.6871437998693;2236.2173239366175;2242.618754811686;2222.3999520129555;2225.8441909066373;2237.3735354100877;2242.3048854855047;2272.943176420586;2085.989570052155;2093.079045220098;2098.5697931923996;2105.3473423238843;2109.230131002173;2164.686120512517;2168.447046003275;2183.039462636451;2186.5736181444627;2187.890605469736;7730.884036739453;7823.139454659983;7823.374130069581;7843.6470358833985;7866.1740517245435;4560.771961401917;4653.464851542082;4658.068386322749;4658.277966915133;4705.317728929286;2780;2901.839264294299;2903.564465330196;2904.7385735283924;2921.2550799546193;825.9174082591753;854.9230569248798;862.5773371048203;899.4378513429107;917.47703808829;10757.408342541157;10800.297980631312;10837.512311945982;10864;10866.185036122244;4242.151569686075;4277.679174061957;4436.689431739812;4504.48198457175;4507.81968721254;9209.953950230207;9260.675876344296;9267.629294828132;9324.673636422693;9345.112214339626;4682.578567928903;4689.788959496831;4693.413323334583;4705.7411842349;4722.881927951828;3680.9079773005355;4051.9797401012806;4184.163167366478;4198.916021679611;4256.7445953242905;3731.104534911656;3749.081475038633;3813.828377723009;3815.8664446744788;3965.484487016727;1229.7970834812156;1240.7952687806592;1249.9187552809037;1256.5288016993627;1268.0362924177691;806.9475484093515;845.0746432656232;858.7595473267495;859.4971941414218;876.7369789063256;4996.950030499721;5086.694798312114;5234.502722241381;5369.543588794918;5404.675719456845;398.9361702127646;404.5145825009941;408.41392601616775;415.0453955901415;415.621784176398;3536.1513236822975;3638.326909521747;3642.3261696586214;3680.705543556509;3700.130469339703;9316.301277404222;9576.760580985392;9706.272029597667;9760.316777825627;9765.804683906283;9620.615175393046;9635.710928672152;9640.276979226446;9648.95175524132;9667.27495437845;7090.255523170096;7181.748638797617;7259.165196002422;7300.56196628204;7424.517406368569;5253.369595648546;5269.525742683024;5338.876266259141;5376.731163441734;5381.2197231402015;9018.954905225432;9024.774380640536;9075.410098343587;9108.77228069277;9154.450732956044;8493.235608795238;8917.866232006654;8942.329325300498;9086.772830679285;9153.542322883963;6070.210872586712;6284.622922624657;6395;6474.223093228654;6729.966350168218;7664.540127592362;7678.731244406419;7719.189485103983;7728;7742.225777422213;6595.274519802721;6882.827929301808;6930.896036559355;7007.509474336747;7014.473914456538;6766.323367663194;6810.6594670265295;6823.1812182538415;6831.795046148623;6890.069840571458;6213.254409470893;6219.191505104308;6274.058891166179;6274.686265686606;6451.70967306463;4778.092162489116;4806.615470762401;4810.374651295309;4827.686200396963;4857.514248575114;4720.173969555382;4735.171345014677;4767.69010014348;4813.78337974785;4814.422269327703 19:30:04 INFO - PROCESS | 5014 | |4;prototype.html;289.73489257329544;296.12199827511427;297.1783019949839;299.12058547869276;300.15506349625787;5056.6207534434925;5108.7956481740775;5121.257417674435;5127.3078134451835;5131.589472842178;4977.282837421093;4990.226514890189;5005.574526165271;5011.221016539131;5012.3985121785345;3752.2683076800035;3894.9610503894883;3967.424723415103;3988.7207895447186;4004;3924.097457584757;3953.2488827122756;3957.821898014582;3972.344563147077;3973.39742468682;3919.2945269851416;3928.3321835287925;3947.684185265172;3948.822302996358;3952.901177470572;3785.3943369060817;3934.504888142516;3943.4873466449467;3948.802559872009;3956.208758248362;3474;3475.2528206435736;3475.7661030334375;3485.5643044619424;3486.4073107571776;4720;4781.6891902026255;4817.638677099197;4828.806847726087;4853.660243782937;4396.802143903532;4502.41468609082;4507.278835386355;4513.796879140446;4530.841420550298;5093.312402825608;5205.698575356161;5222.556082732972;5232.633715639869;5244.842654720364;3762.755420897633;3793.1655035892336;3796.962030379716;3805.58138604756;3808.809559522013;5406.871787789373;5469.589780766459;5494.835154945318;5519.9448005519835;5550.888982220374;3749.662530372225;3861.6331448512346;3874.2832575973534;3882.6893848492055;3888.1446081861945;3902.2195560887935;3903.1608204236227;3923.5487918889694;3928.705347098979;3939.153082087365;4488.573585509372;4497.437820272466;4515.571020753023;4518.909621807546;4530.29780384041;4925.261210818406;5210.410824698428;5246.658967167122;5293.788248470095;5314.441983591744;1284.2358796516057;1308.358904136985;1309.43039777697;1312.1143228320846;1316.6379245707508;816.5424716880459;818.9140140285184;827.3009307135461;835.9122292159236;836.5775283481925;4498.908007776399;4577.679562430664;4610.262358022767;4619.838305659286;4621.884452888705;5398.757055932492;5412.512873841373;5416.133418653076;5430.51125398716;5437.728113594305;4532.410786597721;4613.123506533748;4654.301854721751;4655.534446555385;4665.440147182359;2884.769218462518;2903.7386635202934;2917.591537184796;2920.0801747449486;2920.8393538355595;5065.341505604248;5079.949200508022;5098.923516147261;5099.847004589868;5106.136260264977;5388;5510.586705997066;5520.309961254843;5550.27846379968;5561.610687251934;5081.441041485434;5086.16078347076;5095.095795396663;5106.055379754757;5118.846434606968;5381.784728610812;5386.218998245311;5433.429489903661;5455.61810673265;5465.1529013001455;5126.128558145198;5262.105442074933;5308.442613525524;5371.919421208607;5376.354837419378;5001.699898006132;5007.624428167975;5028.220625803006;5037.722925239147;5052.837847295069;3712.350338690664;3729.9254014920093;3748.5689145747497;3764.5294338207723;3781.4327850822597;5243.947560524346;5333.679979201261;5337.332833395825;5385.730713464232;5401;5212.306000549761;5231.607629427732;5233.973830130825;5250.212468129811;5270.262163297065;5136.409312929061;5196.246544251138;5221.582273418041;5244.921326180034;5244.921326180187;4979.377577802775;5112.769925353294;5154.329937108152;5159.9164175522055;5165.7933682653775;5038.496150384932;5159.065350493565;5262.500062494057;5327.600429967845;5338.1458966566715;5205.505476979681;5227.738613069255;5244.580433565382;5251.36983561975;5266.868328291824 19:30:04 INFO - PROCESS | 5014 | |5;yui.html;737.3032484302333;765.5521519910849;776.5301992294661;781.5779479081297;789.5381201996831;12338.13633045686;12771;13278.800817987738;13368.665783355422;13370.866291337084;14353.282335883216;14378.209198494105;14379;14417.207053612046;14447.060941038824;631.3276360675889;780.4263866058471;807.6325272001226;810.667626273228;817.3951276055735;807.168616325186;807.5921659561913;811.6428771340621;813.3818298093462;813.3980854167903;842.0905422144069;844.3793811548506;845.9280961118312;846.4455781463121;847.8558645030329;832.7918020494876;838.9370797190205;840.2983508770184;840.6091167607092;842.5155535567043;610.5573459242058;611.9632822030648;614.0696844280918;615.938406159385;616.3097330989276;12301.200421972542;12380.504779808796;12385.814212786816;12409.193402428813;12427.440765165498;11972.401379930969;12116.27302361861;12164.695882602917;12209.389530523438;12271.447784849703;9730.221582273402;9850.753731156707;10042.19662427004;10055.39667619945;10070.647527336581;3215.6945090216627;3266.852991615383;3276.8197749123788;3282.6717328267223;3318.0543545089777;46517.069658606975;46888.765556172344;47016;47470.5252947473;48068.03863922737;9261.953690231505;9265.675701350421;9268.304877134242;9426.95286523563;9564.61741530345;16009.519714408587;16556.586085347964;17117.657646846994;17146;17165.656686866194;6685.097511835937;6790.7623233186605;6857.657117144123;6887.655617219119;6930.792076237721;3599.7300202484917;3648.21563363878;3670.471868156962;3678.8528458861883;3690.538682664667;2706.201670507205;2785.9303517412227;2801.761850242752;2806.3124534488775;2806.6070750095005;489.1464394631391;494.5425481429735;499.717659522376;501.0230051399785;504.9192129259301;464.47746285428894;557.5511713071016;558.6815515156403;571.1176232720456;578.9363170051291;8256.215659512336;8274.544900030556;8347.83304333922;8420.873686894702;8474.703385381605;453.055379533676;458.933454649074;487.92899585410396;537.5672583570185;580.5703779203359;3501.8599256029474;3529.647035296501;3575.1419659281587;3634.7455678102806;3655.0862284428895;52647.736761316715;54819.17771233435;55517.44482555203;55553.444465555636;55704.44295557074;47753.28370074452;48495.27257091147;49351;49510;50325.24512132321;45960.770196148806;46160.3075953861;46318.07363852704;46677;47274.76362618165;7241.13106427211;7245.311695388929;7341.119065712149;7402.592857392895;7627.885581716389;30287.848560757935;30695.232619183807;31361.8431907839;31443.528347074356;31668.683313166573;40250.396244056945;40769.59230407658;40972.79513602413;41065.38401924033;41289;9363.859542106738;9379.390339627902;9387.389819661701;9625.133737963337;9716.659916902874;9810.411375317504;9879;9967.152792012761;10082.747931301776;10099.14157296638;8642.092580279232;8770.38607297483;8812.47125172466;8821.514816684887;9092.363534552518;9060;9152.63389464414;9159.129882661136;9286.30352723562;9465.100815422798;9197;9756.170725488413;9805.803883922425;9942.652007179713;10213.387196768217;9091;9188.254231695957;9350.625974961198;9357.672481463116;9598.472084035166;9433.198178154658;9709.6116155353;9749.463779492196;9822.214222862296;9955.601775928882 19:30:04 INFO - PROCESS | 5014 | __end_tp_report 19:30:04 INFO - PROCESS | 5014 | __start_cc_report 19:30:04 INFO - PROCESS | 5014 | _x_x_mozilla_cycle_collect,364 19:30:04 INFO - PROCESS | 5014 | __end_cc_report 19:30:04 INFO - PROCESS | 5014 | __startTimestamp1463711404110__endTimestamp 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | ------- Summary: start ------- 19:30:04 INFO - PROCESS | 5014 | Number of tests: 6 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | [#0] dojo.html Cycles:165 Average:4651.95 Median:4773.90 stddev:567.15 (11.9%) stddev-sans-first:546.67 19:30:04 INFO - PROCESS | 5014 | Values: 2648.1 2686.7 2691.1 2699.9 2721.4 4620.4 4673.8 4689.5 4763.7 4768.1 4631.3 4641.0 4647.7 4657.9 4721.3 4307.7 4361.0 4420.8 4426.2 4450.5 664.0 4291.8 4293.3 4346.4 4415.9 4335.0 4370.0 4392.4 4405.9 4424.9 4357.8 4388.6 4393.4 4396.2 4425.5 4270.6 4339.8 4371.5 4383.8 4387.1 4671.4 4684.1 4694.9 4702.4 4707.7 4970.6 5013.3 5080.3 5119.1 5120.9 5075.1 5094.2 5097.5 5099.6 5150.0 4732.3 4761.5 4764.5 4767.6 4820.9 5126.5 5180.8 5187.4 5201.4 5265.9 4884.5 4898.3 4941.6 4960.0 4961.1 5071.4 5082.9 5082.9 5086.3 5126.2 4929.5 4979.4 5000.7 5000.8 5002.1 4993.6 5025.7 5054.7 5058.3 5065.9 4341.6 4349.2 4349.4 4351.1 4393.9 3699.3 3715.4 3785.9 3837.9 3847.4 4340.8 4343.7 4359.0 4368.4 4415.1 5115.3 5119.1 5125.1 5129.8 5171.4 4291.4 4352.2 4354.6 4365.5 4384.3 4577.6 4619.8 4631.8 4648.3 4665.6 4745.2 4772.6 4772.6 4773.9 4824.3 4888.2 4998.3 5014.2 5047.6 5078.7 4723.3 4725.5 4726.9 4743.9 4783.4 4905.1 4967.4 4971.1 4980.0 5019.7 4953.1 4966.1 4994.9 4995.2 5019.0 4833.3 4837.7 4847.6 4850.2 4889.9 4809.4 4857.9 4861.4 4875.6 4909.9 4771.9 4775.3 4842.0 4845.3 4894.6 4974.3 4977.7 4988.5 4993.1 5010.8 4746.0 4880.8 4892.9 4893.1 4893.9 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | [#1] ext.html Cycles:180 Average:47717.81 Median:36816.17 stddev:90530.99 (245.9%) stddev-sans-first:90715.70 19:30:04 INFO - PROCESS | 5014 | Values: 553.5 596.7 600.0 614.2 624.8 39361.4 40118.6 40306.8 40734.8 43947.0 39644.6 40363.4 40487.6 40495.8 40496.8 7684.0 7785.9 7858.6 7869.3 7874.5 7653.2 7689.0 7749.7 7753.2 7756.1 7756.7 7793.0 7834.7 7838.3 7843.3 7733.3 7777.6 7795.7 7810.6 7816.5 7673.5 7766.4 7769.5 7802.3 7829.1 37607.4 37750.8 37876.4 38048.4 38052.0 3090.2 3194.4 3218.5 3378.9 3718.1 28320.9 28680.0 28714.0 28813.3 29002.3 3052.9 3091.1 3092.8 3132.7 3170.4 256786.0 257231.0 257513.0 258157.0 258455.0 31571.8 51396.7 51441.2 51474.7 51627.7 31949.8 33857.8 33879.3 34095.5 34160.0 12652.5 12753.6 12820.9 12922.7 13041.3 10493.3 10658.6 10660.8 10771.5 10869.6 7866.3 7875.3 7889.4 7915.7 7932.8 3201.3 3201.7 3207.9 3228.6 3273.0 852.3 892.5 908.5 937.2 985.5 27360.7 27923.0 27971.2 28139.2 28405.1 948.6 981.0 984.4 1031.7 1113.9 14557.9 14942.4 15036.8 15215.3 15236.2 402269.0 405539.0 406156.0 406996.0 409349.0 48496.0 48925.0 49152.8 49159.0 49172.8 1186.5 1206.7 1208.1 1227.5 1235.2 25855.0 27371.7 27387.8 27836.4 28137.3 41172.4 41351.0 41853.4 41912.6 41968.8 345221.0 346560.0 347226.0 347339.0 349318.0 24608.9 24879.0 25012.0 25055.9 25235.4 41775.6 42167.6 42381.6 42689.1 42745.4 36063.0 36757.6 36802.1 37086.8 37275.3 36021.6 36390.8 36830.3 37155.6 37198.8 31258.0 34884.5 35305.3 35424.0 38094.0 31255.7 32504.7 32953.3 33186.7 33253.5 24545.1 24723.4 25256.5 25382.9 25533.5 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | [#2] jquery.html Cycles:180 Average:25865.00 Median:49562.26 stddev:67380.23 (136.0%) stddev-sans-first:67542.07 19:30:04 INFO - PROCESS | 5014 | Values: 374.6 378.4 380.3 380.6 394.3 10498.7 11125.3 11143.7 11163.3 16000.8 16162.8 16714.8 16837.2 16958.6 17845.5 5764.5 5778.7 6968.8 7038.8 7149.6 7055.4 7101.9 7119.0 7119.0 7156.8 6852.1 7076.4 7143.1 7151.1 7185.6 6871.6 7030.1 7031.6 7056.2 7056.9 6584.6 6812.1 6846.6 6940.0 6950.2 19307.4 19467.6 19621.2 23667.8 23810.9 1995.4 2093.7 2430.7 2522.1 2684.6 14168.8 14737.4 14783.5 14996.6 15139.7 1833.3 1848.5 1859.8 1924.8 1935.7 56272.6 64794.7 70919.3 79263.6 79453.6 15232.5 16815.4 16957.2 16976.7 17110.9 29519.6 29536.0 29759.4 29762.6 29945.6 8409.4 8644.2 8727.0 8782.3 8810.0 6937.3 6937.5 6947.3 7045.4 7107.6 8579.4 8579.5 8603.4 8707.7 8765.3 3364.9 3417.0 3451.8 3533.5 3584.9 818.4 857.3 909.2 919.1 923.8 16772.2 17170.1 17276.7 17309.7 17372.8 830.9 862.9 863.8 864.9 887.6 9269.5 9655.5 9682.5 9747.6 9793.0 404999.0 407416.0 409522.0 409560.0 415931.0 79004.0 79138.0 79558.0 79678.0 80964.0 922.9 923.9 938.7 943.7 945.1 15063.6 15145.3 15286.8 15303.5 15605.7 34001.3 34004.3 34435.3 34890.8 35644.5 47566.0 49188.3 49544.3 49580.3 49606.8 7406.9 7605.3 7705.2 7793.5 7842.8 6930.9 9771.5 11512.8 11644.4 11860.6 5005.0 6896.9 8378.4 9985.1 10140.9 10276.8 10301.0 10461.9 10465.7 10542.2 10086.7 10148.5 10289.6 10527.9 10638.9 7846.5 8006.5 8018.4 8223.6 8245.3 9363.0 10447.8 10541.0 10637.5 10768.9 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | [#3] mootools.html Cycles:180 Average:5169.06 Median:5041.82 stddev:2900.20 (57.5%) stddev-sans-first:2894.84 19:30:04 INFO - PROCESS | 5014 | Values: 1445.6 1461.0 1575.7 1783.5 1786.7 6785.2 7496.9 7519.8 8021.0 8067.9 7575.4 7668.0 7772.3 7778.6 7787.1 2215.8 2248.8 2258.2 2259.1 2263.0 2196.2 2208.3 2234.7 2236.2 2242.6 2222.4 2225.8 2237.4 2242.3 2272.9 2086.0 2093.1 2098.6 2105.3 2109.2 2164.7 2168.4 2183.0 2186.6 2187.9 7730.9 7823.1 7823.4 7843.6 7866.2 4560.8 4653.5 4658.1 4658.3 4705.3 2780.0 2901.8 2903.6 2904.7 2921.3 825.9 854.9 862.6 899.4 917.5 10757.4 10800.3 10837.5 10864.0 10866.2 4242.2 4277.7 4436.7 4504.5 4507.8 9210.0 9260.7 9267.6 9324.7 9345.1 4682.6 4689.8 4693.4 4705.7 4722.9 3680.9 4052.0 4184.2 4198.9 4256.7 3731.1 3749.1 3813.8 3815.9 3965.5 1229.8 1240.8 1249.9 1256.5 1268.0 806.9 845.1 858.8 859.5 876.7 4997.0 5086.7 5234.5 5369.5 5404.7 398.9 404.5 408.4 415.0 415.6 3536.2 3638.3 3642.3 3680.7 3700.1 9316.3 9576.8 9706.3 9760.3 9765.8 9620.6 9635.7 9640.3 9649.0 9667.3 7090.3 7181.7 7259.2 7300.6 7424.5 5253.4 5269.5 5338.9 5376.7 5381.2 9019.0 9024.8 9075.4 9108.8 9154.5 8493.2 8917.9 8942.3 9086.8 9153.5 6070.2 6284.6 6395.0 6474.2 6730.0 7664.5 7678.7 7719.2 7728.0 7742.2 6595.3 6882.8 6930.9 7007.5 7014.5 6766.3 6810.7 6823.2 6831.8 6890.1 6213.3 6219.2 6274.1 6274.7 6451.7 4778.1 4806.6 4810.4 4827.7 4857.5 4720.2 4735.2 4767.7 4813.8 4814.4 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | [#4] prototype.html Cycles:180 Average:4363.49 Median:5006.60 stddev:1269.24 (25.4%) stddev-sans-first:1235.43 19:30:04 INFO - PROCESS | 5014 | Values: 289.7 296.1 297.2 299.1 300.2 5056.6 5108.8 5121.3 5127.3 5131.6 4977.3 4990.2 5005.6 5011.2 5012.4 3752.3 3895.0 3967.4 3988.7 4004.0 3924.1 3953.2 3957.8 3972.3 3973.4 3919.3 3928.3 3947.7 3948.8 3952.9 3785.4 3934.5 3943.5 3948.8 3956.2 3474.0 3475.3 3475.8 3485.6 3486.4 4720.0 4781.7 4817.6 4828.8 4853.7 4396.8 4502.4 4507.3 4513.8 4530.8 5093.3 5205.7 5222.6 5232.6 5244.8 3762.8 3793.2 3797.0 3805.6 3808.8 5406.9 5469.6 5494.8 5519.9 5550.9 3749.7 3861.6 3874.3 3882.7 3888.1 3902.2 3903.2 3923.5 3928.7 3939.2 4488.6 4497.4 4515.6 4518.9 4530.3 4925.3 5210.4 5246.7 5293.8 5314.4 1284.2 1308.4 1309.4 1312.1 1316.6 816.5 818.9 827.3 835.9 836.6 4498.9 4577.7 4610.3 4619.8 4621.9 5398.8 5412.5 5416.1 5430.5 5437.7 4532.4 4613.1 4654.3 4655.5 4665.4 2884.8 2903.7 2917.6 2920.1 2920.8 5065.3 5079.9 5098.9 5099.8 5106.1 5388.0 5510.6 5520.3 5550.3 5561.6 5081.4 5086.2 5095.1 5106.1 5118.8 5381.8 5386.2 5433.4 5455.6 5465.2 5126.1 5262.1 5308.4 5371.9 5376.4 5001.7 5007.6 5028.2 5037.7 5052.8 3712.4 3729.9 3748.6 3764.5 3781.4 5243.9 5333.7 5337.3 5385.7 5401.0 5212.3 5231.6 5234.0 5250.2 5270.3 5136.4 5196.2 5221.6 5244.9 5244.9 4979.4 5112.8 5154.3 5159.9 5165.8 5038.5 5159.1 5262.5 5327.6 5338.1 5205.5 5227.7 5244.6 5251.4 5266.9 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | [#5] yui.html Cycles:180 Average:12944.80 Median:28131.00 stddev:15326.58 (54.5%) stddev-sans-first:15342.16 19:30:04 INFO - PROCESS | 5014 | Values: 737.3 765.6 776.5 781.6 789.5 12338.1 12771.0 13278.8 13368.7 13370.9 14353.3 14378.2 14379.0 14417.2 14447.1 631.3 780.4 807.6 810.7 817.4 807.2 807.6 811.6 813.4 813.4 842.1 844.4 845.9 846.4 847.9 832.8 838.9 840.3 840.6 842.5 610.6 612.0 614.1 615.9 616.3 12301.2 12380.5 12385.8 12409.2 12427.4 11972.4 12116.3 12164.7 12209.4 12271.4 9730.2 9850.8 10042.2 10055.4 10070.6 3215.7 3266.9 3276.8 3282.7 3318.1 46517.1 46888.8 47016.0 47470.5 48068.0 9262.0 9265.7 9268.3 9427.0 9564.6 16009.5 16556.6 17117.7 17146.0 17165.7 6685.1 6790.8 6857.7 6887.7 6930.8 3599.7 3648.2 3670.5 3678.9 3690.5 2706.2 2785.9 2801.8 2806.3 2806.6 489.1 494.5 499.7 501.0 504.9 464.5 557.6 558.7 571.1 578.9 8256.2 8274.5 8347.8 8420.9 8474.7 453.1 458.9 487.9 537.6 580.6 3501.9 3529.6 3575.1 3634.7 3655.1 52647.7 54819.2 55517.4 55553.4 55704.4 47753.3 48495.3 49351.0 49510.0 50325.2 45960.8 46160.3 46318.1 46677.0 47274.8 7241.1 7245.3 7341.1 7402.6 7627.9 30287.8 30695.2 31361.8 31443.5 31668.7 40250.4 40769.6 40972.8 41065.4 41289.0 9363.9 9379.4 9387.4 9625.1 9716.7 9810.4 9879.0 9967.2 10082.7 10099.1 8642.1 8770.4 8812.5 8821.5 9092.4 9060.0 9152.6 9159.1 9286.3 9465.1 9197.0 9756.2 9805.8 9942.7 10213.4 9091.0 9188.3 9350.6 9357.7 9598.5 9433.2 9709.6 9749.5 9822.2 9955.6 19:30:04 INFO - PROCESS | 5014 | -------- Summary: end -------- 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - PROCESS | 5014 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 19:30:04 INFO - PROCESS | 5014 | 19:30:04 INFO - TEST-INFO | 5014: exit 0 19:30:04 INFO - TEST-OK | dromaeo_css | took 1115520ms 19:30:04 INFO - TEST-START | kraken 19:30:04 INFO - operating with platform_type : linux_ 19:30:04 INFO - Initialising browser for kraken test... 19:30:04 INFO - TEST-INFO | started process 5249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_004L/profile http://localhost:40495/getInfo.html) 19:30:08 INFO - PROCESS | 5249 | 19:30:08 INFO - PROCESS | 5249 | (process:5316): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:30:09 INFO - PROCESS | 5249 | __metrics Screen width/height:1600/1200 19:30:09 INFO - PROCESS | 5249 | colorDepth:24 19:30:09 INFO - PROCESS | 5249 | Browser inner width/height: 1024/697 19:30:09 INFO - PROCESS | 5249 | __metrics 19:30:10 ERROR - PROCESS | 5249 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:30:11 INFO - TEST-INFO | 5249: exit 0 19:30:11 INFO - Browser initialized. 19:30:11 INFO - Running cycle 1/1 for kraken test... 19:30:11 INFO - TEST-INFO | started process 5367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_004L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:13 INFO - PROCESS | 5367 | 19:30:13 INFO - PROCESS | 5367 | (process:5427): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:30:23 INFO - PROCESS | 5367 | RSS: Main: 165367808 19:30:23 INFO - PROCESS | 5367 | 19:30:25 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40495/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:26 INFO - PROCESS | 5367 | RSS: Main: 168628224 19:30:26 INFO - PROCESS | 5367 | 19:30:29 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40495/tests/kraken/driver.html?testName=audio-dft) 19:30:30 INFO - PROCESS | 5367 | RSS: Main: 168906752 19:30:30 INFO - PROCESS | 5367 | 19:30:33 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40495/tests/kraken/driver.html?testName=audio-fft) 19:30:34 INFO - PROCESS | 5367 | RSS: Main: 164765696 19:30:34 INFO - PROCESS | 5367 | 19:30:36 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40495/tests/kraken/driver.html?testName=audio-oscillator) 19:30:36 INFO - PROCESS | 5367 | RSS: Main: 164843520 19:30:36 INFO - PROCESS | 5367 | 19:30:39 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40495/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:39 INFO - PROCESS | 5367 | RSS: Main: 165388288 19:30:39 INFO - PROCESS | 5367 | 19:30:43 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40495/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:43 INFO - PROCESS | 5367 | RSS: Main: 165322752 19:30:43 INFO - PROCESS | 5367 | 19:30:47 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40495/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:48 INFO - PROCESS | 5367 | RSS: Main: 164442112 19:30:48 INFO - PROCESS | 5367 | 19:30:51 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40495/tests/kraken/driver.html?testName=json-parse-financial) 19:30:51 INFO - PROCESS | 5367 | RSS: Main: 164601856 19:30:51 INFO - PROCESS | 5367 | 19:30:53 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40495/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:54 INFO - PROCESS | 5367 | RSS: Main: 164859904 19:30:54 INFO - PROCESS | 5367 | 19:30:56 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:56 INFO - PROCESS | 5367 | RSS: Main: 165539840 19:30:56 INFO - PROCESS | 5367 | 19:30:59 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:59 INFO - PROCESS | 5367 | RSS: Main: 165502976 19:30:59 INFO - PROCESS | 5367 | 19:31:02 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:03 INFO - PROCESS | 5367 | RSS: Main: 165359616 19:31:03 INFO - PROCESS | 5367 | 19:31:06 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:06 INFO - PROCESS | 5367 | RSS: Main: 165519360 19:31:06 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | Cycle 1(1): loaded http://localhost:40495/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40495/tests/kraken/driver.html?testName=ai-astar) 19:31:08 INFO - PROCESS | 5367 | RSS: Main: 168235008 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | __start_tp_report 19:31:08 INFO - PROCESS | 5367 | _x_x_mozilla_page_load 19:31:08 INFO - PROCESS | 5367 | _x_x_mozilla_page_load_details 19:31:08 INFO - PROCESS | 5367 | |i|pagename|runs| 19:31:08 INFO - PROCESS | 5367 | |0;ai-astar;112;116;107;117;121;115;111;115;118;115 19:31:08 INFO - PROCESS | 5367 | |1;audio-beat-detection;162;130;162;211;132;170;169;134;203;136 19:31:08 INFO - PROCESS | 5367 | |2;audio-dft;163;165;176;164;164;165;163;163;164;163 19:31:08 INFO - PROCESS | 5367 | |3;audio-fft;75;75;76;173;79;75;77;75;157;80 19:31:08 INFO - PROCESS | 5367 | |4;audio-oscillator;94;95;176;94;95;94;151;95;94;155 19:31:08 INFO - PROCESS | 5367 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;118;117;117 19:31:08 INFO - PROCESS | 5367 | |6;imaging-darkroom;147;147;147;148;149;148;147;149;147;147 19:31:08 INFO - PROCESS | 5367 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;95 19:31:08 INFO - PROCESS | 5367 | |8;json-parse-financial;64;66;65;65;70;65;65;67;67;67 19:31:08 INFO - PROCESS | 5367 | |9;json-stringify-tinderbox;65;65;64;65;65;65;64;65;69;67 19:31:08 INFO - PROCESS | 5367 | |10;stanford-crypto-aes;89;85;83;86;84;86;89;86;139;83 19:31:08 INFO - PROCESS | 5367 | |11;stanford-crypto-ccm;145;138;137;138;144;133;130;143;153;144 19:31:08 INFO - PROCESS | 5367 | |12;stanford-crypto-pbkdf2;173;173;172;177;175;171;172;173;168;167 19:31:08 INFO - PROCESS | 5367 | |13;stanford-crypto-sha256-iterative;66;68;68;68;71;65;67;66;70;69 19:31:08 INFO - PROCESS | 5367 | __end_tp_report 19:31:08 INFO - PROCESS | 5367 | __start_cc_report 19:31:08 INFO - PROCESS | 5367 | _x_x_mozilla_cycle_collect,956 19:31:08 INFO - PROCESS | 5367 | __end_cc_report 19:31:08 INFO - PROCESS | 5367 | __startTimestamp1463711468923__endTimestamp 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | ------- Summary: start ------- 19:31:08 INFO - PROCESS | 5367 | Number of tests: 14 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.50 stddev:3.92 (3.4%) stddev-sans-first:4.03 19:31:08 INFO - PROCESS | 5367 | Values: 112.0 116.0 107.0 117.0 121.0 115.0 111.0 115.0 118.0 115.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#1] audio-beat-detection Cycles:10 Average:160.90 Median:165.50 stddev:29.00 (17.5%) stddev-sans-first:30.75 19:31:08 INFO - PROCESS | 5367 | Values: 162.0 130.0 162.0 211.0 132.0 170.0 169.0 134.0 203.0 136.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.94 (2.4%) stddev-sans-first:4.12 19:31:08 INFO - PROCESS | 5367 | Values: 163.0 165.0 176.0 164.0 164.0 165.0 163.0 163.0 164.0 163.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:37.55 (49.7%) stddev-sans-first:39.18 19:31:08 INFO - PROCESS | 5367 | Values: 75.0 75.0 76.0 173.0 79.0 75.0 77.0 75.0 157.0 80.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#4] audio-oscillator Cycles:10 Average:114.30 Median:94.00 stddev:32.62 (34.7%) stddev-sans-first:33.76 19:31:08 INFO - PROCESS | 5367 | Values: 94.0 95.0 176.0 94.0 95.0 94.0 151.0 95.0 94.0 155.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:31:08 INFO - PROCESS | 5367 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 19:31:08 INFO - PROCESS | 5367 | Values: 147.0 147.0 147.0 148.0 149.0 148.0 147.0 149.0 147.0 147.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:31:08 INFO - PROCESS | 5367 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.50 stddev:1.73 (2.6%) stddev-sans-first:1.66 19:31:08 INFO - PROCESS | 5367 | Values: 64.0 66.0 65.0 65.0 70.0 65.0 65.0 67.0 67.0 67.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 19:31:08 INFO - PROCESS | 5367 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 69.0 67.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:86.00 stddev:17.00 (19.8%) stddev-sans-first:18.01 19:31:08 INFO - PROCESS | 5367 | Values: 89.0 85.0 83.0 86.0 84.0 86.0 89.0 86.0 139.0 83.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:143.50 stddev:6.65 (4.6%) stddev-sans-first:6.86 19:31:08 INFO - PROCESS | 5367 | Values: 145.0 138.0 137.0 138.0 144.0 133.0 130.0 143.0 153.0 144.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:2.96 (1.7%) stddev-sans-first:3.12 19:31:08 INFO - PROCESS | 5367 | Values: 173.0 173.0 172.0 177.0 175.0 171.0 172.0 173.0 168.0 167.0 19:31:08 INFO - PROCESS | 5367 | 19:31:08 INFO - PROCESS | 5367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.87 19:31:08 INFO - PROCESS | 5367 | Values: 66.0 68.0 68.0 68.0 71.0 65.0 67.0 66.0 70.0 69.0 19:31:08 INFO - PROCESS | 5367 | -------- Summary: end -------- 19:31:08 INFO - PROCESS | 5367 | 19:31:09 INFO - TEST-INFO | 5367: exit 0 19:31:09 INFO - TEST-OK | kraken | took 65114ms 19:31:09 INFO - SUITE-END | took 1180s 19:31:10 INFO - Completed test suite (00:19:40) 19:31:10 INFO - javascript benchmark 19:31:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6363.343503220584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2648.0996461203185, 2686.7313268673133, 2691.0850310894293, 2699.851508167051, 2721.4285000149957, 4620.376249206356, 4673.766311684415, 4689.5310468953085, 4763.714177149373, 4768.141734487799, 4631.305304204371, 4641.048585040067, 4647.7443740594335, 4657.86026419208, 4721.3390125382475, 4307.741535507872, 4360.97819510902, 4420.8010639521135, 4426.2254105531565, 4450.5104438511735, 663.9878473072963, 4291.8497852575165, 4293.313069908815, 4346.391505189276, 4415.911681766363, 4335.0, 4369.956300436987, 4392.428984232061, 4405.911881762347, 4424.867253982386, 4357.782110894443, 4388.605025547684, 4393.384926110347, 4396.164728701537, 4425.491068527129, 4270.636995855356, 4339.761313127777, 4371.540988196225, 4383.846565370229, 4387.056782791683, 4671.392718946515, 4684.086603112394, 4694.906101877978, 4702.435707715096, 4707.71753694776, 4970.552650261494, 5013.298138260647, 5080.263361812554, 5119.052975199563, 5120.92318615221, 5075.0611136939415, 5094.159463688524, 5097.464766199532, 5099.643024988252, 5150.0, 4732.337472753818, 4761.52384761528, 4764.475907650121, 4767.570918617341, 4820.903581928342, 5126.487351264844, 5180.818671346485, 5187.429382767892, 5201.375834899836, 5265.947340526545, 4884.462709101996, 4898.289747986522, 4941.579965702956, 4960.032793605213, 4961.131801934647, 5071.41678706946, 5082.923756143661, 5082.949170508247, 5086.262491938648, 5126.179811230185, 4929.482404347564, 4979.402471703346, 5000.749962501933, 5000.799968001312, 5002.074616196015, 4993.600511959107, 5025.723585202776, 5054.7472626368535, 5058.291839142523, 5065.898682026413, 4341.587549182823, 4349.217140914666, 4349.391085248068, 4351.06452112791, 4393.890152746207, 3699.3341198583976, 3715.4241092630687, 3785.886423407302, 3837.9040523987123, 3847.3844184930276, 4340.804663790137, 4343.739375637472, 4358.956410435919, 4368.432103826546, 4415.116976604692, 5115.309433226466, 5119.0529751996, 5125.077486052546, 5129.794808207705, 5171.3535808024, 4291.356296555479, 4352.151330490524, 4354.586314300136, 4365.476142862877, 4384.254676704968, 4577.610903073276, 4619.815207391666, 4631.8378856739855, 4648.279516674921, 4665.626749860003, 4745.193317136095, 4772.570468657698, 4772.6420518461255, 4773.9045219096115, 4824.300476430898, 4888.169011268022, 4998.2752500886445, 5014.247862820606, 5047.646664733434, 5078.669886457516, 4723.338732577373, 4725.527447255247, 4726.905461890812, 4743.857684269477, 4783.449903261169, 4905.1416002200185, 4967.3542439482635, 4971.080350135237, 4979.975100124476, 5019.698818070928, 4953.133201689762, 4966.130927087817, 4994.925076123934, 4995.200767877122, 5018.974905125597, 4833.32333473307, 4837.685550439211, 4847.612191024639, 4850.1997170466475, 4889.877753056202, 4809.398825146856, 4857.927131093107, 4861.368022157097, 4875.585575226146, 4909.852704418873, 4771.880702982453, 4775.283707443911, 4842.0, 4845.297431872288, 4894.632902532396, 4974.253861920741, 4977.726225057657, 4988.476209997898, 4993.101241776515, 5010.774515146754, 4745.976270118627, 4880.80476780939, 4892.874638833017, 4893.143699852582, 4893.877653058559], "value": 4618.917472576024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5073784331945, 596.7434003378551, 599.9730012149453, 614.2352770800354, 624.8437890527371, 39361.40957885634, 40118.59881401185, 40306.798466007705, 40734.79632601833, 43947.0, 39644.60355396452, 40363.39454908171, 40487.59512404875, 40495.79752101243, 40496.797516012455, 7683.999999999986, 7785.883211751829, 7858.646360913744, 7869.291763741262, 7874.527528348317, 7653.15815260321, 7689.0, 7749.728759493419, 7753.185915478878, 7756.0692716874055, 7756.728514501993, 7793.0, 7834.72578459754, 7838.333741631968, 7843.294103530681, 7733.304002639761, 7777.611119444034, 7795.727149549795, 7810.648520816577, 7816.53100813953, 7673.539587624705, 7766.417518686065, 7769.456138070337, 7802.33680137189, 7829.060512738508, 37607.435888461696, 37750.811245943594, 37876.43185352222, 38048.42927356092, 38052.0, 3090.242890491844, 3194.4090343286334, 3218.5494030835703, 3378.9155271118175, 3718.0890681782867, 28320.858395708095, 28680.0, 28714.0, 28813.279668008257, 29002.27494312638, 3052.893148739806, 3091.0881290019497, 3092.8144311341393, 3132.749380049613, 3170.381775553768, 256786.0, 257231.0, 257513.0, 258157.0, 258455.0, 31571.842140789147, 51396.74301628543, 51441.22838157431, 51474.74262628663, 51627.74186129045, 31949.840250798596, 33857.83071084629, 33879.32241355209, 34095.488567671506, 34159.97520074402, 12652.493900243888, 12753.553625623059, 12820.93589532065, 12922.676933076747, 13041.282729449971, 10493.26547141708, 10658.573657053787, 10660.786784264426, 10771.515281812337, 10869.619563315246, 7866.292033716879, 7875.291223789886, 7889.447738658238, 7915.683372665029, 7932.841343173104, 3201.327721178532, 3201.6798320168264, 3207.903762887117, 3228.596425446819, 3272.967270327314, 852.3096292003497, 892.4823602310644, 908.4776253654176, 937.1612406895927, 985.4924713772413, 27360.726392735818, 27923.0, 27971.16086517408, 28139.155825325273, 28405.147845564665, 948.6489998700387, 980.9509524523888, 984.4339504784778, 1031.7317497450567, 1113.881132828078, 14557.927210364092, 14942.40230390794, 15036.774448383283, 15215.31531081104, 15236.162011089496, 402269.0, 405539.0, 406156.0, 406996.0, 409349.0, 48496.0, 48925.0, 49152.75423622859, 49159.0, 49172.75413622909, 1186.507599346279, 1206.6561030106377, 1208.1241100202458, 1227.5396726227664, 1235.2032938754633, 25855.0, 27371.72628273692, 27387.80322103709, 27836.44327113406, 28137.296567585974, 41172.38241426441, 41350.9662258446, 41853.37219941642, 41912.58087419087, 41968.79015604902, 345221.0, 346560.0, 347226.0, 347339.0, 349318.0, 24608.908242799564, 24879.0, 25012.0, 25055.87472062628, 25235.369115772253, 41775.58224417717, 42167.57832421637, 42381.57618423776, 42689.146217074864, 42745.35881961711, 36063.0, 36757.63242367542, 36802.07994800044, 37086.814565927, 37275.25449491049, 36021.63978360183, 36390.818045909604, 36830.263394732494, 37155.6284437163, 37198.814005929795, 31258.0, 34884.476732849536, 35305.293894122486, 35424.0, 38094.0, 31255.687443125276, 32504.674953250164, 32953.34093318168, 33186.66813331836, 33253.50119748254, 24545.14092006771, 24723.381915451537, 25256.494870102862, 25382.873085634452, 25533.48933021292], "value": 16508.647893911228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.6478310388235, 378.37945768938937, 380.27557502956876, 380.57185666125594, 394.33554460733666, 10498.737531561705, 11125.332480051202, 11143.72140696483, 11163.330200187995, 16000.839991600094, 16162.83837161628, 16714.83285167148, 16837.242324095416, 16958.576035599115, 17845.46463606094, 5764.538836893039, 5778.682172480522, 6968.825779355506, 7038.788836334918, 7149.606771627558, 7055.435565154801, 7101.89347159793, 7118.964405177967, 7118.964405177967, 7156.7852964410895, 6852.109225800664, 7076.398506126985, 7143.142822861264, 7151.141862976424, 7185.568865868038, 6871.587704737682, 7030.121234845645, 7031.6484175791, 7056.223815380304, 7056.858862822741, 6584.572002819801, 6812.14848143982, 6846.5892046477375, 6939.965300173517, 6950.235474097845, 19307.4207773767, 19467.610647787107, 19621.215151393928, 23667.76332236673, 23810.880945595334, 1995.4412764425983, 2093.72781538399, 2430.708315002211, 2522.0794410040203, 2684.5570480870633, 14168.787468187986, 14737.410503579951, 14783.482578109715, 14996.550103496913, 15139.697206055927, 1833.2575307000686, 1848.4639454558296, 1859.8140185981429, 1924.7786504552016, 1935.7483527141521, 56272.59318517029, 64794.676026620036, 70919.29080709179, 79263.6036819818, 79453.60273198655, 15232.543023709306, 16815.411460599065, 16957.15214239283, 16976.660466790596, 17110.914445427694, 29519.55720664149, 29536.0, 29759.404811904074, 29762.553561696594, 29945.550816737767, 8409.369297302726, 8644.178803013703, 8726.956365218133, 8782.253508451726, 8809.955950220208, 6937.306269373023, 6937.479689023344, 6947.305269473012, 7045.436365090781, 7107.609081500567, 8579.399442038997, 8579.485230886166, 8603.397762156588, 8707.651693932172, 8765.342599305077, 3364.915877103092, 3416.982915085409, 3451.8243216241117, 3533.4876442915634, 3584.874529391511, 818.3698552114838, 857.3098655582316, 909.1906010427809, 919.1406035356963, 923.8198551282435, 16772.161391930356, 17170.141492925304, 17276.654466910844, 17309.7403538947, 17372.82627173712, 830.8836762853206, 862.8791969124328, 863.7711006583261, 864.8745931839974, 887.5784002598843, 9269.490178040138, 9655.517224138765, 9682.467464289532, 9747.61009559624, 9792.951035244778, 404999.0, 407416.0, 409522.0, 409560.0, 415931.0, 79004.0, 79138.0, 79558.0, 79678.0, 80964.0, 922.9077092290852, 923.8660394242797, 938.6761567259284, 943.6649989253854, 945.054945054945, 15063.623409414415, 15145.318460669516, 15286.847131528542, 15303.540893773205, 15605.687886242438, 34001.31997360088, 34004.319913601095, 34435.31129377449, 34890.82554587211, 35644.46533301951, 47566.0, 49188.26217606667, 49544.256836148204, 49580.25629615631, 49606.751966239935, 7406.888896666662, 7605.277498637621, 7705.22947705225, 7793.493422927491, 7842.764717058498, 6930.930690693029, 9771.462569558742, 11512.82730759056, 11644.417779110841, 11860.584879529175, 5005.0, 6896.896546551706, 8378.371622128243, 9985.087271664457, 10140.949295253477, 10276.845847312446, 10301.0, 10461.9476902615, 10465.68602941913, 10542.156627469938, 10086.747831304276, 10148.54331555067, 10289.639862604772, 10527.937806630027, 10638.946805266234, 7846.5292082475235, 8006.479578827358, 8018.398620103399, 8223.629936652984, 8245.340372770044, 9362.953185234303, 10447.84328235062, 10541.0, 10637.521311540844, 10768.946155269174], "value": 9254.125266490746, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.6241377241918, 1460.9926950365248, 1575.747880339146, 1783.5184500184957, 1786.6783978883805, 6785.1518560179975, 7496.92503074969, 7519.812004699886, 8021.037475502941, 8067.91932080679, 7575.393968482522, 7667.961660191705, 7772.300492955633, 7778.5721785301785, 7787.065552133752, 2215.8338124640636, 2248.808851247646, 2258.1757658454626, 2259.0850705464313, 2262.988685056572, 2196.2093646287326, 2208.326460429568, 2234.6871437998693, 2236.2173239366175, 2242.618754811686, 2222.3999520129555, 2225.8441909066373, 2237.3735354100877, 2242.3048854855047, 2272.943176420586, 2085.989570052155, 2093.079045220098, 2098.5697931923996, 2105.3473423238843, 2109.230131002173, 2164.686120512517, 2168.447046003275, 2183.039462636451, 2186.5736181444627, 2187.890605469736, 7730.884036739453, 7823.139454659983, 7823.374130069581, 7843.6470358833985, 7866.1740517245435, 4560.771961401917, 4653.464851542082, 4658.068386322749, 4658.277966915133, 4705.317728929286, 2780.0, 2901.839264294299, 2903.564465330196, 2904.7385735283924, 2921.2550799546193, 825.9174082591753, 854.9230569248798, 862.5773371048203, 899.4378513429107, 917.47703808829, 10757.408342541157, 10800.297980631312, 10837.512311945982, 10864.0, 10866.185036122244, 4242.151569686075, 4277.679174061957, 4436.689431739812, 4504.48198457175, 4507.81968721254, 9209.953950230207, 9260.675876344296, 9267.629294828132, 9324.673636422693, 9345.112214339626, 4682.578567928903, 4689.788959496831, 4693.413323334583, 4705.7411842349, 4722.881927951828, 3680.9079773005355, 4051.9797401012806, 4184.163167366478, 4198.916021679611, 4256.7445953242905, 3731.104534911656, 3749.081475038633, 3813.828377723009, 3815.8664446744788, 3965.484487016727, 1229.7970834812156, 1240.7952687806592, 1249.9187552809037, 1256.5288016993627, 1268.0362924177691, 806.9475484093515, 845.0746432656232, 858.7595473267495, 859.4971941414218, 876.7369789063256, 4996.950030499721, 5086.694798312114, 5234.502722241381, 5369.543588794918, 5404.675719456845, 398.9361702127646, 404.5145825009941, 408.41392601616775, 415.0453955901415, 415.621784176398, 3536.1513236822975, 3638.326909521747, 3642.3261696586214, 3680.705543556509, 3700.130469339703, 9316.301277404222, 9576.760580985392, 9706.272029597667, 9760.316777825627, 9765.804683906283, 9620.615175393046, 9635.710928672152, 9640.276979226446, 9648.95175524132, 9667.27495437845, 7090.255523170096, 7181.748638797617, 7259.165196002422, 7300.56196628204, 7424.517406368569, 5253.369595648546, 5269.525742683024, 5338.876266259141, 5376.731163441734, 5381.2197231402015, 9018.954905225432, 9024.774380640536, 9075.410098343587, 9108.77228069277, 9154.450732956044, 8493.235608795238, 8917.866232006654, 8942.329325300498, 9086.772830679285, 9153.542322883963, 6070.210872586712, 6284.622922624657, 6395.0, 6474.223093228654, 6729.966350168218, 7664.540127592362, 7678.731244406419, 7719.189485103983, 7728.0, 7742.225777422213, 6595.274519802721, 6882.827929301808, 6930.896036559355, 7007.509474336747, 7014.473914456538, 6766.323367663194, 6810.6594670265295, 6823.1812182538415, 6831.795046148623, 6890.069840571458, 6213.254409470893, 6219.191505104308, 6274.058891166179, 6274.686265686606, 6451.70967306463, 4778.092162489116, 4806.615470762401, 4810.374651295309, 4827.686200396963, 4857.514248575114, 4720.173969555382, 4735.171345014677, 4767.69010014348, 4813.78337974785, 4814.422269327703], "value": 4098.918632498815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.73489257329544, 296.12199827511427, 297.1783019949839, 299.12058547869276, 300.15506349625787, 5056.6207534434925, 5108.7956481740775, 5121.257417674435, 5127.3078134451835, 5131.589472842178, 4977.282837421093, 4990.226514890189, 5005.574526165271, 5011.221016539131, 5012.3985121785345, 3752.2683076800035, 3894.9610503894883, 3967.424723415103, 3988.7207895447186, 4004.0, 3924.097457584757, 3953.2488827122756, 3957.821898014582, 3972.344563147077, 3973.39742468682, 3919.2945269851416, 3928.3321835287925, 3947.684185265172, 3948.822302996358, 3952.901177470572, 3785.3943369060817, 3934.504888142516, 3943.4873466449467, 3948.802559872009, 3956.208758248362, 3474.0, 3475.2528206435736, 3475.7661030334375, 3485.5643044619424, 3486.4073107571776, 4720.0, 4781.6891902026255, 4817.638677099197, 4828.806847726087, 4853.660243782937, 4396.802143903532, 4502.41468609082, 4507.278835386355, 4513.796879140446, 4530.841420550298, 5093.312402825608, 5205.698575356161, 5222.556082732972, 5232.633715639869, 5244.842654720364, 3762.755420897633, 3793.1655035892336, 3796.962030379716, 3805.58138604756, 3808.809559522013, 5406.871787789373, 5469.589780766459, 5494.835154945318, 5519.9448005519835, 5550.888982220374, 3749.662530372225, 3861.6331448512346, 3874.2832575973534, 3882.6893848492055, 3888.1446081861945, 3902.2195560887935, 3903.1608204236227, 3923.5487918889694, 3928.705347098979, 3939.153082087365, 4488.573585509372, 4497.437820272466, 4515.571020753023, 4518.909621807546, 4530.29780384041, 4925.261210818406, 5210.410824698428, 5246.658967167122, 5293.788248470095, 5314.441983591744, 1284.2358796516057, 1308.358904136985, 1309.43039777697, 1312.1143228320846, 1316.6379245707508, 816.5424716880459, 818.9140140285184, 827.3009307135461, 835.9122292159236, 836.5775283481925, 4498.908007776399, 4577.679562430664, 4610.262358022767, 4619.838305659286, 4621.884452888705, 5398.757055932492, 5412.512873841373, 5416.133418653076, 5430.51125398716, 5437.728113594305, 4532.410786597721, 4613.123506533748, 4654.301854721751, 4655.534446555385, 4665.440147182359, 2884.769218462518, 2903.7386635202934, 2917.591537184796, 2920.0801747449486, 2920.8393538355595, 5065.341505604248, 5079.949200508022, 5098.923516147261, 5099.847004589868, 5106.136260264977, 5388.0, 5510.586705997066, 5520.309961254843, 5550.27846379968, 5561.610687251934, 5081.441041485434, 5086.16078347076, 5095.095795396663, 5106.055379754757, 5118.846434606968, 5381.784728610812, 5386.218998245311, 5433.429489903661, 5455.61810673265, 5465.1529013001455, 5126.128558145198, 5262.105442074933, 5308.442613525524, 5371.919421208607, 5376.354837419378, 5001.699898006132, 5007.624428167975, 5028.220625803006, 5037.722925239147, 5052.837847295069, 3712.350338690664, 3729.9254014920093, 3748.5689145747497, 3764.5294338207723, 3781.4327850822597, 5243.947560524346, 5333.679979201261, 5337.332833395825, 5385.730713464232, 5401.0, 5212.306000549761, 5231.607629427732, 5233.973830130825, 5250.212468129811, 5270.262163297065, 5136.409312929061, 5196.246544251138, 5221.582273418041, 5244.921326180034, 5244.921326180187, 4979.377577802775, 5112.769925353294, 5154.329937108152, 5159.9164175522055, 5165.7933682653775, 5038.496150384932, 5159.065350493565, 5262.500062494057, 5327.600429967845, 5338.1458966566715, 5205.505476979681, 5227.738613069255, 5244.580433565382, 5251.36983561975, 5266.868328291824], "value": 3948.8360164323944, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3032484302333, 765.5521519910849, 776.5301992294661, 781.5779479081297, 789.5381201996831, 12338.13633045686, 12771.0, 13278.800817987738, 13368.665783355422, 13370.866291337084, 14353.282335883216, 14378.209198494105, 14379.0, 14417.207053612046, 14447.060941038824, 631.3276360675889, 780.4263866058471, 807.6325272001226, 810.667626273228, 817.3951276055735, 807.168616325186, 807.5921659561913, 811.6428771340621, 813.3818298093462, 813.3980854167903, 842.0905422144069, 844.3793811548506, 845.9280961118312, 846.4455781463121, 847.8558645030329, 832.7918020494876, 838.9370797190205, 840.2983508770184, 840.6091167607092, 842.5155535567043, 610.5573459242058, 611.9632822030648, 614.0696844280918, 615.938406159385, 616.3097330989276, 12301.200421972542, 12380.504779808796, 12385.814212786816, 12409.193402428813, 12427.440765165498, 11972.401379930969, 12116.27302361861, 12164.695882602917, 12209.389530523438, 12271.447784849703, 9730.221582273402, 9850.753731156707, 10042.19662427004, 10055.39667619945, 10070.647527336581, 3215.6945090216627, 3266.852991615383, 3276.8197749123788, 3282.6717328267223, 3318.0543545089777, 46517.069658606975, 46888.765556172344, 47016.0, 47470.5252947473, 48068.03863922737, 9261.953690231505, 9265.675701350421, 9268.304877134242, 9426.95286523563, 9564.61741530345, 16009.519714408587, 16556.586085347964, 17117.657646846994, 17146.0, 17165.656686866194, 6685.097511835937, 6790.7623233186605, 6857.657117144123, 6887.655617219119, 6930.792076237721, 3599.7300202484917, 3648.21563363878, 3670.471868156962, 3678.8528458861883, 3690.538682664667, 2706.201670507205, 2785.9303517412227, 2801.761850242752, 2806.3124534488775, 2806.6070750095005, 489.1464394631391, 494.5425481429735, 499.717659522376, 501.0230051399785, 504.9192129259301, 464.47746285428894, 557.5511713071016, 558.6815515156403, 571.1176232720456, 578.9363170051291, 8256.215659512336, 8274.544900030556, 8347.83304333922, 8420.873686894702, 8474.703385381605, 453.055379533676, 458.933454649074, 487.92899585410396, 537.5672583570185, 580.5703779203359, 3501.8599256029474, 3529.647035296501, 3575.1419659281587, 3634.7455678102806, 3655.0862284428895, 52647.736761316715, 54819.17771233435, 55517.44482555203, 55553.444465555636, 55704.44295557074, 47753.28370074452, 48495.27257091147, 49351.0, 49510.0, 50325.24512132321, 45960.770196148806, 46160.3075953861, 46318.07363852704, 46677.0, 47274.76362618165, 7241.13106427211, 7245.311695388929, 7341.119065712149, 7402.592857392895, 7627.885581716389, 30287.848560757935, 30695.232619183807, 31361.8431907839, 31443.528347074356, 31668.683313166573, 40250.396244056945, 40769.59230407658, 40972.79513602413, 41065.38401924033, 41289.0, 9363.859542106738, 9379.390339627902, 9387.389819661701, 9625.133737963337, 9716.659916902874, 9810.411375317504, 9879.0, 9967.152792012761, 10082.747931301776, 10099.14157296638, 8642.092580279232, 8770.38607297483, 8812.47125172466, 8821.514816684887, 9092.363534552518, 9060.0, 9152.63389464414, 9159.129882661136, 9286.30352723562, 9465.100815422798, 9197.0, 9756.170725488413, 9805.803883922425, 9942.652007179713, 10213.387196768217, 9091.0, 9188.254231695957, 9350.625974961198, 9357.672481463116, 9598.472084035166, 9433.198178154658, 9709.6116155353, 9749.463779492196, 9822.214222862296, 9955.601775928882], "value": 5812.170187858391, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 107.0, 117.0, 121.0, 115.0, 111.0, 115.0, 118.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 162.0, 211.0, 132.0, 170.0, 169.0, 134.0, 203.0, 136.0], "value": 160.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 176.0, 164.0, 164.0, 165.0, 163.0, 163.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 173.0, 79.0, 75.0, 77.0, 75.0, 157.0, 80.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 176.0, 94.0, 95.0, 94.0, 151.0, 95.0, 94.0, 155.0], "value": 114.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 149.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 70.0, 65.0, 65.0, 67.0, 67.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 69.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 83.0, 86.0, 84.0, 86.0, 89.0, 86.0, 139.0, 83.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 138.0, 137.0, 138.0, 144.0, 133.0, 130.0, 143.0, 153.0, 144.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 172.0, 177.0, 175.0, 171.0, 172.0, 173.0, 168.0, 167.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 68.0, 71.0, 65.0, 67.0, 66.0, 70.0, 69.0], "value": 67.8, "unit": "score"}]}]} 19:31:10 INFO - Return code: 0 19:31:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:31:10 ERROR - # TBPL SUCCESS # 19:31:10 INFO - Running post-action listener: _resource_record_post_action 19:31:10 INFO - ##### 19:31:10 INFO - ##### Finished run-tests step (success) 19:31:10 INFO - ##### 19:31:10 INFO - Running post-run listener: _resource_record_post_run 19:31:10 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532885504; Read time: 8; Write time: 470796 19:31:10 INFO - TinderboxPrint: CPU usage
13.3% 19:31:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:31:10 INFO - TinderboxPrint: I/O write bytes / time
532,885,504 / 470,796 19:31:10 INFO - TinderboxPrint: CPU idle
8,284.5 (86.7%) 19:31:10 INFO - TinderboxPrint: CPU user
1,224.7 (12.8%) 19:31:10 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236765184; Read time: 0; Write time: 263416 19:31:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296120320; Read time: 8; Write time: 207380 19:31:10 INFO - Running post-run listener: _upload_blobber_files 19:31:10 INFO - Blob upload gear active. 19:31:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:15 INFO - (blobuploader) - INFO - Done attempting. 19:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:16 INFO - (blobuploader) - INFO - Done attempting. 19:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:31:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:17 INFO - (blobuploader) - INFO - Done attempting. 19:31:17 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:17 INFO - Return code: 0 19:31:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecd8799b8932d63750f3669cd47bbd0c9b59df1d16f33e3ce2af88bc3be37f8c910dbbd8fbbd00e0fa0f4ab118c5b91674d38be17469cb41ca30c697076d14d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e526a7549cb212b7b5fe6111a02352f7679de9c9ccd6a3e2882d3af19d851290c095b6f83cb411ed6cc070b77f319a5beed29a5ef5be248bd274731ee363618", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bede8668e1759f56a4a57251941273ea0c3a44123a9872898453110a0569568d9614d2058acdc287c3a3aac400b797b75ad1508962507c19117f07c6b146427"} 19:31:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:17 INFO - Contents: 19:31:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ecd8799b8932d63750f3669cd47bbd0c9b59df1d16f33e3ce2af88bc3be37f8c910dbbd8fbbd00e0fa0f4ab118c5b91674d38be17469cb41ca30c697076d14d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e526a7549cb212b7b5fe6111a02352f7679de9c9ccd6a3e2882d3af19d851290c095b6f83cb411ed6cc070b77f319a5beed29a5ef5be248bd274731ee363618", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bede8668e1759f56a4a57251941273ea0c3a44123a9872898453110a0569568d9614d2058acdc287c3a3aac400b797b75ad1508962507c19117f07c6b146427"} 19:31:17 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:17 INFO - Copying logs to upload dir... 19:31:17 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.556912 ========= master_lag: 5.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-05-19 19:31:21.623702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 19:31:21.626901) ========= 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=232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568 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/Fx-Team-Non-PGO/sha512/ecd8799b8932d63750f3669cd47bbd0c9b59df1d16f33e3ce2af88bc3be37f8c910dbbd8fbbd00e0fa0f4ab118c5b91674d38be17469cb41ca30c697076d14d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e526a7549cb212b7b5fe6111a02352f7679de9c9ccd6a3e2882d3af19d851290c095b6f83cb411ed6cc070b77f319a5beed29a5ef5be248bd274731ee363618", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bede8668e1759f56a4a57251941273ea0c3a44123a9872898453110a0569568d9614d2058acdc287c3a3aac400b797b75ad1508962507c19117f07c6b146427"} build_url:https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/Fglx_aZMSSydltO7a-VDIw/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/Fx-Team-Non-PGO/sha512/ecd8799b8932d63750f3669cd47bbd0c9b59df1d16f33e3ce2af88bc3be37f8c910dbbd8fbbd00e0fa0f4ab118c5b91674d38be17469cb41ca30c697076d14d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e526a7549cb212b7b5fe6111a02352f7679de9c9ccd6a3e2882d3af19d851290c095b6f83cb411ed6cc070b77f319a5beed29a5ef5be248bd274731ee363618", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bede8668e1759f56a4a57251941273ea0c3a44123a9872898453110a0569568d9614d2058acdc287c3a3aac400b797b75ad1508962507c19117f07c6b146427"}' ========= master_lag: 0.51 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 19:31:22.149419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:31:22.149721) ========= 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=232498196343f89f466a4a9a000001c8-1463707676.382392-1421602568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 19:31:22.165424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 19:31:22.165717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 19:31:22.166802) ========= ========= Total master_lag: 5.65 =========