builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1464243468.91 results: success (0) buildid: 20160525203033 builduid: 94abec3d545b40a39d51e94f4cf96f6f revision: 8dfd7c9d86397ed898d84933a3c39834f1db886f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:48.910369) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:48.910823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:48.911114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:48.935797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:48.936145) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 23:17:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-25 23:17:49 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.024811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.025147) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019898 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.074580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.074927) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8dfd7c9d86397ed898d84933a3c39834f1db886f --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 8dfd7c9d86397ed898d84933a3c39834f1db886f --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=5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 23:17:49,384 truncating revision to first 12 chars 2016-05-25 23:17:49,384 Setting DEBUG logging. 2016-05-25 23:17:49,384 attempt 1/10 2016-05-25 23:17:49,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8dfd7c9d8639?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 23:17:49,931 unpacking tar archive at: fx-team-8dfd7c9d8639/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.969584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.969928) ========= script_repo_revision: 8dfd7c9d86397ed898d84933a3c39834f1db886f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.970345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.970621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 23:17:49.979498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-25 23:17:49.979935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:17:50 INFO - MultiFileLogger online at 20160525 23:17:50 in /builds/slave/test 23:17:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:17:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:17:50 INFO - {'append_to_log': False, 23:17:50 INFO - 'base_work_dir': '/builds/slave/test', 23:17:50 INFO - 'blob_upload_branch': 'Fx-Team', 23:17:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:17:50 INFO - 'branch': 'Fx-Team', 23:17:50 INFO - 'buildbot_json_path': 'buildprops.json', 23:17:50 INFO - 'config_files': ('talos/linux_config.py',), 23:17:50 INFO - 'default_actions': ('clobber', 23:17:50 INFO - 'read-buildbot-config', 23:17:50 INFO - 'download-and-extract', 23:17:50 INFO - 'populate-webroot', 23:17:50 INFO - 'create-virtualenv', 23:17:50 INFO - 'install', 23:17:50 INFO - 'run-tests'), 23:17:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:17:50 INFO - 'download_minidump_stackwalk': True, 23:17:50 INFO - 'download_symbols': 'ondemand', 23:17:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:17:50 INFO - 'tooltool.py': '/tools/tooltool.py', 23:17:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:17:50 INFO - '/tools/misc-python/virtualenv.py')}, 23:17:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:17:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:17:50 INFO - 'installer_path': 'installer.exe', 23:17:50 INFO - 'log_level': 'info', 23:17:50 INFO - 'log_name': 'talos', 23:17:50 INFO - 'log_to_console': True, 23:17:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:17:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:17:50 INFO - 'opt_config_files': (), 23:17:50 INFO - 'pip_index': False, 23:17:50 INFO - 'sps_profile': False, 23:17:50 INFO - 'sps_profile_interval': 0, 23:17:50 INFO - 'suite': 'dromaeojs-e10s', 23:17:50 INFO - 'system_bits': '32', 23:17:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:17:50 INFO - 'title': 'talos-linux64-ix-011', 23:17:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:17:50 INFO - 'use_talos_json': True, 23:17:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:17:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:17:50 INFO - 'work_dir': 'build'} 23:17:50 INFO - ##### 23:17:50 INFO - ##### Running clobber step. 23:17:50 INFO - ##### 23:17:50 INFO - Running pre-action listener: _resource_record_pre_action 23:17:50 INFO - Running main action method: clobber 23:17:50 INFO - rmtree: /builds/slave/test/build 23:17:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:17:50 INFO - Running post-action listener: _resource_record_post_action 23:17:50 INFO - ##### 23:17:50 INFO - ##### Finished clobber step (success) 23:17:50 INFO - ##### 23:17:50 INFO - ##### 23:17:50 INFO - ##### Running read-buildbot-config step. 23:17:50 INFO - ##### 23:17:50 INFO - Running pre-action listener: _resource_record_pre_action 23:17:50 INFO - Running main action method: read_buildbot_config 23:17:50 INFO - Using buildbot properties: 23:17:50 INFO - { 23:17:50 INFO - "project": "", 23:17:50 INFO - "product": "firefox", 23:17:50 INFO - "script_repo_revision": "production", 23:17:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:17:50 INFO - "repository": "", 23:17:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:17:50 INFO - "buildid": "20160525203033", 23:17:50 INFO - "pgo_build": "True", 23:17:50 INFO - "basedir": "/builds/slave/test", 23:17:50 INFO - "buildnumber": 778, 23:17:50 INFO - "slavename": "talos-linux64-ix-011", 23:17:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:17:50 INFO - "platform": "ubuntu64_hw", 23:17:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:17:50 INFO - "branch": "fx-team", 23:17:50 INFO - "repo_path": "integration/fx-team", 23:17:50 INFO - "revision": "8dfd7c9d86397ed898d84933a3c39834f1db886f", 23:17:50 INFO - "stage_platform": "linux64-pgo", 23:17:50 INFO - "builduid": "94abec3d545b40a39d51e94f4cf96f6f", 23:17:50 INFO - "slavebuilddir": "test" 23:17:50 INFO - } 23:17:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:17:50 INFO - Running post-action listener: _resource_record_post_action 23:17:50 INFO - ##### 23:17:50 INFO - ##### Finished read-buildbot-config step (success) 23:17:50 INFO - ##### 23:17:50 INFO - ##### 23:17:50 INFO - ##### Running download-and-extract step. 23:17:50 INFO - ##### 23:17:50 INFO - Running pre-action listener: _resource_record_pre_action 23:17:50 INFO - Running main action method: download_and_extract 23:17:50 INFO - mkdir: /builds/slave/test/build/tests 23:17: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')]} 23:17:50 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:17:55 INFO - Downloaded 1361 bytes. 23:17:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:17:55 INFO - Using the following test package requirements: 23:17:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:17:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:17:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:17:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'jsshell-linux-x86_64.zip'], 23:17:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:17:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:17:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:17:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:17:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:17:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:17:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:17:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:17: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')]} 23:17:55 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:17:57 INFO - Downloaded 24408799 bytes. 23:17:57 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'] 23:17:57 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 23:17:58 INFO - Return code: 0 23:17:58 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 23:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:17:58 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:18:01 INFO - Downloaded 24408799 bytes. 23:18:01 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'] 23:18:01 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 23:18:02 INFO - Return code: 0 23:18: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')]} 23:18:02 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:18:04 INFO - Downloaded 10834034 bytes. 23:18:04 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'] 23:18:04 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 23:18:04 INFO - Return code: 0 23:18:04 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')]} 23:18:04 INFO - https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNgXiOGaQMifhBsCHTBhyA/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 23:18:05 INFO - Downloaded 58658390 bytes. 23:18:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:18:05 INFO - mkdir: /builds/slave/test/properties 23:18:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:18:05 INFO - Writing to file /builds/slave/test/properties/build_url 23:18:05 INFO - Contents: 23:18:05 INFO - build_url:https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:18:06 INFO - Running post-action listener: _resource_record_post_action 23:18:06 INFO - Running post-action listener: set_extra_try_arguments 23:18:06 INFO - ##### 23:18:06 INFO - ##### Finished download-and-extract step (success) 23:18:06 INFO - ##### 23:18:06 INFO - ##### 23:18:06 INFO - ##### Running populate-webroot step. 23:18:06 INFO - ##### 23:18:06 INFO - Running pre-action listener: _resource_record_pre_action 23:18:06 INFO - Running main action method: populate_webroot 23:18:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:18:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:18:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:18:06 INFO - '--tppagecycles', 23:18:06 INFO - '7'], 23:18:06 INFO - 'tests': ['tsvgm']}}, 23:18:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:18:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:18:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:18:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:18:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:18:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:18:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['damp', 'tps']}, 23:18:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'tests': ['damp', 'tps']}, 23:18:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['dromaeo_dom']}, 23:18:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:18:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['a11yr', 23:18:06 INFO - 'ts_paint', 23:18:06 INFO - 'tpaint', 23:18:06 INFO - 'sessionrestore', 23:18:06 INFO - 'sessionrestore_no_auto_restore', 23:18:06 INFO - 'tabpaint']}, 23:18:06 INFO - 'other-e10s': {'tests': ['a11yr', 23:18:06 INFO - 'ts_paint', 23:18:06 INFO - 'tpaint', 23:18:06 INFO - 'sessionrestore', 23:18:06 INFO - 'sessionrestore_no_auto_restore', 23:18:06 INFO - 'tabpaint']}, 23:18:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:18:06 INFO - 'ts_paint', 23:18:06 INFO - 'tpaint', 23:18:06 INFO - 'sessionrestore', 23:18:06 INFO - 'sessionrestore_no_auto_restore', 23:18:06 INFO - 'tabpaint']}, 23:18:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:18:06 INFO - 'ts_paint', 23:18:06 INFO - 'tpaint', 23:18:06 INFO - 'sessionrestore', 23:18:06 INFO - 'sessionrestore_no_auto_restore', 23:18:06 INFO - 'tabpaint']}, 23:18:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['a11yr', 23:18:06 INFO - 'ts_paint', 23:18:06 INFO - 'tpaint', 23:18:06 INFO - 'sessionrestore', 23:18:06 INFO - 'sessionrestore_no_auto_restore', 23:18:06 INFO - 'tabpaint']}, 23:18:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['a11yr', 23:18:06 INFO - 'ts_paint', 23:18:06 INFO - 'tpaint', 23:18:06 INFO - 'sessionrestore', 23:18:06 INFO - 'sessionrestore_no_auto_restore', 23:18:06 INFO - 'tabpaint']}, 23:18:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['tsvgx', 23:18:06 INFO - 'tsvgr_opacity', 23:18:06 INFO - 'tart', 23:18:06 INFO - 'tscrollx', 23:18:06 INFO - 'cart']}, 23:18:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:18:06 INFO - 'tsvgr_opacity', 23:18:06 INFO - 'tart', 23:18:06 INFO - 'tscrollx', 23:18:06 INFO - 'cart']}, 23:18:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'talos_options': ['--disable-e10s'], 23:18:06 INFO - 'tests': ['tp5o']}, 23:18:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'tests': ['tp5o']}, 23:18:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'talos_options': ['--disable-e10s', 23:18:06 INFO - '--xperf_path', 23:18:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:18:06 INFO - 'tests': ['tp5n']}, 23:18:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:18:06 INFO - 'talos_options': ['--xperf_path', 23:18:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:18:06 INFO - 'tests': ['tp5n']}}, 23:18:06 INFO - 'talos.zip': {'path': '', 23:18:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:18:06 INFO - Running post-action listener: _resource_record_post_action 23:18:06 INFO - ##### 23:18:06 INFO - ##### Finished populate-webroot step (success) 23:18:06 INFO - ##### 23:18:06 INFO - ##### 23:18:06 INFO - ##### Running create-virtualenv step. 23:18:06 INFO - ##### 23:18:06 INFO - Running pre-action listener: _resource_record_pre_action 23:18:06 INFO - Running main action method: create_virtualenv 23:18:06 INFO - Creating virtualenv /builds/slave/test/build/venv 23:18:06 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 23:18:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:18:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:18:06 INFO - Using real prefix '/usr' 23:18:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:18:07 INFO - Installing distribute.............................................................................................................................................................................................done. 23:18:09 INFO - Installing pip.................done. 23:18:09 INFO - Return code: 0 23:18:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:18: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')]} 23:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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')]} 23:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18: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', 'pip>=1.5'] in /builds/slave/test/build 23:18: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 pip>=1.5 23:18:09 INFO - Using env: {'DISPLAY': ':0', 23:18:09 INFO - 'HOME': '/home/cltbld', 23:18:09 INFO - 'LANG': 'en_US.UTF-8', 23:18:09 INFO - 'LANGUAGE': 'en_US:en', 23:18:09 INFO - 'LOGNAME': 'cltbld', 23:18:09 INFO - 'MAIL': '/var/mail/cltbld', 23:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:09 INFO - 'MOZ_NO_REMOTE': '1', 23:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:09 INFO - 'NO_EM_RESTART': '1', 23:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:09 INFO - 'PWD': '/builds/slave/test', 23:18:09 INFO - 'SHELL': '/bin/bash', 23:18:09 INFO - 'SHLVL': '1', 23:18:09 INFO - 'TERM': 'linux', 23:18:09 INFO - 'TMOUT': '86400', 23:18:09 INFO - 'USER': 'cltbld', 23:18:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:09 INFO - '_': '/tools/buildbot/bin/python'} 23:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:09 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 23:18:09 INFO - Cleaning up... 23:18:09 INFO - Return code: 0 23:18:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:18: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')]} 23:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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')]} 23:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18: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', '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 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:18: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 psutil>=3.1.1 23:18:09 INFO - Using env: {'DISPLAY': ':0', 23:18:09 INFO - 'HOME': '/home/cltbld', 23:18:09 INFO - 'LANG': 'en_US.UTF-8', 23:18:09 INFO - 'LANGUAGE': 'en_US:en', 23:18:09 INFO - 'LOGNAME': 'cltbld', 23:18:09 INFO - 'MAIL': '/var/mail/cltbld', 23:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:09 INFO - 'MOZ_NO_REMOTE': '1', 23:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:09 INFO - 'NO_EM_RESTART': '1', 23:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:09 INFO - 'PWD': '/builds/slave/test', 23:18:09 INFO - 'SHELL': '/bin/bash', 23:18:09 INFO - 'SHLVL': '1', 23:18:09 INFO - 'TERM': 'linux', 23:18:09 INFO - 'TMOUT': '86400', 23:18:09 INFO - 'USER': 'cltbld', 23:18:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:09 INFO - '_': '/tools/buildbot/bin/python'} 23:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:09 INFO - Downloading/unpacking psutil>=3.1.1 23:18: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 23:18: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 23:18: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 23:18: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 23:18: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 23:18: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 23:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:18:11 INFO - Installing collected packages: psutil 23:18:11 INFO - Running setup.py install for psutil 23:18:11 INFO - building 'psutil._psutil_linux' extension 23:18:11 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 23:18:11 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 23:18:11 INFO - building 'psutil._psutil_posix' extension 23:18:11 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 23:18:11 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 23:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:18:11 INFO - Successfully installed psutil 23:18:11 INFO - Cleaning up... 23:18:12 INFO - Return code: 0 23:18:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:18:12 INFO - Using env: {'DISPLAY': ':0', 23:18:12 INFO - 'HOME': '/home/cltbld', 23:18:12 INFO - 'LANG': 'en_US.UTF-8', 23:18:12 INFO - 'LANGUAGE': 'en_US:en', 23:18:12 INFO - 'LOGNAME': 'cltbld', 23:18:12 INFO - 'MAIL': '/var/mail/cltbld', 23:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:12 INFO - 'MOZ_NO_REMOTE': '1', 23:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:12 INFO - 'NO_EM_RESTART': '1', 23:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:12 INFO - 'PWD': '/builds/slave/test', 23:18:12 INFO - 'SHELL': '/bin/bash', 23:18:12 INFO - 'SHLVL': '1', 23:18:12 INFO - 'TERM': 'linux', 23:18:12 INFO - 'TMOUT': '86400', 23:18:12 INFO - 'USER': 'cltbld', 23:18:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:12 INFO - '_': '/tools/buildbot/bin/python'} 23:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:18:14 INFO - Installing collected packages: mozsystemmonitor 23:18:14 INFO - Running setup.py install for mozsystemmonitor 23:18:14 INFO - Successfully installed mozsystemmonitor 23:18:14 INFO - Cleaning up... 23:18:14 INFO - Return code: 0 23:18:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:18:14 INFO - Using env: {'DISPLAY': ':0', 23:18:14 INFO - 'HOME': '/home/cltbld', 23:18:14 INFO - 'LANG': 'en_US.UTF-8', 23:18:14 INFO - 'LANGUAGE': 'en_US:en', 23:18:14 INFO - 'LOGNAME': 'cltbld', 23:18:14 INFO - 'MAIL': '/var/mail/cltbld', 23:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:14 INFO - 'MOZ_NO_REMOTE': '1', 23:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:14 INFO - 'NO_EM_RESTART': '1', 23:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:14 INFO - 'PWD': '/builds/slave/test', 23:18:14 INFO - 'SHELL': '/bin/bash', 23:18:14 INFO - 'SHLVL': '1', 23:18:14 INFO - 'TERM': 'linux', 23:18:14 INFO - 'TMOUT': '86400', 23:18:14 INFO - 'USER': 'cltbld', 23:18:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:14 INFO - '_': '/tools/buildbot/bin/python'} 23:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:14 INFO - Downloading/unpacking blobuploader==1.2.4 23:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:16 INFO - Downloading blobuploader-1.2.4.tar.gz 23:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:18:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:18:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 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 23:18:16 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 23:18:17 INFO - Downloading docopt-0.6.1.tar.gz 23:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:18:17 INFO - Installing collected packages: blobuploader, requests, docopt 23:18:17 INFO - Running setup.py install for blobuploader 23:18:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:18:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:18:17 INFO - Running setup.py install for requests 23:18:17 INFO - Running setup.py install for docopt 23:18:17 INFO - Successfully installed blobuploader requests docopt 23:18:17 INFO - Cleaning up... 23:18:17 INFO - Return code: 0 23:18:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:17 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')]} 23:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:17 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')]} 23:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:17 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 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:17 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 23:18:17 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 23:18:17 INFO - Using env: {'DISPLAY': ':0', 23:18:17 INFO - 'HOME': '/home/cltbld', 23:18:17 INFO - 'LANG': 'en_US.UTF-8', 23:18:17 INFO - 'LANGUAGE': 'en_US:en', 23:18:17 INFO - 'LOGNAME': 'cltbld', 23:18:17 INFO - 'MAIL': '/var/mail/cltbld', 23:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:17 INFO - 'MOZ_NO_REMOTE': '1', 23:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:17 INFO - 'NO_EM_RESTART': '1', 23:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:17 INFO - 'PWD': '/builds/slave/test', 23:18:17 INFO - 'SHELL': '/bin/bash', 23:18:17 INFO - 'SHLVL': '1', 23:18:17 INFO - 'TERM': 'linux', 23:18:17 INFO - 'TMOUT': '86400', 23:18:17 INFO - 'USER': 'cltbld', 23:18:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:17 INFO - '_': '/tools/buildbot/bin/python'} 23:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:18:17 INFO - Running setup.py (path:/tmp/pip-V1R7TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:18:18 INFO - Running setup.py (path:/tmp/pip-Fo_tLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:18:18 INFO - Running setup.py (path:/tmp/pip-C8y6b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:18:18 INFO - Running setup.py (path:/tmp/pip-mwZDnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:18:18 INFO - Running setup.py (path:/tmp/pip-wU7pzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:18:18 INFO - Running setup.py (path:/tmp/pip-nfLdhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:18:18 INFO - Running setup.py (path:/tmp/pip-nq_yYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:18:18 INFO - Running setup.py (path:/tmp/pip-H3RVbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:18:18 INFO - Running setup.py (path:/tmp/pip-AKMfXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:18:18 INFO - Running setup.py (path:/tmp/pip-4SgYh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:18:18 INFO - Running setup.py (path:/tmp/pip-MjYipR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:18:18 INFO - Running setup.py (path:/tmp/pip-sxgY63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:18:18 INFO - Running setup.py (path:/tmp/pip-tizjNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:18:18 INFO - Running setup.py (path:/tmp/pip-d97sBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:18 INFO - Running setup.py (path:/tmp/pip-taCulP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:18:19 INFO - Running setup.py (path:/tmp/pip-7AEv_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:18:19 INFO - Running setup.py (path:/tmp/pip-9QVBTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:18:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:18:19 INFO - Running setup.py install for manifestparser 23:18:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Running setup.py install for mozcrash 23:18:19 INFO - Running setup.py install for mozdebug 23:18:19 INFO - Running setup.py install for mozdevice 23:18:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Running setup.py install for mozfile 23:18:19 INFO - Running setup.py install for mozhttpd 23:18:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Running setup.py install for mozinfo 23:18:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Running setup.py install for mozInstall 23:18:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:18:19 INFO - Running setup.py install for mozleak 23:18:20 INFO - Running setup.py install for mozlog 23:18:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Running setup.py install for moznetwork 23:18:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Running setup.py install for mozprocess 23:18:20 INFO - Running setup.py install for mozprofile 23:18:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Running setup.py install for mozrunner 23:18:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Running setup.py install for mozscreenshot 23:18:20 INFO - Running setup.py install for moztest 23:18:20 INFO - Running setup.py install for mozversion 23:18:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:18:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:18:20 INFO - Cleaning up... 23:18:20 INFO - Return code: 0 23:18:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:20 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 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:20 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 23:18:20 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 23:18:20 INFO - Using env: {'DISPLAY': ':0', 23:18:20 INFO - 'HOME': '/home/cltbld', 23:18:20 INFO - 'LANG': 'en_US.UTF-8', 23:18:20 INFO - 'LANGUAGE': 'en_US:en', 23:18:20 INFO - 'LOGNAME': 'cltbld', 23:18:20 INFO - 'MAIL': '/var/mail/cltbld', 23:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:20 INFO - 'MOZ_NO_REMOTE': '1', 23:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:20 INFO - 'NO_EM_RESTART': '1', 23:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:20 INFO - 'PWD': '/builds/slave/test', 23:18:20 INFO - 'SHELL': '/bin/bash', 23:18:20 INFO - 'SHLVL': '1', 23:18:20 INFO - 'TERM': 'linux', 23:18:20 INFO - 'TMOUT': '86400', 23:18:20 INFO - 'USER': 'cltbld', 23:18:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:20 INFO - '_': '/tools/buildbot/bin/python'} 23:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:18:21 INFO - Running setup.py (path:/tmp/pip-fCfLNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:18:21 INFO - Running setup.py (path:/tmp/pip-ttgxfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:18:21 INFO - Running setup.py (path:/tmp/pip-o_cs1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:18:21 INFO - Running setup.py (path:/tmp/pip-YFA4H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:18:21 INFO - Running setup.py (path:/tmp/pip-c22Jq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:18:21 INFO - Running setup.py (path:/tmp/pip-oM2x2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:18:21 INFO - Running setup.py (path:/tmp/pip-VQe1cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:18:21 INFO - Running setup.py (path:/tmp/pip-SoJcgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:18:21 INFO - Running setup.py (path:/tmp/pip-Pk2Rzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:18:21 INFO - Running setup.py (path:/tmp/pip-rE7KLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:18:21 INFO - Running setup.py (path:/tmp/pip-NDpNRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:18:21 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)) 23:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:18:21 INFO - Running setup.py (path:/tmp/pip-dVZ_eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:18:22 INFO - Running setup.py (path:/tmp/pip-Kr1WRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:18:22 INFO - Running setup.py (path:/tmp/pip-2fd5aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:22 INFO - Running setup.py (path:/tmp/pip-a8Nbdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:18:22 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)) 23:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:18:22 INFO - Running setup.py (path:/tmp/pip-oaW9WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:18:22 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)) 23:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:18:22 INFO - Running setup.py (path:/tmp/pip-BFKed6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:18:22 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)) 23:18:22 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)) 23:18:22 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)) 23:18:22 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)) 23:18:22 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)) 23:18:22 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)) 23:18:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:18:22 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 23:18:22 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 23:18:22 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 23:18:22 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 23:18:22 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 23:18:22 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 23:18:24 INFO - Downloading blessings-1.6.tar.gz 23:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:18:24 INFO - Installing collected packages: blessings 23:18:24 INFO - Running setup.py install for blessings 23:18:24 INFO - Successfully installed blessings 23:18:24 INFO - Cleaning up... 23:18:24 INFO - Return code: 0 23:18:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:18:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:18:24 INFO - Reading from file tmpfile_stdout 23:18:24 INFO - Current package versions: 23:18:24 INFO - argparse == 1.2.1 23:18:24 INFO - blessings == 1.6 23:18:24 INFO - blobuploader == 1.2.4 23:18:24 INFO - docopt == 0.6.1 23:18:24 INFO - manifestparser == 1.1 23:18:24 INFO - mozInstall == 1.12 23:18:24 INFO - mozcrash == 0.17 23:18:24 INFO - mozdebug == 0.1 23:18:24 INFO - mozdevice == 0.48 23:18:24 INFO - mozfile == 1.2 23:18:24 INFO - mozhttpd == 0.7 23:18:24 INFO - mozinfo == 0.9 23:18:24 INFO - mozleak == 0.1 23:18:24 INFO - mozlog == 3.2 23:18:24 INFO - moznetwork == 0.27 23:18:24 INFO - mozprocess == 0.22 23:18:24 INFO - mozprofile == 0.28 23:18:24 INFO - mozrunner == 6.11 23:18:24 INFO - mozscreenshot == 0.1 23:18:24 INFO - mozsystemmonitor == 0.3 23:18:24 INFO - moztest == 0.7 23:18:24 INFO - mozversion == 1.4 23:18:24 INFO - psutil == 3.1.1 23:18:24 INFO - requests == 1.2.3 23:18:24 INFO - wsgiref == 0.1.2 23:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:18:24 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')]} 23:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:24 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')]} 23:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:24 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 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:24 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 23:18:24 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 23:18:24 INFO - Using env: {'DISPLAY': ':0', 23:18:24 INFO - 'HOME': '/home/cltbld', 23:18:24 INFO - 'LANG': 'en_US.UTF-8', 23:18:24 INFO - 'LANGUAGE': 'en_US:en', 23:18:24 INFO - 'LOGNAME': 'cltbld', 23:18:24 INFO - 'MAIL': '/var/mail/cltbld', 23:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:24 INFO - 'MOZ_NO_REMOTE': '1', 23:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:24 INFO - 'NO_EM_RESTART': '1', 23:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:24 INFO - 'PWD': '/builds/slave/test', 23:18:24 INFO - 'SHELL': '/bin/bash', 23:18:24 INFO - 'SHLVL': '1', 23:18:24 INFO - 'TERM': 'linux', 23:18:24 INFO - 'TMOUT': '86400', 23:18:24 INFO - 'USER': 'cltbld', 23:18:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:24 INFO - '_': '/tools/buildbot/bin/python'} 23:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 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)) 23:18:24 INFO - Cleaning up... 23:18:24 INFO - Return code: 0 23:18:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:18:24 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')]} 23:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:24 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')]} 23:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:24 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 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:24 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 23:18:24 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 23:18:24 INFO - Using env: {'DISPLAY': ':0', 23:18:24 INFO - 'HOME': '/home/cltbld', 23:18:24 INFO - 'LANG': 'en_US.UTF-8', 23:18:24 INFO - 'LANGUAGE': 'en_US:en', 23:18:24 INFO - 'LOGNAME': 'cltbld', 23:18:24 INFO - 'MAIL': '/var/mail/cltbld', 23:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:24 INFO - 'MOZ_NO_REMOTE': '1', 23:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:24 INFO - 'NO_EM_RESTART': '1', 23:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:24 INFO - 'PWD': '/builds/slave/test', 23:18:24 INFO - 'SHELL': '/bin/bash', 23:18:24 INFO - 'SHLVL': '1', 23:18:24 INFO - 'TERM': 'linux', 23:18:24 INFO - 'TMOUT': '86400', 23:18:24 INFO - 'USER': 'cltbld', 23:18:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:24 INFO - '_': '/tools/buildbot/bin/python'} 23:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:25 INFO - Downloading/unpacking jsonschema 23:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:18:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:18:27 INFO - Downloading/unpacking functools32 (from jsonschema) 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 INFO - Downloading functools32-3.2.3-2.tar.gz 23:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:18:27 INFO - warning: no files found matching '*.txt' 23:18:27 INFO - no previously-included directories found matching 'build' 23:18:27 INFO - no previously-included directories found matching 'dist' 23:18:27 INFO - no previously-included directories found matching '.git*' 23:18:27 INFO - Installing collected packages: jsonschema, functools32 23:18:27 INFO - Running setup.py install for functools32 23:18:27 INFO - warning: no files found matching '*.txt' 23:18:27 INFO - no previously-included directories found matching 'build' 23:18:27 INFO - no previously-included directories found matching 'dist' 23:18:27 INFO - no previously-included directories found matching '.git*' 23:18:27 INFO - Successfully installed jsonschema functools32 23:18:27 INFO - Cleaning up... 23:18:27 INFO - Return code: 0 23:18:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:18:27 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 0x7f14a1c29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe57770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', '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 23:18:27 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 23:18:27 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 23:18:27 INFO - Using env: {'DISPLAY': ':0', 23:18:27 INFO - 'HOME': '/home/cltbld', 23:18:27 INFO - 'LANG': 'en_US.UTF-8', 23:18:27 INFO - 'LANGUAGE': 'en_US:en', 23:18:27 INFO - 'LOGNAME': 'cltbld', 23:18:27 INFO - 'MAIL': '/var/mail/cltbld', 23:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:27 INFO - 'MOZ_NO_REMOTE': '1', 23:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:27 INFO - 'NO_EM_RESTART': '1', 23:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:27 INFO - 'PWD': '/builds/slave/test', 23:18:27 INFO - 'SHELL': '/bin/bash', 23:18:27 INFO - 'SHLVL': '1', 23:18:27 INFO - 'TERM': 'linux', 23:18:27 INFO - 'TMOUT': '86400', 23:18:27 INFO - 'USER': 'cltbld', 23:18:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:27 INFO - '_': '/tools/buildbot/bin/python'} 23:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:18:27 INFO - Downloading/unpacking flake8 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 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 23:18:27 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 23:18:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:18:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:18:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 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 23:18:29 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 23:18:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:18:30 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 23:18:30 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 23:18:30 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 23:18:30 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 23:18:30 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 23:18:30 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 23:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:18:30 INFO - no previously-included directories found matching 'docs/_build' 23:18:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:18:30 INFO - Running setup.py install for pep8 23:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:18:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:18:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:18:30 INFO - no previously-included directories found matching 'docs/_build' 23:18:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:18:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:18:30 INFO - Cleaning up... 23:18:30 INFO - Return code: 0 23:18:30 INFO - Running post-action listener: _resource_record_post_action 23:18:30 INFO - Running post-action listener: _start_resource_monitoring 23:18:30 INFO - Starting resource monitoring. 23:18:30 INFO - ##### 23:18:30 INFO - ##### Finished create-virtualenv step (success) 23:18:30 INFO - ##### 23:18:30 INFO - ##### 23:18:30 INFO - ##### Running install step. 23:18:30 INFO - ##### 23:18:30 INFO - Running pre-action listener: _resource_record_pre_action 23:18:30 INFO - Running main action method: install 23:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:18:30 INFO - Reading from file tmpfile_stdout 23:18:30 INFO - Detecting whether we're running mozinstall >=1.0... 23:18:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:18:30 INFO - Reading from file tmpfile_stdout 23:18:30 INFO - Output received: 23:18:30 INFO - Usage: mozinstall [options] installer 23:18:30 INFO - Options: 23:18:30 INFO - -h, --help show this help message and exit 23:18:30 INFO - -d DEST, --destination=DEST 23:18:30 INFO - Directory to install application into. [default: 23:18:30 INFO - "/builds/slave/test"] 23:18:30 INFO - --app=APP Application being installed. [default: firefox] 23:18:30 INFO - mkdir: /builds/slave/test/build/application 23:18:30 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'] 23:18:30 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 23:18:47 INFO - Reading from file tmpfile_stdout 23:18:47 INFO - Output received: 23:18:47 INFO - /builds/slave/test/build/application/firefox/firefox 23:18:47 INFO - Running post-action listener: _resource_record_post_action 23:18:47 INFO - ##### 23:18:47 INFO - ##### Finished install step (success) 23:18:47 INFO - ##### 23:18:47 INFO - ##### 23:18:47 INFO - ##### Running run-tests step. 23:18:47 INFO - ##### 23:18:47 INFO - Running pre-action listener: _resource_record_pre_action 23:18:47 INFO - Running main action method: run_tests 23:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:18:47 INFO - Python 2.7.3 23:18:47 INFO - Return code: 0 23:18:47 INFO - grabbing minidump binary from tooltool 23:18:47 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')]} 23:18:47 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 0xee69c0>, '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 0xee78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:18:47 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 23:18:47 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 23:18:47 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 23:18:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:18:47 INFO - Return code: 0 23:18:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:18:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:18:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:18:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:18:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:18:48 INFO - Return code: 0 23:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 23:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 23:18:48 INFO - Using env: {'DISPLAY': ':0', 23:18:48 INFO - 'HOME': '/home/cltbld', 23:18:48 INFO - 'LANG': 'en_US.UTF-8', 23:18:48 INFO - 'LANGUAGE': 'en_US:en', 23:18:48 INFO - 'LOGNAME': 'cltbld', 23:18:48 INFO - 'MAIL': '/var/mail/cltbld', 23:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:18:48 INFO - 'MOZ_NO_REMOTE': '1', 23:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:18:48 INFO - 'NO_EM_RESTART': '1', 23:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:18:48 INFO - 'PWD': '/builds/slave/test', 23:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:18:48 INFO - 'SHELL': '/bin/bash', 23:18:48 INFO - 'SHLVL': '1', 23:18:48 INFO - 'TERM': 'linux', 23:18:48 INFO - 'TMOUT': '86400', 23:18:48 INFO - 'USER': 'cltbld', 23:18:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770', 23:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:18:48 INFO - '_': '/tools/buildbot/bin/python'} 23:18:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 23:18:48 INFO - mozversion application_buildid: 20160525203033 23:18:48 INFO - mozversion application_changeset: 8dfd7c9d86397ed898d84933a3c39834f1db886f 23:18:48 INFO - mozversion application_display_name: Nightly 23:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:18:48 INFO - mozversion application_name: Firefox 23:18:48 INFO - mozversion application_remotingname: firefox 23:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:18:48 INFO - mozversion application_vendor: Mozilla 23:18:48 INFO - mozversion application_version: 49.0a1 23:18:48 INFO - mozversion platform_buildid: 20160525203033 23:18:48 INFO - mozversion platform_changeset: 8dfd7c9d86397ed898d84933a3c39834f1db886f 23:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:18:48 INFO - mozversion platform_version: 49.0a1 23:18:48 INFO - using testdate: 1464243528 23:18:48 INFO - actual date: 1464243528 23:18:48 INFO - starting webserver on 'localhost:44990' 23:18:48 INFO - SUITE-START | Running 2 tests 23:18:48 INFO - TEST-START | dromaeo_css 23:18:48 INFO - operating with platform_type : linux_ 23:18:48 INFO - Initialising browser for dromaeo_css test... 23:18:48 INFO - TEST-INFO | started process 16140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIj1qC1/profile http://localhost:44990/getInfo.html) 23:18:53 INFO - PROCESS | 16140 | 23:18:53 INFO - PROCESS | 16140 | (process:16209): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:18:54 INFO - PROCESS | 16140 | __metrics Screen width/height:1600/1200 23:18:54 INFO - PROCESS | 16140 | colorDepth:24 23:18:54 INFO - PROCESS | 16140 | Browser inner width/height: 1024/697 23:18:54 INFO - PROCESS | 16140 | __metrics 23:18:55 ERROR - PROCESS | 16140 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:18:56 INFO - TEST-INFO | 16140: exit 0 23:18:56 INFO - Browser initialized. 23:18:56 INFO - Running cycle 1/1 for dromaeo_css test... 23:18:56 INFO - TEST-INFO | started process 16260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIj1qC1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:58 INFO - PROCESS | 16260 | 23:18:58 INFO - PROCESS | 16260 | (process:16319): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:19:08 INFO - PROCESS | 16260 | RSS: Main: 166080512 23:19:08 INFO - PROCESS | 16260 | 23:19:57 INFO - PROCESS | 16260 | 1464243597991 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] 23:22:05 INFO - PROCESS | 16260 | Cycle 1(1): loaded http://localhost:44990/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44990/tests/dromaeo/cssquery-ext.html) 23:22:06 INFO - PROCESS | 16260 | RSS: Main: 169033728 23:22:06 INFO - PROCESS | 16260 | 23:25:08 INFO - PROCESS | 16260 | Cycle 1(1): loaded http://localhost:44990/tests/dromaeo/cssquery-ext.html (next: http://localhost:44990/tests/dromaeo/cssquery-jquery.html) 23:25:08 INFO - PROCESS | 16260 | RSS: Main: 169619456 23:25:08 INFO - PROCESS | 16260 | 23:28:10 INFO - PROCESS | 16260 | Cycle 1(1): loaded http://localhost:44990/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44990/tests/dromaeo/cssquery-mootools.html) 23:28:11 INFO - PROCESS | 16260 | RSS: Main: 169660416 23:28:11 INFO - PROCESS | 16260 | 23:31:12 INFO - PROCESS | 16260 | Cycle 1(1): loaded http://localhost:44990/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44990/tests/dromaeo/cssquery-prototype.html) 23:31:13 INFO - PROCESS | 16260 | RSS: Main: 168103936 23:31:13 INFO - PROCESS | 16260 | 23:34:15 INFO - PROCESS | 16260 | Cycle 1(1): loaded http://localhost:44990/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44990/tests/dromaeo/cssquery-yui.html) 23:34:16 INFO - PROCESS | 16260 | RSS: Main: 168534016 23:34:16 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | Cycle 1(1): loaded http://localhost:44990/tests/dromaeo/cssquery-yui.html (next: http://localhost:44990/tests/dromaeo/cssquery-dojo.html) 23:37:19 INFO - PROCESS | 16260 | RSS: Main: 170754048 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | __start_tp_report 23:37:19 INFO - PROCESS | 16260 | _x_x_mozilla_page_load 23:37:19 INFO - PROCESS | 16260 | _x_x_mozilla_page_load_details 23:37:19 INFO - PROCESS | 16260 | |i|pagename|runs| 23:37:19 INFO - PROCESS | 16260 | |0;dojo.html;3074.3390171113215;3094.195509167616;3142.9371412571763;3145.3080322329088;3154.7791654584175;5363.812266570666;5383.838484845451;5428.728563571821;5465.098258787295;5465.180222966547;5324.201369794523;5402.081646120159;5425.755840987155;5433.239346491485;5520.558355331574;4865.270209468573;4902.926456103143;4992.425871024824;5029.47190544993;5089.46560611136;637.9535040147977;4843.176659967797;4906.386701662293;4910.091633047879;5011.899762004758;4888.804447822083;4922.237053256751;4942.579880710126;4957.801687932479;4962.230854217584;4962.379702537183;4981.750912454399;4982.676126051795;4985.302057711923;4995.525425084647;4890.923996720751;4946.258061290835;4952.5542701157065;4971.204607262821;4974.900501989976;5357.08929481989;5374.193870919355;5411.296531450926;5424.457554244544;5427.0773968425465;5689.947359738461;5802.245708057968;5851.151583020481;5865.472107510302;5870.501007414375;5900.262467191601;5904.645721256738;5949.8810023799715;5962.761489540413;5965.880682386328;5535.972320138373;5547.1679248112705;5564.33228012637;5564.4991950724625;5576.302962129734;5806.854828629318;5994.610350327215;6064.9090263646085;6069.969650151721;6077.483413909778;5785.190073389729;5787.247657804459;5789.189513468118;5790.768369265266;5833.300003999547;5875;5878.441548052928;5881.852953676193;5891.823245302562;5896.616719913192;5703.771849125988;5757.568182386338;5807.622504537191;5817.767289308465;5837.270341207349;5823.854403639858;5873.148393483007;5875.236219291465;5884.2350494436305;5897.439743224387;4425.668074894395;4425.977870110693;4469.865904022885;4472.888177795581;4487.192305384997;3880.3015457217407;3896.298666240104;3921.5490218624655;3953.9604603954167;3973.642372186517;5514;5588.552915766811;5629.380768115504;5665.405132461115;5717.599768016282;5964.105384192406;5994.700264986734;5994.790182343684;5996.070609055603;6002.039673652282;5469.835904922858;5562.276904002535;5579.4978451938705;5609;5688.914666280009;5049.596032317406;5059.696418214919;5061.089003979246;5069.315642388304;5076.44159142494;6068.393160683896;6093.878122437526;6094.691077340286;6096.329403765582;6109.6413581843635;5737.8565535861935;5844.415558444121;5876.794312199053;5884.735186916513;5948.940510594839;6047.637141771508;6060.727267272895;6071.150038994632;6085.57400981927;6101.908471373022;5660.971695141498;5806.65160090396;5811.535077193899;5816.680082595329;5831.7667293307795;5856.707164641836;5882.441168089196;5925.703714814156;5928.525717942468;5956.463918247378;5717.571182161271;5742.7702891883855;5745.1956726059225;5752.769889204553;5782.392848750989;5617.241672374177;5653.095504719226;5780.942190578208;5786.681732504584;5789.739461724317;5580.135079062752;5631.408702086222;5636.464535869086;5654.745536450787;5696.316442026983;5731.140328950691;5731.684757338387;5765.654060756368;5777.508911742549;5777.6822274775295;5510.366307874646;5577.609567330248;5628.240187574789;5633.577481688972;5634.718264086861 23:37:19 INFO - PROCESS | 16260 | |1;ext.html;591.8490784849863;630.4326106504145;636.341386664802;649.9870002599948;664.2925284571934;39079.80460097699;43088.13823723524;43449.34825977605;43536.34695479571;43617.56382436179;43441;44335.113297734024;44352;44380;44412;8711.956440217806;8885.511296878669;8889.42218755782;8891.06643802401;8894.11058894112;8674.392792504526;8814.074522175175;8819.51492667903;8861.202491775739;8870.246029087535;8829.646814127427;8844.867326990101;8888.822223555526;8895.199432051115;8899.110088991081;8818.911810881937;8859.911400885972;8884.866726999067;8910.554472276424;8968.686095986643;8702.086280940537;8750.562471876445;8774.473531588124;8798.648054077828;8813.647454101892;41457;41561.37657935133;42019;42055.36916946248;42149.78925105386;3567.430330654504;3979.0848104935735;4276.358546218061;4287.571242875719;4320.1143765527995;32206.35587288241;32660.346793064007;32754.836225818955;32916.50625240623;33705;4199.580041995807;4331.480222373335;4350.390945267665;4351.108022855307;4490.865274041784;230453;230647;231151;231229;231836;58557.70721146367;59062;59255;59615.70192149098;59658;63235.15441805038;63248.05127923085;63480;63631;63843.680781596726;17392.47822565325;17578.736318955227;17629.559261018578;17645.7353139703;17651.205695743465;13463.192208467523;13524.32378381077;13537.526186583422;13547.174714872699;13571;15612.76580851288;17471.475855724348;17629;17681.469555913343;17685.734713979302;5471;6144.846378840565;6158.599691020069;6271.310155882849;6313.084602732578;1058.1904842795268;1073.8013467508536;1078.8166011778017;1080.9459527023616;1146.6158836789768;32211.67788322087;32517.51223731646;32935.18856462918;33548.66451335455;34065.65934340675;1135.0151682910848;1163.743976325207;1165.1669056624555;1227.8710735372836;1240.5472002719123;17319;17499.387521436944;17507.824921750875;17706.380276690255;17714.202860871294;554231;555151;561999;563414;564849;59364.703176484705;59391;59712.10431843526;60080.39919600748;60263.397366025776;1339.7521458530202;1358.5109360630165;1387.8195834541445;1421.3461807568428;1422.6087825847974;32121.51817722689;32553;32788.67211327856;32861;33193.502097468074;52234.21648675349;52241;52759.472405275454;52822.47177528175;52885;462890;464483;465149;465224;466534;42917.78541107274;43177.78411107924;44909.775451122536;45241.773791130836;45362.54637453715;48895.5110448891;49209.75395123001;49412.50587494079;50433.74783126207;51104;41815.58184418239;42449.151016980104;42952.78523607362;43645;43992.34011489894;40696;41893.53718414401;41993.370099449145;42065.57934420739;42543;42202.788986054875;42409.787951061284;42527;42975.57024429716;43060;36414.27171456503;37516.43725344176;37540.81229593835;37604.26678352833;38384;28748.568771468865;28882.71117288884;29094.56358154587;29257.707422925498;29259.56110658299 23:37:19 INFO - PROCESS | 16260 | |2;jquery.html;394.4162639293845;395.2766437419519;401.9216252830697;402.51295931922374;416.35068623514877;15125.319360628771;18003.909980450095;18821.05894705266;19892.801071989295;19972.300969466072;18481.260749570036;18832.34086806962;19958.900205498987;20024.29914952977;20032.098555564997;5353.705546194958;5502.2296878436955;5664.54683625309;5674.3190817102;5742.913856292138;5438.401775804658;5651.632643878155;5668.603197776158;5818.941810581903;5888.64668119912;5835.533157347402;5859.79490717825;5888.882222355551;5897;5924.970375148118;5617.887642247173;5746.482816546531;5750.597458177929;5777.19119323295;5860.267466566679;5536.889262214773;5540.86147846303;5542.944570554324;5543.833684989457;5572.7770889164385;13185.472581096745;13795.448182072705;13931.791023134661;14011.038454616362;14033.78949315761;2124.9043793029196;2209.4476380904775;2328.732195797488;2335.311083230451;2344.39045848079;10203.948980255125;10495.685129446128;10513.632022879163;10611.734706632396;10616.575336986589;1950.980490195094;1998.980010199894;2000.3098930868828;2000.469875482998;2012.2554654777825;82145.58927205326;84554.57722711409;84852.57573712153;85044.57477712634;85361;10661.200409969284;10729.517171727291;10886.564537418573;10929.344239345664;11269.492872820743;13426.932865335611;13741.656458588415;14719.337629806685;15323.770143447857;15353.232338383035;7548.282913123245;7615.428842836809;8391.580420978926;8397.370197235232;8682.479051256945;8370.581470926429;8422.705205317785;8431.536265505456;8472.237498625153;8518.190771876662;4626.4910859805395;4654.999175177353;4726.929096063562;4749.95250047502;4773.522647735199;1922.2695375757403;1971.5312092491185;1974.210315873662;2015.7581090269261;2034.491377155711;968.7820240445843;992.9156021738089;1025.415513157493;1039.5322105052755;1096.7641956979128;19512.219511219675;20029.59940801205;20043.298484553263;20069.598608027758;20315.593688126155;1034.7361422837128;1040.2146379483443;1054.135608800776;1062.0653824634426;1140.5266814271984;10511.947440262902;11223.494942727597;11236.157288203418;11281.661550153509;11288.153388495895;497286;497812;500700;515172;515924;96680;96791.51604241933;97238.51380743193;98224.50887745658;99661.50169249107;984.5766320482118;995.576879826071;1006.7986402719486;1020.8315627921459;1024.5543188712934;17243.482695519153;17718.734218986985;17749.645007100044;17887.28450861951;18019.639607208046;33177.83411082929;37372.626273738;39222.2155556893;41923.1615367697;43794.124117518106;52442;56251.43748562626;56972;57421.42578574161;57881.710591446776;7766.106897706836;7803.531788092732;7925.762227133196;8065.8790118149445;8067.959660201662;8665.913340866511;12141.696457588278;12887;12910.419031143809;13032.152910060815;11621.360825154698;11718.472668729757;11781.941090294837;11864.940675296568;11955.64133076009;11292.266002709797;11362.431878406212;11530;11743.530258789895;12259.938700306442;11833.763324733285;12031.398430078287;12082.939585302018;12158.452869621065;12393.318367489876;7613.238676132564;7765.922340776746;7799.766007019798;7858.6070696466095;8056.831759394972;11146.88853111491;11560.710982225512;11835.881641183478;11939.52241910314;12076.154669173073 23:37:19 INFO - PROCESS | 16260 | |3;mootools.html;1478.2682572126796;1535.5239875638554;1674.6566953774477;1787.865910056746;1809.249161597937;7745.419093567977;8376.371772117085;8558.101399353063;9139.268858491321;9154.267658587314;8582.742517724479;8820.206181443686;8862.423942443736;8921.776955576113;8936.553172341373;2080.9375718728425;2130.456733532955;2132.605467988419;2134.1890081768984;2135.8291336693105;2215.401841502793;2241.674957131215;2284.1091974130104;2301.3786277705008;2317.385892738417;2292.3466811958597;2297.5749486345;2298.4368829636765;2304.06685292456;2304.758000409958;2212.668099785029;2223.9777602224012;2224.3104637562406;2239.070785623964;2239.4177513846353;2245.10195921631;2245.124401483423;2248.752637209922;2250.5273892482596;2256.356938272601;8707.346948978851;8835.249003834682;8841.115888411172;8859.955700221522;8866.379353445262;5023.899522009539;5077.796888124471;5124.718140502271;5163.40620828602;5165.457626949154;3161.2096975756062;3271.738260939143;3504.702100321476;3511.0344655219765;3514.8066856322894;1059.793340298642;1097.286763603656;1106.6790630717082;1146.5471138900089;1158.7682463507333;12538.310392928386;12601.873981260162;12632.431540580605;12636.431360588704;12642.2414655121;4281.250781113293;4445.555444455528;4482.350059241392;4496.213162696515;4526.773661316987;10451.790964180675;10503.894961050291;10507;10510.632127875488;10539.367637941748;5005.499450054966;5053.69677819332;5062.4684408137355;5062.594992400599;5065.037642847848;4243.448351714319;4616.676832621684;4727.7399743013775;4728.550787675165;4802.591779698765;3835.194609132058;3875.5736868944396;3925.980370098131;3947.8618248361745;4004.519457665099;1188.483009890683;1203.2599951030054;1206.6862615719801;1207.3661327802797;1214.7084699672016;921.6589861751195;937.4422218779815;938.4216641344226;943.5612440215195;955.3837774635322;5546.667199968015;5613.635113717595;5718.256626638594;5775.133729940542;5802.88394232113;977.3744803325877;1007.8337074382645;1014.2228913276025;1028.6605420211313;1047.8899715529913;3749.1189570450924;3794.658480736747;3804.505414296179;3806.5051543299196;3843.9039024024623;10419.42693151884;10670.73323166927;10739.463026848627;10739.677809665722;10754.40850753216;10531.420771857469;10551.577936882439;10569.101626361691;11071.225014248925;11091.057260132979;8124.187581241828;8162.7143049992965;8222.38332125093;8308.916910830814;8350.79123021917;5555.972220138873;5861.120831875252;5872.148538461814;5973.850653733692;6121.296050954197;9837.213022958289;9921.107100361001;9984.60061597528;10047.09576138151;10136.239782016231;10214.285000049926;10318.277720559488;10390.324628899098;10414.531346089292;10539.473026348805;6948.200956890022;7588.582627955516;7661.961690191513;7748.690052397841;7861;8758.693445729368;8765.737027889174;8785.604647790737;8835.734927952171;8842.955785221033;7706.344960678405;7707.229277072248;7835.608219589112;8026.2375074370175;8157.8368432632205;7813.687452502064;7822.647980840762;7837.725679601187;7947.364210863233;8010.599470026592;6992.755253566101;7048.365647091787;7125.5368401053765;7177.354038136593;7177.856442871218;4934.753262336941;4942.777575009061;4975.303457515878;5070.087384270867;5078.822241221687;4814.566688998007;5056.671316364572;5090.389153301479;5093.1341671915125;5104.4129925057605 23:37:19 INFO - PROCESS | 16260 | |4;prototype.html;330.34921205225714;331.1885879594992;336.9545111409959;337.6926996433245;339.49415371097075;5449.972750136249;5508.944910550893;5526.309211348586;5562.443755624436;5572.108462645978;5396.64921780085;5435;5461.15352120421;5467.261919640848;5480.342358916925;4062.593740625936;4081.9591804081874;4166.270902592049;4170.624643782059;4183.372494125875;4185.393117997888;4191.266528357541;4213.115245798386;4214.431051808013;4228.224145858747;4143.767861068356;4184.769837658928;4189.518205406372;4189.539150693421;4208.431861698662;4048.9148088734178;4194.727342722728;4243.511996120455;4258.169656916903;4269.509006464265;3721.5348081489815;3731.7014638828828;3736.065983504124;3746.269477451898;3764.73646844721;5319.414864364917;5325.573954083703;5335.946640533583;5356.54469370104;5359.196120581905;4787.6648634595595;4929.1374009548545;4936.48166942473;4943.579795717368;4950.331705219785;5690.60165788395;5747.339056008571;5747.511461525775;5819.67991760453;5836.854078648025;4127.463429754142;4133.21468920904;4136.772477513736;4137.441445404862;4148.481439820022;5776.364599894008;6056.303525094582;6060.181875446847;6074.025941569008;6082.452579267887;4174.91650166995;4176.561461046607;4178.435911152016;4183.728057676241;4196.181744559782;4219.409282700424;4243.681723870722;4246.617804397619;4255.5318914919335;4258.893527661833;4725.834595789131;4823.638227132979;4871.585915197177;4874.46380898101;4889.3888263967;5821.825345239649;5841.620294680833;5864.70676466175;5864.70676466175;5876.41437767381;1438.5756201920458;1450.6881020580627;1461.218248237188;1461.2620626583507;1468.5153899213235;886.6453418632469;925.546482223719;929.6327950459531;932.7854593443546;940.6707652321769;5609.971950140223;5613.382527921925;5627.437256274422;5645.915311270334;5663.207150998864;5897.793577224862;5964.642121472639;5976.73104710289;6003.909941350883;6055.061465472859;5476.698781566973;5597.664140151523;5623.437656234344;5624.156376543551;5638.238837756932;3187.6812318768402;3193.920151996172;3195.440797860365;3213.052149615869;3227.386796508656;5866.208061911588;6137.938620613737;6167.722452489649;6176.8764624707255;6201.10084037812;6061.454469097803;6068.605540639845;6086.7260973255425;6110.877782444415;6113.449789518964;6126.5098792097415;6144.78493252734;6145.016797312409;6170.598911070766;6243.500519958392;5706.914396284142;5926.496247818811;5980.282366116094;6015.969920150371;6040;5891.941080589139;5893.2044174035955;5894.174815525744;5918.668299632548;5936.7922122725495;5848.210491583582;6093.817185484442;6124.6325220486915;6129.172561704113;6192.287886892885;4114.485689288839;4114.670826333826;4131.607497287753;4134.73124246923;4150.647194988339;5958.582899197015;5964.940350596612;5985.162077309094;5995.640261584319;6007.939920600738;5579.8884022320135;5761.8559536011935;5766.481016708516;5838.241028666416;5938;5795.1745200261785;5825.70871456434;5828.912566311424;5837.270341207349;5839.328477225004;5540.390557038803;5606.85982850432;5632.88734225305;5659.207710920392;5667.518260947865;5846;5892.9116063258225;5922.378150294329;5925.200097986716;5957.91063134062;5651.474101992357;5704.657720536781;5705.286839145107;5775.537956963349;5803.767849285981 23:37:19 INFO - PROCESS | 16260 | |5;yui.html;760.8283243804541;781.3983232910659;849.4648371525942;867.488181972636;876.701921346742;13141.737165256689;13149;13180.670483237924;13955.555999540478;14023;13148.276844773534;13169;13172.93413532931;13219.339033048358;13225.074244802867;685.0683071023404;804.252045597594;805.9476134051268;827.1976183102381;827.7599496146111;815.384384789486;818.0306336990656;819.3895547816885;819.8852160697508;820.7045463633087;861.5519929636616;871.4901782457271;871.5119533061505;873.2053831013778;874.846901792187;856.4861083349971;859.8022454835392;859.8839156713826;867.7049803066988;867.8654808504692;628.6134027573055;630.1304200203735;630.4326106504183;631.2267472346385;631.406477910767;13375.531856385078;13376.331183440789;13447.125936814076;13449.932750336284;13477.86522134776;14469.276536173149;14575.489857855031;14601.926990365086;14787.630309242248;14820.70358592833;12020.338881361522;12039.63881083569;12065.396730163544;12226.510939562408;12326.5069397224;3782.5460944686815;3881.573026967031;3985.362342025291;4037.8990525237105;4040.434339192486;65393;65530.01704974429;65638.3436165637;66314.66842665804;66481.335186648;11027.558897644005;11085.556577736961;11098.833517497244;11372.203945723886;11383.203175777782;19142.71285930712;19389.709154362696;19411.417657470018;19411.417657470298;19499;8324.308212032414;8356.206160414751;8487.208286534382;8489.915100849035;8508.914910850812;4753.144434001843;4827.2395654489255;4874.683145595525;4885.1206782779445;4901.387326584177;3391.5082313064468;3493.1441796759955;3496.5279687241896;3496.7027802637062;3508.298340331944;603.7192705392014;613.8864310102556;614.8616561273677;623.4046485606235;629.2040568680623;563.7434967090046;673.1787219592089;699.6431819771851;724.5471580262337;730.4010711216857;9735.513224338754;9936.534905801924;10021.899781002097;10060.949695251624;10098.949505252427;697.5884228305324;720.4740539406263;725.9963700181465;743.382992116542;764.1479750078622;4468.664850136188;4571.954280457219;4572.428446444194;4595.678302518859;4628.761741419537;68599.65700171568;69298.65350673214;69784;71023;72099.6395018032;59520.40479595235;59693.701531492065;61620.69189654023;62018.68990655018;62653.68673156605;55587;55832.72083639556;55871.44128558744;56267.43732562704;56279.87440251172;9142.542872856198;9169.220616247694;9356;9455.574499147417;9475.299539631173;36865.26269474649;37788.244235114595;38135.618643813206;38553.22893542057;38587.61412385952;47636.2854557175;48933.26600101073;49112;49203.753981229864;50978.74510627423;11324.6036388726;11405.258658187191;11712.238704484182;11809.23239989398;12116.454759535665;12545.598022720756;12686.111972162229;12960;13135;13268.46926122983;12336;12615.87384126147;12775.61673149807;12989.285589292302;13073.441218703854;11016.559337626406;12403.193792403465;12619.87380126187;12719.491220351452;13007.089503735026;12066.517339306329;12116.636500904988;12208.45061972231;12215.206011609216;12452.750944981231;9512.667056652985;9546.665866694633;9600.567974441306;9754.80490390174;9996.450195239331;9772.951135244279;9999.55002024896;10033.598656053968;10068.597256109966;10072.194224462171 23:37:19 INFO - PROCESS | 16260 | __end_tp_report 23:37:19 INFO - PROCESS | 16260 | __start_cc_report 23:37:19 INFO - PROCESS | 16260 | _x_x_mozilla_cycle_collect,332 23:37:19 INFO - PROCESS | 16260 | __end_cc_report 23:37:19 INFO - PROCESS | 16260 | __startTimestamp1464244639494__endTimestamp 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | ------- Summary: start ------- 23:37:19 INFO - PROCESS | 16260 | Number of tests: 6 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | [#0] dojo.html Cycles:165 Average:5416.44 Median:5660.97 stddev:740.25 (13.1%) stddev-sans-first:719.36 23:37:19 INFO - PROCESS | 16260 | Values: 3074.3 3094.2 3142.9 3145.3 3154.8 5363.8 5383.8 5428.7 5465.1 5465.2 5324.2 5402.1 5425.8 5433.2 5520.6 4865.3 4902.9 4992.4 5029.5 5089.5 638.0 4843.2 4906.4 4910.1 5011.9 4888.8 4922.2 4942.6 4957.8 4962.2 4962.4 4981.8 4982.7 4985.3 4995.5 4890.9 4946.3 4952.6 4971.2 4974.9 5357.1 5374.2 5411.3 5424.5 5427.1 5689.9 5802.2 5851.2 5865.5 5870.5 5900.3 5904.6 5949.9 5962.8 5965.9 5536.0 5547.2 5564.3 5564.5 5576.3 5806.9 5994.6 6064.9 6070.0 6077.5 5785.2 5787.2 5789.2 5790.8 5833.3 5875.0 5878.4 5881.9 5891.8 5896.6 5703.8 5757.6 5807.6 5817.8 5837.3 5823.9 5873.1 5875.2 5884.2 5897.4 4425.7 4426.0 4469.9 4472.9 4487.2 3880.3 3896.3 3921.5 3954.0 3973.6 5514.0 5588.6 5629.4 5665.4 5717.6 5964.1 5994.7 5994.8 5996.1 6002.0 5469.8 5562.3 5579.5 5609.0 5688.9 5049.6 5059.7 5061.1 5069.3 5076.4 6068.4 6093.9 6094.7 6096.3 6109.6 5737.9 5844.4 5876.8 5884.7 5948.9 6047.6 6060.7 6071.2 6085.6 6101.9 5661.0 5806.7 5811.5 5816.7 5831.8 5856.7 5882.4 5925.7 5928.5 5956.5 5717.6 5742.8 5745.2 5752.8 5782.4 5617.2 5653.1 5780.9 5786.7 5789.7 5580.1 5631.4 5636.5 5654.7 5696.3 5731.1 5731.7 5765.7 5777.5 5777.7 5510.4 5577.6 5628.2 5633.6 5634.7 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | [#1] ext.html Cycles:180 Average:59308.05 Median:43132.96 stddev:117315.02 (272.0%) stddev-sans-first:117561.29 23:37:19 INFO - PROCESS | 16260 | Values: 591.8 630.4 636.3 650.0 664.3 39079.8 43088.1 43449.3 43536.3 43617.6 43441.0 44335.1 44352.0 44380.0 44412.0 8712.0 8885.5 8889.4 8891.1 8894.1 8674.4 8814.1 8819.5 8861.2 8870.2 8829.6 8844.9 8888.8 8895.2 8899.1 8818.9 8859.9 8884.9 8910.6 8968.7 8702.1 8750.6 8774.5 8798.6 8813.6 41457.0 41561.4 42019.0 42055.4 42149.8 3567.4 3979.1 4276.4 4287.6 4320.1 32206.4 32660.3 32754.8 32916.5 33705.0 4199.6 4331.5 4350.4 4351.1 4490.9 230453.0 230647.0 231151.0 231229.0 231836.0 58557.7 59062.0 59255.0 59615.7 59658.0 63235.2 63248.1 63480.0 63631.0 63843.7 17392.5 17578.7 17629.6 17645.7 17651.2 13463.2 13524.3 13537.5 13547.2 13571.0 15612.8 17471.5 17629.0 17681.5 17685.7 5471.0 6144.8 6158.6 6271.3 6313.1 1058.2 1073.8 1078.8 1080.9 1146.6 32211.7 32517.5 32935.2 33548.7 34065.7 1135.0 1163.7 1165.2 1227.9 1240.5 17319.0 17499.4 17507.8 17706.4 17714.2 554231.0 555151.0 561999.0 563414.0 564849.0 59364.7 59391.0 59712.1 60080.4 60263.4 1339.8 1358.5 1387.8 1421.3 1422.6 32121.5 32553.0 32788.7 32861.0 33193.5 52234.2 52241.0 52759.5 52822.5 52885.0 462890.0 464483.0 465149.0 465224.0 466534.0 42917.8 43177.8 44909.8 45241.8 45362.5 48895.5 49209.8 49412.5 50433.7 51104.0 41815.6 42449.2 42952.8 43645.0 43992.3 40696.0 41893.5 41993.4 42065.6 42543.0 42202.8 42409.8 42527.0 42975.6 43060.0 36414.3 37516.4 37540.8 37604.3 38384.0 28748.6 28882.7 29094.6 29257.7 29259.6 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | [#2] jquery.html Cycles:180 Average:29264.31 Median:2167.18 stddev:83461.79 (3851.2%) stddev-sans-first:83667.77 23:37:19 INFO - PROCESS | 16260 | Values: 394.4 395.3 401.9 402.5 416.4 15125.3 18003.9 18821.1 19892.8 19972.3 18481.3 18832.3 19958.9 20024.3 20032.1 5353.7 5502.2 5664.5 5674.3 5742.9 5438.4 5651.6 5668.6 5818.9 5888.6 5835.5 5859.8 5888.9 5897.0 5925.0 5617.9 5746.5 5750.6 5777.2 5860.3 5536.9 5540.9 5542.9 5543.8 5572.8 13185.5 13795.4 13931.8 14011.0 14033.8 2124.9 2209.4 2328.7 2335.3 2344.4 10203.9 10495.7 10513.6 10611.7 10616.6 1951.0 1999.0 2000.3 2000.5 2012.3 82145.6 84554.6 84852.6 85044.6 85361.0 10661.2 10729.5 10886.6 10929.3 11269.5 13426.9 13741.7 14719.3 15323.8 15353.2 7548.3 7615.4 8391.6 8397.4 8682.5 8370.6 8422.7 8431.5 8472.2 8518.2 4626.5 4655.0 4726.9 4750.0 4773.5 1922.3 1971.5 1974.2 2015.8 2034.5 968.8 992.9 1025.4 1039.5 1096.8 19512.2 20029.6 20043.3 20069.6 20315.6 1034.7 1040.2 1054.1 1062.1 1140.5 10511.9 11223.5 11236.2 11281.7 11288.2 497286.0 497812.0 500700.0 515172.0 515924.0 96680.0 96791.5 97238.5 98224.5 99661.5 984.6 995.6 1006.8 1020.8 1024.6 17243.5 17718.7 17749.6 17887.3 18019.6 33177.8 37372.6 39222.2 41923.2 43794.1 52442.0 56251.4 56972.0 57421.4 57881.7 7766.1 7803.5 7925.8 8065.9 8068.0 8665.9 12141.7 12887.0 12910.4 13032.2 11621.4 11718.5 11781.9 11864.9 11955.6 11292.3 11362.4 11530.0 11743.5 12259.9 11833.8 12031.4 12082.9 12158.5 12393.3 7613.2 7765.9 7799.8 7858.6 8056.8 11146.9 11560.7 11835.9 11939.5 12076.2 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | [#3] mootools.html Cycles:180 Average:5768.21 Median:4511.49 stddev:3341.09 (74.1%) stddev-sans-first:3334.91 23:37:19 INFO - PROCESS | 16260 | Values: 1478.3 1535.5 1674.7 1787.9 1809.2 7745.4 8376.4 8558.1 9139.3 9154.3 8582.7 8820.2 8862.4 8921.8 8936.6 2080.9 2130.5 2132.6 2134.2 2135.8 2215.4 2241.7 2284.1 2301.4 2317.4 2292.3 2297.6 2298.4 2304.1 2304.8 2212.7 2224.0 2224.3 2239.1 2239.4 2245.1 2245.1 2248.8 2250.5 2256.4 8707.3 8835.2 8841.1 8860.0 8866.4 5023.9 5077.8 5124.7 5163.4 5165.5 3161.2 3271.7 3504.7 3511.0 3514.8 1059.8 1097.3 1106.7 1146.5 1158.8 12538.3 12601.9 12632.4 12636.4 12642.2 4281.3 4445.6 4482.4 4496.2 4526.8 10451.8 10503.9 10507.0 10510.6 10539.4 5005.5 5053.7 5062.5 5062.6 5065.0 4243.4 4616.7 4727.7 4728.6 4802.6 3835.2 3875.6 3926.0 3947.9 4004.5 1188.5 1203.3 1206.7 1207.4 1214.7 921.7 937.4 938.4 943.6 955.4 5546.7 5613.6 5718.3 5775.1 5802.9 977.4 1007.8 1014.2 1028.7 1047.9 3749.1 3794.7 3804.5 3806.5 3843.9 10419.4 10670.7 10739.5 10739.7 10754.4 10531.4 10551.6 10569.1 11071.2 11091.1 8124.2 8162.7 8222.4 8308.9 8350.8 5556.0 5861.1 5872.1 5973.9 6121.3 9837.2 9921.1 9984.6 10047.1 10136.2 10214.3 10318.3 10390.3 10414.5 10539.5 6948.2 7588.6 7662.0 7748.7 7861.0 8758.7 8765.7 8785.6 8835.7 8843.0 7706.3 7707.2 7835.6 8026.2 8157.8 7813.7 7822.6 7837.7 7947.4 8010.6 6992.8 7048.4 7125.5 7177.4 7177.9 4934.8 4942.8 4975.3 5070.1 5078.8 4814.6 5056.7 5090.4 5093.1 5104.4 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | [#4] prototype.html Cycles:180 Average:4863.76 Median:5611.68 stddev:1456.31 (26.0%) stddev-sans-first:1420.09 23:37:19 INFO - PROCESS | 16260 | Values: 330.3 331.2 337.0 337.7 339.5 5450.0 5508.9 5526.3 5562.4 5572.1 5396.6 5435.0 5461.2 5467.3 5480.3 4062.6 4082.0 4166.3 4170.6 4183.4 4185.4 4191.3 4213.1 4214.4 4228.2 4143.8 4184.8 4189.5 4189.5 4208.4 4048.9 4194.7 4243.5 4258.2 4269.5 3721.5 3731.7 3736.1 3746.3 3764.7 5319.4 5325.6 5335.9 5356.5 5359.2 4787.7 4929.1 4936.5 4943.6 4950.3 5690.6 5747.3 5747.5 5819.7 5836.9 4127.5 4133.2 4136.8 4137.4 4148.5 5776.4 6056.3 6060.2 6074.0 6082.5 4174.9 4176.6 4178.4 4183.7 4196.2 4219.4 4243.7 4246.6 4255.5 4258.9 4725.8 4823.6 4871.6 4874.5 4889.4 5821.8 5841.6 5864.7 5864.7 5876.4 1438.6 1450.7 1461.2 1461.3 1468.5 886.6 925.5 929.6 932.8 940.7 5610.0 5613.4 5627.4 5645.9 5663.2 5897.8 5964.6 5976.7 6003.9 6055.1 5476.7 5597.7 5623.4 5624.2 5638.2 3187.7 3193.9 3195.4 3213.1 3227.4 5866.2 6137.9 6167.7 6176.9 6201.1 6061.5 6068.6 6086.7 6110.9 6113.4 6126.5 6144.8 6145.0 6170.6 6243.5 5706.9 5926.5 5980.3 6016.0 6040.0 5891.9 5893.2 5894.2 5918.7 5936.8 5848.2 6093.8 6124.6 6129.2 6192.3 4114.5 4114.7 4131.6 4134.7 4150.6 5958.6 5964.9 5985.2 5995.6 6007.9 5579.9 5761.9 5766.5 5838.2 5938.0 5795.2 5825.7 5828.9 5837.3 5839.3 5540.4 5606.9 5632.9 5659.2 5667.5 5846.0 5892.9 5922.4 5925.2 5957.9 5651.5 5704.7 5705.3 5775.5 5803.8 23:37:19 INFO - PROCESS | 16260 | 23:37:19 INFO - PROCESS | 16260 | [#5] yui.html Cycles:180 Average:15852.45 Median:26909.19 stddev:19520.77 (72.5%) stddev-sans-first:19542.64 23:37:19 INFO - PROCESS | 16260 | Values: 760.8 781.4 849.5 867.5 876.7 13141.7 13149.0 13180.7 13955.6 14023.0 13148.3 13169.0 13172.9 13219.3 13225.1 685.1 804.3 805.9 827.2 827.8 815.4 818.0 819.4 819.9 820.7 861.6 871.5 871.5 873.2 874.8 856.5 859.8 859.9 867.7 867.9 628.6 630.1 630.4 631.2 631.4 13375.5 13376.3 13447.1 13449.9 13477.9 14469.3 14575.5 14601.9 14787.6 14820.7 12020.3 12039.6 12065.4 12226.5 12326.5 3782.5 3881.6 3985.4 4037.9 4040.4 65393.0 65530.0 65638.3 66314.7 66481.3 11027.6 11085.6 11098.8 11372.2 11383.2 19142.7 19389.7 19411.4 19411.4 19499.0 8324.3 8356.2 8487.2 8489.9 8508.9 4753.1 4827.2 4874.7 4885.1 4901.4 3391.5 3493.1 3496.5 3496.7 3508.3 603.7 613.9 614.9 623.4 629.2 563.7 673.2 699.6 724.5 730.4 9735.5 9936.5 10021.9 10060.9 10098.9 697.6 720.5 726.0 743.4 764.1 4468.7 4572.0 4572.4 4595.7 4628.8 68599.7 69298.7 69784.0 71023.0 72099.6 59520.4 59693.7 61620.7 62018.7 62653.7 55587.0 55832.7 55871.4 56267.4 56279.9 9142.5 9169.2 9356.0 9455.6 9475.3 36865.3 37788.2 38135.6 38553.2 38587.6 47636.3 48933.3 49112.0 49203.8 50978.7 11324.6 11405.3 11712.2 11809.2 12116.5 12545.6 12686.1 12960.0 13135.0 13268.5 12336.0 12615.9 12775.6 12989.3 13073.4 11016.6 12403.2 12619.9 12719.5 13007.1 12066.5 12116.6 12208.5 12215.2 12452.8 9512.7 9546.7 9600.6 9754.8 9996.5 9773.0 9999.6 10033.6 10068.6 10072.2 23:37:19 INFO - PROCESS | 16260 | -------- Summary: end -------- 23:37:19 INFO - PROCESS | 16260 | 23:37:20 INFO - TEST-INFO | 16260: exit 0 23:37:20 INFO - TEST-OK | dromaeo_css | took 1111475ms 23:37:20 INFO - TEST-START | kraken 23:37:20 INFO - operating with platform_type : linux_ 23:37:20 INFO - Initialising browser for kraken test... 23:37:20 INFO - TEST-INFO | started process 16491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfSCeXA/profile http://localhost:44990/getInfo.html) 23:37:25 INFO - PROCESS | 16491 | 23:37:25 INFO - PROCESS | 16491 | (process:16556): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:37:26 INFO - PROCESS | 16491 | __metrics Screen width/height:1600/1200 23:37:26 INFO - PROCESS | 16491 | colorDepth:24 23:37:26 INFO - PROCESS | 16491 | Browser inner width/height: 1024/697 23:37:26 INFO - PROCESS | 16491 | __metrics 23:37:27 ERROR - PROCESS | 16491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:37:28 INFO - TEST-INFO | 16491: exit 0 23:37:28 INFO - Browser initialized. 23:37:28 INFO - Running cycle 1/1 for kraken test... 23:37:28 INFO - TEST-INFO | started process 16607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfSCeXA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:37:30 INFO - PROCESS | 16607 | 23:37:30 INFO - PROCESS | 16607 | (process:16670): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:37:40 INFO - PROCESS | 16607 | RSS: Main: 165851136 23:37:40 INFO - PROCESS | 16607 | 23:37:42 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44990/tests/kraken/driver.html?testName=audio-beat-detection) 23:37:43 INFO - PROCESS | 16607 | RSS: Main: 170979328 23:37:43 INFO - PROCESS | 16607 | 23:37:46 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44990/tests/kraken/driver.html?testName=audio-dft) 23:37:46 INFO - PROCESS | 16607 | RSS: Main: 171442176 23:37:46 INFO - PROCESS | 16607 | 23:37:49 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44990/tests/kraken/driver.html?testName=audio-fft) 23:37:50 INFO - PROCESS | 16607 | RSS: Main: 165572608 23:37:50 INFO - PROCESS | 16607 | 23:37:52 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44990/tests/kraken/driver.html?testName=audio-oscillator) 23:37:53 INFO - PROCESS | 16607 | RSS: Main: 165842944 23:37:53 INFO - PROCESS | 16607 | 23:37:55 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44990/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:37:55 INFO - PROCESS | 16607 | RSS: Main: 166014976 23:37:55 INFO - PROCESS | 16607 | 23:37:58 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44990/tests/kraken/driver.html?testName=imaging-darkroom) 23:37:59 INFO - PROCESS | 16607 | RSS: Main: 166510592 23:37:59 INFO - PROCESS | 16607 | 23:38:02 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44990/tests/kraken/driver.html?testName=imaging-desaturate) 23:38:03 INFO - PROCESS | 16607 | RSS: Main: 166363136 23:38:03 INFO - PROCESS | 16607 | 23:38:06 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44990/tests/kraken/driver.html?testName=json-parse-financial) 23:38:06 INFO - PROCESS | 16607 | RSS: Main: 166912000 23:38:06 INFO - PROCESS | 16607 | 23:38:08 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44990/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:38:09 INFO - PROCESS | 16607 | RSS: Main: 167002112 23:38:09 INFO - PROCESS | 16607 | 23:38:10 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:38:11 INFO - PROCESS | 16607 | RSS: Main: 166907904 23:38:11 INFO - PROCESS | 16607 | 23:38:13 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:38:14 INFO - PROCESS | 16607 | RSS: Main: 166936576 23:38:14 INFO - PROCESS | 16607 | 23:38:16 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:38:17 INFO - PROCESS | 16607 | RSS: Main: 166563840 23:38:17 INFO - PROCESS | 16607 | 23:38:20 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:38:20 INFO - PROCESS | 16607 | RSS: Main: 166412288 23:38:20 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | Cycle 1(1): loaded http://localhost:44990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44990/tests/kraken/driver.html?testName=ai-astar) 23:38:22 INFO - PROCESS | 16607 | RSS: Main: 168112128 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | __start_tp_report 23:38:22 INFO - PROCESS | 16607 | _x_x_mozilla_page_load 23:38:22 INFO - PROCESS | 16607 | _x_x_mozilla_page_load_details 23:38:22 INFO - PROCESS | 16607 | |i|pagename|runs| 23:38:22 INFO - PROCESS | 16607 | |0;ai-astar;110;106;111;110;110;113;111;112;110;111 23:38:22 INFO - PROCESS | 16607 | |1;audio-beat-detection;157;125;164;173;128;160;158;133;174;130 23:38:22 INFO - PROCESS | 16607 | |2;audio-dft;161;162;160;161;161;164;173;161;162;161 23:38:22 INFO - PROCESS | 16607 | |3;audio-fft;76;74;76;148;75;75;74;75;162;75 23:38:22 INFO - PROCESS | 16607 | |4;audio-oscillator;83;84;139;83;82;83;142;82;83;142 23:38:22 INFO - PROCESS | 16607 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;118;117 23:38:22 INFO - PROCESS | 16607 | |6;imaging-darkroom;146;147;148;146;147;147;148;147;148;147 23:38:22 INFO - PROCESS | 16607 | |7;imaging-desaturate;96;98;96;95;95;95;96;96;96;95 23:38:22 INFO - PROCESS | 16607 | |8;json-parse-financial;54;56;54;55;57;60;56;72;59;54 23:38:22 INFO - PROCESS | 16607 | |9;json-stringify-tinderbox;61;61;61;62;61;61;61;60;60;61 23:38:22 INFO - PROCESS | 16607 | |10;stanford-crypto-aes;82;78;78;81;80;80;82;80;81;80 23:38:22 INFO - PROCESS | 16607 | |11;stanford-crypto-ccm;133;130;130;138;129;132;137;130;174;124 23:38:22 INFO - PROCESS | 16607 | |12;stanford-crypto-pbkdf2;166;159;157;159;160;158;168;164;157;164 23:38:22 INFO - PROCESS | 16607 | |13;stanford-crypto-sha256-iterative;67;65;63;64;61;64;62;63;61;62 23:38:22 INFO - PROCESS | 16607 | __end_tp_report 23:38:22 INFO - PROCESS | 16607 | __start_cc_report 23:38:22 INFO - PROCESS | 16607 | _x_x_mozilla_cycle_collect,890 23:38:22 INFO - PROCESS | 16607 | __end_cc_report 23:38:22 INFO - PROCESS | 16607 | __startTimestamp1464244702734__endTimestamp 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | ------- Summary: start ------- 23:38:22 INFO - PROCESS | 16607 | Number of tests: 14 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 23:38:22 INFO - PROCESS | 16607 | Values: 110.0 106.0 111.0 110.0 110.0 113.0 111.0 112.0 110.0 111.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:159.00 stddev:19.18 (12.1%) stddev-sans-first:20.19 23:38:22 INFO - PROCESS | 16607 | Values: 157.0 125.0 164.0 173.0 128.0 160.0 158.0 133.0 174.0 130.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#2] audio-dft Cycles:10 Average:162.60 Median:161.50 stddev:3.81 (2.4%) stddev-sans-first:3.99 23:38:22 INFO - PROCESS | 16607 | Values: 161.0 162.0 160.0 161.0 161.0 164.0 173.0 161.0 162.0 161.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#3] audio-fft Cycles:10 Average:91.00 Median:75.00 stddev:33.90 (45.2%) stddev-sans-first:35.52 23:38:22 INFO - PROCESS | 16607 | Values: 76.0 74.0 76.0 148.0 75.0 75.0 74.0 75.0 162.0 75.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:83.00 stddev:28.10 (33.9%) stddev-sans-first:29.10 23:38:22 INFO - PROCESS | 16607 | Values: 83.0 84.0 139.0 83.0 82.0 83.0 142.0 82.0 83.0 142.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:38:22 INFO - PROCESS | 16607 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 23:38:22 INFO - PROCESS | 16607 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 148.0 147.0 148.0 147.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 23:38:22 INFO - PROCESS | 16607 | Values: 96.0 98.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.50 stddev:5.44 (9.6%) stddev-sans-first:5.60 23:38:22 INFO - PROCESS | 16607 | Values: 54.0 56.0 54.0 55.0 57.0 60.0 56.0 72.0 59.0 54.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:38:22 INFO - PROCESS | 16607 | Values: 61.0 61.0 61.0 62.0 61.0 61.0 61.0 60.0 60.0 61.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:1.40 (1.7%) stddev-sans-first:1.32 23:38:22 INFO - PROCESS | 16607 | Values: 82.0 78.0 78.0 81.0 80.0 80.0 82.0 80.0 81.0 80.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:132.50 stddev:14.04 (10.6%) stddev-sans-first:14.86 23:38:22 INFO - PROCESS | 16607 | Values: 133.0 130.0 130.0 138.0 129.0 132.0 137.0 130.0 174.0 124.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.00 stddev:3.97 (2.4%) stddev-sans-first:3.81 23:38:22 INFO - PROCESS | 16607 | Values: 166.0 159.0 157.0 159.0 160.0 158.0 168.0 164.0 157.0 164.0 23:38:22 INFO - PROCESS | 16607 | 23:38:22 INFO - PROCESS | 16607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.87 (3.0%) stddev-sans-first:1.39 23:38:22 INFO - PROCESS | 16607 | Values: 67.0 65.0 63.0 64.0 61.0 64.0 62.0 63.0 61.0 62.0 23:38:22 INFO - PROCESS | 16607 | -------- Summary: end -------- 23:38:22 INFO - PROCESS | 16607 | 23:38:23 INFO - TEST-INFO | 16607: exit 0 23:38:23 INFO - TEST-OK | kraken | took 63431ms 23:38:23 INFO - SUITE-END | took 1174s 23:38:23 INFO - Completed test suite (00:19:35) 23:38:23 INFO - javascript benchmark 23:38:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7196.940683127773, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.3390171113215, 3094.195509167616, 3142.9371412571763, 3145.3080322329088, 3154.7791654584175, 5363.812266570666, 5383.838484845451, 5428.728563571821, 5465.098258787295, 5465.180222966547, 5324.201369794523, 5402.081646120159, 5425.755840987155, 5433.239346491485, 5520.558355331574, 4865.270209468573, 4902.926456103143, 4992.425871024824, 5029.47190544993, 5089.46560611136, 637.9535040147977, 4843.176659967797, 4906.386701662293, 4910.091633047879, 5011.899762004758, 4888.804447822083, 4922.237053256751, 4942.579880710126, 4957.801687932479, 4962.230854217584, 4962.379702537183, 4981.750912454399, 4982.676126051795, 4985.302057711923, 4995.525425084647, 4890.923996720751, 4946.258061290835, 4952.5542701157065, 4971.204607262821, 4974.900501989976, 5357.08929481989, 5374.193870919355, 5411.296531450926, 5424.457554244544, 5427.0773968425465, 5689.947359738461, 5802.245708057968, 5851.151583020481, 5865.472107510302, 5870.501007414375, 5900.262467191601, 5904.645721256738, 5949.8810023799715, 5962.761489540413, 5965.880682386328, 5535.972320138373, 5547.1679248112705, 5564.33228012637, 5564.4991950724625, 5576.302962129734, 5806.854828629318, 5994.610350327215, 6064.9090263646085, 6069.969650151721, 6077.483413909778, 5785.190073389729, 5787.247657804459, 5789.189513468118, 5790.768369265266, 5833.300003999547, 5875.0, 5878.441548052928, 5881.852953676193, 5891.823245302562, 5896.616719913192, 5703.771849125988, 5757.568182386338, 5807.622504537191, 5817.767289308465, 5837.270341207349, 5823.854403639858, 5873.148393483007, 5875.236219291465, 5884.2350494436305, 5897.439743224387, 4425.668074894395, 4425.977870110693, 4469.865904022885, 4472.888177795581, 4487.192305384997, 3880.3015457217407, 3896.298666240104, 3921.5490218624655, 3953.9604603954167, 3973.642372186517, 5514.0, 5588.552915766811, 5629.380768115504, 5665.405132461115, 5717.599768016282, 5964.105384192406, 5994.700264986734, 5994.790182343684, 5996.070609055603, 6002.039673652282, 5469.835904922858, 5562.276904002535, 5579.4978451938705, 5609.0, 5688.914666280009, 5049.596032317406, 5059.696418214919, 5061.089003979246, 5069.315642388304, 5076.44159142494, 6068.393160683896, 6093.878122437526, 6094.691077340286, 6096.329403765582, 6109.6413581843635, 5737.8565535861935, 5844.415558444121, 5876.794312199053, 5884.735186916513, 5948.940510594839, 6047.637141771508, 6060.727267272895, 6071.150038994632, 6085.57400981927, 6101.908471373022, 5660.971695141498, 5806.65160090396, 5811.535077193899, 5816.680082595329, 5831.7667293307795, 5856.707164641836, 5882.441168089196, 5925.703714814156, 5928.525717942468, 5956.463918247378, 5717.571182161271, 5742.7702891883855, 5745.1956726059225, 5752.769889204553, 5782.392848750989, 5617.241672374177, 5653.095504719226, 5780.942190578208, 5786.681732504584, 5789.739461724317, 5580.135079062752, 5631.408702086222, 5636.464535869086, 5654.745536450787, 5696.316442026983, 5731.140328950691, 5731.684757338387, 5765.654060756368, 5777.508911742549, 5777.6822274775295, 5510.366307874646, 5577.609567330248, 5628.240187574789, 5633.577481688972, 5634.718264086861], "value": 5366.220666300285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8490784849863, 630.4326106504145, 636.341386664802, 649.9870002599948, 664.2925284571934, 39079.80460097699, 43088.13823723524, 43449.34825977605, 43536.34695479571, 43617.56382436179, 43441.0, 44335.113297734024, 44352.0, 44380.0, 44412.0, 8711.956440217806, 8885.511296878669, 8889.42218755782, 8891.06643802401, 8894.11058894112, 8674.392792504526, 8814.074522175175, 8819.51492667903, 8861.202491775739, 8870.246029087535, 8829.646814127427, 8844.867326990101, 8888.822223555526, 8895.199432051115, 8899.110088991081, 8818.911810881937, 8859.911400885972, 8884.866726999067, 8910.554472276424, 8968.686095986643, 8702.086280940537, 8750.562471876445, 8774.473531588124, 8798.648054077828, 8813.647454101892, 41457.0, 41561.37657935133, 42019.0, 42055.36916946248, 42149.78925105386, 3567.430330654504, 3979.0848104935735, 4276.358546218061, 4287.571242875719, 4320.1143765527995, 32206.35587288241, 32660.346793064007, 32754.836225818955, 32916.50625240623, 33705.0, 4199.580041995807, 4331.480222373335, 4350.390945267665, 4351.108022855307, 4490.865274041784, 230453.0, 230647.0, 231151.0, 231229.0, 231836.0, 58557.70721146367, 59062.0, 59255.0, 59615.70192149098, 59658.0, 63235.15441805038, 63248.05127923085, 63480.0, 63631.0, 63843.680781596726, 17392.47822565325, 17578.736318955227, 17629.559261018578, 17645.7353139703, 17651.205695743465, 13463.192208467523, 13524.32378381077, 13537.526186583422, 13547.174714872699, 13571.0, 15612.76580851288, 17471.475855724348, 17629.0, 17681.469555913343, 17685.734713979302, 5471.0, 6144.846378840565, 6158.599691020069, 6271.310155882849, 6313.084602732578, 1058.1904842795268, 1073.8013467508536, 1078.8166011778017, 1080.9459527023616, 1146.6158836789768, 32211.67788322087, 32517.51223731646, 32935.18856462918, 33548.66451335455, 34065.65934340675, 1135.0151682910848, 1163.743976325207, 1165.1669056624555, 1227.8710735372836, 1240.5472002719123, 17319.0, 17499.387521436944, 17507.824921750875, 17706.380276690255, 17714.202860871294, 554231.0, 555151.0, 561999.0, 563414.0, 564849.0, 59364.703176484705, 59391.0, 59712.10431843526, 60080.39919600748, 60263.397366025776, 1339.7521458530202, 1358.5109360630165, 1387.8195834541445, 1421.3461807568428, 1422.6087825847974, 32121.51817722689, 32553.0, 32788.67211327856, 32861.0, 33193.502097468074, 52234.21648675349, 52241.0, 52759.472405275454, 52822.47177528175, 52885.0, 462890.0, 464483.0, 465149.0, 465224.0, 466534.0, 42917.78541107274, 43177.78411107924, 44909.775451122536, 45241.773791130836, 45362.54637453715, 48895.5110448891, 49209.75395123001, 49412.50587494079, 50433.74783126207, 51104.0, 41815.58184418239, 42449.151016980104, 42952.78523607362, 43645.0, 43992.34011489894, 40696.0, 41893.53718414401, 41993.370099449145, 42065.57934420739, 42543.0, 42202.788986054875, 42409.787951061284, 42527.0, 42975.57024429716, 43060.0, 36414.27171456503, 37516.43725344176, 37540.81229593835, 37604.26678352833, 38384.0, 28748.568771468865, 28882.71117288884, 29094.56358154587, 29257.707422925498, 29259.56110658299], "value": 20523.582990522857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.4162639293845, 395.2766437419519, 401.9216252830697, 402.51295931922374, 416.35068623514877, 15125.319360628771, 18003.909980450095, 18821.05894705266, 19892.801071989295, 19972.300969466072, 18481.260749570036, 18832.34086806962, 19958.900205498987, 20024.29914952977, 20032.098555564997, 5353.705546194958, 5502.2296878436955, 5664.54683625309, 5674.3190817102, 5742.913856292138, 5438.401775804658, 5651.632643878155, 5668.603197776158, 5818.941810581903, 5888.64668119912, 5835.533157347402, 5859.79490717825, 5888.882222355551, 5897.0, 5924.970375148118, 5617.887642247173, 5746.482816546531, 5750.597458177929, 5777.19119323295, 5860.267466566679, 5536.889262214773, 5540.86147846303, 5542.944570554324, 5543.833684989457, 5572.7770889164385, 13185.472581096745, 13795.448182072705, 13931.791023134661, 14011.038454616362, 14033.78949315761, 2124.9043793029196, 2209.4476380904775, 2328.732195797488, 2335.311083230451, 2344.39045848079, 10203.948980255125, 10495.685129446128, 10513.632022879163, 10611.734706632396, 10616.575336986589, 1950.980490195094, 1998.980010199894, 2000.3098930868828, 2000.469875482998, 2012.2554654777825, 82145.58927205326, 84554.57722711409, 84852.57573712153, 85044.57477712634, 85361.0, 10661.200409969284, 10729.517171727291, 10886.564537418573, 10929.344239345664, 11269.492872820743, 13426.932865335611, 13741.656458588415, 14719.337629806685, 15323.770143447857, 15353.232338383035, 7548.282913123245, 7615.428842836809, 8391.580420978926, 8397.370197235232, 8682.479051256945, 8370.581470926429, 8422.705205317785, 8431.536265505456, 8472.237498625153, 8518.190771876662, 4626.4910859805395, 4654.999175177353, 4726.929096063562, 4749.95250047502, 4773.522647735199, 1922.2695375757403, 1971.5312092491185, 1974.210315873662, 2015.7581090269261, 2034.491377155711, 968.7820240445843, 992.9156021738089, 1025.415513157493, 1039.5322105052755, 1096.7641956979128, 19512.219511219675, 20029.59940801205, 20043.298484553263, 20069.598608027758, 20315.593688126155, 1034.7361422837128, 1040.2146379483443, 1054.135608800776, 1062.0653824634426, 1140.5266814271984, 10511.947440262902, 11223.494942727597, 11236.157288203418, 11281.661550153509, 11288.153388495895, 497286.0, 497812.0, 500700.0, 515172.0, 515924.0, 96680.0, 96791.51604241933, 97238.51380743193, 98224.50887745658, 99661.50169249107, 984.5766320482118, 995.576879826071, 1006.7986402719486, 1020.8315627921459, 1024.5543188712934, 17243.482695519153, 17718.734218986985, 17749.645007100044, 17887.28450861951, 18019.639607208046, 33177.83411082929, 37372.626273738, 39222.2155556893, 41923.1615367697, 43794.124117518106, 52442.0, 56251.43748562626, 56972.0, 57421.42578574161, 57881.710591446776, 7766.106897706836, 7803.531788092732, 7925.762227133196, 8065.8790118149445, 8067.959660201662, 8665.913340866511, 12141.696457588278, 12887.0, 12910.419031143809, 13032.152910060815, 11621.360825154698, 11718.472668729757, 11781.941090294837, 11864.940675296568, 11955.64133076009, 11292.266002709797, 11362.431878406212, 11530.0, 11743.530258789895, 12259.938700306442, 11833.763324733285, 12031.398430078287, 12082.939585302018, 12158.452869621065, 12393.318367489876, 7613.238676132564, 7765.922340776746, 7799.766007019798, 7858.6070696466095, 8056.831759394972, 11146.88853111491, 11560.710982225512, 11835.881641183478, 11939.52241910314, 12076.154669173073], "value": 9092.429270628714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.2682572126796, 1535.5239875638554, 1674.6566953774477, 1787.865910056746, 1809.249161597937, 7745.419093567977, 8376.371772117085, 8558.101399353063, 9139.268858491321, 9154.267658587314, 8582.742517724479, 8820.206181443686, 8862.423942443736, 8921.776955576113, 8936.553172341373, 2080.9375718728425, 2130.456733532955, 2132.605467988419, 2134.1890081768984, 2135.8291336693105, 2215.401841502793, 2241.674957131215, 2284.1091974130104, 2301.3786277705008, 2317.385892738417, 2292.3466811958597, 2297.5749486345, 2298.4368829636765, 2304.06685292456, 2304.758000409958, 2212.668099785029, 2223.9777602224012, 2224.3104637562406, 2239.070785623964, 2239.4177513846353, 2245.10195921631, 2245.124401483423, 2248.752637209922, 2250.5273892482596, 2256.356938272601, 8707.346948978851, 8835.249003834682, 8841.115888411172, 8859.955700221522, 8866.379353445262, 5023.899522009539, 5077.796888124471, 5124.718140502271, 5163.40620828602, 5165.457626949154, 3161.2096975756062, 3271.738260939143, 3504.702100321476, 3511.0344655219765, 3514.8066856322894, 1059.793340298642, 1097.286763603656, 1106.6790630717082, 1146.5471138900089, 1158.7682463507333, 12538.310392928386, 12601.873981260162, 12632.431540580605, 12636.431360588704, 12642.2414655121, 4281.250781113293, 4445.555444455528, 4482.350059241392, 4496.213162696515, 4526.773661316987, 10451.790964180675, 10503.894961050291, 10507.0, 10510.632127875488, 10539.367637941748, 5005.499450054966, 5053.69677819332, 5062.4684408137355, 5062.594992400599, 5065.037642847848, 4243.448351714319, 4616.676832621684, 4727.7399743013775, 4728.550787675165, 4802.591779698765, 3835.194609132058, 3875.5736868944396, 3925.980370098131, 3947.8618248361745, 4004.519457665099, 1188.483009890683, 1203.2599951030054, 1206.6862615719801, 1207.3661327802797, 1214.7084699672016, 921.6589861751195, 937.4422218779815, 938.4216641344226, 943.5612440215195, 955.3837774635322, 5546.667199968015, 5613.635113717595, 5718.256626638594, 5775.133729940542, 5802.88394232113, 977.3744803325877, 1007.8337074382645, 1014.2228913276025, 1028.6605420211313, 1047.8899715529913, 3749.1189570450924, 3794.658480736747, 3804.505414296179, 3806.5051543299196, 3843.9039024024623, 10419.42693151884, 10670.73323166927, 10739.463026848627, 10739.677809665722, 10754.40850753216, 10531.420771857469, 10551.577936882439, 10569.101626361691, 11071.225014248925, 11091.057260132979, 8124.187581241828, 8162.7143049992965, 8222.38332125093, 8308.916910830814, 8350.79123021917, 5555.972220138873, 5861.120831875252, 5872.148538461814, 5973.850653733692, 6121.296050954197, 9837.213022958289, 9921.107100361001, 9984.60061597528, 10047.09576138151, 10136.239782016231, 10214.285000049926, 10318.277720559488, 10390.324628899098, 10414.531346089292, 10539.473026348805, 6948.200956890022, 7588.582627955516, 7661.961690191513, 7748.690052397841, 7861.0, 8758.693445729368, 8765.737027889174, 8785.604647790737, 8835.734927952171, 8842.955785221033, 7706.344960678405, 7707.229277072248, 7835.608219589112, 8026.2375074370175, 8157.8368432632205, 7813.687452502064, 7822.647980840762, 7837.725679601187, 7947.364210863233, 8010.599470026592, 6992.755253566101, 7048.365647091787, 7125.5368401053765, 7177.354038136593, 7177.856442871218, 4934.753262336941, 4942.777575009061, 4975.303457515878, 5070.087384270867, 5078.822241221687, 4814.566688998007, 5056.671316364572, 5090.389153301479, 5093.1341671915125, 5104.4129925057605], "value": 4592.021811823373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.34921205225714, 331.1885879594992, 336.9545111409959, 337.6926996433245, 339.49415371097075, 5449.972750136249, 5508.944910550893, 5526.309211348586, 5562.443755624436, 5572.108462645978, 5396.64921780085, 5435.0, 5461.15352120421, 5467.261919640848, 5480.342358916925, 4062.593740625936, 4081.9591804081874, 4166.270902592049, 4170.624643782059, 4183.372494125875, 4185.393117997888, 4191.266528357541, 4213.115245798386, 4214.431051808013, 4228.224145858747, 4143.767861068356, 4184.769837658928, 4189.518205406372, 4189.539150693421, 4208.431861698662, 4048.9148088734178, 4194.727342722728, 4243.511996120455, 4258.169656916903, 4269.509006464265, 3721.5348081489815, 3731.7014638828828, 3736.065983504124, 3746.269477451898, 3764.73646844721, 5319.414864364917, 5325.573954083703, 5335.946640533583, 5356.54469370104, 5359.196120581905, 4787.6648634595595, 4929.1374009548545, 4936.48166942473, 4943.579795717368, 4950.331705219785, 5690.60165788395, 5747.339056008571, 5747.511461525775, 5819.67991760453, 5836.854078648025, 4127.463429754142, 4133.21468920904, 4136.772477513736, 4137.441445404862, 4148.481439820022, 5776.364599894008, 6056.303525094582, 6060.181875446847, 6074.025941569008, 6082.452579267887, 4174.91650166995, 4176.561461046607, 4178.435911152016, 4183.728057676241, 4196.181744559782, 4219.409282700424, 4243.681723870722, 4246.617804397619, 4255.5318914919335, 4258.893527661833, 4725.834595789131, 4823.638227132979, 4871.585915197177, 4874.46380898101, 4889.3888263967, 5821.825345239649, 5841.620294680833, 5864.70676466175, 5864.70676466175, 5876.41437767381, 1438.5756201920458, 1450.6881020580627, 1461.218248237188, 1461.2620626583507, 1468.5153899213235, 886.6453418632469, 925.546482223719, 929.6327950459531, 932.7854593443546, 940.6707652321769, 5609.971950140223, 5613.382527921925, 5627.437256274422, 5645.915311270334, 5663.207150998864, 5897.793577224862, 5964.642121472639, 5976.73104710289, 6003.909941350883, 6055.061465472859, 5476.698781566973, 5597.664140151523, 5623.437656234344, 5624.156376543551, 5638.238837756932, 3187.6812318768402, 3193.920151996172, 3195.440797860365, 3213.052149615869, 3227.386796508656, 5866.208061911588, 6137.938620613737, 6167.722452489649, 6176.8764624707255, 6201.10084037812, 6061.454469097803, 6068.605540639845, 6086.7260973255425, 6110.877782444415, 6113.449789518964, 6126.5098792097415, 6144.78493252734, 6145.016797312409, 6170.598911070766, 6243.500519958392, 5706.914396284142, 5926.496247818811, 5980.282366116094, 6015.969920150371, 6040.0, 5891.941080589139, 5893.2044174035955, 5894.174815525744, 5918.668299632548, 5936.7922122725495, 5848.210491583582, 6093.817185484442, 6124.6325220486915, 6129.172561704113, 6192.287886892885, 4114.485689288839, 4114.670826333826, 4131.607497287753, 4134.73124246923, 4150.647194988339, 5958.582899197015, 5964.940350596612, 5985.162077309094, 5995.640261584319, 6007.939920600738, 5579.8884022320135, 5761.8559536011935, 5766.481016708516, 5838.241028666416, 5938.0, 5795.1745200261785, 5825.70871456434, 5828.912566311424, 5837.270341207349, 5839.328477225004, 5540.390557038803, 5606.85982850432, 5632.88734225305, 5659.207710920392, 5667.518260947865, 5846.0, 5892.9116063258225, 5922.378150294329, 5925.200097986716, 5957.91063134062, 5651.474101992357, 5704.657720536781, 5705.286839145107, 5775.537956963349, 5803.767849285981], "value": 4392.199711656277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.8283243804541, 781.3983232910659, 849.4648371525942, 867.488181972636, 876.701921346742, 13141.737165256689, 13149.0, 13180.670483237924, 13955.555999540478, 14023.0, 13148.276844773534, 13169.0, 13172.93413532931, 13219.339033048358, 13225.074244802867, 685.0683071023404, 804.252045597594, 805.9476134051268, 827.1976183102381, 827.7599496146111, 815.384384789486, 818.0306336990656, 819.3895547816885, 819.8852160697508, 820.7045463633087, 861.5519929636616, 871.4901782457271, 871.5119533061505, 873.2053831013778, 874.846901792187, 856.4861083349971, 859.8022454835392, 859.8839156713826, 867.7049803066988, 867.8654808504692, 628.6134027573055, 630.1304200203735, 630.4326106504183, 631.2267472346385, 631.406477910767, 13375.531856385078, 13376.331183440789, 13447.125936814076, 13449.932750336284, 13477.86522134776, 14469.276536173149, 14575.489857855031, 14601.926990365086, 14787.630309242248, 14820.70358592833, 12020.338881361522, 12039.63881083569, 12065.396730163544, 12226.510939562408, 12326.5069397224, 3782.5460944686815, 3881.573026967031, 3985.362342025291, 4037.8990525237105, 4040.434339192486, 65393.0, 65530.01704974429, 65638.3436165637, 66314.66842665804, 66481.335186648, 11027.558897644005, 11085.556577736961, 11098.833517497244, 11372.203945723886, 11383.203175777782, 19142.71285930712, 19389.709154362696, 19411.417657470018, 19411.417657470298, 19499.0, 8324.308212032414, 8356.206160414751, 8487.208286534382, 8489.915100849035, 8508.914910850812, 4753.144434001843, 4827.2395654489255, 4874.683145595525, 4885.1206782779445, 4901.387326584177, 3391.5082313064468, 3493.1441796759955, 3496.5279687241896, 3496.7027802637062, 3508.298340331944, 603.7192705392014, 613.8864310102556, 614.8616561273677, 623.4046485606235, 629.2040568680623, 563.7434967090046, 673.1787219592089, 699.6431819771851, 724.5471580262337, 730.4010711216857, 9735.513224338754, 9936.534905801924, 10021.899781002097, 10060.949695251624, 10098.949505252427, 697.5884228305324, 720.4740539406263, 725.9963700181465, 743.382992116542, 764.1479750078622, 4468.664850136188, 4571.954280457219, 4572.428446444194, 4595.678302518859, 4628.761741419537, 68599.65700171568, 69298.65350673214, 69784.0, 71023.0, 72099.6395018032, 59520.40479595235, 59693.701531492065, 61620.69189654023, 62018.68990655018, 62653.68673156605, 55587.0, 55832.72083639556, 55871.44128558744, 56267.43732562704, 56279.87440251172, 9142.542872856198, 9169.220616247694, 9356.0, 9455.574499147417, 9475.299539631173, 36865.26269474649, 37788.244235114595, 38135.618643813206, 38553.22893542057, 38587.61412385952, 47636.2854557175, 48933.26600101073, 49112.0, 49203.753981229864, 50978.74510627423, 11324.6036388726, 11405.258658187191, 11712.238704484182, 11809.23239989398, 12116.454759535665, 12545.598022720756, 12686.111972162229, 12960.0, 13135.0, 13268.46926122983, 12336.0, 12615.87384126147, 12775.61673149807, 12989.285589292302, 13073.441218703854, 11016.559337626406, 12403.193792403465, 12619.87380126187, 12719.491220351452, 13007.089503735026, 12066.517339306329, 12116.636500904988, 12208.45061972231, 12215.206011609216, 12452.750944981231, 9512.667056652985, 9546.665866694633, 9600.567974441306, 9754.80490390174, 9996.450195239331, 9772.951135244279, 9999.55002024896, 10033.598656053968, 10068.597256109966, 10072.194224462171], "value": 6879.47846221871, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 110.0, 110.0, 113.0, 111.0, 112.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 164.0, 173.0, 128.0, 160.0, 158.0, 133.0, 174.0, 130.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 164.0, 173.0, 161.0, 162.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 148.0, 75.0, 75.0, 74.0, 75.0, 162.0, 75.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 139.0, 83.0, 82.0, 83.0, 142.0, 82.0, 83.0, 142.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 57.0, 60.0, 56.0, 72.0, 59.0, 54.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 78.0, 81.0, 80.0, 80.0, 82.0, 80.0, 81.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 130.0, 138.0, 129.0, 132.0, 137.0, 130.0, 174.0, 124.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 159.0, 157.0, 159.0, 160.0, 158.0, 168.0, 164.0, 157.0, 164.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 63.0, 64.0, 61.0, 64.0, 62.0, 63.0, 61.0, 62.0], "value": 63.2, "unit": "score"}]}]} 23:38:23 INFO - Return code: 0 23:38:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:38:24 ERROR - # TBPL SUCCESS # 23:38:24 INFO - Running post-action listener: _resource_record_post_action 23:38:24 INFO - ##### 23:38:24 INFO - ##### Finished run-tests step (success) 23:38:24 INFO - ##### 23:38:24 INFO - Running post-run listener: _resource_record_post_run 23:38:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536764416; Read time: 12; Write time: 649032 23:38:24 INFO - TinderboxPrint: CPU usage
13.5% 23:38:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:38:24 INFO - TinderboxPrint: I/O write bytes / time
536,764,416 / 649,032 23:38:24 INFO - TinderboxPrint: CPU idle
8,236.3 (86.5%) 23:38:24 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 23:38:24 INFO - TinderboxPrint: Swap in / out
0 / 0 23:38:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247144448; Read time: 0; Write time: 368680 23:38:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289619968; Read time: 12; Write time: 280352 23:38:24 INFO - Running post-run listener: _upload_blobber_files 23:38:24 INFO - Blob upload gear active. 23:38:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:38:24 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 23:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:38:25 INFO - (blobuploader) - INFO - Open directory for files ... 23:38:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:38:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:38:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:25 INFO - (blobuploader) - INFO - Done attempting. 23:38:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:38:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:38:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:26 INFO - (blobuploader) - INFO - Done attempting. 23:38:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:38:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:38:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:38:30 INFO - (blobuploader) - INFO - Done attempting. 23:38:30 INFO - (blobuploader) - INFO - Iteration through files over. 23:38:30 INFO - Return code: 0 23:38:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:38:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:38:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c878b97b6573cf6bd36aa8d627533965a534580b94350a7275f7ce04e469712ec7935a95fbc212ceedbb565ef78e8ae8d2edf19660c04869e6b6dc131643eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f6d030112a3a95973a54283906487feb8e372649044f6cb35ee93e219c2e895aad06090ac5d4b50dc3e80d7cf3db342939b5cee73547bad8b6fb16592eb42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65b6fcc4e2b21ca1fd0ec4124208a0cd870d7cdd7f55ad7ee0778112eab0bfedbacbe1bb63664ddbe6095c0ed7d632d0cd8a263df255937c2954025f1dea0cbb"} 23:38:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:38:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:38:30 INFO - Contents: 23:38:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c878b97b6573cf6bd36aa8d627533965a534580b94350a7275f7ce04e469712ec7935a95fbc212ceedbb565ef78e8ae8d2edf19660c04869e6b6dc131643eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f6d030112a3a95973a54283906487feb8e372649044f6cb35ee93e219c2e895aad06090ac5d4b50dc3e80d7cf3db342939b5cee73547bad8b6fb16592eb42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65b6fcc4e2b21ca1fd0ec4124208a0cd870d7cdd7f55ad7ee0778112eab0bfedbacbe1bb63664ddbe6095c0ed7d632d0cd8a263df255937c2954025f1dea0cbb"} 23:38:30 INFO - Running post-run listener: copy_logs_to_upload_dir 23:38:30 INFO - Copying logs to upload dir... 23:38:30 INFO - mkdir: /builds/slave/test/build/upload/logs 23:38:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.189754 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-25 23:38:30.198440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 23:38:30.202124) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770 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/sha512/1c878b97b6573cf6bd36aa8d627533965a534580b94350a7275f7ce04e469712ec7935a95fbc212ceedbb565ef78e8ae8d2edf19660c04869e6b6dc131643eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f6d030112a3a95973a54283906487feb8e372649044f6cb35ee93e219c2e895aad06090ac5d4b50dc3e80d7cf3db342939b5cee73547bad8b6fb16592eb42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65b6fcc4e2b21ca1fd0ec4124208a0cd870d7cdd7f55ad7ee0778112eab0bfedbacbe1bb63664ddbe6095c0ed7d632d0cd8a263df255937c2954025f1dea0cbb"} build_url:https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/TNgXiOGaQMifhBsCHTBhyA/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/sha512/1c878b97b6573cf6bd36aa8d627533965a534580b94350a7275f7ce04e469712ec7935a95fbc212ceedbb565ef78e8ae8d2edf19660c04869e6b6dc131643eb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f6d030112a3a95973a54283906487feb8e372649044f6cb35ee93e219c2e895aad06090ac5d4b50dc3e80d7cf3db342939b5cee73547bad8b6fb16592eb42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65b6fcc4e2b21ca1fd0ec4124208a0cd870d7cdd7f55ad7ee0778112eab0bfedbacbe1bb63664ddbe6095c0ed7d632d0cd8a263df255937c2954025f1dea0cbb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 23:38:30.227625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:38:30.227956) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464240797.763278-1778353770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:38:30.311493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 23:38:30.311827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 23:38:30.312109) ========= ========= Total master_lag: 0.18 =========