builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1463172225.36 results: success (0) buildid: 20160513083005 builduid: 3a1d029a01394de4af1822c362c79d96 revision: c7942b0606ada54b06f6c241e1431e9c677a443f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.357369) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.358016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.358389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.375315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.375664) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 13:43:45-- 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.9M=0s 2016-05-13 13:43:45 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.514917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.515245) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017115 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:45.564525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 13:43:45.564896) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c7942b0606ada54b06f6c241e1431e9c677a443f --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 c7942b0606ada54b06f6c241e1431e9c677a443f --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=97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 13:43:45,919 truncating revision to first 12 chars 2016-05-13 13:43:45,919 Setting DEBUG logging. 2016-05-13 13:43:45,919 attempt 1/10 2016-05-13 13:43:45,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c7942b0606ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 13:43:47,172 unpacking tar archive at: fx-team-c7942b0606ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.541258 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 13:43:47.123374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:47.124218) ========= script_repo_revision: c7942b0606ada54b06f6c241e1431e9c677a443f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:47.125196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:47.126305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 13:43:47.136509) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-05-13 13:43:47.136851) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:43:47 INFO - MultiFileLogger online at 20160513 13:43:47 in /builds/slave/test 13:43:47 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 13:43:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:47 INFO - {'append_to_log': False, 13:43:47 INFO - 'base_work_dir': '/builds/slave/test', 13:43:47 INFO - 'blob_upload_branch': 'Fx-Team', 13:43:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:47 INFO - 'branch': 'Fx-Team', 13:43:47 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:47 INFO - 'config_files': ('talos/linux_config.py',), 13:43:47 INFO - 'default_actions': ('clobber', 13:43:47 INFO - 'read-buildbot-config', 13:43:47 INFO - 'download-and-extract', 13:43:47 INFO - 'populate-webroot', 13:43:47 INFO - 'create-virtualenv', 13:43:47 INFO - 'install', 13:43:47 INFO - 'run-tests'), 13:43:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:47 INFO - 'download_minidump_stackwalk': True, 13:43:47 INFO - 'download_symbols': 'ondemand', 13:43:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:47 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:47 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:47 INFO - 'installer_path': 'installer.exe', 13:43:47 INFO - 'log_level': 'info', 13:43:47 INFO - 'log_name': 'talos', 13:43:47 INFO - 'log_to_console': True, 13:43:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:43:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:43:47 INFO - 'opt_config_files': (), 13:43:47 INFO - 'pip_index': False, 13:43:47 INFO - 'sps_profile': False, 13:43:47 INFO - 'sps_profile_interval': 0, 13:43:47 INFO - 'suite': 'dromaeojs-e10s', 13:43:47 INFO - 'system_bits': '32', 13:43:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:47 INFO - 'title': 'talos-linux64-ix-068', 13:43:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:47 INFO - 'use_talos_json': True, 13:43:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:47 INFO - 'work_dir': 'build'} 13:43:47 INFO - ##### 13:43:47 INFO - ##### Running clobber step. 13:43:47 INFO - ##### 13:43:47 INFO - Running pre-action listener: _resource_record_pre_action 13:43:47 INFO - Running main action method: clobber 13:43:47 INFO - rmtree: /builds/slave/test/build 13:43:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:48 INFO - Running post-action listener: _resource_record_post_action 13:43:48 INFO - ##### 13:43:48 INFO - ##### Finished clobber step (success) 13:43:48 INFO - ##### 13:43:48 INFO - ##### 13:43:48 INFO - ##### Running read-buildbot-config step. 13:43:48 INFO - ##### 13:43:48 INFO - Running pre-action listener: _resource_record_pre_action 13:43:48 INFO - Running main action method: read_buildbot_config 13:43:48 INFO - Using buildbot properties: 13:43:48 INFO - { 13:43:48 INFO - "project": "", 13:43:48 INFO - "product": "firefox", 13:43:48 INFO - "script_repo_revision": "production", 13:43:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:43:48 INFO - "repository": "", 13:43:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 13:43:48 INFO - "buildid": "20160513083005", 13:43:48 INFO - "pgo_build": "True", 13:43:48 INFO - "basedir": "/builds/slave/test", 13:43:48 INFO - "buildnumber": 737, 13:43:48 INFO - "slavename": "talos-linux64-ix-068", 13:43:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:43:48 INFO - "platform": "ubuntu64_hw", 13:43:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:43:48 INFO - "branch": "fx-team", 13:43:48 INFO - "repo_path": "integration/fx-team", 13:43:48 INFO - "revision": "c7942b0606ada54b06f6c241e1431e9c677a443f", 13:43:48 INFO - "stage_platform": "linux64-pgo", 13:43:48 INFO - "builduid": "3a1d029a01394de4af1822c362c79d96", 13:43:48 INFO - "slavebuilddir": "test" 13:43:48 INFO - } 13:43:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:43:48 INFO - Running post-action listener: _resource_record_post_action 13:43:48 INFO - ##### 13:43:48 INFO - ##### Finished read-buildbot-config step (success) 13:43:48 INFO - ##### 13:43:48 INFO - ##### 13:43:48 INFO - ##### Running download-and-extract step. 13:43:48 INFO - ##### 13:43:48 INFO - Running pre-action listener: _resource_record_pre_action 13:43:48 INFO - Running main action method: download_and_extract 13:43:48 INFO - mkdir: /builds/slave/test/build/tests 13:43:48 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')]} 13:43:48 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:49 INFO - Downloaded 1361 bytes. 13:43:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:43:49 INFO - Using the following test package requirements: 13:43:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:43:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'jsshell-linux-x86_64.zip'], 13:43:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:43:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:43:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:49 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:50 INFO - Downloaded 23910111 bytes. 13:43:50 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'] 13:43:50 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 13:43:52 INFO - Return code: 0 13:43:52 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 13:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:52 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:53 INFO - Downloaded 23910111 bytes. 13:43:53 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'] 13:43:53 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 13:43:55 INFO - Return code: 0 13:43: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')]} 13:43:55 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:43:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:56 INFO - Downloaded 10840239 bytes. 13:43:56 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'] 13:43:56 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 13:43:56 INFO - Return code: 0 13:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:56 INFO - https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aOQWTm0KStu7wQBsD1wcXA/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 13:43:57 INFO - Downloaded 58400368 bytes. 13:43:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:57 INFO - mkdir: /builds/slave/test/properties 13:43:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:57 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:57 INFO - Contents: 13:43:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:43:58 INFO - Running post-action listener: _resource_record_post_action 13:43:58 INFO - Running post-action listener: set_extra_try_arguments 13:43:58 INFO - ##### 13:43:58 INFO - ##### Finished download-and-extract step (success) 13:43:58 INFO - ##### 13:43:58 INFO - ##### 13:43:58 INFO - ##### Running populate-webroot step. 13:43:58 INFO - ##### 13:43:58 INFO - Running pre-action listener: _resource_record_pre_action 13:43:58 INFO - Running main action method: populate_webroot 13:43:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:58 INFO - '--tppagecycles', 13:43:58 INFO - '7'], 13:43:58 INFO - 'tests': ['tsvgm']}}, 13:43:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:43:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:43:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:43:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['damp', 'tps']}, 13:43:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'tests': ['damp', 'tps']}, 13:43:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['dromaeo_dom']}, 13:43:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['a11yr', 13:43:58 INFO - 'ts_paint', 13:43:58 INFO - 'tpaint', 13:43:58 INFO - 'sessionrestore', 13:43:58 INFO - 'sessionrestore_no_auto_restore', 13:43:58 INFO - 'tabpaint']}, 13:43:58 INFO - 'other-e10s': {'tests': ['a11yr', 13:43:58 INFO - 'ts_paint', 13:43:58 INFO - 'tpaint', 13:43:58 INFO - 'sessionrestore', 13:43:58 INFO - 'sessionrestore_no_auto_restore', 13:43:58 INFO - 'tabpaint']}, 13:43:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:43:58 INFO - 'ts_paint', 13:43:58 INFO - 'tpaint', 13:43:58 INFO - 'sessionrestore', 13:43:58 INFO - 'sessionrestore_no_auto_restore', 13:43:58 INFO - 'tabpaint']}, 13:43:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:43:58 INFO - 'ts_paint', 13:43:58 INFO - 'tpaint', 13:43:58 INFO - 'sessionrestore', 13:43:58 INFO - 'sessionrestore_no_auto_restore', 13:43:58 INFO - 'tabpaint']}, 13:43:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['a11yr', 13:43:58 INFO - 'ts_paint', 13:43:58 INFO - 'tpaint', 13:43:58 INFO - 'sessionrestore', 13:43:58 INFO - 'sessionrestore_no_auto_restore', 13:43:58 INFO - 'tabpaint']}, 13:43:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['a11yr', 13:43:58 INFO - 'ts_paint', 13:43:58 INFO - 'tpaint', 13:43:58 INFO - 'sessionrestore', 13:43:58 INFO - 'sessionrestore_no_auto_restore', 13:43:58 INFO - 'tabpaint']}, 13:43:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['tsvgx', 13:43:58 INFO - 'tsvgr_opacity', 13:43:58 INFO - 'tart', 13:43:58 INFO - 'tscrollx', 13:43:58 INFO - 'cart']}, 13:43:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:43:58 INFO - 'tsvgr_opacity', 13:43:58 INFO - 'tart', 13:43:58 INFO - 'tscrollx', 13:43:58 INFO - 'cart']}, 13:43:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'talos_options': ['--disable-e10s'], 13:43:58 INFO - 'tests': ['tp5o']}, 13:43:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'tests': ['tp5o']}, 13:43:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'talos_options': ['--disable-e10s', 13:43:58 INFO - '--xperf_path', 13:43:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:58 INFO - 'tests': ['tp5n']}, 13:43:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:58 INFO - 'talos_options': ['--xperf_path', 13:43:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:58 INFO - 'tests': ['tp5n']}}, 13:43:58 INFO - 'talos.zip': {'path': '', 13:43:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:58 INFO - Running post-action listener: _resource_record_post_action 13:43:58 INFO - ##### 13:43:58 INFO - ##### Finished populate-webroot step (success) 13:43:58 INFO - ##### 13:43:58 INFO - ##### 13:43:58 INFO - ##### Running create-virtualenv step. 13:43:58 INFO - ##### 13:43:58 INFO - Running pre-action listener: _resource_record_pre_action 13:43:58 INFO - Running main action method: create_virtualenv 13:43:58 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:58 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 13:43:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:58 INFO - Using real prefix '/usr' 13:43:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:44:00 INFO - Installing pip.................done. 13:44:00 INFO - Return code: 0 13:44:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:44:00 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')]} 13:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:00 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')]} 13:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:00 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:00 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 13:44:00 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 13:44:00 INFO - Using env: {'DISPLAY': ':0', 13:44:00 INFO - 'HOME': '/home/cltbld', 13:44:00 INFO - 'LANG': 'en_US.UTF-8', 13:44:00 INFO - 'LANGUAGE': 'en_US:en', 13:44:00 INFO - 'LOGNAME': 'cltbld', 13:44:00 INFO - 'MAIL': '/var/mail/cltbld', 13:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:00 INFO - 'MOZ_NO_REMOTE': '1', 13:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:00 INFO - 'NO_EM_RESTART': '1', 13:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:00 INFO - 'PWD': '/builds/slave/test', 13:44:00 INFO - 'SHELL': '/bin/bash', 13:44:00 INFO - 'SHLVL': '1', 13:44:00 INFO - 'TERM': 'linux', 13:44:00 INFO - 'TMOUT': '86400', 13:44:00 INFO - 'USER': 'cltbld', 13:44:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:00 INFO - '_': '/tools/buildbot/bin/python'} 13:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:01 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 13:44:01 INFO - Cleaning up... 13:44:01 INFO - Return code: 0 13:44:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:44:01 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')]} 13:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:01 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')]} 13:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:01 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:01 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 13:44:01 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 13:44:01 INFO - Using env: {'DISPLAY': ':0', 13:44:01 INFO - 'HOME': '/home/cltbld', 13:44:01 INFO - 'LANG': 'en_US.UTF-8', 13:44:01 INFO - 'LANGUAGE': 'en_US:en', 13:44:01 INFO - 'LOGNAME': 'cltbld', 13:44:01 INFO - 'MAIL': '/var/mail/cltbld', 13:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:01 INFO - 'MOZ_NO_REMOTE': '1', 13:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:01 INFO - 'NO_EM_RESTART': '1', 13:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:01 INFO - 'PWD': '/builds/slave/test', 13:44:01 INFO - 'SHELL': '/bin/bash', 13:44:01 INFO - 'SHLVL': '1', 13:44:01 INFO - 'TERM': 'linux', 13:44:01 INFO - 'TMOUT': '86400', 13:44:01 INFO - 'USER': 'cltbld', 13:44:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:01 INFO - '_': '/tools/buildbot/bin/python'} 13:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:01 INFO - Downloading/unpacking psutil>=3.1.1 13:44:01 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 13:44:01 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 13:44:01 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 13:44:01 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 13:44:01 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 13:44:01 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 13:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:03 INFO - Installing collected packages: psutil 13:44:03 INFO - Running setup.py install for psutil 13:44:03 INFO - building 'psutil._psutil_linux' extension 13:44:03 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 13:44:03 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 13:44:03 INFO - building 'psutil._psutil_posix' extension 13:44:03 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 13:44:03 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 13:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:44:03 INFO - Successfully installed psutil 13:44:03 INFO - Cleaning up... 13:44:03 INFO - Return code: 0 13:44:03 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 13:44:03 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')]} 13:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:03 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')]} 13:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:03 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:03 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.1'] in /builds/slave/test/build 13:44:03 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.1 13:44:03 INFO - Using env: {'DISPLAY': ':0', 13:44:03 INFO - 'HOME': '/home/cltbld', 13:44:03 INFO - 'LANG': 'en_US.UTF-8', 13:44:03 INFO - 'LANGUAGE': 'en_US:en', 13:44:03 INFO - 'LOGNAME': 'cltbld', 13:44:03 INFO - 'MAIL': '/var/mail/cltbld', 13:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:03 INFO - 'MOZ_NO_REMOTE': '1', 13:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:03 INFO - 'NO_EM_RESTART': '1', 13:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:03 INFO - 'PWD': '/builds/slave/test', 13:44:03 INFO - 'SHELL': '/bin/bash', 13:44:03 INFO - 'SHLVL': '1', 13:44:03 INFO - 'TERM': 'linux', 13:44:03 INFO - 'TMOUT': '86400', 13:44:03 INFO - 'USER': 'cltbld', 13:44:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:03 INFO - '_': '/tools/buildbot/bin/python'} 13:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:04 INFO - Downloading/unpacking mozsystemmonitor==0.1 13:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:06 INFO - Downloading mozsystemmonitor-0.1.tar.gz 13:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 13:44:06 INFO - Installing collected packages: mozsystemmonitor 13:44:06 INFO - Running setup.py install for mozsystemmonitor 13:44:06 INFO - Successfully installed mozsystemmonitor 13:44:06 INFO - Cleaning up... 13:44:06 INFO - Return code: 0 13:44:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:44:06 INFO - Using env: {'DISPLAY': ':0', 13:44:06 INFO - 'HOME': '/home/cltbld', 13:44:06 INFO - 'LANG': 'en_US.UTF-8', 13:44:06 INFO - 'LANGUAGE': 'en_US:en', 13:44:06 INFO - 'LOGNAME': 'cltbld', 13:44:06 INFO - 'MAIL': '/var/mail/cltbld', 13:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:06 INFO - 'MOZ_NO_REMOTE': '1', 13:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:06 INFO - 'NO_EM_RESTART': '1', 13:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:06 INFO - 'PWD': '/builds/slave/test', 13:44:06 INFO - 'SHELL': '/bin/bash', 13:44:06 INFO - 'SHLVL': '1', 13:44:06 INFO - 'TERM': 'linux', 13:44:06 INFO - 'TMOUT': '86400', 13:44:06 INFO - 'USER': 'cltbld', 13:44:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:06 INFO - '_': '/tools/buildbot/bin/python'} 13:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:06 INFO - Downloading/unpacking blobuploader==1.2.4 13:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:08 INFO - Downloading blobuploader-1.2.4.tar.gz 13:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:44:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:44:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:09 INFO - Downloading docopt-0.6.1.tar.gz 13:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:44:09 INFO - Installing collected packages: blobuploader, requests, docopt 13:44:09 INFO - Running setup.py install for blobuploader 13:44:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:44:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:44:09 INFO - Running setup.py install for requests 13:44:09 INFO - Running setup.py install for docopt 13:44:09 INFO - Successfully installed blobuploader requests docopt 13:44:09 INFO - Cleaning up... 13:44:09 INFO - Return code: 0 13:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:09 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:09 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 13:44:09 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 13:44:09 INFO - Using env: {'DISPLAY': ':0', 13:44:09 INFO - 'HOME': '/home/cltbld', 13:44:09 INFO - 'LANG': 'en_US.UTF-8', 13:44:09 INFO - 'LANGUAGE': 'en_US:en', 13:44:09 INFO - 'LOGNAME': 'cltbld', 13:44:09 INFO - 'MAIL': '/var/mail/cltbld', 13:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:09 INFO - 'MOZ_NO_REMOTE': '1', 13:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:09 INFO - 'NO_EM_RESTART': '1', 13:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:09 INFO - 'PWD': '/builds/slave/test', 13:44:09 INFO - 'SHELL': '/bin/bash', 13:44:09 INFO - 'SHLVL': '1', 13:44:09 INFO - 'TERM': 'linux', 13:44:09 INFO - 'TMOUT': '86400', 13:44:09 INFO - 'USER': 'cltbld', 13:44:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:09 INFO - '_': '/tools/buildbot/bin/python'} 13:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:09 INFO - Running setup.py (path:/tmp/pip-HMMLeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:10 INFO - Running setup.py (path:/tmp/pip-Xfwb5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:10 INFO - Running setup.py (path:/tmp/pip-XARkIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:10 INFO - Running setup.py (path:/tmp/pip-E7EBVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:10 INFO - Running setup.py (path:/tmp/pip-XGINqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:10 INFO - Running setup.py (path:/tmp/pip-b8z5ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:10 INFO - Running setup.py (path:/tmp/pip-fGFWcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:10 INFO - Running setup.py (path:/tmp/pip-ygn8_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:10 INFO - Running setup.py (path:/tmp/pip-YiSs36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:10 INFO - Running setup.py (path:/tmp/pip-9h3CB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:10 INFO - Running setup.py (path:/tmp/pip-fqbVWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:10 INFO - Running setup.py (path:/tmp/pip-gNI1QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:10 INFO - Running setup.py (path:/tmp/pip-gBFuN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:10 INFO - Running setup.py (path:/tmp/pip-5niYWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:10 INFO - Running setup.py (path:/tmp/pip-rNzwu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:11 INFO - Running setup.py (path:/tmp/pip-AwU1_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:11 INFO - Running setup.py (path:/tmp/pip-ryTWJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:44:11 INFO - Running setup.py install for manifestparser 13:44:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Running setup.py install for mozcrash 13:44:11 INFO - Running setup.py install for mozdebug 13:44:11 INFO - Running setup.py install for mozdevice 13:44:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Running setup.py install for mozfile 13:44:11 INFO - Running setup.py install for mozhttpd 13:44:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Running setup.py install for mozinfo 13:44:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Running setup.py install for mozInstall 13:44:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:44:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Running setup.py install for mozleak 13:44:12 INFO - Running setup.py install for mozlog 13:44:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Running setup.py install for moznetwork 13:44:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Running setup.py install for mozprocess 13:44:12 INFO - Running setup.py install for mozprofile 13:44:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Running setup.py install for mozrunner 13:44:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Running setup.py install for mozscreenshot 13:44:12 INFO - Running setup.py install for moztest 13:44:12 INFO - Running setup.py install for mozversion 13:44:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:44:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:44:12 INFO - Cleaning up... 13:44:13 INFO - Return code: 0 13:44:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:13 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:13 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 13:44:13 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 13:44:13 INFO - Using env: {'DISPLAY': ':0', 13:44:13 INFO - 'HOME': '/home/cltbld', 13:44:13 INFO - 'LANG': 'en_US.UTF-8', 13:44:13 INFO - 'LANGUAGE': 'en_US:en', 13:44:13 INFO - 'LOGNAME': 'cltbld', 13:44:13 INFO - 'MAIL': '/var/mail/cltbld', 13:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:13 INFO - 'MOZ_NO_REMOTE': '1', 13:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:13 INFO - 'NO_EM_RESTART': '1', 13:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:13 INFO - 'PWD': '/builds/slave/test', 13:44:13 INFO - 'SHELL': '/bin/bash', 13:44:13 INFO - 'SHLVL': '1', 13:44:13 INFO - 'TERM': 'linux', 13:44:13 INFO - 'TMOUT': '86400', 13:44:13 INFO - 'USER': 'cltbld', 13:44:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:13 INFO - '_': '/tools/buildbot/bin/python'} 13:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:44:13 INFO - Running setup.py (path:/tmp/pip-doBk8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:44:13 INFO - Running setup.py (path:/tmp/pip-54KlWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:44:13 INFO - Running setup.py (path:/tmp/pip-hEOeO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:44:13 INFO - Running setup.py (path:/tmp/pip-J_JYuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:44:13 INFO - Running setup.py (path:/tmp/pip-yCxzJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:44:13 INFO - Running setup.py (path:/tmp/pip-eSJFtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:44:13 INFO - Running setup.py (path:/tmp/pip-kIftlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:44:13 INFO - Running setup.py (path:/tmp/pip-tpWWXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:44:13 INFO - Running setup.py (path:/tmp/pip-WxPwGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:44:13 INFO - Running setup.py (path:/tmp/pip-69caVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:44:13 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)) 13:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:44:13 INFO - Running setup.py (path:/tmp/pip-7vx8rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:44:14 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)) 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:44:14 INFO - Running setup.py (path:/tmp/pip-O1Dsxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:44:14 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)) 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:44:14 INFO - Running setup.py (path:/tmp/pip-QZcmx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:44:14 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)) 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:44:14 INFO - Running setup.py (path:/tmp/pip-cbzhIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:44:14 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)) 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:14 INFO - Running setup.py (path:/tmp/pip-OnRQ1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:44:14 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)) 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:44:14 INFO - Running setup.py (path:/tmp/pip-X5Loor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:44:14 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)) 13:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:44:14 INFO - Running setup.py (path:/tmp/pip-GNe57I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:44:14 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)) 13:44:14 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)) 13:44:14 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)) 13:44:14 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)) 13:44:14 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)) 13:44:14 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)) 13:44:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:16 INFO - Downloading blessings-1.6.tar.gz 13:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:44:16 INFO - Installing collected packages: blessings 13:44:16 INFO - Running setup.py install for blessings 13:44:16 INFO - Successfully installed blessings 13:44:16 INFO - Cleaning up... 13:44:16 INFO - Return code: 0 13:44:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:16 INFO - Reading from file tmpfile_stdout 13:44:16 INFO - Current package versions: 13:44:16 INFO - argparse == 1.2.1 13:44:16 INFO - blessings == 1.6 13:44:16 INFO - blobuploader == 1.2.4 13:44:16 INFO - docopt == 0.6.1 13:44:16 INFO - manifestparser == 1.1 13:44:16 INFO - mozInstall == 1.12 13:44:16 INFO - mozcrash == 0.17 13:44:16 INFO - mozdebug == 0.1 13:44:16 INFO - mozdevice == 0.48 13:44:16 INFO - mozfile == 1.2 13:44:16 INFO - mozhttpd == 0.7 13:44:16 INFO - mozinfo == 0.9 13:44:16 INFO - mozleak == 0.1 13:44:16 INFO - mozlog == 3.2 13:44:16 INFO - moznetwork == 0.27 13:44:16 INFO - mozprocess == 0.22 13:44:16 INFO - mozprofile == 0.28 13:44:16 INFO - mozrunner == 6.11 13:44:16 INFO - mozscreenshot == 0.1 13:44:16 INFO - mozsystemmonitor == 0.1 13:44:16 INFO - moztest == 0.7 13:44:16 INFO - mozversion == 1.4 13:44:16 INFO - psutil == 3.1.1 13:44:16 INFO - requests == 1.2.3 13:44:16 INFO - wsgiref == 0.1.2 13:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:44:16 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')]} 13:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:16 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')]} 13:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:16 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:16 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 13:44:16 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 13:44:16 INFO - Using env: {'DISPLAY': ':0', 13:44:16 INFO - 'HOME': '/home/cltbld', 13:44:16 INFO - 'LANG': 'en_US.UTF-8', 13:44:16 INFO - 'LANGUAGE': 'en_US:en', 13:44:16 INFO - 'LOGNAME': 'cltbld', 13:44:16 INFO - 'MAIL': '/var/mail/cltbld', 13:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:16 INFO - 'MOZ_NO_REMOTE': '1', 13:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:16 INFO - 'NO_EM_RESTART': '1', 13:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:16 INFO - 'PWD': '/builds/slave/test', 13:44:16 INFO - 'SHELL': '/bin/bash', 13:44:16 INFO - 'SHLVL': '1', 13:44:16 INFO - 'TERM': 'linux', 13:44:16 INFO - 'TMOUT': '86400', 13:44:16 INFO - 'USER': 'cltbld', 13:44:16 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:16 INFO - '_': '/tools/buildbot/bin/python'} 13:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 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)) 13:44:17 INFO - Cleaning up... 13:44:17 INFO - Return code: 0 13:44:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:44: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')]} 13:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44: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')]} 13:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:17 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:17 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 13:44:17 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 13:44:17 INFO - Using env: {'DISPLAY': ':0', 13:44:17 INFO - 'HOME': '/home/cltbld', 13:44:17 INFO - 'LANG': 'en_US.UTF-8', 13:44:17 INFO - 'LANGUAGE': 'en_US:en', 13:44:17 INFO - 'LOGNAME': 'cltbld', 13:44:17 INFO - 'MAIL': '/var/mail/cltbld', 13:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:17 INFO - 'MOZ_NO_REMOTE': '1', 13:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:17 INFO - 'NO_EM_RESTART': '1', 13:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:17 INFO - 'PWD': '/builds/slave/test', 13:44:17 INFO - 'SHELL': '/bin/bash', 13:44:17 INFO - 'SHLVL': '1', 13:44:17 INFO - 'TERM': 'linux', 13:44:17 INFO - 'TMOUT': '86400', 13:44:17 INFO - 'USER': 'cltbld', 13:44:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:17 INFO - '_': '/tools/buildbot/bin/python'} 13:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:17 INFO - Downloading/unpacking jsonschema 13:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:44:19 INFO - Downloading/unpacking functools32 (from jsonschema) 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 INFO - Downloading functools32-3.2.3-2.tar.gz 13:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:44:19 INFO - warning: no files found matching '*.txt' 13:44:19 INFO - no previously-included directories found matching 'build' 13:44:19 INFO - no previously-included directories found matching 'dist' 13:44:19 INFO - no previously-included directories found matching '.git*' 13:44:19 INFO - Installing collected packages: jsonschema, functools32 13:44:19 INFO - Running setup.py install for functools32 13:44:19 INFO - warning: no files found matching '*.txt' 13:44:19 INFO - no previously-included directories found matching 'build' 13:44:19 INFO - no previously-included directories found matching 'dist' 13:44:19 INFO - no previously-included directories found matching '.git*' 13:44:19 INFO - Successfully installed jsonschema functools32 13:44:19 INFO - Cleaning up... 13:44:19 INFO - Return code: 0 13:44:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:44:19 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')]} 13:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:19 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')]} 13:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:44:19 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 0x7fade5c85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, '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': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', '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 13:44:19 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 13:44:19 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 13:44:19 INFO - Using env: {'DISPLAY': ':0', 13:44:19 INFO - 'HOME': '/home/cltbld', 13:44:19 INFO - 'LANG': 'en_US.UTF-8', 13:44:19 INFO - 'LANGUAGE': 'en_US:en', 13:44:19 INFO - 'LOGNAME': 'cltbld', 13:44:19 INFO - 'MAIL': '/var/mail/cltbld', 13:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:19 INFO - 'MOZ_NO_REMOTE': '1', 13:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:19 INFO - 'NO_EM_RESTART': '1', 13:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:19 INFO - 'PWD': '/builds/slave/test', 13:44:19 INFO - 'SHELL': '/bin/bash', 13:44:19 INFO - 'SHLVL': '1', 13:44:19 INFO - 'TERM': 'linux', 13:44:19 INFO - 'TMOUT': '86400', 13:44:19 INFO - 'USER': 'cltbld', 13:44:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:19 INFO - '_': '/tools/buildbot/bin/python'} 13:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:44:19 INFO - Downloading/unpacking flake8 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:19 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 13:44:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:44:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:44:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:44:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44: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 13:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:44:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:22 INFO - no previously-included directories found matching 'docs/_build' 13:44:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:44:22 INFO - Running setup.py install for pep8 13:44:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:44:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:44:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:44:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:44:22 INFO - no previously-included directories found matching 'docs/_build' 13:44:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:44:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:44:22 INFO - Cleaning up... 13:44:22 INFO - Return code: 0 13:44:22 INFO - Running post-action listener: _resource_record_post_action 13:44:22 INFO - Running post-action listener: _start_resource_monitoring 13:44:22 INFO - Starting resource monitoring. 13:44:22 INFO - ##### 13:44:22 INFO - ##### Finished create-virtualenv step (success) 13:44:22 INFO - ##### 13:44:22 INFO - ##### 13:44:22 INFO - ##### Running install step. 13:44:22 INFO - ##### 13:44:22 INFO - Running pre-action listener: _resource_record_pre_action 13:44:22 INFO - Running main action method: install 13:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:22 INFO - Reading from file tmpfile_stdout 13:44:22 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:44:23 INFO - Reading from file tmpfile_stdout 13:44:23 INFO - Output received: 13:44:23 INFO - Usage: mozinstall [options] installer 13:44:23 INFO - Options: 13:44:23 INFO - -h, --help show this help message and exit 13:44:23 INFO - -d DEST, --destination=DEST 13:44:23 INFO - Directory to install application into. [default: 13:44:23 INFO - "/builds/slave/test"] 13:44:23 INFO - --app=APP Application being installed. [default: firefox] 13:44:23 INFO - mkdir: /builds/slave/test/build/application 13:44:23 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'] 13:44:23 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 13:44:39 INFO - Reading from file tmpfile_stdout 13:44:39 INFO - Output received: 13:44:39 INFO - /builds/slave/test/build/application/firefox/firefox 13:44:39 INFO - Running post-action listener: _resource_record_post_action 13:44:39 INFO - ##### 13:44:39 INFO - ##### Finished install step (success) 13:44:39 INFO - ##### 13:44:39 INFO - ##### 13:44:39 INFO - ##### Running run-tests step. 13:44:39 INFO - ##### 13:44:39 INFO - Running pre-action listener: _resource_record_pre_action 13:44:39 INFO - Running main action method: run_tests 13:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:44:39 INFO - Python 2.7.3 13:44:39 INFO - Return code: 0 13:44:39 INFO - grabbing minidump binary from tooltool 13:44:39 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')]} 13:44:39 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 0x282c9c0>, '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 0x282d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:44:39 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 13:44:39 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 13:44:39 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 13:44:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:44:39 INFO - Return code: 0 13:44:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:44:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:44:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:44:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:44:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:44:40 INFO - Return code: 0 13:44:40 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/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 13:44:40 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/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 13:44:40 INFO - Using env: {'DISPLAY': ':0', 13:44:40 INFO - 'HOME': '/home/cltbld', 13:44:40 INFO - 'LANG': 'en_US.UTF-8', 13:44:40 INFO - 'LANGUAGE': 'en_US:en', 13:44:40 INFO - 'LOGNAME': 'cltbld', 13:44:40 INFO - 'MAIL': '/var/mail/cltbld', 13:44:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:44:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:40 INFO - 'MOZ_NO_REMOTE': '1', 13:44:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:40 INFO - 'NO_EM_RESTART': '1', 13:44:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:40 INFO - 'PWD': '/builds/slave/test', 13:44:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:44:40 INFO - 'SHELL': '/bin/bash', 13:44:40 INFO - 'SHLVL': '1', 13:44:40 INFO - 'TERM': 'linux', 13:44:40 INFO - 'TMOUT': '86400', 13:44:40 INFO - 'USER': 'cltbld', 13:44:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294', 13:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:40 INFO - '_': '/tools/buildbot/bin/python'} 13:44:40 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/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 13:44:40 INFO - mozversion application_buildid: 20160513083005 13:44:40 INFO - mozversion application_changeset: c7942b0606ada54b06f6c241e1431e9c677a443f 13:44:40 INFO - mozversion application_display_name: Nightly 13:44:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:44:40 INFO - mozversion application_name: Firefox 13:44:40 INFO - mozversion application_remotingname: firefox 13:44:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:44:40 INFO - mozversion application_vendor: Mozilla 13:44:40 INFO - mozversion application_version: 49.0a1 13:44:40 INFO - mozversion platform_buildid: 20160513083005 13:44:40 INFO - mozversion platform_changeset: c7942b0606ada54b06f6c241e1431e9c677a443f 13:44:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:44:40 INFO - mozversion platform_version: 49.0a1 13:44:40 INFO - using testdate: 1463172280 13:44:40 INFO - actual date: 1463172280 13:44:40 INFO - starting webserver on 'localhost:58857' 13:44:40 INFO - SUITE-START | Running 2 tests 13:44:40 INFO - TEST-START | dromaeo_css 13:44:40 INFO - operating with platform_type : linux_ 13:44:40 INFO - Initialising browser for dromaeo_css test... 13:44:40 INFO - TEST-INFO | started process 7301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjX3hUY/profile http://localhost:58857/getInfo.html) 13:44:44 INFO - PROCESS | 7301 | 13:44:44 INFO - PROCESS | 7301 | (process:7370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:44:45 INFO - PROCESS | 7301 | __metrics Screen width/height:1600/1200 13:44:45 INFO - PROCESS | 7301 | colorDepth:24 13:44:45 INFO - PROCESS | 7301 | Browser inner width/height: 1024/697 13:44:45 INFO - PROCESS | 7301 | __metrics 13:44:46 ERROR - PROCESS | 7301 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 13:44:47 INFO - TEST-INFO | 7301: exit 0 13:44:47 INFO - Browser initialized. 13:44:47 INFO - Running cycle 1/1 for dromaeo_css test... 13:44:47 INFO - TEST-INFO | started process 7421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjX3hUY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:44:49 INFO - PROCESS | 7421 | 13:44:49 INFO - PROCESS | 7421 | (process:7481): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:44:59 INFO - PROCESS | 7421 | RSS: Main: 163803136 13:44:59 INFO - PROCESS | 7421 | 13:45:48 INFO - PROCESS | 7421 | 1463172348792 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] 13:47:56 INFO - PROCESS | 7421 | Cycle 1(1): loaded http://localhost:58857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58857/tests/dromaeo/cssquery-ext.html) 13:47:57 INFO - PROCESS | 7421 | RSS: Main: 167583744 13:47:57 INFO - PROCESS | 7421 | 13:50:59 INFO - PROCESS | 7421 | Cycle 1(1): loaded http://localhost:58857/tests/dromaeo/cssquery-ext.html (next: http://localhost:58857/tests/dromaeo/cssquery-jquery.html) 13:51:00 INFO - PROCESS | 7421 | RSS: Main: 166670336 13:51:00 INFO - PROCESS | 7421 | 13:54:01 INFO - PROCESS | 7421 | Cycle 1(1): loaded http://localhost:58857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58857/tests/dromaeo/cssquery-mootools.html) 13:54:02 INFO - PROCESS | 7421 | RSS: Main: 167899136 13:54:02 INFO - PROCESS | 7421 | 13:57:04 INFO - PROCESS | 7421 | Cycle 1(1): loaded http://localhost:58857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58857/tests/dromaeo/cssquery-prototype.html) 13:57:04 INFO - PROCESS | 7421 | RSS: Main: 165539840 13:57:04 INFO - PROCESS | 7421 | 14:00:07 INFO - PROCESS | 7421 | Cycle 1(1): loaded http://localhost:58857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58857/tests/dromaeo/cssquery-yui.html) 14:00:07 INFO - PROCESS | 7421 | RSS: Main: 166756352 14:00:07 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | Cycle 1(1): loaded http://localhost:58857/tests/dromaeo/cssquery-yui.html (next: http://localhost:58857/tests/dromaeo/cssquery-dojo.html) 14:03:10 INFO - PROCESS | 7421 | RSS: Main: 168611840 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | __start_tp_report 14:03:10 INFO - PROCESS | 7421 | _x_x_mozilla_page_load 14:03:10 INFO - PROCESS | 7421 | _x_x_mozilla_page_load_details 14:03:10 INFO - PROCESS | 7421 | |i|pagename|runs| 14:03:10 INFO - PROCESS | 7421 | |0;dojo.html;3126.062181345596;3156.068959656901;3170.064830874892;3181.9840900795493;3191.601049868768;5414.296141501604;5422.810201642943;5469.425710300416;5503.394626591082;5556.083246264372;5367.1680889462195;5417.079096553585;5469.07025805613;5486.890262194754;5489.752961116749;4915.533024362689;4955.4548999610015;5046.243063540462;5060.190369540875;5116.846494605149;830.9665228337207;5026.120428924942;5036.4208116066575;5067.822626208083;5088.211327244283;4979.950200497985;4998.325226094467;5007;5014.498550144975;5039.823606173784;4887.291342755316;5009.148444764399;5011.348524691767;5019.372578427697;5076.086304465195;4904.264360345941;4911.386076740408;4912.533309335643;4913.336699545552;4930.605551555867;5269.86825329366;5376.704281264529;5391.946080539184;5396.055690254229;5400.432954539756;5674.546036317085;5739.885202295973;5840.415958404125;5866.1494083357675;5913.526917846605;5796.217510636052;5836.182934389147;5837.241158649391;5845.7369418376275;5882.764689412418;5393.78424863005;5401.135818269097;5406.91889621656;5413.891722165574;5459.181122831567;5884.0585506318785;5926.4666180044005;6018.458338749533;6036.607620504653;6038.033914573735;5784.074548072288;5805;5806.042003069446;5806.564507661942;5807.361190269067;5907.586468947133;5936;5954.136650185699;5965.105234214902;5990.281166260077;5725.08398656213;5857.7949771757785;5870.882582348329;5924.377940316291;5946.167536544887;5685.971570142123;5810.941890581124;5881.382454842265;5887.705614719247;5935.40645935403;4429.822807087745;4444.822207111744;4454.621357184676;4490.932636010462;4510.954890451054;3877.476540666974;3936.0553467167674;3953.3081710700512;4006;4046.1503084352025;5512.145617429305;5555.111182210827;5559.8888022239325;5561.972190139023;5620.943790562042;5862.794802181903;5899.793507227227;5906.645601263938;5914.704264786744;5935.881282374328;5430.51125398716;5532.2531458253425;5532.5573954083575;5564.972175139098;5590.18942253371;5053.140966035783;5066.721330326794;5067.493250674903;5089.567386772092;5093.465186155475;6102.420270074336;6144.754209831646;6145.446909778141;6159.4456498915315;6160;5774.711264436677;5918.970405147947;5951.583389162717;5968.134620479919;6083.361247068994;6147.974984515111;6151.630902145886;6182.938170618237;6191.721372538336;6192;5851.1223316502865;5862.970685146717;5863.325717542367;5867.383924687846;5867.823965281048;5719.342275638355;5837.29952405714;5901.203337549376;5951.523878089656;5957.880842383215;5684.602077854511;5719.084946408555;5770.163326317745;5777.162311464898;5780.075187969905;5579.051561234681;5801.535877129735;5804.071348584206;5808;5823.912641310469;5483.040467918178;5557.110862262019;5564.4713752193475;5645.40723224072;5693.829185124453;5765.221695071279;5814.476697097281;5835.7373918174635;5856.531477481706;5858.209141765807;5512.035393806148;5674.77300907959;5731.799387021434;5734.5125664319;5736.254286942671 14:03:10 INFO - PROCESS | 7421 | |1;ext.html;577.197695203667;631.6589041917364;646.237439821011;649.1172006071743;651.6643928376884;32043.359132817328;42154.789226053865;42670.57329426705;42839.78580107095;43049.56950430495;43870.780646096806;43935.340969885474;44234.7788261059;44409.333859992046;44560.108797824025;8760.211580957712;8925.866112008325;8936.64253429862;8948.776280592972;8953.507557084358;8771.342149338825;8790.780230494225;8835.734927952171;8868.15752503511;8881.689140880071;8868.246199073054;8901.510416927067;8919.955400223022;8932.687355942544;8940.8658870117;8881.555922203865;8921.15249051339;8933.55332233389;8937.463752174857;8937.46375217489;8884.156005179497;8891.422057566237;8897.110288971116;8899.37704360695;8949.463032218022;41100.1779964402;41101.79449102765;41183.7940810297;41447.792761036304;41450.37824432636;3656.9634303657153;3758.2107757370986;3954.604539546051;4122.196171746511;4280.5719428057255;32368;32543.67456325454;32572.511412328833;32672.183195420068;32711.836440817642;3782.7919464429447;3789.0906182516273;3841.2509560635685;3847.5190601174854;3918.8824335269987;350444;351623;352130;353100;353741;57016.71491642515;57071.71464142653;57297;57719.71140144272;57795.13307300394;37683;37719;38467.6153238464;60684.696576517716;61090.69454652698;17375.652486950443;17616.64766704659;17641.911790441223;17651;17712.380066697602;13172.802407963889;13186.340682966005;13188.670283242996;13216.933915330554;13264.867351326557;19842.404727858186;20019.39941801748;20130.899345503178;20179.899100504404;20189.79810201879;7205.2434494378385;7396.704131834774;7469.365103966224;7510.248975102446;7615.847683046419;1051.7686109055996;1070.721612380771;1075.2473268711776;1096.7497053359177;1112.5994641928899;32050.35899282048;32148.83925580357;32800;32907.50638740421;33026.91239937016;1118.4799068433217;1139.1740987783955;1191.5948577483523;1210.509743553862;1228.2323547782637;16990.74513882268;17157.742633860504;17245.741313880302;17283.395081172097;17374;561846;562287;563046;570519;571452;59882;60045;60082.399176008556;60350.396496034475;60495;1392.2481859795798;1420.8650178233052;1433.1616004637403;1439.417036100381;1445.197915157098;31327.21681957969;31655.683443165275;32072.839635801673;32256.35487290288;32911.50632740559;49921.75039124781;50146.49853501564;50165.24752128648;50209;50384.24423633722;420091;427504;427745;429254;432091;27956.440871182054;28017.579736303564;28338.574921376607;28481.43037139287;28493.145205643865;49283;49796.751016244685;49858.50141498684;50469.74765126151;51173.744131279105;40804.071145458416;41465;42232;43033.354499683155;43129.35305970476;41928.3710744333;42164.78917605515;42667.78666106649;43596.34605480857;43744.34383484314;43293;43813.34279985866;43976.900577485816;44445;44607.33089003603;36898.44652330271;37577.6242237585;38036.619633803304;38127.618723812404;38190.427143592315;29406.41187176202;29737.702622973495;29863.552046718884;30248.395032098793;30344.84827575848 14:03:10 INFO - PROCESS | 7421 | |2;jquery.html;407.8919086442093;410.32706361567034;413.53683874061045;415.4723501153533;420.16177725437757;18161.182746776394;19603.705944410845;19872;19874.801251987494;20404.285849995253;19030.2387904484;19359.709604355947;19783.307584234553;19792.802071979313;19807.306744263955;5600.6079574429805;5893.941060589404;5909.615874968134;5910.822675319747;5910.881782364371;5688.772449102031;5845.85385365365;5883.058710606304;5888.234529511179;5888.263967004124;5786.421357864222;5808.767649294024;5819.272590926134;5824.126381042856;5843.620164689281;5528.834134975958;5778.017736984722;5778.682172480512;5787.710614469281;5866.706664666793;5226.634135610509;5227.973860130713;5237.214417837316;5242.659227150261;5255.737213139328;20230.393088207376;21535.46161345979;21654.566908661895;22711.659325110137;23039.193628222933;2310.4454930816482;2359.7640235976437;2360.1857359211044;2463.5935070713313;2466.987665061681;10177.592896284139;10345.79308413835;10674.786504269949;13574.778269955652;13706;1998.7801341852385;2065.3390914907236;2080.895955202249;2083.0313904034697;2117.5658989907033;64874.16927774566;65129.81266779648;79125.60437197777;80592.59703701503;84886.15113848844;10404.5838166474;10437.373757574569;10446.582136714598;10838.837417438745;10934.890651093547;15527.689446211012;15674.294656740474;15698.76451853223;15748.212589370485;15755.44855930037;8107.391945604103;8473.23740863313;8502.659893604186;8579;8600.612972416257;7894.723684671009;7902.24928631779;7965.920340796518;8082.191780821989;8086.150954149847;4725.787339569728;4791.520847915181;4818.373611430492;4832.34763306949;4871.074495845778;1952.1313015708158;2006;2026.7567891853073;2049.559344740888;2101.810837024675;961.1397798969883;985.142925654685;999.820032394176;1002.7042022603349;1004.638330201127;17924.91037544804;18898;19632.3128690498;19789.010549472758;19901.900490497745;969.9127078562963;992.3549692699803;1042.8122937871103;1060.671191930504;1080.8162612355918;10812;11016.491010539368;11091.667249982513;11128.054115400282;11185.888141118485;484937;486185;486878;489435;497265;60394;80406;80605;98890;99128;1075.634284343327;1085.2999815119204;1098.906592939593;1104.6133853151332;1105.1269497097203;16198.433054843024;16553.25510352013;16831.495055148363;17534.386296479563;18068.277268909624;29824.552631710107;39338.81983540498;41369.79315103405;41372.58627413688;44580.777096115606;57016.14475782784;59600.70199648974;59689.403105968384;60323;60512.394876050676;7316.926830731624;8593.140685931357;8650.178233067849;8718.52048137333;8723.738287851374;13125.868741312846;13642.795358069836;14046.719065618427;14111.929440352733;14276.286185690466;12088.39558022113;12121.15151939391;12328.81506777381;12441.564545240873;12485.438155283216;12124.333161676192;12191.878081219429;12272.693182670148;12474.251544907334;12515.56195533152;5935.109733539831;8733.563321833755;9764.511774411392;11607.142857143155;12463.189892656948;7263.418926485974;7428.777136685908;7452.292032256927;7522.3605993491165;7689.538627682357;9721.513924303898;11320.943395282971;11435.59975400857;11568.479418426023;11581.305121692725 14:03:10 INFO - PROCESS | 7421 | |3;mootools.html;1517.1428143099145;1568.537281501957;1756.4818378578318;1855;1856.2853301478926;7681.846363072736;8342.624581893822;8633.050364459905;8987.955060224698;9019.684311049123;8646.394752367321;8672.566371681407;8724.302055835533;8733.606987685553;8778;2322.3613506285824;2346.460314127743;2347.2606129069372;2348.3542025942916;2349.107339211106;2285.0517035430275;2290.610596198642;2298.2071185440996;2310.1452462588863;2314.5255222679393;2296.3799774060994;2301.436148143707;2318.8260880434036;2326.3486223857262;2342.121704360865;2248.7751224877543;2262.671912572684;2320.883955802203;2323.2101085630884;2323.3843031596557;2238.6082435573708;2256.435891027243;2275.0444813178337;2284.6001949658744;2286.371247906822;8533.658653653909;8552.486850788973;8626.568671566396;8631.309495240366;8634.179752923463;5130.48695130484;5199.402068762065;5253.921191182136;5262.23697563855;5268.104422248227;3310.2717402171484;3400.2179498715436;3423.4864770284407;3542.3977923753023;3551.5383000210068;1089.9019088282093;1106.634810512529;1121.3664279682034;1136.4261048170704;1163.2962057954985;12093.637190884288;12120.393980301038;12123.515059397614;12128.757424851454;12169.513219471211;4591.540845915449;4685.672002959828;4726.172919739032;4757.500462451393;4766.951270720436;10279.640212592523;10314.742131446625;10330;10343.689689309333;10355.17158627308;5161.948380516222;5203.7918483261;5282.049231138432;5294.602904782157;5300.893982120336;4328.696991210585;4719.079779442975;4831.130396528588;4868.78090485929;4875.07373599015;3990.082281075369;3997.960020399817;4004.379321205218;4044.1911617676583;4174.248635245624;1235.8022716365338;1250.6123101838277;1252.5803855708439;1264.9304288264234;1271.4278574641448;933.7712260496222;997.1723469520426;1028.8508166315842;1071.8017166824163;1082.4533610526792;5854.121881717776;5976.103584462278;5999.880002399927;6039.78860739872;6216.6270023797815;1015.4313584392763;1049.4385503755454;1051.6266725312405;1055.7518983038979;1065.4033741105006;4131.5248746393945;4169.145325208325;4191.3293872980175;4206.621404073648;4233.216854881856;10794.406307653155;11068.28056176346;11149.554017839358;11153.386563739072;11164.441777911072;10902.18233632465;10939.28894621847;11014.339139651487;11016.339019658846;11021.83467247992;7644.770656880302;7892.4869883457395;7901.920980790233;8088.352931765562;8205.835883282301;5703.942960570341;5829.94170058294;5879.617824841372;5947.821565352873;5993.490553303018;9907.306488545733;9952.10431061208;10025.598976040877;10119.696409107739;10148.695539133838;10148.086672199537;10281.794364112526;10283.07452329264;10413.271071024956;10471.057604815604;6981.650917454209;7398;7569.697212111454;7617.314441700273;7804.492707973964;8447;8504.192101750325;8551.486910785372;8552.957235213784;8554.144585541397;7502.587357695379;7648.847023059619;7653.885191722017;7750.689972401041;7757.224277572198;7540.736074237376;7687.769366919001;7689.538627682357;7726.266004729542;7749.147593764794;6925.861482770216;7033.050538177486;7061.964690176516;7090.149182098181;7097.112860892388;4994.700317980933;5051.87370315745;5103.10695628271;5167.173252279617;5214.921776173284;5265.131253343308;5274.261603375454;5278.577713782812;5287.68273903567;5311.229871668664 14:03:10 INFO - PROCESS | 7421 | |4;prototype.html;309.1960901655694;316.53153333067075;319.30391745993734;322.83696733149753;325.6613122352754;5263.394709608387;5626.352969408519;5696.544276457884;5703.173039909216;5710.71446427678;5599.584253605308;5604.187392828037;5626.268585083943;5643.520300774439;5710.486056254937;4333.891652708692;4347.673924455678;4379.802908869108;4389.648828093745;4401.05377343871;4319.870403887889;4362.694611377205;4364.694471387004;4381.452318460192;4423.4028406165235;4293.892652683677;4299.462567179103;4338.370936214247;4342.71889792512;4347.913041739163;4368.060866913613;4409.29451287794;4412.933805992912;4420.80106395213;4434.667399945017;3739.345614517476;3859.4017927221325;3905.5703872573995;3905.8828235152705;3928.2732694451333;5421.21392398104;5433.4566543345745;5496.367917689437;5498.5876059295715;5514.145307477347;5040.621953353477;5042.294078828967;5064.29099926007;5084.949150508484;5097.592192624618;5763.538916886681;5916.852078698067;5917.556183286228;6027.758889644409;6043.728032238516;4213.810378532973;4230.513490948519;4234.407182994383;4245.81117287157;4246.681498887565;6175.907361389583;6186.288576813679;6210.782622608187;6244.31312555623;6254.155688981975;4188.916221675549;4280.5291417944;4301.79516260388;4328.718633288826;4354;4269.743815371087;4315.482142142963;4328;4361.171377438277;4384.824607015684;4951.72765497901;4954.95945851368;4982.651214415028;5009.674371165863;5010.423801262828;5552.750126244328;5874.383189765013;5910.645361278337;6004.249468816398;6033.456988870935;1452.7385070687167;1474.9336279867432;1476.350405821435;1482.9777553336708;1498.220925118932;914.3541625074839;922.9478394630127;927.893292271384;935.4901578639658;945.2390825385493;4962.429320628102;5038.874028149326;5101.69389836611;5106.4382917879;5126.436092029874;5490.752916118784;5501.697406642593;5507.972460137754;5512.5589952803675;5536.252605898152;5024.547790698854;5034.320366750515;5143.588512918957;5156.917047420009;5168.18334007959;2857.357094653686;2869.1679412970007;2954.9066845266957;2980.1225228106587;2997.7302042815813;5554.833484968121;5557.6109672323355;5581.944180558224;5588.764494202271;5669;5177.611679124006;5349.046278924325;5473.27591808579;5516.482967183976;5527.50252477279;5536.86157846049;5537.473939975695;5558.527525160326;5568.7215639217875;5595.916061259084;5366.6243362964215;5374.677519348852;5399.136138217867;5424.566034717134;5688.829335119953;6049.243844519435;6079.969600151971;6080.422359875804;6085.1785009023215;6098.627808743175;6119.051547010221;6199;6228.314885362697;6270.4670103039925;6288.465480434214;4220.134872351099;4245.915081698287;4261.850835220753;4278.614924656796;4290.592393722592;6171.783987560593;6200.604863905585;6201.007838745779;6205.565610407228;6232.036908374029;5784.623999440023;5876.44173803488;5912.822615321547;5937.287525496795;6031.276246850406;5887.8233652990475;5922.555808314308;5926.644401335933;5927.496162826035;5931.970340148272;5714.457126572969;5776.9133462998925;5825.650460972355;5848.590598658053;5852.268466441695;5992.850178745566;6001.969990150022;6016;6033.577649564489;6058.182145410489;5832.12518122285;5890.941090589211;5894.791567728691;5905.810862134571;5905.91141132892 14:03:10 INFO - PROCESS | 7421 | |5;yui.html;836.799168199632;869.5217630303332;873.401719821922;883.2713011765293;886.2599729226096;14643.70712585749;15582.688346233097;15611.063336199835;15654.608634784121;15679.529614111567;14393.352299146538;14589.635259118528;14590.854091459083;14654.120752754841;14720.779188312157;852.2627926843298;853.5902766672001;857.6655104509247;862.2067697718084;865.6191275838611;848.1264297773304;851.8637018077109;853.8548446764034;855.9272461840751;857.0486759696731;910.517425764346;912.8174365126968;913.2876356441986;918.3433844800966;919;898.3531857062904;906.8005038891433;907.6233363154316;909.0182602788972;909.6225066597354;660.7588230295955;661.8841702702056;663.0286630086897;663.3101574362657;665.2781731820932;14258.928705356511;14359.78460323096;14374.35315410809;14397.712045759132;14443.133411995314;12603;12659.430325635369;12688.682782930407;12773.872261277362;12958.287294198815;10769.9461502692;10789.46052697362;10876.673699789018;11243.83134252987;11389.601363952223;3852.8651497197466;3897.5322961244833;3973.7417067890497;3985.60143985602;4039.0508230565792;50069.74965125188;53534.46465535334;54888.72555637236;55665.72167139138;57404.71297643485;10772.569097236179;10786.137109031259;11116.833247501294;11732.237404568676;11906.523739050514;19757.40727778169;19969.400917972485;20039.398818035483;20046.198152074045;20184.798152018586;8168.183181681903;8275.08974012858;8275.917240827635;8315.126911674308;8629.22336989674;4806.4712881583;4930.630202734809;5066.417362003343;5096.719680417613;5195.3246078009615;3585.2470981093743;3747.3254814133716;3750.3811871041516;3756.549214094326;3773.981130094332;661.3485716569272;667.0760996020547;669.2704951602776;678.1489231015144;691.3673988300649;686.4405509509734;724.1852915470096;739.3863093632273;748.7828529726427;755.2258934592087;8897.510636915033;8950.104989500998;9036.186743193144;9075.228605568469;9106.544672766335;752.7440670172168;754.5962909843207;765.9693612255559;772.75658167677;782.7221336425487;4347.7173983690955;4386.71486353386;4435.911281774346;4491.169133710274;4492.640588752892;72142.63928680323;72640;74226.6288668564;74920.25079749133;74933.62533187299;65625.67187164034;67041.32958670448;67458;67618;68479.3152068473;49557;56367;60671.089933651034;60995;61356.386436135064;9149.77125571866;9642.951785241028;9768.755781105529;9817.116459518678;9913.851292230478;35312.82343588266;37873;37986;38691.41962870616;38822.80588597039;51090;51560.484395157066;51616.22575661443;52269.7386513065;52977.47022529726;12213.69465763363;12801.93599031999;12858.485660573846;12862.421191046238;12907.806382904451;13612.523561675294;14437.133771973715;14960.700785984001;15144.621384465036;15318.234088295763;13626.182429054288;13733.107348022746;14020.719585608434;14401.78397324062;14461.710765784836;14098.929505352407;14225.573232803032;14333.426662933365;14361.281935903373;15090.24548772535;13558.86441135576;13959.232242226775;14087;14216.857831421554;14725.337359819048;11544.480498377761;11645.126615504041;11815.113866460222;11950.462229199533;12148.271103733805;11519.76960460803;11793.29240245588;12036.939815300868;12043.518259269882;12129.272243665408 14:03:10 INFO - PROCESS | 7421 | __end_tp_report 14:03:10 INFO - PROCESS | 7421 | __start_cc_report 14:03:10 INFO - PROCESS | 7421 | _x_x_mozilla_cycle_collect,334 14:03:10 INFO - PROCESS | 7421 | __end_cc_report 14:03:10 INFO - PROCESS | 7421 | __startTimestamp1463173390407__endTimestamp 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | ------- Summary: start ------- 14:03:10 INFO - PROCESS | 7421 | Number of tests: 6 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | [#0] dojo.html Cycles:165 Average:5430.19 Median:5684.60 stddev:727.68 (12.8%) stddev-sans-first:707.10 14:03:10 INFO - PROCESS | 7421 | Values: 3126.1 3156.1 3170.1 3182.0 3191.6 5414.3 5422.8 5469.4 5503.4 5556.1 5367.2 5417.1 5469.1 5486.9 5489.8 4915.5 4955.5 5046.2 5060.2 5116.8 831.0 5026.1 5036.4 5067.8 5088.2 4980.0 4998.3 5007.0 5014.5 5039.8 4887.3 5009.1 5011.3 5019.4 5076.1 4904.3 4911.4 4912.5 4913.3 4930.6 5269.9 5376.7 5391.9 5396.1 5400.4 5674.5 5739.9 5840.4 5866.1 5913.5 5796.2 5836.2 5837.2 5845.7 5882.8 5393.8 5401.1 5406.9 5413.9 5459.2 5884.1 5926.5 6018.5 6036.6 6038.0 5784.1 5805.0 5806.0 5806.6 5807.4 5907.6 5936.0 5954.1 5965.1 5990.3 5725.1 5857.8 5870.9 5924.4 5946.2 5686.0 5810.9 5881.4 5887.7 5935.4 4429.8 4444.8 4454.6 4490.9 4511.0 3877.5 3936.1 3953.3 4006.0 4046.2 5512.1 5555.1 5559.9 5562.0 5620.9 5862.8 5899.8 5906.6 5914.7 5935.9 5430.5 5532.3 5532.6 5565.0 5590.2 5053.1 5066.7 5067.5 5089.6 5093.5 6102.4 6144.8 6145.4 6159.4 6160.0 5774.7 5919.0 5951.6 5968.1 6083.4 6148.0 6151.6 6182.9 6191.7 6192.0 5851.1 5863.0 5863.3 5867.4 5867.8 5719.3 5837.3 5901.2 5951.5 5957.9 5684.6 5719.1 5770.2 5777.2 5780.1 5579.1 5801.5 5804.1 5808.0 5823.9 5483.0 5557.1 5564.5 5645.4 5693.8 5765.2 5814.5 5835.7 5856.5 5858.2 5512.0 5674.8 5731.8 5734.5 5736.3 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | [#1] ext.html Cycles:180 Average:60849.56 Median:231009.69 stddev:121290.39 (52.5%) stddev-sans-first:121546.22 14:03:10 INFO - PROCESS | 7421 | Values: 577.2 631.7 646.2 649.1 651.7 32043.4 42154.8 42670.6 42839.8 43049.6 43870.8 43935.3 44234.8 44409.3 44560.1 8760.2 8925.9 8936.6 8948.8 8953.5 8771.3 8790.8 8835.7 8868.2 8881.7 8868.2 8901.5 8920.0 8932.7 8940.9 8881.6 8921.2 8933.6 8937.5 8937.5 8884.2 8891.4 8897.1 8899.4 8949.5 41100.2 41101.8 41183.8 41447.8 41450.4 3657.0 3758.2 3954.6 4122.2 4280.6 32368.0 32543.7 32572.5 32672.2 32711.8 3782.8 3789.1 3841.3 3847.5 3918.9 350444.0 351623.0 352130.0 353100.0 353741.0 57016.7 57071.7 57297.0 57719.7 57795.1 37683.0 37719.0 38467.6 60684.7 61090.7 17375.7 17616.6 17641.9 17651.0 17712.4 13172.8 13186.3 13188.7 13216.9 13264.9 19842.4 20019.4 20130.9 20179.9 20189.8 7205.2 7396.7 7469.4 7510.2 7615.8 1051.8 1070.7 1075.2 1096.7 1112.6 32050.4 32148.8 32800.0 32907.5 33026.9 1118.5 1139.2 1191.6 1210.5 1228.2 16990.7 17157.7 17245.7 17283.4 17374.0 561846.0 562287.0 563046.0 570519.0 571452.0 59882.0 60045.0 60082.4 60350.4 60495.0 1392.2 1420.9 1433.2 1439.4 1445.2 31327.2 31655.7 32072.8 32256.4 32911.5 49921.8 50146.5 50165.2 50209.0 50384.2 420091.0 427504.0 427745.0 429254.0 432091.0 27956.4 28017.6 28338.6 28481.4 28493.1 49283.0 49796.8 49858.5 50469.7 51173.7 40804.1 41465.0 42232.0 43033.4 43129.4 41928.4 42164.8 42667.8 43596.3 43744.3 43293.0 43813.3 43976.9 44445.0 44607.3 36898.4 37577.6 38036.6 38127.6 38190.4 29406.4 29737.7 29863.6 30248.4 30344.8 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | [#2] jquery.html Cycles:180 Average:28545.64 Median:16145.77 stddev:80411.68 (498.0%) stddev-sans-first:80609.50 14:03:10 INFO - PROCESS | 7421 | Values: 407.9 410.3 413.5 415.5 420.2 18161.2 19603.7 19872.0 19874.8 20404.3 19030.2 19359.7 19783.3 19792.8 19807.3 5600.6 5893.9 5909.6 5910.8 5910.9 5688.8 5845.9 5883.1 5888.2 5888.3 5786.4 5808.8 5819.3 5824.1 5843.6 5528.8 5778.0 5778.7 5787.7 5866.7 5226.6 5228.0 5237.2 5242.7 5255.7 20230.4 21535.5 21654.6 22711.7 23039.2 2310.4 2359.8 2360.2 2463.6 2467.0 10177.6 10345.8 10674.8 13574.8 13706.0 1998.8 2065.3 2080.9 2083.0 2117.6 64874.2 65129.8 79125.6 80592.6 84886.2 10404.6 10437.4 10446.6 10838.8 10934.9 15527.7 15674.3 15698.8 15748.2 15755.4 8107.4 8473.2 8502.7 8579.0 8600.6 7894.7 7902.2 7965.9 8082.2 8086.2 4725.8 4791.5 4818.4 4832.3 4871.1 1952.1 2006.0 2026.8 2049.6 2101.8 961.1 985.1 999.8 1002.7 1004.6 17924.9 18898.0 19632.3 19789.0 19901.9 969.9 992.4 1042.8 1060.7 1080.8 10812.0 11016.5 11091.7 11128.1 11185.9 484937.0 486185.0 486878.0 489435.0 497265.0 60394.0 80406.0 80605.0 98890.0 99128.0 1075.6 1085.3 1098.9 1104.6 1105.1 16198.4 16553.3 16831.5 17534.4 18068.3 29824.6 39338.8 41369.8 41372.6 44580.8 57016.1 59600.7 59689.4 60323.0 60512.4 7316.9 8593.1 8650.2 8718.5 8723.7 13125.9 13642.8 14046.7 14111.9 14276.3 12088.4 12121.2 12328.8 12441.6 12485.4 12124.3 12191.9 12272.7 12474.3 12515.6 5935.1 8733.6 9764.5 11607.1 12463.2 7263.4 7428.8 7452.3 7522.4 7689.5 9721.5 11320.9 11435.6 11568.5 11581.3 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | [#3] mootools.html Cycles:180 Average:5793.03 Median:4280.96 stddev:3265.79 (76.3%) stddev-sans-first:3259.14 14:03:10 INFO - PROCESS | 7421 | Values: 1517.1 1568.5 1756.5 1855.0 1856.3 7681.8 8342.6 8633.1 8988.0 9019.7 8646.4 8672.6 8724.3 8733.6 8778.0 2322.4 2346.5 2347.3 2348.4 2349.1 2285.1 2290.6 2298.2 2310.1 2314.5 2296.4 2301.4 2318.8 2326.3 2342.1 2248.8 2262.7 2320.9 2323.2 2323.4 2238.6 2256.4 2275.0 2284.6 2286.4 8533.7 8552.5 8626.6 8631.3 8634.2 5130.5 5199.4 5253.9 5262.2 5268.1 3310.3 3400.2 3423.5 3542.4 3551.5 1089.9 1106.6 1121.4 1136.4 1163.3 12093.6 12120.4 12123.5 12128.8 12169.5 4591.5 4685.7 4726.2 4757.5 4767.0 10279.6 10314.7 10330.0 10343.7 10355.2 5161.9 5203.8 5282.0 5294.6 5300.9 4328.7 4719.1 4831.1 4868.8 4875.1 3990.1 3998.0 4004.4 4044.2 4174.2 1235.8 1250.6 1252.6 1264.9 1271.4 933.8 997.2 1028.9 1071.8 1082.5 5854.1 5976.1 5999.9 6039.8 6216.6 1015.4 1049.4 1051.6 1055.8 1065.4 4131.5 4169.1 4191.3 4206.6 4233.2 10794.4 11068.3 11149.6 11153.4 11164.4 10902.2 10939.3 11014.3 11016.3 11021.8 7644.8 7892.5 7901.9 8088.4 8205.8 5703.9 5829.9 5879.6 5947.8 5993.5 9907.3 9952.1 10025.6 10119.7 10148.7 10148.1 10281.8 10283.1 10413.3 10471.1 6981.7 7398.0 7569.7 7617.3 7804.5 8447.0 8504.2 8551.5 8553.0 8554.1 7502.6 7648.8 7653.9 7750.7 7757.2 7540.7 7687.8 7689.5 7726.3 7749.1 6925.9 7033.1 7062.0 7090.1 7097.1 4994.7 5051.9 5103.1 5167.2 5214.9 5265.1 5274.3 5278.6 5287.7 5311.2 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | [#4] prototype.html Cycles:180 Average:4850.77 Median:5493.56 stddev:1429.35 (26.0%) stddev-sans-first:1392.12 14:03:10 INFO - PROCESS | 7421 | Values: 309.2 316.5 319.3 322.8 325.7 5263.4 5626.4 5696.5 5703.2 5710.7 5599.6 5604.2 5626.3 5643.5 5710.5 4333.9 4347.7 4379.8 4389.6 4401.1 4319.9 4362.7 4364.7 4381.5 4423.4 4293.9 4299.5 4338.4 4342.7 4347.9 4368.1 4409.3 4412.9 4420.8 4434.7 3739.3 3859.4 3905.6 3905.9 3928.3 5421.2 5433.5 5496.4 5498.6 5514.1 5040.6 5042.3 5064.3 5084.9 5097.6 5763.5 5916.9 5917.6 6027.8 6043.7 4213.8 4230.5 4234.4 4245.8 4246.7 6175.9 6186.3 6210.8 6244.3 6254.2 4188.9 4280.5 4301.8 4328.7 4354.0 4269.7 4315.5 4328.0 4361.2 4384.8 4951.7 4955.0 4982.7 5009.7 5010.4 5552.8 5874.4 5910.6 6004.2 6033.5 1452.7 1474.9 1476.4 1483.0 1498.2 914.4 922.9 927.9 935.5 945.2 4962.4 5038.9 5101.7 5106.4 5126.4 5490.8 5501.7 5508.0 5512.6 5536.3 5024.5 5034.3 5143.6 5156.9 5168.2 2857.4 2869.2 2954.9 2980.1 2997.7 5554.8 5557.6 5581.9 5588.8 5669.0 5177.6 5349.0 5473.3 5516.5 5527.5 5536.9 5537.5 5558.5 5568.7 5595.9 5366.6 5374.7 5399.1 5424.6 5688.8 6049.2 6080.0 6080.4 6085.2 6098.6 6119.1 6199.0 6228.3 6270.5 6288.5 4220.1 4245.9 4261.9 4278.6 4290.6 6171.8 6200.6 6201.0 6205.6 6232.0 5784.6 5876.4 5912.8 5937.3 6031.3 5887.8 5922.6 5926.6 5927.5 5932.0 5714.5 5776.9 5825.7 5848.6 5852.3 5992.9 6002.0 6016.0 6033.6 6058.2 5832.1 5890.9 5894.8 5905.8 5905.9 14:03:10 INFO - PROCESS | 7421 | 14:03:10 INFO - PROCESS | 7421 | [#5] yui.html Cycles:180 Average:16312.60 Median:4868.55 stddev:19690.32 (404.4%) stddev-sans-first:19711.26 14:03:10 INFO - PROCESS | 7421 | Values: 836.8 869.5 873.4 883.3 886.3 14643.7 15582.7 15611.1 15654.6 15679.5 14393.4 14589.6 14590.9 14654.1 14720.8 852.3 853.6 857.7 862.2 865.6 848.1 851.9 853.9 855.9 857.0 910.5 912.8 913.3 918.3 919.0 898.4 906.8 907.6 909.0 909.6 660.8 661.9 663.0 663.3 665.3 14258.9 14359.8 14374.4 14397.7 14443.1 12603.0 12659.4 12688.7 12773.9 12958.3 10769.9 10789.5 10876.7 11243.8 11389.6 3852.9 3897.5 3973.7 3985.6 4039.1 50069.7 53534.5 54888.7 55665.7 57404.7 10772.6 10786.1 11116.8 11732.2 11906.5 19757.4 19969.4 20039.4 20046.2 20184.8 8168.2 8275.1 8275.9 8315.1 8629.2 4806.5 4930.6 5066.4 5096.7 5195.3 3585.2 3747.3 3750.4 3756.5 3774.0 661.3 667.1 669.3 678.1 691.4 686.4 724.2 739.4 748.8 755.2 8897.5 8950.1 9036.2 9075.2 9106.5 752.7 754.6 766.0 772.8 782.7 4347.7 4386.7 4435.9 4491.2 4492.6 72142.6 72640.0 74226.6 74920.3 74933.6 65625.7 67041.3 67458.0 67618.0 68479.3 49557.0 56367.0 60671.1 60995.0 61356.4 9149.8 9643.0 9768.8 9817.1 9913.9 35312.8 37873.0 37986.0 38691.4 38822.8 51090.0 51560.5 51616.2 52269.7 52977.5 12213.7 12801.9 12858.5 12862.4 12907.8 13612.5 14437.1 14960.7 15144.6 15318.2 13626.2 13733.1 14020.7 14401.8 14461.7 14098.9 14225.6 14333.4 14361.3 15090.2 13558.9 13959.2 14087.0 14216.9 14725.3 11544.5 11645.1 11815.1 11950.5 12148.3 11519.8 11793.3 12036.9 12043.5 12129.3 14:03:10 INFO - PROCESS | 7421 | -------- Summary: end -------- 14:03:10 INFO - PROCESS | 7421 | 14:03:11 INFO - TEST-INFO | 7421: exit 0 14:03:11 INFO - TEST-OK | dromaeo_css | took 1110359ms 14:03:11 INFO - TEST-START | kraken 14:03:11 INFO - operating with platform_type : linux_ 14:03:11 INFO - Initialising browser for kraken test... 14:03:11 INFO - TEST-INFO | started process 7650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1azy9I/profile http://localhost:58857/getInfo.html) 14:03:14 INFO - PROCESS | 7650 | 14:03:14 INFO - PROCESS | 7650 | (process:7718): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:03:15 INFO - PROCESS | 7650 | __metrics Screen width/height:1600/1200 14:03:15 INFO - PROCESS | 7650 | colorDepth:24 14:03:15 INFO - PROCESS | 7650 | Browser inner width/height: 1024/697 14:03:15 INFO - PROCESS | 7650 | __metrics 14:03:16 ERROR - PROCESS | 7650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:03:17 INFO - TEST-INFO | 7650: exit 0 14:03:17 INFO - Browser initialized. 14:03:17 INFO - Running cycle 1/1 for kraken test... 14:03:17 INFO - TEST-INFO | started process 7769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1azy9I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:19 INFO - PROCESS | 7769 | 14:03:19 INFO - PROCESS | 7769 | (process:7828): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:03:29 INFO - PROCESS | 7769 | RSS: Main: 163172352 14:03:29 INFO - PROCESS | 7769 | 14:03:31 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58857/tests/kraken/driver.html?testName=audio-beat-detection) 14:03:32 INFO - PROCESS | 7769 | RSS: Main: 167919616 14:03:32 INFO - PROCESS | 7769 | 14:03:35 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58857/tests/kraken/driver.html?testName=audio-dft) 14:03:35 INFO - PROCESS | 7769 | RSS: Main: 168140800 14:03:35 INFO - PROCESS | 7769 | 14:03:38 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58857/tests/kraken/driver.html?testName=audio-fft) 14:03:39 INFO - PROCESS | 7769 | RSS: Main: 163266560 14:03:39 INFO - PROCESS | 7769 | 14:03:41 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58857/tests/kraken/driver.html?testName=audio-oscillator) 14:03:42 INFO - PROCESS | 7769 | RSS: Main: 163864576 14:03:42 INFO - PROCESS | 7769 | 14:03:44 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:45 INFO - PROCESS | 7769 | RSS: Main: 163450880 14:03:45 INFO - PROCESS | 7769 | 14:03:48 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58857/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:48 INFO - PROCESS | 7769 | RSS: Main: 163500032 14:03:48 INFO - PROCESS | 7769 | 14:03:52 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58857/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:53 INFO - PROCESS | 7769 | RSS: Main: 161910784 14:03:53 INFO - PROCESS | 7769 | 14:03:55 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58857/tests/kraken/driver.html?testName=json-parse-financial) 14:03:56 INFO - PROCESS | 7769 | RSS: Main: 163352576 14:03:56 INFO - PROCESS | 7769 | 14:03:58 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:58 INFO - PROCESS | 7769 | RSS: Main: 163643392 14:03:58 INFO - PROCESS | 7769 | 14:04:00 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:04:01 INFO - PROCESS | 7769 | RSS: Main: 163876864 14:04:01 INFO - PROCESS | 7769 | 14:04:03 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:04:04 INFO - PROCESS | 7769 | RSS: Main: 163840000 14:04:04 INFO - PROCESS | 7769 | 14:04:06 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:04:07 INFO - PROCESS | 7769 | RSS: Main: 164290560 14:04:07 INFO - PROCESS | 7769 | 14:04:10 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:04:10 INFO - PROCESS | 7769 | RSS: Main: 164929536 14:04:10 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | Cycle 1(1): loaded http://localhost:58857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58857/tests/kraken/driver.html?testName=ai-astar) 14:04:12 INFO - PROCESS | 7769 | RSS: Main: 166170624 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | __start_tp_report 14:04:12 INFO - PROCESS | 7769 | _x_x_mozilla_page_load 14:04:12 INFO - PROCESS | 7769 | _x_x_mozilla_page_load_details 14:04:12 INFO - PROCESS | 7769 | |i|pagename|runs| 14:04:12 INFO - PROCESS | 7769 | |0;ai-astar;109;114;103;109;110;112;113;112;109;110 14:04:12 INFO - PROCESS | 7769 | |1;audio-beat-detection;161;129;158;223;136;157;159;137;193;132 14:04:12 INFO - PROCESS | 7769 | |2;audio-dft;162;164;162;163;164;177;163;163;163;163 14:04:12 INFO - PROCESS | 7769 | |3;audio-fft;74;75;75;174;76;75;75;76;170;76 14:04:12 INFO - PROCESS | 7769 | |4;audio-oscillator;91;93;173;91;92;93;149;92;92;138 14:04:12 INFO - PROCESS | 7769 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;119;119;119 14:04:12 INFO - PROCESS | 7769 | |6;imaging-darkroom;147;147;148;147;147;147;147;147;147;148 14:04:12 INFO - PROCESS | 7769 | |7;imaging-desaturate;96;97;96;95;95;95;96;95;96;95 14:04:12 INFO - PROCESS | 7769 | |8;json-parse-financial;58;57;58;56;57;58;58;58;57;59 14:04:12 INFO - PROCESS | 7769 | |9;json-stringify-tinderbox;60;61;60;60;61;61;60;59;61;61 14:04:12 INFO - PROCESS | 7769 | |10;stanford-crypto-aes;80;78;78;83;79;85;82;81;130;79 14:04:12 INFO - PROCESS | 7769 | |11;stanford-crypto-ccm;134;123;119;128;118;124;130;122;157;124 14:04:12 INFO - PROCESS | 7769 | |12;stanford-crypto-pbkdf2;164;166;164;167;161;159;161;162;162;163 14:04:12 INFO - PROCESS | 7769 | |13;stanford-crypto-sha256-iterative;63;65;66;65;62;63;65;63;65;63 14:04:12 INFO - PROCESS | 7769 | __end_tp_report 14:04:12 INFO - PROCESS | 7769 | __start_cc_report 14:04:12 INFO - PROCESS | 7769 | _x_x_mozilla_cycle_collect,853 14:04:12 INFO - PROCESS | 7769 | __end_cc_report 14:04:12 INFO - PROCESS | 7769 | __startTimestamp1463173452727__endTimestamp 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | ------- Summary: start ------- 14:04:12 INFO - PROCESS | 7769 | Number of tests: 14 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.07 (2.8%) stddev-sans-first:3.23 14:04:12 INFO - PROCESS | 7769 | Values: 109.0 114.0 103.0 109.0 110.0 112.0 113.0 112.0 109.0 110.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#1] audio-beat-detection Cycles:10 Average:158.50 Median:158.50 stddev:29.63 (18.7%) stddev-sans-first:31.41 14:04:12 INFO - PROCESS | 7769 | Values: 161.0 129.0 158.0 223.0 136.0 157.0 159.0 137.0 193.0 132.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.48 (2.7%) stddev-sans-first:4.66 14:04:12 INFO - PROCESS | 7769 | Values: 162.0 164.0 162.0 163.0 164.0 177.0 163.0 163.0 163.0 163.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:40.81 (54.4%) stddev-sans-first:42.60 14:04:12 INFO - PROCESS | 7769 | Values: 74.0 75.0 75.0 174.0 76.0 75.0 75.0 76.0 170.0 76.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.00 stddev:30.81 (33.5%) stddev-sans-first:31.87 14:04:12 INFO - PROCESS | 7769 | Values: 91.0 93.0 173.0 91.0 92.0 93.0 149.0 92.0 92.0 138.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:04:12 INFO - PROCESS | 7769 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 119.0 119.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:04:12 INFO - PROCESS | 7769 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:04:12 INFO - PROCESS | 7769 | Values: 96.0 97.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 14:04:12 INFO - PROCESS | 7769 | Values: 58.0 57.0 58.0 56.0 57.0 58.0 58.0 58.0 57.0 59.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 14:04:12 INFO - PROCESS | 7769 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 60.0 59.0 61.0 61.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:80.50 stddev:15.80 (19.6%) stddev-sans-first:16.63 14:04:12 INFO - PROCESS | 7769 | Values: 80.0 78.0 78.0 83.0 79.0 85.0 82.0 81.0 130.0 79.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:126.00 stddev:11.33 (9.0%) stddev-sans-first:11.80 14:04:12 INFO - PROCESS | 7769 | Values: 134.0 123.0 119.0 128.0 118.0 124.0 130.0 122.0 157.0 124.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:2.42 (1.5%) stddev-sans-first:2.54 14:04:12 INFO - PROCESS | 7769 | Values: 164.0 166.0 164.0 167.0 161.0 159.0 161.0 162.0 162.0 163.0 14:04:12 INFO - PROCESS | 7769 | 14:04:12 INFO - PROCESS | 7769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:65.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 14:04:12 INFO - PROCESS | 7769 | Values: 63.0 65.0 66.0 65.0 62.0 63.0 65.0 63.0 65.0 63.0 14:04:12 INFO - PROCESS | 7769 | -------- Summary: end -------- 14:04:12 INFO - PROCESS | 7769 | 14:04:13 INFO - TEST-INFO | 7769: exit 0 14:04:13 INFO - TEST-OK | kraken | took 62552ms 14:04:13 INFO - SUITE-END | took 1172s 14:04:13 INFO - Completed test suite (00:19:33) 14:04:13 INFO - javascript benchmark 14:04:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.420716478525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.062181345596, 3156.068959656901, 3170.064830874892, 3181.9840900795493, 3191.601049868768, 5414.296141501604, 5422.810201642943, 5469.425710300416, 5503.394626591082, 5556.083246264372, 5367.1680889462195, 5417.079096553585, 5469.07025805613, 5486.890262194754, 5489.752961116749, 4915.533024362689, 4955.4548999610015, 5046.243063540462, 5060.190369540875, 5116.846494605149, 830.9665228337207, 5026.120428924942, 5036.4208116066575, 5067.822626208083, 5088.211327244283, 4979.950200497985, 4998.325226094467, 5007.0, 5014.498550144975, 5039.823606173784, 4887.291342755316, 5009.148444764399, 5011.348524691767, 5019.372578427697, 5076.086304465195, 4904.264360345941, 4911.386076740408, 4912.533309335643, 4913.336699545552, 4930.605551555867, 5269.86825329366, 5376.704281264529, 5391.946080539184, 5396.055690254229, 5400.432954539756, 5674.546036317085, 5739.885202295973, 5840.415958404125, 5866.1494083357675, 5913.526917846605, 5796.217510636052, 5836.182934389147, 5837.241158649391, 5845.7369418376275, 5882.764689412418, 5393.78424863005, 5401.135818269097, 5406.91889621656, 5413.891722165574, 5459.181122831567, 5884.0585506318785, 5926.4666180044005, 6018.458338749533, 6036.607620504653, 6038.033914573735, 5784.074548072288, 5805.0, 5806.042003069446, 5806.564507661942, 5807.361190269067, 5907.586468947133, 5936.0, 5954.136650185699, 5965.105234214902, 5990.281166260077, 5725.08398656213, 5857.7949771757785, 5870.882582348329, 5924.377940316291, 5946.167536544887, 5685.971570142123, 5810.941890581124, 5881.382454842265, 5887.705614719247, 5935.40645935403, 4429.822807087745, 4444.822207111744, 4454.621357184676, 4490.932636010462, 4510.954890451054, 3877.476540666974, 3936.0553467167674, 3953.3081710700512, 4006.0, 4046.1503084352025, 5512.145617429305, 5555.111182210827, 5559.8888022239325, 5561.972190139023, 5620.943790562042, 5862.794802181903, 5899.793507227227, 5906.645601263938, 5914.704264786744, 5935.881282374328, 5430.51125398716, 5532.2531458253425, 5532.5573954083575, 5564.972175139098, 5590.18942253371, 5053.140966035783, 5066.721330326794, 5067.493250674903, 5089.567386772092, 5093.465186155475, 6102.420270074336, 6144.754209831646, 6145.446909778141, 6159.4456498915315, 6160.0, 5774.711264436677, 5918.970405147947, 5951.583389162717, 5968.134620479919, 6083.361247068994, 6147.974984515111, 6151.630902145886, 6182.938170618237, 6191.721372538336, 6192.0, 5851.1223316502865, 5862.970685146717, 5863.325717542367, 5867.383924687846, 5867.823965281048, 5719.342275638355, 5837.29952405714, 5901.203337549376, 5951.523878089656, 5957.880842383215, 5684.602077854511, 5719.084946408555, 5770.163326317745, 5777.162311464898, 5780.075187969905, 5579.051561234681, 5801.535877129735, 5804.071348584206, 5808.0, 5823.912641310469, 5483.040467918178, 5557.110862262019, 5564.4713752193475, 5645.40723224072, 5693.829185124453, 5765.221695071279, 5814.476697097281, 5835.7373918174635, 5856.531477481706, 5858.209141765807, 5512.035393806148, 5674.77300907959, 5731.799387021434, 5734.5125664319, 5736.254286942671], "value": 5382.331239650828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.197695203667, 631.6589041917364, 646.237439821011, 649.1172006071743, 651.6643928376884, 32043.359132817328, 42154.789226053865, 42670.57329426705, 42839.78580107095, 43049.56950430495, 43870.780646096806, 43935.340969885474, 44234.7788261059, 44409.333859992046, 44560.108797824025, 8760.211580957712, 8925.866112008325, 8936.64253429862, 8948.776280592972, 8953.507557084358, 8771.342149338825, 8790.780230494225, 8835.734927952171, 8868.15752503511, 8881.689140880071, 8868.246199073054, 8901.510416927067, 8919.955400223022, 8932.687355942544, 8940.8658870117, 8881.555922203865, 8921.15249051339, 8933.55332233389, 8937.463752174857, 8937.46375217489, 8884.156005179497, 8891.422057566237, 8897.110288971116, 8899.37704360695, 8949.463032218022, 41100.1779964402, 41101.79449102765, 41183.7940810297, 41447.792761036304, 41450.37824432636, 3656.9634303657153, 3758.2107757370986, 3954.604539546051, 4122.196171746511, 4280.5719428057255, 32368.0, 32543.67456325454, 32572.511412328833, 32672.183195420068, 32711.836440817642, 3782.7919464429447, 3789.0906182516273, 3841.2509560635685, 3847.5190601174854, 3918.8824335269987, 350444.0, 351623.0, 352130.0, 353100.0, 353741.0, 57016.71491642515, 57071.71464142653, 57297.0, 57719.71140144272, 57795.13307300394, 37683.0, 37719.0, 38467.6153238464, 60684.696576517716, 61090.69454652698, 17375.652486950443, 17616.64766704659, 17641.911790441223, 17651.0, 17712.380066697602, 13172.802407963889, 13186.340682966005, 13188.670283242996, 13216.933915330554, 13264.867351326557, 19842.404727858186, 20019.39941801748, 20130.899345503178, 20179.899100504404, 20189.79810201879, 7205.2434494378385, 7396.704131834774, 7469.365103966224, 7510.248975102446, 7615.847683046419, 1051.7686109055996, 1070.721612380771, 1075.2473268711776, 1096.7497053359177, 1112.5994641928899, 32050.35899282048, 32148.83925580357, 32800.0, 32907.50638740421, 33026.91239937016, 1118.4799068433217, 1139.1740987783955, 1191.5948577483523, 1210.509743553862, 1228.2323547782637, 16990.74513882268, 17157.742633860504, 17245.741313880302, 17283.395081172097, 17374.0, 561846.0, 562287.0, 563046.0, 570519.0, 571452.0, 59882.0, 60045.0, 60082.399176008556, 60350.396496034475, 60495.0, 1392.2481859795798, 1420.8650178233052, 1433.1616004637403, 1439.417036100381, 1445.197915157098, 31327.21681957969, 31655.683443165275, 32072.839635801673, 32256.35487290288, 32911.50632740559, 49921.75039124781, 50146.49853501564, 50165.24752128648, 50209.0, 50384.24423633722, 420091.0, 427504.0, 427745.0, 429254.0, 432091.0, 27956.440871182054, 28017.579736303564, 28338.574921376607, 28481.43037139287, 28493.145205643865, 49283.0, 49796.751016244685, 49858.50141498684, 50469.74765126151, 51173.744131279105, 40804.071145458416, 41465.0, 42232.0, 43033.354499683155, 43129.35305970476, 41928.3710744333, 42164.78917605515, 42667.78666106649, 43596.34605480857, 43744.34383484314, 43293.0, 43813.34279985866, 43976.900577485816, 44445.0, 44607.33089003603, 36898.44652330271, 37577.6242237585, 38036.619633803304, 38127.618723812404, 38190.427143592315, 29406.41187176202, 29737.702622973495, 29863.552046718884, 30248.395032098793, 30344.84827575848], "value": 20353.249246035008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.8919086442093, 410.32706361567034, 413.53683874061045, 415.4723501153533, 420.16177725437757, 18161.182746776394, 19603.705944410845, 19872.0, 19874.801251987494, 20404.285849995253, 19030.2387904484, 19359.709604355947, 19783.307584234553, 19792.802071979313, 19807.306744263955, 5600.6079574429805, 5893.941060589404, 5909.615874968134, 5910.822675319747, 5910.881782364371, 5688.772449102031, 5845.85385365365, 5883.058710606304, 5888.234529511179, 5888.263967004124, 5786.421357864222, 5808.767649294024, 5819.272590926134, 5824.126381042856, 5843.620164689281, 5528.834134975958, 5778.017736984722, 5778.682172480512, 5787.710614469281, 5866.706664666793, 5226.634135610509, 5227.973860130713, 5237.214417837316, 5242.659227150261, 5255.737213139328, 20230.393088207376, 21535.46161345979, 21654.566908661895, 22711.659325110137, 23039.193628222933, 2310.4454930816482, 2359.7640235976437, 2360.1857359211044, 2463.5935070713313, 2466.987665061681, 10177.592896284139, 10345.79308413835, 10674.786504269949, 13574.778269955652, 13706.0, 1998.7801341852385, 2065.3390914907236, 2080.895955202249, 2083.0313904034697, 2117.5658989907033, 64874.16927774566, 65129.81266779648, 79125.60437197777, 80592.59703701503, 84886.15113848844, 10404.5838166474, 10437.373757574569, 10446.582136714598, 10838.837417438745, 10934.890651093547, 15527.689446211012, 15674.294656740474, 15698.76451853223, 15748.212589370485, 15755.44855930037, 8107.391945604103, 8473.23740863313, 8502.659893604186, 8579.0, 8600.612972416257, 7894.723684671009, 7902.24928631779, 7965.920340796518, 8082.191780821989, 8086.150954149847, 4725.787339569728, 4791.520847915181, 4818.373611430492, 4832.34763306949, 4871.074495845778, 1952.1313015708158, 2006.0, 2026.7567891853073, 2049.559344740888, 2101.810837024675, 961.1397798969883, 985.142925654685, 999.820032394176, 1002.7042022603349, 1004.638330201127, 17924.91037544804, 18898.0, 19632.3128690498, 19789.010549472758, 19901.900490497745, 969.9127078562963, 992.3549692699803, 1042.8122937871103, 1060.671191930504, 1080.8162612355918, 10812.0, 11016.491010539368, 11091.667249982513, 11128.054115400282, 11185.888141118485, 484937.0, 486185.0, 486878.0, 489435.0, 497265.0, 60394.0, 80406.0, 80605.0, 98890.0, 99128.0, 1075.634284343327, 1085.2999815119204, 1098.906592939593, 1104.6133853151332, 1105.1269497097203, 16198.433054843024, 16553.25510352013, 16831.495055148363, 17534.386296479563, 18068.277268909624, 29824.552631710107, 39338.81983540498, 41369.79315103405, 41372.58627413688, 44580.777096115606, 57016.14475782784, 59600.70199648974, 59689.403105968384, 60323.0, 60512.394876050676, 7316.926830731624, 8593.140685931357, 8650.178233067849, 8718.52048137333, 8723.738287851374, 13125.868741312846, 13642.795358069836, 14046.719065618427, 14111.929440352733, 14276.286185690466, 12088.39558022113, 12121.15151939391, 12328.81506777381, 12441.564545240873, 12485.438155283216, 12124.333161676192, 12191.878081219429, 12272.693182670148, 12474.251544907334, 12515.56195533152, 5935.109733539831, 8733.563321833755, 9764.511774411392, 11607.142857143155, 12463.189892656948, 7263.418926485974, 7428.777136685908, 7452.292032256927, 7522.3605993491165, 7689.538627682357, 9721.513924303898, 11320.943395282971, 11435.59975400857, 11568.479418426023, 11581.305121692725], "value": 9221.954665051637, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.1428143099145, 1568.537281501957, 1756.4818378578318, 1855.0, 1856.2853301478926, 7681.846363072736, 8342.624581893822, 8633.050364459905, 8987.955060224698, 9019.684311049123, 8646.394752367321, 8672.566371681407, 8724.302055835533, 8733.606987685553, 8778.0, 2322.3613506285824, 2346.460314127743, 2347.2606129069372, 2348.3542025942916, 2349.107339211106, 2285.0517035430275, 2290.610596198642, 2298.2071185440996, 2310.1452462588863, 2314.5255222679393, 2296.3799774060994, 2301.436148143707, 2318.8260880434036, 2326.3486223857262, 2342.121704360865, 2248.7751224877543, 2262.671912572684, 2320.883955802203, 2323.2101085630884, 2323.3843031596557, 2238.6082435573708, 2256.435891027243, 2275.0444813178337, 2284.6001949658744, 2286.371247906822, 8533.658653653909, 8552.486850788973, 8626.568671566396, 8631.309495240366, 8634.179752923463, 5130.48695130484, 5199.402068762065, 5253.921191182136, 5262.23697563855, 5268.104422248227, 3310.2717402171484, 3400.2179498715436, 3423.4864770284407, 3542.3977923753023, 3551.5383000210068, 1089.9019088282093, 1106.634810512529, 1121.3664279682034, 1136.4261048170704, 1163.2962057954985, 12093.637190884288, 12120.393980301038, 12123.515059397614, 12128.757424851454, 12169.513219471211, 4591.540845915449, 4685.672002959828, 4726.172919739032, 4757.500462451393, 4766.951270720436, 10279.640212592523, 10314.742131446625, 10330.0, 10343.689689309333, 10355.17158627308, 5161.948380516222, 5203.7918483261, 5282.049231138432, 5294.602904782157, 5300.893982120336, 4328.696991210585, 4719.079779442975, 4831.130396528588, 4868.78090485929, 4875.07373599015, 3990.082281075369, 3997.960020399817, 4004.379321205218, 4044.1911617676583, 4174.248635245624, 1235.8022716365338, 1250.6123101838277, 1252.5803855708439, 1264.9304288264234, 1271.4278574641448, 933.7712260496222, 997.1723469520426, 1028.8508166315842, 1071.8017166824163, 1082.4533610526792, 5854.121881717776, 5976.103584462278, 5999.880002399927, 6039.78860739872, 6216.6270023797815, 1015.4313584392763, 1049.4385503755454, 1051.6266725312405, 1055.7518983038979, 1065.4033741105006, 4131.5248746393945, 4169.145325208325, 4191.3293872980175, 4206.621404073648, 4233.216854881856, 10794.406307653155, 11068.28056176346, 11149.554017839358, 11153.386563739072, 11164.441777911072, 10902.18233632465, 10939.28894621847, 11014.339139651487, 11016.339019658846, 11021.83467247992, 7644.770656880302, 7892.4869883457395, 7901.920980790233, 8088.352931765562, 8205.835883282301, 5703.942960570341, 5829.94170058294, 5879.617824841372, 5947.821565352873, 5993.490553303018, 9907.306488545733, 9952.10431061208, 10025.598976040877, 10119.696409107739, 10148.695539133838, 10148.086672199537, 10281.794364112526, 10283.07452329264, 10413.271071024956, 10471.057604815604, 6981.650917454209, 7398.0, 7569.697212111454, 7617.314441700273, 7804.492707973964, 8447.0, 8504.192101750325, 8551.486910785372, 8552.957235213784, 8554.144585541397, 7502.587357695379, 7648.847023059619, 7653.885191722017, 7750.689972401041, 7757.224277572198, 7540.736074237376, 7687.769366919001, 7689.538627682357, 7726.266004729542, 7749.147593764794, 6925.861482770216, 7033.050538177486, 7061.964690176516, 7090.149182098181, 7097.112860892388, 4994.700317980933, 5051.87370315745, 5103.10695628271, 5167.173252279617, 5214.921776173284, 5265.131253343308, 5274.261603375454, 5278.577713782812, 5287.68273903567, 5311.229871668664], "value": 4665.546396913081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1960901655694, 316.53153333067075, 319.30391745993734, 322.83696733149753, 325.6613122352754, 5263.394709608387, 5626.352969408519, 5696.544276457884, 5703.173039909216, 5710.71446427678, 5599.584253605308, 5604.187392828037, 5626.268585083943, 5643.520300774439, 5710.486056254937, 4333.891652708692, 4347.673924455678, 4379.802908869108, 4389.648828093745, 4401.05377343871, 4319.870403887889, 4362.694611377205, 4364.694471387004, 4381.452318460192, 4423.4028406165235, 4293.892652683677, 4299.462567179103, 4338.370936214247, 4342.71889792512, 4347.913041739163, 4368.060866913613, 4409.29451287794, 4412.933805992912, 4420.80106395213, 4434.667399945017, 3739.345614517476, 3859.4017927221325, 3905.5703872573995, 3905.8828235152705, 3928.2732694451333, 5421.21392398104, 5433.4566543345745, 5496.367917689437, 5498.5876059295715, 5514.145307477347, 5040.621953353477, 5042.294078828967, 5064.29099926007, 5084.949150508484, 5097.592192624618, 5763.538916886681, 5916.852078698067, 5917.556183286228, 6027.758889644409, 6043.728032238516, 4213.810378532973, 4230.513490948519, 4234.407182994383, 4245.81117287157, 4246.681498887565, 6175.907361389583, 6186.288576813679, 6210.782622608187, 6244.31312555623, 6254.155688981975, 4188.916221675549, 4280.5291417944, 4301.79516260388, 4328.718633288826, 4354.0, 4269.743815371087, 4315.482142142963, 4328.0, 4361.171377438277, 4384.824607015684, 4951.72765497901, 4954.95945851368, 4982.651214415028, 5009.674371165863, 5010.423801262828, 5552.750126244328, 5874.383189765013, 5910.645361278337, 6004.249468816398, 6033.456988870935, 1452.7385070687167, 1474.9336279867432, 1476.350405821435, 1482.9777553336708, 1498.220925118932, 914.3541625074839, 922.9478394630127, 927.893292271384, 935.4901578639658, 945.2390825385493, 4962.429320628102, 5038.874028149326, 5101.69389836611, 5106.4382917879, 5126.436092029874, 5490.752916118784, 5501.697406642593, 5507.972460137754, 5512.5589952803675, 5536.252605898152, 5024.547790698854, 5034.320366750515, 5143.588512918957, 5156.917047420009, 5168.18334007959, 2857.357094653686, 2869.1679412970007, 2954.9066845266957, 2980.1225228106587, 2997.7302042815813, 5554.833484968121, 5557.6109672323355, 5581.944180558224, 5588.764494202271, 5669.0, 5177.611679124006, 5349.046278924325, 5473.27591808579, 5516.482967183976, 5527.50252477279, 5536.86157846049, 5537.473939975695, 5558.527525160326, 5568.7215639217875, 5595.916061259084, 5366.6243362964215, 5374.677519348852, 5399.136138217867, 5424.566034717134, 5688.829335119953, 6049.243844519435, 6079.969600151971, 6080.422359875804, 6085.1785009023215, 6098.627808743175, 6119.051547010221, 6199.0, 6228.314885362697, 6270.4670103039925, 6288.465480434214, 4220.134872351099, 4245.915081698287, 4261.850835220753, 4278.614924656796, 4290.592393722592, 6171.783987560593, 6200.604863905585, 6201.007838745779, 6205.565610407228, 6232.036908374029, 5784.623999440023, 5876.44173803488, 5912.822615321547, 5937.287525496795, 6031.276246850406, 5887.8233652990475, 5922.555808314308, 5926.644401335933, 5927.496162826035, 5931.970340148272, 5714.457126572969, 5776.9133462998925, 5825.650460972355, 5848.590598658053, 5852.268466441695, 5992.850178745566, 6001.969990150022, 6016.0, 6033.577649564489, 6058.182145410489, 5832.12518122285, 5890.941090589211, 5894.791567728691, 5905.810862134571, 5905.91141132892], "value": 4382.464305799123, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [836.799168199632, 869.5217630303332, 873.401719821922, 883.2713011765293, 886.2599729226096, 14643.70712585749, 15582.688346233097, 15611.063336199835, 15654.608634784121, 15679.529614111567, 14393.352299146538, 14589.635259118528, 14590.854091459083, 14654.120752754841, 14720.779188312157, 852.2627926843298, 853.5902766672001, 857.6655104509247, 862.2067697718084, 865.6191275838611, 848.1264297773304, 851.8637018077109, 853.8548446764034, 855.9272461840751, 857.0486759696731, 910.517425764346, 912.8174365126968, 913.2876356441986, 918.3433844800966, 919.0, 898.3531857062904, 906.8005038891433, 907.6233363154316, 909.0182602788972, 909.6225066597354, 660.7588230295955, 661.8841702702056, 663.0286630086897, 663.3101574362657, 665.2781731820932, 14258.928705356511, 14359.78460323096, 14374.35315410809, 14397.712045759132, 14443.133411995314, 12603.0, 12659.430325635369, 12688.682782930407, 12773.872261277362, 12958.287294198815, 10769.9461502692, 10789.46052697362, 10876.673699789018, 11243.83134252987, 11389.601363952223, 3852.8651497197466, 3897.5322961244833, 3973.7417067890497, 3985.60143985602, 4039.0508230565792, 50069.74965125188, 53534.46465535334, 54888.72555637236, 55665.72167139138, 57404.71297643485, 10772.569097236179, 10786.137109031259, 11116.833247501294, 11732.237404568676, 11906.523739050514, 19757.40727778169, 19969.400917972485, 20039.398818035483, 20046.198152074045, 20184.798152018586, 8168.183181681903, 8275.08974012858, 8275.917240827635, 8315.126911674308, 8629.22336989674, 4806.4712881583, 4930.630202734809, 5066.417362003343, 5096.719680417613, 5195.3246078009615, 3585.2470981093743, 3747.3254814133716, 3750.3811871041516, 3756.549214094326, 3773.981130094332, 661.3485716569272, 667.0760996020547, 669.2704951602776, 678.1489231015144, 691.3673988300649, 686.4405509509734, 724.1852915470096, 739.3863093632273, 748.7828529726427, 755.2258934592087, 8897.510636915033, 8950.104989500998, 9036.186743193144, 9075.228605568469, 9106.544672766335, 752.7440670172168, 754.5962909843207, 765.9693612255559, 772.75658167677, 782.7221336425487, 4347.7173983690955, 4386.71486353386, 4435.911281774346, 4491.169133710274, 4492.640588752892, 72142.63928680323, 72640.0, 74226.6288668564, 74920.25079749133, 74933.62533187299, 65625.67187164034, 67041.32958670448, 67458.0, 67618.0, 68479.3152068473, 49557.0, 56367.0, 60671.089933651034, 60995.0, 61356.386436135064, 9149.77125571866, 9642.951785241028, 9768.755781105529, 9817.116459518678, 9913.851292230478, 35312.82343588266, 37873.0, 37986.0, 38691.41962870616, 38822.80588597039, 51090.0, 51560.484395157066, 51616.22575661443, 52269.7386513065, 52977.47022529726, 12213.69465763363, 12801.93599031999, 12858.485660573846, 12862.421191046238, 12907.806382904451, 13612.523561675294, 14437.133771973715, 14960.700785984001, 15144.621384465036, 15318.234088295763, 13626.182429054288, 13733.107348022746, 14020.719585608434, 14401.78397324062, 14461.710765784836, 14098.929505352407, 14225.573232803032, 14333.426662933365, 14361.281935903373, 15090.24548772535, 13558.86441135576, 13959.232242226775, 14087.0, 14216.857831421554, 14725.337359819048, 11544.480498377761, 11645.126615504041, 11815.113866460222, 11950.462229199533, 12148.271103733805, 11519.76960460803, 11793.29240245588, 12036.939815300868, 12043.518259269882, 12129.272243665408], "value": 7202.599061266997, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 103.0, 109.0, 110.0, 112.0, 113.0, 112.0, 109.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 129.0, 158.0, 223.0, 136.0, 157.0, 159.0, 137.0, 193.0, 132.0], "value": 158.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 163.0, 164.0, 177.0, 163.0, 163.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 174.0, 76.0, 75.0, 75.0, 76.0, 170.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 173.0, 91.0, 92.0, 93.0, 149.0, 92.0, 92.0, 138.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 119.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 56.0, 57.0, 58.0, 58.0, 58.0, 57.0, 59.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 59.0, 61.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 83.0, 79.0, 85.0, 82.0, 81.0, 130.0, 79.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 123.0, 119.0, 128.0, 118.0, 124.0, 130.0, 122.0, 157.0, 124.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 167.0, 161.0, 159.0, 161.0, 162.0, 162.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 65.0, 62.0, 63.0, 65.0, 63.0, 65.0, 63.0], "value": 64.0, "unit": "score"}]}]} 14:04:13 INFO - Return code: 0 14:04:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:04:14 ERROR - # TBPL SUCCESS # 14:04:14 INFO - Running post-action listener: _resource_record_post_action 14:04:14 INFO - ##### 14:04:14 INFO - ##### Finished run-tests step (success) 14:04:14 INFO - ##### 14:04:14 INFO - Running post-run listener: _resource_record_post_run 14:04:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546697216; Read time: 12; Write time: 586428 14:04:14 INFO - TinderboxPrint: CPU usage
13.5% 14:04:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:04:14 INFO - TinderboxPrint: I/O write bytes / time
546,697,216 / 586,428 14:04:14 INFO - TinderboxPrint: CPU idle
8,222.1 (86.5%) 14:04:14 INFO - TinderboxPrint: CPU user
1,220.2 (12.8%) 14:04:14 INFO - TinderboxPrint: Swap in / out
0 / 0 14:04:14 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257409024; Read time: 0; Write time: 341396 14:04:14 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289288192; Read time: 12; Write time: 245032 14:04:14 INFO - Running post-run listener: _upload_blobber_files 14:04:14 INFO - Blob upload gear active. 14:04:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:04:14 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 14:04:14 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'] 14:04:14 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 14:04:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:16 INFO - (blobuploader) - INFO - Done attempting. 14:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:04:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:20 INFO - (blobuploader) - INFO - Done attempting. 14:04:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:04:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:04:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:21 INFO - (blobuploader) - INFO - Done attempting. 14:04:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:04:21 INFO - Return code: 0 14:04:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:04:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:04:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/104dccbd33d832d97e6450bde4163b91061f7a4bc160a44675f1751df252f1a30554edc9de011e416029c25b4cd442dd1d396c31ebf3a533f76421b18972b213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54cabb7f73a36803ad58bf938aeacf87b52266c9969e0ef8b41ac7b2c11e02c0ac5ea55305c8356e98964906f2458ba134a3d28e72714be52a15f26273121355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db6f1c996bb04b3b5deb230d25114f1dcc36e26dad0786f5dfdb0a671d91ce4b14ebe216338fbcad27220010daa5af00cf46388093ae87d4765640ee947bd65"} 14:04:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:04:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:04:21 INFO - Contents: 14:04:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/104dccbd33d832d97e6450bde4163b91061f7a4bc160a44675f1751df252f1a30554edc9de011e416029c25b4cd442dd1d396c31ebf3a533f76421b18972b213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54cabb7f73a36803ad58bf938aeacf87b52266c9969e0ef8b41ac7b2c11e02c0ac5ea55305c8356e98964906f2458ba134a3d28e72714be52a15f26273121355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db6f1c996bb04b3b5deb230d25114f1dcc36e26dad0786f5dfdb0a671d91ce4b14ebe216338fbcad27220010daa5af00cf46388093ae87d4765640ee947bd65"} 14:04:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:04:21 INFO - Copying logs to upload dir... 14:04:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:04:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.635524 ========= master_lag: 79.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-05-13 14:05:40.304162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-05-13 14:05:40.308132) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294 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/104dccbd33d832d97e6450bde4163b91061f7a4bc160a44675f1751df252f1a30554edc9de011e416029c25b4cd442dd1d396c31ebf3a533f76421b18972b213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54cabb7f73a36803ad58bf938aeacf87b52266c9969e0ef8b41ac7b2c11e02c0ac5ea55305c8356e98964906f2458ba134a3d28e72714be52a15f26273121355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db6f1c996bb04b3b5deb230d25114f1dcc36e26dad0786f5dfdb0a671d91ce4b14ebe216338fbcad27220010daa5af00cf46388093ae87d4765640ee947bd65"} build_url:https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/aOQWTm0KStu7wQBsD1wcXA/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/104dccbd33d832d97e6450bde4163b91061f7a4bc160a44675f1751df252f1a30554edc9de011e416029c25b4cd442dd1d396c31ebf3a533f76421b18972b213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54cabb7f73a36803ad58bf938aeacf87b52266c9969e0ef8b41ac7b2c11e02c0ac5ea55305c8356e98964906f2458ba134a3d28e72714be52a15f26273121355", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0db6f1c996bb04b3b5deb230d25114f1dcc36e26dad0786f5dfdb0a671d91ce4b14ebe216338fbcad27220010daa5af00cf46388093ae87d4765640ee947bd65"}' ========= master_lag: 5.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-05-13 14:05:45.789373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:05:45.789819) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1463172180.534098-539489294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.40 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:05:46.197773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:05:46.198174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 14:05:46.412346) ========= ========= Total master_lag: 85.47 =========