builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1463050901.0 results: success (0) buildid: 20160512013006 builduid: 5e8d256c49614c3881adb15569e555df revision: 5190ada5abfef2d6308277f2948bc1286409d659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:40.997446) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:40.997860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:40.998136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.014854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.015209) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 04:01:40-- 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.5M=0s 2016-05-12 04:01:41 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.112343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.112692) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.162543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.162923) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5190ada5abfef2d6308277f2948bc1286409d659 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5190ada5abfef2d6308277f2948bc1286409d659 --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=a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 04:01:41,176 truncating revision to first 12 chars 2016-05-12 04:01:41,176 Setting DEBUG logging. 2016-05-12 04:01:41,176 attempt 1/10 2016-05-12 04:01:41,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5190ada5abfe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 04:01:41,432 unpacking tar archive at: mozilla-inbound-5190ada5abfe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.726498) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.726829) ========= script_repo_revision: 5190ada5abfef2d6308277f2948bc1286409d659 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.727226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.727493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 04:01:41.736271) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-12 04:01:41.736564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:41 INFO - MultiFileLogger online at 20160512 04:01:41 in /builds/slave/test 04:01:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:01:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:41 INFO - {'append_to_log': False, 04:01:41 INFO - 'base_work_dir': '/builds/slave/test', 04:01:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:01:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:41 INFO - 'branch': 'Mozilla-Inbound', 04:01:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:41 INFO - 'config_files': ('talos/linux_config.py',), 04:01:41 INFO - 'default_actions': ('clobber', 04:01:41 INFO - 'read-buildbot-config', 04:01:41 INFO - 'download-and-extract', 04:01:41 INFO - 'populate-webroot', 04:01:41 INFO - 'create-virtualenv', 04:01:41 INFO - 'install', 04:01:41 INFO - 'run-tests'), 04:01:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:41 INFO - 'download_minidump_stackwalk': True, 04:01:41 INFO - 'download_symbols': 'ondemand', 04:01:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:41 INFO - 'installer_path': 'installer.exe', 04:01:41 INFO - 'log_level': 'info', 04:01:41 INFO - 'log_name': 'talos', 04:01:41 INFO - 'log_to_console': True, 04:01:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:41 INFO - 'opt_config_files': (), 04:01:41 INFO - 'pip_index': False, 04:01:41 INFO - 'sps_profile': False, 04:01:41 INFO - 'sps_profile_interval': 0, 04:01:41 INFO - 'suite': 'dromaeojs-e10s', 04:01:41 INFO - 'system_bits': '32', 04:01:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:41 INFO - 'title': 'talos-linux64-ix-002', 04:01:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:41 INFO - 'use_talos_json': True, 04:01:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:41 INFO - 'work_dir': 'build'} 04:01:41 INFO - ##### 04:01:41 INFO - ##### Running clobber step. 04:01:41 INFO - ##### 04:01:41 INFO - Running pre-action listener: _resource_record_pre_action 04:01:41 INFO - Running main action method: clobber 04:01:41 INFO - rmtree: /builds/slave/test/build 04:01:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:42 INFO - Running post-action listener: _resource_record_post_action 04:01:42 INFO - ##### 04:01:42 INFO - ##### Finished clobber step (success) 04:01:42 INFO - ##### 04:01:42 INFO - ##### 04:01:42 INFO - ##### Running read-buildbot-config step. 04:01:42 INFO - ##### 04:01:42 INFO - Running pre-action listener: _resource_record_pre_action 04:01:42 INFO - Running main action method: read_buildbot_config 04:01:42 INFO - Using buildbot properties: 04:01:42 INFO - { 04:01:42 INFO - "project": "", 04:01:42 INFO - "product": "firefox", 04:01:42 INFO - "script_repo_revision": "production", 04:01:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:01:42 INFO - "repository": "", 04:01:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:01:42 INFO - "buildid": "20160512013006", 04:01:42 INFO - "pgo_build": "True", 04:01:42 INFO - "basedir": "/builds/slave/test", 04:01:42 INFO - "buildnumber": 1014, 04:01:42 INFO - "slavename": "talos-linux64-ix-002", 04:01:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:01:42 INFO - "platform": "ubuntu64_hw", 04:01:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:01:42 INFO - "branch": "mozilla-inbound", 04:01:42 INFO - "repo_path": "integration/mozilla-inbound", 04:01:42 INFO - "revision": "5190ada5abfef2d6308277f2948bc1286409d659", 04:01:42 INFO - "stage_platform": "linux64-pgo", 04:01:42 INFO - "builduid": "5e8d256c49614c3881adb15569e555df", 04:01:42 INFO - "slavebuilddir": "test" 04:01:42 INFO - } 04:01:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:01:42 INFO - Running post-action listener: _resource_record_post_action 04:01:42 INFO - ##### 04:01:42 INFO - ##### Finished read-buildbot-config step (success) 04:01:42 INFO - ##### 04:01:42 INFO - ##### 04:01:42 INFO - ##### Running download-and-extract step. 04:01:42 INFO - ##### 04:01:42 INFO - Running pre-action listener: _resource_record_pre_action 04:01:42 INFO - Running main action method: download_and_extract 04:01:42 INFO - mkdir: /builds/slave/test/build/tests 04:01:42 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')]} 04:01:42 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:42 INFO - Downloaded 1361 bytes. 04:01:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:01:42 INFO - Using the following test package requirements: 04:01:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:01:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:01:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'jsshell-linux-x86_64.zip'], 04:01:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:01:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:01:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:01:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:01:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01:42 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')]} 04:01:42 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:50 INFO - Downloaded 23903718 bytes. 04:01: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'] 04:01: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 04:01:51 INFO - Return code: 0 04:01:51 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 04:01:51 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')]} 04:01:51 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:52 INFO - Downloaded 23903718 bytes. 04:01:52 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'] 04:01:52 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 04:01:54 INFO - Return code: 0 04:01:54 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')]} 04:01:54 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:55 INFO - Downloaded 10840239 bytes. 04:01:55 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'] 04:01:55 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 04:01:55 INFO - Return code: 0 04:01: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')]} 04:01:55 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:01:56 INFO - Downloaded 58324169 bytes. 04:01:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:01:56 INFO - mkdir: /builds/slave/test/properties 04:01:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:56 INFO - Contents: 04:01:56 INFO - build_url:https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:01:58 INFO - Running post-action listener: _resource_record_post_action 04:01:58 INFO - Running post-action listener: set_extra_try_arguments 04:01:58 INFO - ##### 04:01:58 INFO - ##### Finished download-and-extract step (success) 04:01:58 INFO - ##### 04:01:58 INFO - ##### 04:01:58 INFO - ##### Running populate-webroot step. 04:01:58 INFO - ##### 04:01:58 INFO - Running pre-action listener: _resource_record_pre_action 04:01:58 INFO - Running main action method: populate_webroot 04:01:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:58 INFO - '--tppagecycles', 04:01:58 INFO - '7'], 04:01:58 INFO - 'tests': ['tsvgm']}}, 04:01:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['damp', 'tps']}, 04:01:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'tests': ['damp', 'tps']}, 04:01:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['dromaeo_dom']}, 04:01:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['a11yr', 04:01:58 INFO - 'ts_paint', 04:01:58 INFO - 'tpaint', 04:01:58 INFO - 'sessionrestore', 04:01:58 INFO - 'sessionrestore_no_auto_restore', 04:01:58 INFO - 'tabpaint']}, 04:01:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:58 INFO - 'ts_paint', 04:01:58 INFO - 'tpaint', 04:01:58 INFO - 'sessionrestore', 04:01:58 INFO - 'sessionrestore_no_auto_restore', 04:01:58 INFO - 'tabpaint']}, 04:01:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:58 INFO - 'ts_paint', 04:01:58 INFO - 'tpaint', 04:01:58 INFO - 'sessionrestore', 04:01:58 INFO - 'sessionrestore_no_auto_restore', 04:01:58 INFO - 'tabpaint']}, 04:01:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:58 INFO - 'ts_paint', 04:01:58 INFO - 'tpaint', 04:01:58 INFO - 'sessionrestore', 04:01:58 INFO - 'sessionrestore_no_auto_restore', 04:01:58 INFO - 'tabpaint']}, 04:01:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['a11yr', 04:01:58 INFO - 'ts_paint', 04:01:58 INFO - 'tpaint', 04:01:58 INFO - 'sessionrestore', 04:01:58 INFO - 'sessionrestore_no_auto_restore', 04:01:58 INFO - 'tabpaint']}, 04:01:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['a11yr', 04:01:58 INFO - 'ts_paint', 04:01:58 INFO - 'tpaint', 04:01:58 INFO - 'sessionrestore', 04:01:58 INFO - 'sessionrestore_no_auto_restore', 04:01:58 INFO - 'tabpaint']}, 04:01:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['tsvgx', 04:01:58 INFO - 'tsvgr_opacity', 04:01:58 INFO - 'tart', 04:01:58 INFO - 'tscrollx', 04:01:58 INFO - 'cart']}, 04:01:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:58 INFO - 'tsvgr_opacity', 04:01:58 INFO - 'tart', 04:01:58 INFO - 'tscrollx', 04:01:58 INFO - 'cart']}, 04:01:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'talos_options': ['--disable-e10s'], 04:01:58 INFO - 'tests': ['tp5o']}, 04:01:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'tests': ['tp5o']}, 04:01:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'talos_options': ['--disable-e10s', 04:01:58 INFO - '--xperf_path', 04:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:58 INFO - 'tests': ['tp5n']}, 04:01:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:58 INFO - 'talos_options': ['--xperf_path', 04:01:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:58 INFO - 'tests': ['tp5n']}}, 04:01:58 INFO - 'talos.zip': {'path': '', 04:01:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:58 INFO - Running post-action listener: _resource_record_post_action 04:01:58 INFO - ##### 04:01:58 INFO - ##### Finished populate-webroot step (success) 04:01:58 INFO - ##### 04:01:58 INFO - ##### 04:01:58 INFO - ##### Running create-virtualenv step. 04:01:58 INFO - ##### 04:01:58 INFO - Running pre-action listener: _resource_record_pre_action 04:01:58 INFO - Running main action method: create_virtualenv 04:01:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01: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 04:01:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:58 INFO - Using real prefix '/usr' 04:01:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:02 INFO - Installing pip.................done. 04:02:02 INFO - Return code: 0 04:02:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:02:02 INFO - Using env: {'DISPLAY': ':0', 04:02:02 INFO - 'HOME': '/home/cltbld', 04:02:02 INFO - 'LANG': 'en_US.UTF-8', 04:02:02 INFO - 'LANGUAGE': 'en_US:en', 04:02:02 INFO - 'LOGNAME': 'cltbld', 04:02:02 INFO - 'MAIL': '/var/mail/cltbld', 04:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:02 INFO - 'MOZ_NO_REMOTE': '1', 04:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:02 INFO - 'NO_EM_RESTART': '1', 04:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:02 INFO - 'PWD': '/builds/slave/test', 04:02:02 INFO - 'SHELL': '/bin/bash', 04:02:02 INFO - 'SHLVL': '1', 04:02:02 INFO - 'TERM': 'linux', 04:02:02 INFO - 'TMOUT': '86400', 04:02:02 INFO - 'USER': 'cltbld', 04:02:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:02 INFO - '_': '/tools/buildbot/bin/python'} 04:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:02 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 04:02:02 INFO - Cleaning up... 04:02:02 INFO - Return code: 0 04:02:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:02:02 INFO - Using env: {'DISPLAY': ':0', 04:02:02 INFO - 'HOME': '/home/cltbld', 04:02:02 INFO - 'LANG': 'en_US.UTF-8', 04:02:02 INFO - 'LANGUAGE': 'en_US:en', 04:02:02 INFO - 'LOGNAME': 'cltbld', 04:02:02 INFO - 'MAIL': '/var/mail/cltbld', 04:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:02 INFO - 'MOZ_NO_REMOTE': '1', 04:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:02 INFO - 'NO_EM_RESTART': '1', 04:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:02 INFO - 'PWD': '/builds/slave/test', 04:02:02 INFO - 'SHELL': '/bin/bash', 04:02:02 INFO - 'SHLVL': '1', 04:02:02 INFO - 'TERM': 'linux', 04:02:02 INFO - 'TMOUT': '86400', 04:02:02 INFO - 'USER': 'cltbld', 04:02:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:02 INFO - '_': '/tools/buildbot/bin/python'} 04:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:02 INFO - Downloading/unpacking psutil>=0.7.1 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:04 INFO - Installing collected packages: psutil 04:02:04 INFO - Running setup.py install for psutil 04:02:04 INFO - building 'psutil._psutil_linux' extension 04:02:04 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 04:02:04 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 04:02:04 INFO - building 'psutil._psutil_posix' extension 04:02:04 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 04:02:05 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 04:02:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:05 INFO - Successfully installed psutil 04:02:05 INFO - Cleaning up... 04:02:05 INFO - Return code: 0 04:02:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:05 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:05 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.0.0'] in /builds/slave/test/build 04:02:05 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.0.0 04:02:05 INFO - Using env: {'DISPLAY': ':0', 04:02:05 INFO - 'HOME': '/home/cltbld', 04:02:05 INFO - 'LANG': 'en_US.UTF-8', 04:02:05 INFO - 'LANGUAGE': 'en_US:en', 04:02:05 INFO - 'LOGNAME': 'cltbld', 04:02:05 INFO - 'MAIL': '/var/mail/cltbld', 04:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:05 INFO - 'MOZ_NO_REMOTE': '1', 04:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:05 INFO - 'NO_EM_RESTART': '1', 04:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:05 INFO - 'PWD': '/builds/slave/test', 04:02:05 INFO - 'SHELL': '/bin/bash', 04:02:05 INFO - 'SHLVL': '1', 04:02:05 INFO - 'TERM': 'linux', 04:02:05 INFO - 'TMOUT': '86400', 04:02:05 INFO - 'USER': 'cltbld', 04:02:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:05 INFO - '_': '/tools/buildbot/bin/python'} 04:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:02:05 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 04:02:05 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 04:02:05 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 04:02:05 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 04:02:05 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 04:02:05 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 04:02:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:02:07 INFO - Installing collected packages: mozsystemmonitor 04:02:07 INFO - Running setup.py install for mozsystemmonitor 04:02:07 INFO - Successfully installed mozsystemmonitor 04:02:07 INFO - Cleaning up... 04:02:07 INFO - Return code: 0 04:02:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02:07 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')]} 04:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:07 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')]} 04:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:07 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 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:07 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 04:02:07 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 04:02:07 INFO - Using env: {'DISPLAY': ':0', 04:02:07 INFO - 'HOME': '/home/cltbld', 04:02:07 INFO - 'LANG': 'en_US.UTF-8', 04:02:07 INFO - 'LANGUAGE': 'en_US:en', 04:02:07 INFO - 'LOGNAME': 'cltbld', 04:02:07 INFO - 'MAIL': '/var/mail/cltbld', 04:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:07 INFO - 'MOZ_NO_REMOTE': '1', 04:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:07 INFO - 'NO_EM_RESTART': '1', 04:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:07 INFO - 'PWD': '/builds/slave/test', 04:02:07 INFO - 'SHELL': '/bin/bash', 04:02:07 INFO - 'SHLVL': '1', 04:02:07 INFO - 'TERM': 'linux', 04:02:07 INFO - 'TMOUT': '86400', 04:02:07 INFO - 'USER': 'cltbld', 04:02:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:07 INFO - '_': '/tools/buildbot/bin/python'} 04:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:07 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 04:02:07 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 04:02:07 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 04:02:07 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 04:02:07 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 04:02:07 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 04:02:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:10 INFO - Downloading docopt-0.6.1.tar.gz 04:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:10 INFO - Running setup.py install for blobuploader 04:02:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:10 INFO - Running setup.py install for requests 04:02:10 INFO - Running setup.py install for docopt 04:02:10 INFO - Successfully installed blobuploader requests docopt 04:02:10 INFO - Cleaning up... 04:02:10 INFO - Return code: 0 04:02:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:10 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')]} 04:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:10 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')]} 04:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:10 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 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:10 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 04:02:10 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 04:02:10 INFO - Using env: {'DISPLAY': ':0', 04:02:10 INFO - 'HOME': '/home/cltbld', 04:02:10 INFO - 'LANG': 'en_US.UTF-8', 04:02:10 INFO - 'LANGUAGE': 'en_US:en', 04:02:10 INFO - 'LOGNAME': 'cltbld', 04:02:10 INFO - 'MAIL': '/var/mail/cltbld', 04:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:10 INFO - 'MOZ_NO_REMOTE': '1', 04:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:10 INFO - 'NO_EM_RESTART': '1', 04:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:10 INFO - 'PWD': '/builds/slave/test', 04:02:10 INFO - 'SHELL': '/bin/bash', 04:02:10 INFO - 'SHLVL': '1', 04:02:10 INFO - 'TERM': 'linux', 04:02:10 INFO - 'TMOUT': '86400', 04:02:10 INFO - 'USER': 'cltbld', 04:02:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:10 INFO - '_': '/tools/buildbot/bin/python'} 04:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:11 INFO - Running setup.py (path:/tmp/pip-NTL3pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:11 INFO - Running setup.py (path:/tmp/pip-oAzVXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:11 INFO - Running setup.py (path:/tmp/pip-O65Dt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:11 INFO - Running setup.py (path:/tmp/pip-uIVbTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:11 INFO - Running setup.py (path:/tmp/pip-2eAGFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:11 INFO - Running setup.py (path:/tmp/pip-goIg7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:11 INFO - Running setup.py (path:/tmp/pip-rcQnqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:11 INFO - Running setup.py (path:/tmp/pip-DxW0Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:11 INFO - Running setup.py (path:/tmp/pip-6eVHBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:11 INFO - Running setup.py (path:/tmp/pip-rpRKcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:11 INFO - Running setup.py (path:/tmp/pip-JMAOaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:11 INFO - Running setup.py (path:/tmp/pip-2pwZej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:12 INFO - Running setup.py (path:/tmp/pip-XAZBq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:12 INFO - Running setup.py (path:/tmp/pip-ZIYpu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:12 INFO - Running setup.py (path:/tmp/pip-OtV9P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:12 INFO - Running setup.py (path:/tmp/pip-Wzjx4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:12 INFO - Running setup.py (path:/tmp/pip-z3_how-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:12 INFO - Running setup.py install for manifestparser 04:02:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:12 INFO - Running setup.py install for mozcrash 04:02:12 INFO - Running setup.py install for mozdebug 04:02:12 INFO - Running setup.py install for mozdevice 04:02:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:02:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:12 INFO - Running setup.py install for mozfile 04:02:12 INFO - Running setup.py install for mozhttpd 04:02:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for mozinfo 04:02:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for mozInstall 04:02:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for mozleak 04:02:13 INFO - Running setup.py install for mozlog 04:02:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for moznetwork 04:02:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for mozprocess 04:02:13 INFO - Running setup.py install for mozprofile 04:02:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for mozrunner 04:02:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:13 INFO - Running setup.py install for mozscreenshot 04:02:13 INFO - Running setup.py install for moztest 04:02:14 INFO - Running setup.py install for mozversion 04:02:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:14 INFO - Cleaning up... 04:02:14 INFO - Return code: 0 04:02:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:14 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 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:14 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 04:02:14 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 04:02:14 INFO - Using env: {'DISPLAY': ':0', 04:02:14 INFO - 'HOME': '/home/cltbld', 04:02:14 INFO - 'LANG': 'en_US.UTF-8', 04:02:14 INFO - 'LANGUAGE': 'en_US:en', 04:02:14 INFO - 'LOGNAME': 'cltbld', 04:02:14 INFO - 'MAIL': '/var/mail/cltbld', 04:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:14 INFO - 'MOZ_NO_REMOTE': '1', 04:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:14 INFO - 'NO_EM_RESTART': '1', 04:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:14 INFO - 'PWD': '/builds/slave/test', 04:02:14 INFO - 'SHELL': '/bin/bash', 04:02:14 INFO - 'SHLVL': '1', 04:02:14 INFO - 'TERM': 'linux', 04:02:14 INFO - 'TMOUT': '86400', 04:02:14 INFO - 'USER': 'cltbld', 04:02:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:14 INFO - '_': '/tools/buildbot/bin/python'} 04:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:14 INFO - Running setup.py (path:/tmp/pip-PeB_NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:14 INFO - Running setup.py (path:/tmp/pip-IQ4sc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:14 INFO - Running setup.py (path:/tmp/pip-9vb5aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:14 INFO - Running setup.py (path:/tmp/pip-wIlPDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:14 INFO - Running setup.py (path:/tmp/pip-eXuyB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:14 INFO - Running setup.py (path:/tmp/pip-JbqTjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:14 INFO - Running setup.py (path:/tmp/pip-6KRhjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:14 INFO - Running setup.py (path:/tmp/pip-d_Vk1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:14 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)) 04:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:14 INFO - Running setup.py (path:/tmp/pip-rsQcYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:15 INFO - Running setup.py (path:/tmp/pip-aQzuX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:15 INFO - Running setup.py (path:/tmp/pip-UTqoB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:15 INFO - Running setup.py (path:/tmp/pip-jrPhwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:15 INFO - Running setup.py (path:/tmp/pip-CWiODf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:15 INFO - Running setup.py (path:/tmp/pip-zpeBYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:15 INFO - Running setup.py (path:/tmp/pip-yHxuNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:15 INFO - Running setup.py (path:/tmp/pip-shdIiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:15 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)) 04:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:15 INFO - Running setup.py (path:/tmp/pip-z29dNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:15 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)) 04:02:15 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)) 04:02:15 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)) 04:02:15 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)) 04:02:15 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)) 04:02:15 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)) 04:02:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:17 INFO - Downloading blessings-1.6.tar.gz 04:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:17 INFO - Installing collected packages: blessings 04:02:17 INFO - Running setup.py install for blessings 04:02:17 INFO - Successfully installed blessings 04:02:17 INFO - Cleaning up... 04:02:17 INFO - Return code: 0 04:02:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:17 INFO - Reading from file tmpfile_stdout 04:02:17 INFO - Current package versions: 04:02:17 INFO - argparse == 1.2.1 04:02:17 INFO - blessings == 1.6 04:02:17 INFO - blobuploader == 1.2.4 04:02:17 INFO - docopt == 0.6.1 04:02:17 INFO - manifestparser == 1.1 04:02:17 INFO - mozInstall == 1.12 04:02:17 INFO - mozcrash == 0.17 04:02:17 INFO - mozdebug == 0.1 04:02:17 INFO - mozdevice == 0.48 04:02:17 INFO - mozfile == 1.2 04:02:17 INFO - mozhttpd == 0.7 04:02:17 INFO - mozinfo == 0.9 04:02:17 INFO - mozleak == 0.1 04:02:17 INFO - mozlog == 3.2 04:02:17 INFO - moznetwork == 0.27 04:02:17 INFO - mozprocess == 0.22 04:02:17 INFO - mozprofile == 0.28 04:02:17 INFO - mozrunner == 6.11 04:02:17 INFO - mozscreenshot == 0.1 04:02:17 INFO - mozsystemmonitor == 0.0 04:02:17 INFO - moztest == 0.7 04:02:17 INFO - mozversion == 1.4 04:02:17 INFO - psutil == 3.1.1 04:02:17 INFO - requests == 1.2.3 04:02:17 INFO - wsgiref == 0.1.2 04:02:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:17 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 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:17 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 04:02:17 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 04:02:17 INFO - Using env: {'DISPLAY': ':0', 04:02:17 INFO - 'HOME': '/home/cltbld', 04:02:17 INFO - 'LANG': 'en_US.UTF-8', 04:02:17 INFO - 'LANGUAGE': 'en_US:en', 04:02:17 INFO - 'LOGNAME': 'cltbld', 04:02:17 INFO - 'MAIL': '/var/mail/cltbld', 04:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:17 INFO - 'MOZ_NO_REMOTE': '1', 04:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:17 INFO - 'NO_EM_RESTART': '1', 04:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:17 INFO - 'PWD': '/builds/slave/test', 04:02:17 INFO - 'SHELL': '/bin/bash', 04:02:17 INFO - 'SHLVL': '1', 04:02:17 INFO - 'TERM': 'linux', 04:02:17 INFO - 'TMOUT': '86400', 04:02:17 INFO - 'USER': 'cltbld', 04:02:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:17 INFO - '_': '/tools/buildbot/bin/python'} 04:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 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)) 04:02:18 INFO - Cleaning up... 04:02:18 INFO - Return code: 0 04:02:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:18 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 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:18 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 04:02:18 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 04:02:18 INFO - Using env: {'DISPLAY': ':0', 04:02:18 INFO - 'HOME': '/home/cltbld', 04:02:18 INFO - 'LANG': 'en_US.UTF-8', 04:02:18 INFO - 'LANGUAGE': 'en_US:en', 04:02:18 INFO - 'LOGNAME': 'cltbld', 04:02:18 INFO - 'MAIL': '/var/mail/cltbld', 04:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:18 INFO - 'MOZ_NO_REMOTE': '1', 04:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:18 INFO - 'NO_EM_RESTART': '1', 04:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:18 INFO - 'PWD': '/builds/slave/test', 04:02:18 INFO - 'SHELL': '/bin/bash', 04:02:18 INFO - 'SHLVL': '1', 04:02:18 INFO - 'TERM': 'linux', 04:02:18 INFO - 'TMOUT': '86400', 04:02:18 INFO - 'USER': 'cltbld', 04:02:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:18 INFO - '_': '/tools/buildbot/bin/python'} 04:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:18 INFO - Downloading/unpacking jsonschema 04:02:18 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 04:02:18 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 04:02:18 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 04:02:18 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 04:02:18 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 04:02:18 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 04:02:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:20 INFO - Downloading/unpacking functools32 (from jsonschema) 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:20 INFO - warning: no files found matching '*.txt' 04:02:20 INFO - no previously-included directories found matching 'build' 04:02:20 INFO - no previously-included directories found matching 'dist' 04:02:20 INFO - no previously-included directories found matching '.git*' 04:02:20 INFO - Installing collected packages: jsonschema, functools32 04:02:20 INFO - Running setup.py install for functools32 04:02:20 INFO - warning: no files found matching '*.txt' 04:02:20 INFO - no previously-included directories found matching 'build' 04:02:20 INFO - no previously-included directories found matching 'dist' 04:02:20 INFO - no previously-included directories found matching '.git*' 04:02:20 INFO - Successfully installed jsonschema functools32 04:02:20 INFO - Cleaning up... 04:02:20 INFO - Return code: 0 04:02:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:20 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 0x7f055e4aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', '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 04:02:20 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 04:02:20 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 04:02:20 INFO - Using env: {'DISPLAY': ':0', 04:02:20 INFO - 'HOME': '/home/cltbld', 04:02:20 INFO - 'LANG': 'en_US.UTF-8', 04:02:20 INFO - 'LANGUAGE': 'en_US:en', 04:02:20 INFO - 'LOGNAME': 'cltbld', 04:02:20 INFO - 'MAIL': '/var/mail/cltbld', 04:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:20 INFO - 'MOZ_NO_REMOTE': '1', 04:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:20 INFO - 'NO_EM_RESTART': '1', 04:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:20 INFO - 'PWD': '/builds/slave/test', 04:02:20 INFO - 'SHELL': '/bin/bash', 04:02:20 INFO - 'SHLVL': '1', 04:02:20 INFO - 'TERM': 'linux', 04:02:20 INFO - 'TMOUT': '86400', 04:02:20 INFO - 'USER': 'cltbld', 04:02:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:20 INFO - '_': '/tools/buildbot/bin/python'} 04:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:20 INFO - Downloading/unpacking flake8 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:02:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:02:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:02:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:23 INFO - no previously-included directories found matching 'docs/_build' 04:02:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:02:23 INFO - Running setup.py install for pep8 04:02:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:02:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:02:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:02:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:02:23 INFO - no previously-included directories found matching 'docs/_build' 04:02:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:02:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:02:23 INFO - Cleaning up... 04:02:23 INFO - Return code: 0 04:02:23 INFO - Running post-action listener: _resource_record_post_action 04:02:23 INFO - Running post-action listener: _start_resource_monitoring 04:02:23 INFO - Starting resource monitoring. 04:02:23 INFO - ##### 04:02:23 INFO - ##### Finished create-virtualenv step (success) 04:02:23 INFO - ##### 04:02:23 INFO - ##### 04:02:23 INFO - ##### Running install step. 04:02:23 INFO - ##### 04:02:23 INFO - Running pre-action listener: _resource_record_pre_action 04:02:23 INFO - Running main action method: install 04:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:24 INFO - Reading from file tmpfile_stdout 04:02:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:24 INFO - Reading from file tmpfile_stdout 04:02:24 INFO - Output received: 04:02:24 INFO - Usage: mozinstall [options] installer 04:02:24 INFO - Options: 04:02:24 INFO - -h, --help show this help message and exit 04:02:24 INFO - -d DEST, --destination=DEST 04:02:24 INFO - Directory to install application into. [default: 04:02:24 INFO - "/builds/slave/test"] 04:02:24 INFO - --app=APP Application being installed. [default: firefox] 04:02:24 INFO - mkdir: /builds/slave/test/build/application 04:02:24 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'] 04:02:24 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 04:02:40 INFO - Reading from file tmpfile_stdout 04:02:40 INFO - Output received: 04:02:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:40 INFO - Running post-action listener: _resource_record_post_action 04:02:40 INFO - ##### 04:02:40 INFO - ##### Finished install step (success) 04:02:40 INFO - ##### 04:02:40 INFO - ##### 04:02:40 INFO - ##### Running run-tests step. 04:02:40 INFO - ##### 04:02:40 INFO - Running pre-action listener: _resource_record_pre_action 04:02:40 INFO - Running main action method: run_tests 04:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:40 INFO - Python 2.7.3 04:02:40 INFO - Return code: 0 04:02:40 INFO - grabbing minidump binary from tooltool 04:02:40 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')]} 04:02:40 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 0x2b139c0>, '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 0x2b148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:40 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 04:02:40 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 04:02:40 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 04:02:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:40 INFO - Return code: 0 04:02:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:02:41 INFO - Return code: 0 04:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 04:02:41 INFO - Using env: {'DISPLAY': ':0', 04:02:41 INFO - 'HOME': '/home/cltbld', 04:02:41 INFO - 'LANG': 'en_US.UTF-8', 04:02:41 INFO - 'LANGUAGE': 'en_US:en', 04:02:41 INFO - 'LOGNAME': 'cltbld', 04:02:41 INFO - 'MAIL': '/var/mail/cltbld', 04:02:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:41 INFO - 'MOZ_NO_REMOTE': '1', 04:02:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:41 INFO - 'NO_EM_RESTART': '1', 04:02:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:41 INFO - 'PWD': '/builds/slave/test', 04:02:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:41 INFO - 'SHELL': '/bin/bash', 04:02:41 INFO - 'SHLVL': '1', 04:02:41 INFO - 'TERM': 'linux', 04:02:41 INFO - 'TMOUT': '86400', 04:02:41 INFO - 'USER': 'cltbld', 04:02:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759', 04:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:41 INFO - '_': '/tools/buildbot/bin/python'} 04:02:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 04:02:41 INFO - mozversion application_buildid: 20160512013006 04:02:41 INFO - mozversion application_changeset: 5190ada5abfef2d6308277f2948bc1286409d659 04:02:41 INFO - mozversion application_display_name: Nightly 04:02:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:41 INFO - mozversion application_name: Firefox 04:02:41 INFO - mozversion application_remotingname: firefox 04:02:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:02:41 INFO - mozversion application_vendor: Mozilla 04:02:41 INFO - mozversion application_version: 49.0a1 04:02:41 INFO - mozversion platform_buildid: 20160512013006 04:02:41 INFO - mozversion platform_changeset: 5190ada5abfef2d6308277f2948bc1286409d659 04:02:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:02:41 INFO - mozversion platform_version: 49.0a1 04:02:41 INFO - using testdate: 1463050961 04:02:41 INFO - actual date: 1463050961 04:02:41 INFO - starting webserver on 'localhost:48295' 04:02:41 INFO - SUITE-START | Running 2 tests 04:02:41 INFO - TEST-START | dromaeo_css 04:02:41 INFO - operating with platform_type : linux_ 04:02:41 INFO - Initialising browser for dromaeo_css test... 04:02:41 INFO - TEST-INFO | started process 5521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExAhYb/profile http://localhost:48295/getInfo.html) 04:02:45 INFO - PROCESS | 5521 | 04:02:45 INFO - PROCESS | 5521 | (process:5587): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:02:46 INFO - PROCESS | 5521 | __metrics Screen width/height:1600/1200 04:02:46 INFO - PROCESS | 5521 | colorDepth:24 04:02:46 INFO - PROCESS | 5521 | Browser inner width/height: 1024/697 04:02:46 INFO - PROCESS | 5521 | __metrics 04:02:47 ERROR - PROCESS | 5521 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:02:47 INFO - TEST-INFO | 5521: exit 0 04:02:47 INFO - Browser initialized. 04:02:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:47 INFO - TEST-INFO | started process 5639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExAhYb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:49 INFO - PROCESS | 5639 | 04:02:49 INFO - PROCESS | 5639 | (process:5700): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:02:59 INFO - PROCESS | 5639 | RSS: Main: 163319808 04:02:59 INFO - PROCESS | 5639 | 04:03:49 INFO - PROCESS | 5639 | 1463051029361 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] 04:05:57 INFO - PROCESS | 5639 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48295/tests/dromaeo/cssquery-ext.html) 04:05:58 INFO - PROCESS | 5639 | RSS: Main: 165289984 04:05:58 INFO - PROCESS | 5639 | 04:09:00 INFO - PROCESS | 5639 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-ext.html (next: http://localhost:48295/tests/dromaeo/cssquery-jquery.html) 04:09:00 INFO - PROCESS | 5639 | RSS: Main: 166084608 04:09:00 INFO - PROCESS | 5639 | 04:12:02 INFO - PROCESS | 5639 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48295/tests/dromaeo/cssquery-mootools.html) 04:12:03 INFO - PROCESS | 5639 | RSS: Main: 167309312 04:12:03 INFO - PROCESS | 5639 | 04:15:05 INFO - PROCESS | 5639 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48295/tests/dromaeo/cssquery-prototype.html) 04:15:05 INFO - PROCESS | 5639 | RSS: Main: 165388288 04:15:05 INFO - PROCESS | 5639 | 04:18:08 INFO - PROCESS | 5639 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48295/tests/dromaeo/cssquery-yui.html) 04:18:08 INFO - PROCESS | 5639 | RSS: Main: 166699008 04:18:08 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | Cycle 1(1): loaded http://localhost:48295/tests/dromaeo/cssquery-yui.html (next: http://localhost:48295/tests/dromaeo/cssquery-dojo.html) 04:21:11 INFO - PROCESS | 5639 | RSS: Main: 168497152 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | __start_tp_report 04:21:11 INFO - PROCESS | 5639 | _x_x_mozilla_page_load 04:21:11 INFO - PROCESS | 5639 | _x_x_mozilla_page_load_details 04:21:11 INFO - PROCESS | 5639 | |i|pagename|runs| 04:21:11 INFO - PROCESS | 5639 | |0;dojo.html;3121.765867559933;3202.167436466518;3207.037888633411;3215.1962009497624;3226.9677303226977;5441.56467482601;5476.972615136924;5484.095124304495;5500.257465242191;5574.526165275946;5311.389190243113;5439.891202175954;5464.0711079116545;5491.972540137303;5533.944660553393;4927.605791536668;4953.207486802113;5068.493150684939;5082.2376643503585;5132.589392848582;842.0602096311219;4828.348172996653;4896.485868983759;4984.77568509418;5014.548690617844;4957.231629097496;4959.479254678261;4990.076835785373;4990.101781679278;5005.599552035828;5005.774740136666;5005.774740136702;5018.723970181639;5021.5229553192385;5030.622703297267;4915.680480768774;4964.925526117111;5017.34774479319;5021.970496048301;5026.89946201074;5405.594580406446;5432.402435732066;5462.945370546323;5513.338399392059;5513.5037846594;5613.494785469286;5681.886362272773;5888.735006924656;5903.085021821625;5904.084866845646;5834.008218602848;5852;5883.38224486427;5967.552433567456;5972.163897054415;5490.313710786152;5494.09347457669;5505.119180931072;5524.116141417354;5532.170174473821;5804.535637149018;5871.853203669943;6015;6019.819405417845;6032.034874420159;5631.4087020863035;5665.9716701417055;5677;5684.37471878093;5688.829335119953;5763.077907534775;5782.971085144547;5792.0732682771395;5792.247007888947;5801.12983052537;5598.608097433141;5738.741756620962;5741.052726300114;5745.683987380734;5839.620424672383;5835.416458354215;5859.384764599656;5872.383399743051;5874.060150375919;5915.319738230072;4435.467743870756;4445.622122119591;4452.621527170227;4471.8658440246845;4491.438570178728;3879.2047630235734;3943.8225279862477;3978.2839088964265;3982.9601703983167;4045.959540404617;5610.663360198401;5627.943720562824;5647.407022262685;5651.9152212716845;5670.971645141748;5941.197938278364;5991.221141251696;6009.879802403927;6012.278526576839;6018.518518518508;5489.862753431196;5513.255710479114;5566.304211973504;5597.272354593877;5714.228579141763;4853.490383509751;4867.537583929521;4871.171900776876;4873;4925.87685307863;6096.451319381277;6103.938960610337;6104.298005729309;6127.111568822495;6147.84630384244;5643.068893632587;5875.177475153568;5913.438223368773;5921.6743079131065;5988.790392336247;6099.176611157437;6117.051856962178;6136.693165341804;6138.907916381348;6150.538709596709;5578.804741834017;5843.29880414353;5845.561582881216;5851.297844258716;5862.472377486047;5732.426757324234;5782.335031471266;5843.1235314703135;5856.150858125633;5864.882702346014;5626.915596265977;5718.7998420056765;5723.7996670116345;5738.8278351649515;5748.798792042258;5536.972315138399;5714.742836572447;5728.054870946414;5732.627379220337;5740.167675686918;5525.060739674184;5554.111342185231;5582.637128586629;5592.888142237214;5611.663300202001;5643.802466913638;5768.423157684198;5770.0190967536455;5773.181447844084;5783.306003279633;5506.697131657797;5609.382967873449;5646.237757902631;5648.23748793924;5663.9716801415725 04:21:11 INFO - PROCESS | 5639 | |1;ext.html;606.9362716914724;644.4200219802177;649.3117295666593;652.2857471069184;673.5352606701374;30161.245968850788;41838.16323673525;43170.56829431705;43356.13287734243;43393.56606433935;44724.776376118156;44805;45066.54933450664;45260.3210951836;45489.31766023512;8943.552822358872;9033.187013168814;9039.141281578239;9092.590833412512;9094.09059094092;8870.15733505316;8982.461052336848;8982.999999999967;9037.774055648595;9075.546222688872;9031.458112513237;9060;9063.682771103013;9070.09299070091;9077.273818094536;8939.284857211407;9017.864732029026;9023.819523609556;9030.593623286935;9041.95479022604;8794.780130496789;8883.955580222058;8893.866592001124;8898.59956301968;8939.374243802937;41020.38469422961;41474;41500;41580;41710;3420.196253880336;3519.472079188117;3522.084258092889;3561.6082230954576;3627.4196128619296;32133.6786632133;32202.6779732202;32336.353272934408;32522.674773252438;32771.83614081938;4267.167902259061;4326.307790753496;4384.714993525443;4457.843975460875;4472.418585583853;231929;232786;326485;330110;330198;58996.70501647464;59125;59476.405235947954;59605.403945960854;59722.40277597255;35833;36422.81788591093;36721.449178262345;38313.233735325135;60045;15435.768463473058;15446.304916278794;15470;15541.84458155404;15553.22233888301;13237.801432978513;13339.799903001463;13446.731065378637;13455.461781528826;13487.393067311994;19540.413787586396;19599.608007839764;19800.4059878201;19828.50428739293;19863.205471781257;7350.816229594303;7413.36986356155;7464.365528930101;7492.887606685904;7628.69485220596;996.4768496539375;1134.1493879590307;1169.2458364355114;1183.1717797541755;1183.355071486042;32430.189245268586;32792;33343.833280833926;33450.49824252638;33951;1135.39823893335;1139.680889350983;1153.8673052599058;1156.4564654612318;1245.2715161630547;17277.740833887503;17356.218970146372;17361;17372.13139343053;17451.912740436215;485406;486669;488720;489036;489479;57180.71409642925;58519.4148058514;58761;58784.706076469345;58965.70517147387;1415.242845077899;1417.7873319002026;1436.6049336432566;1438.280859570215;1460.6932544165631;30579.23551911131;31935.36129277355;32446.513302300013;33049.669503304656;33212.83393583017;52290;52529;52624;52775;52932.470675294295;397396;399504;401180;401678;401771;27912.162635120978;28863.42273154567;28979.710202897702;29192.562111567917;29224.70775292305;49119.754401227765;49145;49417;50064.249036263755;50126.74936625294;40683.59316406798;41296.79351603223;41362;41847.58152418559;42425;40082.39876401798;40318.79840600778;41503.58496415118;42127.57872421359;42860;38944;40708.389374160004;41809;42443.7877810609;45450.31824522701;34488.48267276043;37487;37996;40228;40968.18063638651;29168.124956251348;29275.41449170962;29326.85336573389;29423.264418388855;29600.851995739882 04:21:11 INFO - PROCESS | 5639 | |2;jquery.html;401.87541862022755;405.36357918068643;408.2467846822612;408.35276087401473;420.20161692783705;13631.727365452709;17522.474325770232;18630.34793782218;19508.609827803437;19659.213631454742;18305.359312424036;18459.44621661349;18734.531636709056;19340.323088691897;19353.80646193541;5521.972390138044;5573.888522229563;5744.396838331978;5805.071188609823;5807.73865176066;5671.8014869479575;5692.459216374458;5716.085426331788;5722.055860782966;5727.055035919068;5531.225628412006;5697.0599851024535;5737.225474560943;5739.368669446379;5752.884942301152;5696.544276457894;5700.116481945305;5706.572007099463;5718.685472299043;5725.541956643458;4938.876528086791;5119.206522988943;5122.846314610568;5149.227615857614;5150.639455238135;22170.224042158447;22307;22420.66369004466;22672.886635566883;22730.88634556833;2332.591796435617;2362.5629258587214;2378.9524209515885;2670.4792565449743;3121.190928164647;14239.857601423957;14400.207988560625;14405.135691858522;14698.485553005701;14954.775678364833;1965.665836807746;1981.7324661170846;2017.5157962088992;2030.056023948871;2056.4036429435446;84195.15804841995;84946.57526712389;85826;86138;86148;10195.949020254851;10274.640387586398;10681.465926703633;10802.135829133807;10854.29447085937;15157.545273641808;15163.848361516464;15224.086554806525;15238.542843714706;15252;8187.918120818835;8321.6671333146;8351.749447516584;8515.233628973423;8535.487870727777;8287.088420273765;8319.084900660922;8366.288865446506;8457.238848503664;8514.191151840565;6435.163428754326;6495.447886929664;6528.412442880163;6572.80281591553;6594.439472644783;1921.1738952250387;1929.4564348521128;1940.1560321260297;1959.206521358852;1984.128963394891;1070.3203465799118;1071.464267866067;1113.4265853085506;1124.3872089711126;1168.526746667584;17881.7317740234;19151.616967660568;19563.217471301272;19834.206631734858;19911.800881991283;1012.3268026762267;1038.7143535527791;1061.310148403544;1064.6646306413454;1117.279354816139;9663.420194788336;11106.944465277784;11139.888601113886;11416.94291528537;11441.54233830654;459271;467573;476076;480230;482488;63972.68013659902;70612;73753.6312318435;83890.58054709688;85930.57034714786;1048.496721573649;1063.7978784031009;1073.8765042020268;1093.781243751253;1102.1513434655271;17246.568835778704;17721.468355949342;17813.73279400836;17890.642187155925;18025.459236222934;36517.63482365249;37444.62555374411;37736.62263377331;37752;37761.62238377691;49556.25665615091;49565;50272.24591631055;50496.49503504918;50555;7609.277118673938;7756.806079848049;8047.51714897108;8221.342292616697;8753.64985400577;9687.88589312238;13766.174029558259;13960.30198490051;13985;14196.574102776933;11786.941065294619;11877.76244475123;12009.939950300193;12236.632901012983;12250.448729807002;11329;11777.52889884395;11958.222715523463;11973.76052478963;12195.817062743889;11528.135389845627;11740.236884602473;11990.340531270864;12024.519019239482;12364.505419783109;8123.83752324962;8188.303994160563;8325.318316597217;8336.707810289416;8400.705975290835;11245.831312530156;11663.533458661559;11783.76432471363;11931.985781208694;12023 04:21:11 INFO - PROCESS | 5639 | |3;mootools.html;1331.4407948661565;1424.7008128293057;1483.2583708145928;1815.0743121008297;1821.790494093179;7343.632818359088;8333.374996875236;8421.536815475147;8940.821183576325;9018.188363047333;8429.199226073513;8721.040685524587;8769.123087691227;8848.690295839648;8867.379283450162;2319.22306027481;2333.3116730564525;2343.6015877300815;2343.6484527320954;2348.8003519700846;2322.756110608387;2326.2904814031713;2337.9064837406568;2356.71719393673;2356.7643235676383;2239.0372139979804;2256.638937769957;2309.7459279479244;2354.2701762453694;2367.9644805327935;2341.613633750429;2351.6237402015768;2363.456405026845;2364.2788949370433;2367.4791545859885;2219.7669244729395;2224.710787597602;2235.48583825721;2248.2917880867476;2252.718410198725;8653.264472519844;8738.344624153215;8803.911960880374;8817.735467935972;8835.293176545925;5267.947320526822;5346.1713434417725;5392.325959255093;5394.352677678665;5404.891902161935;3175.5077962915784;3211.3898359311656;3374.8481318340732;3375.3080618473155;3396.4056290149124;1066.935983840972;1077.2459278505;1096.9177311701574;1117.6423544465774;1139.202558209257;12235.32705701195;12237.632871013884;12239.32683702396;12245.08161887862;12293.262404255773;4665.6967297125575;4713.410823647044;4812.687175333592;4832.589229915497;4934.629902757236;9700.90299097014;9722.368046076983;9857.605695772232;9865.309428339948;9869.21046316293;5361.731913404315;5372.462753724674;5407.864803379868;5422.620416570802;5429.239906413105;4323.092150648399;4790.616750659939;4885.193942999436;4892.755362231874;5073.822416215415;3848.13416981177;3851.4607954886337;3879.0690234343556;3899.590542992945;3981.427336202242;1173.7124404520946;1220.45079714129;1222.9266244025387;1223.6451429085466;1233.272369302116;872.6334939325499;963.8746962894779;968.7481254873784;978.0512902484578;981.7840075183448;5691.231683722727;5790.594658373873;5814.912776308359;5921.61509501881;5932.3474417814;445.7191969059472;458.6308022042288;459.8712360539054;472.9101470720552;1056.9947150264354;4040.5353384360587;4129.97935010329;4140.213359461753;4169.728967617095;4183.979080104641;10499.107575855985;10939.726506837393;10941.781164376667;11018.44907754609;11044.171687123498;10642.095421889226;10818.24272300947;10876.401797901191;10888.945555272332;10895.237333386587;8198.713045043514;8251.422400431911;8312.916870831214;8442.240198382053;8456.154384561618;5680.403557626555;5783.103618939072;5805.94194058054;5832.125181222681;5865.090910908816;9798.363106398061;10051.547680354548;10130;10230.6419275325;10313.432761198206;10202.33684810485;10315.587376505156;10351.343784994364;10458.424786636808;10488.580456781643;6634.137562116894;6980.616066116412;7085.964570177116;7362.190159082389;7494.138174110047;8648.43785153963;8692.521911294687;8776.122387761172;8791.780205494913;8828.161324674145;7741.690332386642;7853.37173026168;7885.802854928673;7955.761327160194;7977.561234131947;7706.576138312446;7721.729739459092;7788.415868809749;7856.882146767689;7954.5624990623755;7064.32888875556;7142.071530700976;7151.749688760869;7154.785356439315;7158.176809666955;4747.430308363018;4925.21196608541;5024.698518088926;5075.746212689424;5114.923276150935;4805.783739731791;5032.716657252524;5151.5363617274625;5182.637215394886;5243.030039442563 04:21:11 INFO - PROCESS | 5639 | |4;prototype.html;336.74070965356674;339.82668838892164;348.4946827100704;349.87451233754945;354.0546740203658;5499.945000550003;5600.5799565032685;5679.318481782187;5760.9630266552;5767.394423585521;5572.58205634578;5621.4659607337235;5636.971815140919;5646.548276137909;5647.689377084259;4312.870613881589;4325.82696692132;4326.242907491184;4327.545607711192;4368.62866656333;4081.265372232997;4324.524302326741;4333.285007973681;4360.21516127097;4364.607185353318;4259.936100958488;4268.765217913014;4280;4286.992556749177;4296.914061718764;4296.710986703992;4313.719608225471;4322.330038843984;4332.588404101605;4343.956560434387;3558.576569372246;3801.486799282089;3802.524684414448;3804.8205056432594;3806.8667596633986;5300.814471493479;5323.973380133113;5341.732913354355;5373.220882971987;5412.891742165135;4904.60763138948;4926.261060840867;4938.703677779309;4956.653034287601;4977.203647416432;5579.218909352694;5796.000379868939;5800.9709951450395;5824.126381042877;5825.563082768809;4114.7119701620895;4141.358089496133;4146;4153.854615088458;4163.500379954425;6066.211392518989;6093.512518998426;6110.969445152746;6139.969300153515;6157.107219453199;4148.8133034013545;4189.685773566995;4204.26425375558;4267.594578515098;4270.697437281597;4248.171606536757;4254.340577210537;4272.487301523837;4274.059706864485;4279.465066866642;4836.492168322346;4900.142475066849;4902.803887844518;4911.189653707098;4951.504849515091;5762.74067666956;5874;5875.6474611523445;5893.116032595145;5942.37605051472;1454.639911682559;1492.1271056431892;1498.4081287891222;1501.1743541052379;1506.540505145919;923.8244733500613;930.7859192385654;934.2152591822901;946.8485042393185;963.426761077158;5043.87390315245;5048.469910659402;5057;5079.415867175322;5126.436092029874;5311.867203319871;5320.281761962163;5330.320948901084;5334.3865455473115;5357.919631205457;5009.524095210949;5082.771275292621;5133.512316329943;5268.81559145428;5743.4256574342235;3227.4836026236158;3251.8211498367345;3252.837358132131;3273.688999545087;3275.6560561141214;6145.801568694151;6293.748250070037;6295.213098362705;6301.275353334334;6320.304766475684;6145.692715364214;6162.26052873649;6172.722227499773;6183.721732522047;6189.907151392733;6262;6278.089676996809;6284.214473190851;6287.559870808999;6331.258903801399;5820.341202757194;6026.035834266497;6043.153958445733;6065.090236464565;6107.236595425572;5897.587168898136;5946.643201407929;5947.940520594739;5969.552283578662;5997;6032.4570788629235;6247.5939063960695;6273.466755325666;6273.560850740587;6297.779577714758;4155.9584404156785;4175.561566035644;4179.725183818964;4189.769562674082;4234.597713217239;6041.75832966694;6055.818325450244;6062.636241825505;6064.939350606437;6071.908921366095;5564.693941833076;5904.439078287728;5930.703464826827;5931.13998470228;5957.599964008541;5827.659638283303;5874.559408044328;5876.147958546072;5895.145203945318;5902.704864756831;5656.264685590847;5766.452187042224;5778.653280803165;5782.595218334676;5795.478406943395;5921.61509501881;5957.195778569838;5964.135200396005;5969.552283578836;5980.19267398913;5762.8847423050465;5827.504662103769;5857.414258574108;5863.618864773776;5888.676122813115 04:21:11 INFO - PROCESS | 5639 | |5;yui.html;621.1118101115403;657.0538424668478;805.0580820440084;831.4927893984668;875.4528419737663;13136.146150500223;13194.802077968838;13984.510542131027;14065.929670351634;14068.929655351734;12463.314517701523;12466.750664986695;12495.875041249585;12502.56241031564;12518.311492867912;669.4343279928453;795.4948607634136;816.9714060007901;817.8609636361833;818.5088946632033;821.5563595658338;821.9342452603807;824.1675907333577;824.8886400335938;827.3877330775243;872.1017352127287;872.9214370706635;875.5928493250638;881.1232823340785;881.3698205782864;872.6116877989328;872.821071680304;875.2822685397977;876.4040452492303;880.5861245214771;640.1262276991872;640.8686219325074;641.4996302883758;641.5188608543592;641.6278558436096;11872.940635296854;11960.043196544255;11975.46110425033;11982.70043248917;11985.820212696817;13671.453141874314;13726.595590766401;13829.585112446643;13897.374618142208;13944.442222311096;10917.126629869592;10998.285111467729;11115.221934464591;11135.443227838576;11204.15968802343;3656.725745569093;3671.1005803578296;3676.3933950898067;3706.240220754739;3717.2937141942944;53892.46107538914;54087.72956135234;54331.45668543303;54984.45015549874;56664.15003774988;9993.850092248622;10097.141742951784;10540.578376864993;10679.825219225879;10680.839787403194;18631;19035.714464283046;19055.714164287547;19316.420507384802;19321.90339048296;7549;7680.846383072308;7705.1909549496495;7752.7674169775;7777.416693747991;4330.328799036154;4489.438820147481;4571.679982401267;4597.586217240398;4609.976950115228;3295.4727243641382;3364.444866597033;3365.764396492222;3376.206591451007;3376.2572234108457;631.5515983651567;633.0504243634548;640.5484133685741;647.847755777392;648.0764910003321;693.809202469325;707.678006507038;711.7544447165719;741.1217707017095;747.0064813797636;8165.795855103551;8396.06941912997;8448.629387056288;8480.279176269964;8679.739607811649;711.989320160198;721.4661150748514;723.2442098007594;725.6117976882342;742.985140297191;3845.9230815383535;4002.2795896738285;4029.879103626896;4036.8990775230855;4134.37984302357;56781.14828277579;57875.71062144746;58100;58275;58600;52531.21203181955;54456.18315725267;55017.44982550123;55022;55156.72421637866;48335.5166448331;48663;50440.49559504358;50783.49216507788;50897.23654145191;8783.472991620523;8843.204111629984;8892.510911899908;8993.505357205417;9084.682036128705;35397.82301088478;35407.822960886064;35422.291554169286;35525.46711799273;35573.46639800353;43812;45025.32462013138;46198.769006154755;46205.76897115493;47289.7635511834;12506.937465312616;12656;12702.667689762846;12702.87297127017;12826.74346513046;13411.329433528479;13575.728485430434;13879.167249965034;14252.643683907985;14352.354144063333;11518.596849110241;11691;12386.938065309976;12611.49554017829;12958.935205323913;13152.145110567782;13325.345115954278;13466.259355735529;13685.521006764715;13775.104618199784;10772.24594278393;12021.459034343301;12074.577389791315;12392.070594705252;12637.93681031589;11232.775344493228;11421.629394555395;11429.828552571884;11765.705857353634;11829;10623.683396064365;10637.703986522445;10947.50736216888;11043.72390690207;11316.717082072684 04:21:11 INFO - PROCESS | 5639 | __end_tp_report 04:21:11 INFO - PROCESS | 5639 | __start_cc_report 04:21:11 INFO - PROCESS | 5639 | _x_x_mozilla_cycle_collect,355 04:21:11 INFO - PROCESS | 5639 | __end_cc_report 04:21:11 INFO - PROCESS | 5639 | __startTimestamp1463052071501__endTimestamp 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | ------- Summary: start ------- 04:21:11 INFO - PROCESS | 5639 | Number of tests: 6 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | [#0] dojo.html Cycles:165 Average:5410.09 Median:5631.41 stddev:716.81 (12.7%) stddev-sans-first:696.16 04:21:11 INFO - PROCESS | 5639 | Values: 3121.8 3202.2 3207.0 3215.2 3227.0 5441.6 5477.0 5484.1 5500.3 5574.5 5311.4 5439.9 5464.1 5492.0 5533.9 4927.6 4953.2 5068.5 5082.2 5132.6 842.1 4828.3 4896.5 4984.8 5014.5 4957.2 4959.5 4990.1 4990.1 5005.6 5005.8 5005.8 5018.7 5021.5 5030.6 4915.7 4964.9 5017.3 5022.0 5026.9 5405.6 5432.4 5462.9 5513.3 5513.5 5613.5 5681.9 5888.7 5903.1 5904.1 5834.0 5852.0 5883.4 5967.6 5972.2 5490.3 5494.1 5505.1 5524.1 5532.2 5804.5 5871.9 6015.0 6019.8 6032.0 5631.4 5666.0 5677.0 5684.4 5688.8 5763.1 5783.0 5792.1 5792.2 5801.1 5598.6 5738.7 5741.1 5745.7 5839.6 5835.4 5859.4 5872.4 5874.1 5915.3 4435.5 4445.6 4452.6 4471.9 4491.4 3879.2 3943.8 3978.3 3983.0 4046.0 5610.7 5627.9 5647.4 5651.9 5671.0 5941.2 5991.2 6009.9 6012.3 6018.5 5489.9 5513.3 5566.3 5597.3 5714.2 4853.5 4867.5 4871.2 4873.0 4925.9 6096.5 6103.9 6104.3 6127.1 6147.8 5643.1 5875.2 5913.4 5921.7 5988.8 6099.2 6117.1 6136.7 6138.9 6150.5 5578.8 5843.3 5845.6 5851.3 5862.5 5732.4 5782.3 5843.1 5856.2 5864.9 5626.9 5718.8 5723.8 5738.8 5748.8 5537.0 5714.7 5728.1 5732.6 5740.2 5525.1 5554.1 5582.6 5592.9 5611.7 5643.8 5768.4 5770.0 5773.2 5783.3 5506.7 5609.4 5646.2 5648.2 5664.0 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | [#1] ext.html Cycles:180 Average:56017.41 Median:41329.40 stddev:106276.25 (257.1%) stddev-sans-first:106492.96 04:21:11 INFO - PROCESS | 5639 | Values: 606.9 644.4 649.3 652.3 673.5 30161.2 41838.2 43170.6 43356.1 43393.6 44724.8 44805.0 45066.5 45260.3 45489.3 8943.6 9033.2 9039.1 9092.6 9094.1 8870.2 8982.5 8983.0 9037.8 9075.5 9031.5 9060.0 9063.7 9070.1 9077.3 8939.3 9017.9 9023.8 9030.6 9042.0 8794.8 8884.0 8893.9 8898.6 8939.4 41020.4 41474.0 41500.0 41580.0 41710.0 3420.2 3519.5 3522.1 3561.6 3627.4 32133.7 32202.7 32336.4 32522.7 32771.8 4267.2 4326.3 4384.7 4457.8 4472.4 231929.0 232786.0 326485.0 330110.0 330198.0 58996.7 59125.0 59476.4 59605.4 59722.4 35833.0 36422.8 36721.4 38313.2 60045.0 15435.8 15446.3 15470.0 15541.8 15553.2 13237.8 13339.8 13446.7 13455.5 13487.4 19540.4 19599.6 19800.4 19828.5 19863.2 7350.8 7413.4 7464.4 7492.9 7628.7 996.5 1134.1 1169.2 1183.2 1183.4 32430.2 32792.0 33343.8 33450.5 33951.0 1135.4 1139.7 1153.9 1156.5 1245.3 17277.7 17356.2 17361.0 17372.1 17451.9 485406.0 486669.0 488720.0 489036.0 489479.0 57180.7 58519.4 58761.0 58784.7 58965.7 1415.2 1417.8 1436.6 1438.3 1460.7 30579.2 31935.4 32446.5 33049.7 33212.8 52290.0 52529.0 52624.0 52775.0 52932.5 397396.0 399504.0 401180.0 401678.0 401771.0 27912.2 28863.4 28979.7 29192.6 29224.7 49119.8 49145.0 49417.0 50064.2 50126.7 40683.6 41296.8 41362.0 41847.6 42425.0 40082.4 40318.8 41503.6 42127.6 42860.0 38944.0 40708.4 41809.0 42443.8 45450.3 34488.5 37487.0 37996.0 40228.0 40968.2 29168.1 29275.4 29326.9 29423.3 29600.9 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | [#2] jquery.html Cycles:180 Average:27985.72 Median:22546.78 stddev:77766.32 (344.9%) stddev-sans-first:77956.90 04:21:11 INFO - PROCESS | 5639 | Values: 401.9 405.4 408.2 408.4 420.2 13631.7 17522.5 18630.3 19508.6 19659.2 18305.4 18459.4 18734.5 19340.3 19353.8 5522.0 5573.9 5744.4 5805.1 5807.7 5671.8 5692.5 5716.1 5722.1 5727.1 5531.2 5697.1 5737.2 5739.4 5752.9 5696.5 5700.1 5706.6 5718.7 5725.5 4938.9 5119.2 5122.8 5149.2 5150.6 22170.2 22307.0 22420.7 22672.9 22730.9 2332.6 2362.6 2379.0 2670.5 3121.2 14239.9 14400.2 14405.1 14698.5 14954.8 1965.7 1981.7 2017.5 2030.1 2056.4 84195.2 84946.6 85826.0 86138.0 86148.0 10195.9 10274.6 10681.5 10802.1 10854.3 15157.5 15163.8 15224.1 15238.5 15252.0 8187.9 8321.7 8351.7 8515.2 8535.5 8287.1 8319.1 8366.3 8457.2 8514.2 6435.2 6495.4 6528.4 6572.8 6594.4 1921.2 1929.5 1940.2 1959.2 1984.1 1070.3 1071.5 1113.4 1124.4 1168.5 17881.7 19151.6 19563.2 19834.2 19911.8 1012.3 1038.7 1061.3 1064.7 1117.3 9663.4 11106.9 11139.9 11416.9 11441.5 459271.0 467573.0 476076.0 480230.0 482488.0 63972.7 70612.0 73753.6 83890.6 85930.6 1048.5 1063.8 1073.9 1093.8 1102.2 17246.6 17721.5 17813.7 17890.6 18025.5 36517.6 37444.6 37736.6 37752.0 37761.6 49556.3 49565.0 50272.2 50496.5 50555.0 7609.3 7756.8 8047.5 8221.3 8753.6 9687.9 13766.2 13960.3 13985.0 14196.6 11786.9 11877.8 12009.9 12236.6 12250.4 11329.0 11777.5 11958.2 11973.8 12195.8 11528.1 11740.2 11990.3 12024.5 12364.5 8123.8 8188.3 8325.3 8336.7 8400.7 11245.8 11663.5 11783.8 11932.0 12023.0 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | [#3] mootools.html Cycles:180 Average:5764.32 Median:4822.64 stddev:3295.29 (68.3%) stddev-sans-first:3287.69 04:21:11 INFO - PROCESS | 5639 | Values: 1331.4 1424.7 1483.3 1815.1 1821.8 7343.6 8333.4 8421.5 8940.8 9018.2 8429.2 8721.0 8769.1 8848.7 8867.4 2319.2 2333.3 2343.6 2343.6 2348.8 2322.8 2326.3 2337.9 2356.7 2356.8 2239.0 2256.6 2309.7 2354.3 2368.0 2341.6 2351.6 2363.5 2364.3 2367.5 2219.8 2224.7 2235.5 2248.3 2252.7 8653.3 8738.3 8803.9 8817.7 8835.3 5267.9 5346.2 5392.3 5394.4 5404.9 3175.5 3211.4 3374.8 3375.3 3396.4 1066.9 1077.2 1096.9 1117.6 1139.2 12235.3 12237.6 12239.3 12245.1 12293.3 4665.7 4713.4 4812.7 4832.6 4934.6 9700.9 9722.4 9857.6 9865.3 9869.2 5361.7 5372.5 5407.9 5422.6 5429.2 4323.1 4790.6 4885.2 4892.8 5073.8 3848.1 3851.5 3879.1 3899.6 3981.4 1173.7 1220.5 1222.9 1223.6 1233.3 872.6 963.9 968.7 978.1 981.8 5691.2 5790.6 5814.9 5921.6 5932.3 445.7 458.6 459.9 472.9 1057.0 4040.5 4130.0 4140.2 4169.7 4184.0 10499.1 10939.7 10941.8 11018.4 11044.2 10642.1 10818.2 10876.4 10888.9 10895.2 8198.7 8251.4 8312.9 8442.2 8456.2 5680.4 5783.1 5805.9 5832.1 5865.1 9798.4 10051.5 10130.0 10230.6 10313.4 10202.3 10315.6 10351.3 10458.4 10488.6 6634.1 6980.6 7086.0 7362.2 7494.1 8648.4 8692.5 8776.1 8791.8 8828.2 7741.7 7853.4 7885.8 7955.8 7977.6 7706.6 7721.7 7788.4 7856.9 7954.6 7064.3 7142.1 7151.7 7154.8 7158.2 4747.4 4925.2 5024.7 5075.7 5114.9 4805.8 5032.7 5151.5 5182.6 5243.0 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | [#4] prototype.html Cycles:180 Average:4888.02 Median:5568.64 stddev:1455.80 (26.1%) stddev-sans-first:1419.24 04:21:11 INFO - PROCESS | 5639 | Values: 336.7 339.8 348.5 349.9 354.1 5499.9 5600.6 5679.3 5761.0 5767.4 5572.6 5621.5 5637.0 5646.5 5647.7 4312.9 4325.8 4326.2 4327.5 4368.6 4081.3 4324.5 4333.3 4360.2 4364.6 4259.9 4268.8 4280.0 4287.0 4296.9 4296.7 4313.7 4322.3 4332.6 4344.0 3558.6 3801.5 3802.5 3804.8 3806.9 5300.8 5324.0 5341.7 5373.2 5412.9 4904.6 4926.3 4938.7 4956.7 4977.2 5579.2 5796.0 5801.0 5824.1 5825.6 4114.7 4141.4 4146.0 4153.9 4163.5 6066.2 6093.5 6111.0 6140.0 6157.1 4148.8 4189.7 4204.3 4267.6 4270.7 4248.2 4254.3 4272.5 4274.1 4279.5 4836.5 4900.1 4902.8 4911.2 4951.5 5762.7 5874.0 5875.6 5893.1 5942.4 1454.6 1492.1 1498.4 1501.2 1506.5 923.8 930.8 934.2 946.8 963.4 5043.9 5048.5 5057.0 5079.4 5126.4 5311.9 5320.3 5330.3 5334.4 5357.9 5009.5 5082.8 5133.5 5268.8 5743.4 3227.5 3251.8 3252.8 3273.7 3275.7 6145.8 6293.7 6295.2 6301.3 6320.3 6145.7 6162.3 6172.7 6183.7 6189.9 6262.0 6278.1 6284.2 6287.6 6331.3 5820.3 6026.0 6043.2 6065.1 6107.2 5897.6 5946.6 5947.9 5969.6 5997.0 6032.5 6247.6 6273.5 6273.6 6297.8 4156.0 4175.6 4179.7 4189.8 4234.6 6041.8 6055.8 6062.6 6064.9 6071.9 5564.7 5904.4 5930.7 5931.1 5957.6 5827.7 5874.6 5876.1 5895.1 5902.7 5656.3 5766.5 5778.7 5782.6 5795.5 5921.6 5957.2 5964.1 5969.6 5980.2 5762.9 5827.5 5857.4 5863.6 5888.7 04:21:11 INFO - PROCESS | 5639 | 04:21:11 INFO - PROCESS | 5639 | [#5] yui.html Cycles:180 Average:14578.42 Median:24150.72 stddev:16825.34 (69.7%) stddev-sans-first:16839.89 04:21:11 INFO - PROCESS | 5639 | Values: 621.1 657.1 805.1 831.5 875.5 13136.1 13194.8 13984.5 14065.9 14068.9 12463.3 12466.8 12495.9 12502.6 12518.3 669.4 795.5 817.0 817.9 818.5 821.6 821.9 824.2 824.9 827.4 872.1 872.9 875.6 881.1 881.4 872.6 872.8 875.3 876.4 880.6 640.1 640.9 641.5 641.5 641.6 11872.9 11960.0 11975.5 11982.7 11985.8 13671.5 13726.6 13829.6 13897.4 13944.4 10917.1 10998.3 11115.2 11135.4 11204.2 3656.7 3671.1 3676.4 3706.2 3717.3 53892.5 54087.7 54331.5 54984.5 56664.2 9993.9 10097.1 10540.6 10679.8 10680.8 18631.0 19035.7 19055.7 19316.4 19321.9 7549.0 7680.8 7705.2 7752.8 7777.4 4330.3 4489.4 4571.7 4597.6 4610.0 3295.5 3364.4 3365.8 3376.2 3376.3 631.6 633.1 640.5 647.8 648.1 693.8 707.7 711.8 741.1 747.0 8165.8 8396.1 8448.6 8480.3 8679.7 712.0 721.5 723.2 725.6 743.0 3845.9 4002.3 4029.9 4036.9 4134.4 56781.1 57875.7 58100.0 58275.0 58600.0 52531.2 54456.2 55017.4 55022.0 55156.7 48335.5 48663.0 50440.5 50783.5 50897.2 8783.5 8843.2 8892.5 8993.5 9084.7 35397.8 35407.8 35422.3 35525.5 35573.5 43812.0 45025.3 46198.8 46205.8 47289.8 12506.9 12656.0 12702.7 12702.9 12826.7 13411.3 13575.7 13879.2 14252.6 14352.4 11518.6 11691.0 12386.9 12611.5 12958.9 13152.1 13325.3 13466.3 13685.5 13775.1 10772.2 12021.5 12074.6 12392.1 12637.9 11232.8 11421.6 11429.8 11765.7 11829.0 10623.7 10637.7 10947.5 11043.7 11316.7 04:21:11 INFO - PROCESS | 5639 | -------- Summary: end -------- 04:21:11 INFO - PROCESS | 5639 | 04:21:12 INFO - TEST-INFO | 5639: exit 0 04:21:12 INFO - TEST-OK | dromaeo_css | took 1110357ms 04:21:12 INFO - TEST-START | kraken 04:21:12 INFO - operating with platform_type : linux_ 04:21:12 INFO - Initialising browser for kraken test... 04:21:12 INFO - TEST-INFO | started process 5876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZbmKOO/profile http://localhost:48295/getInfo.html) 04:21:15 INFO - PROCESS | 5876 | 04:21:15 INFO - PROCESS | 5876 | (process:5945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:21:16 INFO - PROCESS | 5876 | __metrics Screen width/height:1600/1200 04:21:16 INFO - PROCESS | 5876 | colorDepth:24 04:21:16 INFO - PROCESS | 5876 | Browser inner width/height: 1024/697 04:21:16 INFO - PROCESS | 5876 | __metrics 04:21:17 ERROR - PROCESS | 5876 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:21:18 INFO - TEST-INFO | 5876: exit 0 04:21:18 INFO - Browser initialized. 04:21:18 INFO - Running cycle 1/1 for kraken test... 04:21:18 INFO - TEST-INFO | started process 5996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZbmKOO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:20 INFO - PROCESS | 5996 | 04:21:20 INFO - PROCESS | 5996 | (process:6058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:21:30 INFO - PROCESS | 5996 | RSS: Main: 163192832 04:21:30 INFO - PROCESS | 5996 | 04:21:32 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:33 INFO - PROCESS | 5996 | RSS: Main: 167497728 04:21:33 INFO - PROCESS | 5996 | 04:21:36 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-dft) 04:21:36 INFO - PROCESS | 5996 | RSS: Main: 167616512 04:21:36 INFO - PROCESS | 5996 | 04:21:39 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-fft) 04:21:40 INFO - PROCESS | 5996 | RSS: Main: 162598912 04:21:40 INFO - PROCESS | 5996 | 04:21:42 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48295/tests/kraken/driver.html?testName=audio-oscillator) 04:21:43 INFO - PROCESS | 5996 | RSS: Main: 162799616 04:21:43 INFO - PROCESS | 5996 | 04:21:45 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:46 INFO - PROCESS | 5996 | RSS: Main: 163274752 04:21:46 INFO - PROCESS | 5996 | 04:21:49 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48295/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:49 INFO - PROCESS | 5996 | RSS: Main: 163266560 04:21:49 INFO - PROCESS | 5996 | 04:21:53 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48295/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:54 INFO - PROCESS | 5996 | RSS: Main: 162054144 04:21:54 INFO - PROCESS | 5996 | 04:21:56 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48295/tests/kraken/driver.html?testName=json-parse-financial) 04:21:57 INFO - PROCESS | 5996 | RSS: Main: 162529280 04:21:57 INFO - PROCESS | 5996 | 04:21:59 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:59 INFO - PROCESS | 5996 | RSS: Main: 162689024 04:21:59 INFO - PROCESS | 5996 | 04:22:01 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:02 INFO - PROCESS | 5996 | RSS: Main: 162717696 04:22:02 INFO - PROCESS | 5996 | 04:22:04 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:05 INFO - PROCESS | 5996 | RSS: Main: 163115008 04:22:05 INFO - PROCESS | 5996 | 04:22:07 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:08 INFO - PROCESS | 5996 | RSS: Main: 163782656 04:22:08 INFO - PROCESS | 5996 | 04:22:11 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:12 INFO - PROCESS | 5996 | RSS: Main: 163528704 04:22:12 INFO - PROCESS | 5996 | 04:22:13 INFO - PROCESS | 5996 | Cycle 1(1): loaded http://localhost:48295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48295/tests/kraken/driver.html?testName=ai-astar) 04:22:13 INFO - PROCESS | 5996 | RSS: Main: 165281792 04:22:13 INFO - PROCESS | 5996 | 04:22:13 INFO - PROCESS | 5996 | __start_tp_report 04:22:13 INFO - PROCESS | 5996 | _x_x_mozilla_page_load 04:22:13 INFO - PROCESS | 5996 | _x_x_mozilla_page_load_details 04:22:13 INFO - PROCESS | 5996 | |i|pagename|runs| 04:22:13 INFO - PROCESS | 5996 | |0;ai-astar;110;114;103;112;114;110;107;110;110;111 04:22:13 INFO - PROCESS | 5996 | |1;audio-beat-detection;157;126;155;207;127;150;160;130;192;131 04:22:13 INFO - PROCESS | 5996 | |2;audio-dft;167;161;162;165;164;172;163;161;160;163 04:22:13 INFO - PROCESS | 5996 | |3;audio-fft;74;75;75;165;77;74;75;75;162;75 04:22:13 INFO - PROCESS | 5996 | |4;audio-oscillator;93;93;188;92;92;92;148;100;92;141 04:22:13 INFO - PROCESS | 5996 | |5;imaging-gaussian-blur;118;117;117;117;117;118;122;120;122;122 04:22:13 INFO - PROCESS | 5996 | |6;imaging-darkroom;147;146;147;147;146;146;147;146;146;148 04:22:13 INFO - PROCESS | 5996 | |7;imaging-desaturate;95;96;94;95;95;96;96;95;95;96 04:22:13 INFO - PROCESS | 5996 | |8;json-parse-financial;61;61;61;61;61;61;61;111;60;58 04:22:13 INFO - PROCESS | 5996 | |9;json-stringify-tinderbox;59;59;59;59;59;59;59;58;58;59 04:22:13 INFO - PROCESS | 5996 | |10;stanford-crypto-aes;79;80;79;80;80;86;86;82;81;80 04:22:13 INFO - PROCESS | 5996 | |11;stanford-crypto-ccm;124;133;128;126;125;122;123;135;195;128 04:22:13 INFO - PROCESS | 5996 | |12;stanford-crypto-pbkdf2;174;174;173;175;177;180;176;182;174;171 04:22:13 INFO - PROCESS | 5996 | |13;stanford-crypto-sha256-iterative;68;66;70;64;64;65;69;64;66;64 04:22:13 INFO - PROCESS | 5996 | __end_tp_report 04:22:13 INFO - PROCESS | 5996 | __start_cc_report 04:22:13 INFO - PROCESS | 5996 | _x_x_mozilla_cycle_collect,920 04:22:13 INFO - PROCESS | 5996 | __end_cc_report 04:22:13 INFO - PROCESS | 5996 | __startTimestamp1463052133987__endTimestamp 04:22:13 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | ------- Summary: start ------- 04:22:14 INFO - PROCESS | 5996 | Number of tests: 14 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:3.25 (2.9%) stddev-sans-first:3.44 04:22:14 INFO - PROCESS | 5996 | Values: 110.0 114.0 103.0 112.0 114.0 110.0 107.0 110.0 110.0 111.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:156.00 stddev:27.75 (17.8%) stddev-sans-first:29.40 04:22:14 INFO - PROCESS | 5996 | Values: 157.0 126.0 155.0 207.0 127.0 150.0 160.0 130.0 192.0 131.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.55 (2.2%) stddev-sans-first:3.57 04:22:14 INFO - PROCESS | 5996 | Values: 167.0 161.0 162.0 165.0 164.0 172.0 163.0 161.0 160.0 163.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:37.33 (49.8%) stddev-sans-first:38.98 04:22:14 INFO - PROCESS | 5996 | Values: 74.0 75.0 75.0 165.0 77.0 74.0 75.0 75.0 162.0 75.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#4] audio-oscillator Cycles:10 Average:113.10 Median:92.00 stddev:33.94 (36.9%) stddev-sans-first:35.21 04:22:14 INFO - PROCESS | 5996 | Values: 93.0 93.0 188.0 92.0 92.0 92.0 148.0 100.0 92.0 141.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:119.00 stddev:2.26 (1.9%) stddev-sans-first:2.37 04:22:14 INFO - PROCESS | 5996 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 122.0 120.0 122.0 122.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:22:14 INFO - PROCESS | 5996 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 148.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:22:14 INFO - PROCESS | 5996 | Values: 95.0 96.0 94.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:61.00 stddev:15.98 (26.2%) stddev-sans-first:16.86 04:22:14 INFO - PROCESS | 5996 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 111.0 60.0 58.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 04:22:14 INFO - PROCESS | 5996 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:2.63 (3.3%) stddev-sans-first:2.65 04:22:14 INFO - PROCESS | 5996 | Values: 79.0 80.0 79.0 80.0 80.0 86.0 86.0 82.0 81.0 80.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:128.00 stddev:21.87 (17.1%) stddev-sans-first:22.90 04:22:14 INFO - PROCESS | 5996 | Values: 124.0 133.0 128.0 126.0 125.0 122.0 123.0 135.0 195.0 128.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:175.50 stddev:3.31 (1.9%) stddev-sans-first:3.46 04:22:14 INFO - PROCESS | 5996 | Values: 174.0 174.0 173.0 175.0 177.0 180.0 176.0 182.0 174.0 171.0 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - PROCESS | 5996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:2.26 (3.4%) stddev-sans-first:2.28 04:22:14 INFO - PROCESS | 5996 | Values: 68.0 66.0 70.0 64.0 64.0 65.0 69.0 64.0 66.0 64.0 04:22:14 INFO - PROCESS | 5996 | -------- Summary: end -------- 04:22:14 INFO - PROCESS | 5996 | 04:22:14 INFO - TEST-INFO | 5996: exit 0 04:22:14 INFO - TEST-OK | kraken | took 62693ms 04:22:14 INFO - SUITE-END | took 1173s 04:22:15 INFO - Completed test suite (00:19:33) 04:22:15 INFO - javascript benchmark 04:22:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7157.527592334732, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.765867559933, 3202.167436466518, 3207.037888633411, 3215.1962009497624, 3226.9677303226977, 5441.56467482601, 5476.972615136924, 5484.095124304495, 5500.257465242191, 5574.526165275946, 5311.389190243113, 5439.891202175954, 5464.0711079116545, 5491.972540137303, 5533.944660553393, 4927.605791536668, 4953.207486802113, 5068.493150684939, 5082.2376643503585, 5132.589392848582, 842.0602096311219, 4828.348172996653, 4896.485868983759, 4984.77568509418, 5014.548690617844, 4957.231629097496, 4959.479254678261, 4990.076835785373, 4990.101781679278, 5005.599552035828, 5005.774740136666, 5005.774740136702, 5018.723970181639, 5021.5229553192385, 5030.622703297267, 4915.680480768774, 4964.925526117111, 5017.34774479319, 5021.970496048301, 5026.89946201074, 5405.594580406446, 5432.402435732066, 5462.945370546323, 5513.338399392059, 5513.5037846594, 5613.494785469286, 5681.886362272773, 5888.735006924656, 5903.085021821625, 5904.084866845646, 5834.008218602848, 5852.0, 5883.38224486427, 5967.552433567456, 5972.163897054415, 5490.313710786152, 5494.09347457669, 5505.119180931072, 5524.116141417354, 5532.170174473821, 5804.535637149018, 5871.853203669943, 6015.0, 6019.819405417845, 6032.034874420159, 5631.4087020863035, 5665.9716701417055, 5677.0, 5684.37471878093, 5688.829335119953, 5763.077907534775, 5782.971085144547, 5792.0732682771395, 5792.247007888947, 5801.12983052537, 5598.608097433141, 5738.741756620962, 5741.052726300114, 5745.683987380734, 5839.620424672383, 5835.416458354215, 5859.384764599656, 5872.383399743051, 5874.060150375919, 5915.319738230072, 4435.467743870756, 4445.622122119591, 4452.621527170227, 4471.8658440246845, 4491.438570178728, 3879.2047630235734, 3943.8225279862477, 3978.2839088964265, 3982.9601703983167, 4045.959540404617, 5610.663360198401, 5627.943720562824, 5647.407022262685, 5651.9152212716845, 5670.971645141748, 5941.197938278364, 5991.221141251696, 6009.879802403927, 6012.278526576839, 6018.518518518508, 5489.862753431196, 5513.255710479114, 5566.304211973504, 5597.272354593877, 5714.228579141763, 4853.490383509751, 4867.537583929521, 4871.171900776876, 4873.0, 4925.87685307863, 6096.451319381277, 6103.938960610337, 6104.298005729309, 6127.111568822495, 6147.84630384244, 5643.068893632587, 5875.177475153568, 5913.438223368773, 5921.6743079131065, 5988.790392336247, 6099.176611157437, 6117.051856962178, 6136.693165341804, 6138.907916381348, 6150.538709596709, 5578.804741834017, 5843.29880414353, 5845.561582881216, 5851.297844258716, 5862.472377486047, 5732.426757324234, 5782.335031471266, 5843.1235314703135, 5856.150858125633, 5864.882702346014, 5626.915596265977, 5718.7998420056765, 5723.7996670116345, 5738.8278351649515, 5748.798792042258, 5536.972315138399, 5714.742836572447, 5728.054870946414, 5732.627379220337, 5740.167675686918, 5525.060739674184, 5554.111342185231, 5582.637128586629, 5592.888142237214, 5611.663300202001, 5643.802466913638, 5768.423157684198, 5770.0190967536455, 5773.181447844084, 5783.306003279633, 5506.697131657797, 5609.382967873449, 5646.237757902631, 5648.23748793924, 5663.9716801415725], "value": 5363.294227748509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.9362716914724, 644.4200219802177, 649.3117295666593, 652.2857471069184, 673.5352606701374, 30161.245968850788, 41838.16323673525, 43170.56829431705, 43356.13287734243, 43393.56606433935, 44724.776376118156, 44805.0, 45066.54933450664, 45260.3210951836, 45489.31766023512, 8943.552822358872, 9033.187013168814, 9039.141281578239, 9092.590833412512, 9094.09059094092, 8870.15733505316, 8982.461052336848, 8982.999999999967, 9037.774055648595, 9075.546222688872, 9031.458112513237, 9060.0, 9063.682771103013, 9070.09299070091, 9077.273818094536, 8939.284857211407, 9017.864732029026, 9023.819523609556, 9030.593623286935, 9041.95479022604, 8794.780130496789, 8883.955580222058, 8893.866592001124, 8898.59956301968, 8939.374243802937, 41020.38469422961, 41474.0, 41500.0, 41580.0, 41710.0, 3420.196253880336, 3519.472079188117, 3522.084258092889, 3561.6082230954576, 3627.4196128619296, 32133.6786632133, 32202.6779732202, 32336.353272934408, 32522.674773252438, 32771.83614081938, 4267.167902259061, 4326.307790753496, 4384.714993525443, 4457.843975460875, 4472.418585583853, 231929.0, 232786.0, 326485.0, 330110.0, 330198.0, 58996.70501647464, 59125.0, 59476.405235947954, 59605.403945960854, 59722.40277597255, 35833.0, 36422.81788591093, 36721.449178262345, 38313.233735325135, 60045.0, 15435.768463473058, 15446.304916278794, 15470.0, 15541.84458155404, 15553.22233888301, 13237.801432978513, 13339.799903001463, 13446.731065378637, 13455.461781528826, 13487.393067311994, 19540.413787586396, 19599.608007839764, 19800.4059878201, 19828.50428739293, 19863.205471781257, 7350.816229594303, 7413.36986356155, 7464.365528930101, 7492.887606685904, 7628.69485220596, 996.4768496539375, 1134.1493879590307, 1169.2458364355114, 1183.1717797541755, 1183.355071486042, 32430.189245268586, 32792.0, 33343.833280833926, 33450.49824252638, 33951.0, 1135.39823893335, 1139.680889350983, 1153.8673052599058, 1156.4564654612318, 1245.2715161630547, 17277.740833887503, 17356.218970146372, 17361.0, 17372.13139343053, 17451.912740436215, 485406.0, 486669.0, 488720.0, 489036.0, 489479.0, 57180.71409642925, 58519.4148058514, 58761.0, 58784.706076469345, 58965.70517147387, 1415.242845077899, 1417.7873319002026, 1436.6049336432566, 1438.280859570215, 1460.6932544165631, 30579.23551911131, 31935.36129277355, 32446.513302300013, 33049.669503304656, 33212.83393583017, 52290.0, 52529.0, 52624.0, 52775.0, 52932.470675294295, 397396.0, 399504.0, 401180.0, 401678.0, 401771.0, 27912.162635120978, 28863.42273154567, 28979.710202897702, 29192.562111567917, 29224.70775292305, 49119.754401227765, 49145.0, 49417.0, 50064.249036263755, 50126.74936625294, 40683.59316406798, 41296.79351603223, 41362.0, 41847.58152418559, 42425.0, 40082.39876401798, 40318.79840600778, 41503.58496415118, 42127.57872421359, 42860.0, 38944.0, 40708.389374160004, 41809.0, 42443.7877810609, 45450.31824522701, 34488.48267276043, 37487.0, 37996.0, 40228.0, 40968.18063638651, 29168.124956251348, 29275.41449170962, 29326.85336573389, 29423.264418388855, 29600.851995739882], "value": 20063.572297753617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.87541862022755, 405.36357918068643, 408.2467846822612, 408.35276087401473, 420.20161692783705, 13631.727365452709, 17522.474325770232, 18630.34793782218, 19508.609827803437, 19659.213631454742, 18305.359312424036, 18459.44621661349, 18734.531636709056, 19340.323088691897, 19353.80646193541, 5521.972390138044, 5573.888522229563, 5744.396838331978, 5805.071188609823, 5807.73865176066, 5671.8014869479575, 5692.459216374458, 5716.085426331788, 5722.055860782966, 5727.055035919068, 5531.225628412006, 5697.0599851024535, 5737.225474560943, 5739.368669446379, 5752.884942301152, 5696.544276457894, 5700.116481945305, 5706.572007099463, 5718.685472299043, 5725.541956643458, 4938.876528086791, 5119.206522988943, 5122.846314610568, 5149.227615857614, 5150.639455238135, 22170.224042158447, 22307.0, 22420.66369004466, 22672.886635566883, 22730.88634556833, 2332.591796435617, 2362.5629258587214, 2378.9524209515885, 2670.4792565449743, 3121.190928164647, 14239.857601423957, 14400.207988560625, 14405.135691858522, 14698.485553005701, 14954.775678364833, 1965.665836807746, 1981.7324661170846, 2017.5157962088992, 2030.056023948871, 2056.4036429435446, 84195.15804841995, 84946.57526712389, 85826.0, 86138.0, 86148.0, 10195.949020254851, 10274.640387586398, 10681.465926703633, 10802.135829133807, 10854.29447085937, 15157.545273641808, 15163.848361516464, 15224.086554806525, 15238.542843714706, 15252.0, 8187.918120818835, 8321.6671333146, 8351.749447516584, 8515.233628973423, 8535.487870727777, 8287.088420273765, 8319.084900660922, 8366.288865446506, 8457.238848503664, 8514.191151840565, 6435.163428754326, 6495.447886929664, 6528.412442880163, 6572.80281591553, 6594.439472644783, 1921.1738952250387, 1929.4564348521128, 1940.1560321260297, 1959.206521358852, 1984.128963394891, 1070.3203465799118, 1071.464267866067, 1113.4265853085506, 1124.3872089711126, 1168.526746667584, 17881.7317740234, 19151.616967660568, 19563.217471301272, 19834.206631734858, 19911.800881991283, 1012.3268026762267, 1038.7143535527791, 1061.310148403544, 1064.6646306413454, 1117.279354816139, 9663.420194788336, 11106.944465277784, 11139.888601113886, 11416.94291528537, 11441.54233830654, 459271.0, 467573.0, 476076.0, 480230.0, 482488.0, 63972.68013659902, 70612.0, 73753.6312318435, 83890.58054709688, 85930.57034714786, 1048.496721573649, 1063.7978784031009, 1073.8765042020268, 1093.781243751253, 1102.1513434655271, 17246.568835778704, 17721.468355949342, 17813.73279400836, 17890.642187155925, 18025.459236222934, 36517.63482365249, 37444.62555374411, 37736.62263377331, 37752.0, 37761.62238377691, 49556.25665615091, 49565.0, 50272.24591631055, 50496.49503504918, 50555.0, 7609.277118673938, 7756.806079848049, 8047.51714897108, 8221.342292616697, 8753.64985400577, 9687.88589312238, 13766.174029558259, 13960.30198490051, 13985.0, 14196.574102776933, 11786.941065294619, 11877.76244475123, 12009.939950300193, 12236.632901012983, 12250.448729807002, 11329.0, 11777.52889884395, 11958.222715523463, 11973.76052478963, 12195.817062743889, 11528.135389845627, 11740.236884602473, 11990.340531270864, 12024.519019239482, 12364.505419783109, 8123.83752324962, 8188.303994160563, 8325.318316597217, 8336.707810289416, 8400.705975290835, 11245.831312530156, 11663.533458661559, 11783.76432471363, 11931.985781208694, 12023.0], "value": 9338.986095539763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.4407948661565, 1424.7008128293057, 1483.2583708145928, 1815.0743121008297, 1821.790494093179, 7343.632818359088, 8333.374996875236, 8421.536815475147, 8940.821183576325, 9018.188363047333, 8429.199226073513, 8721.040685524587, 8769.123087691227, 8848.690295839648, 8867.379283450162, 2319.22306027481, 2333.3116730564525, 2343.6015877300815, 2343.6484527320954, 2348.8003519700846, 2322.756110608387, 2326.2904814031713, 2337.9064837406568, 2356.71719393673, 2356.7643235676383, 2239.0372139979804, 2256.638937769957, 2309.7459279479244, 2354.2701762453694, 2367.9644805327935, 2341.613633750429, 2351.6237402015768, 2363.456405026845, 2364.2788949370433, 2367.4791545859885, 2219.7669244729395, 2224.710787597602, 2235.48583825721, 2248.2917880867476, 2252.718410198725, 8653.264472519844, 8738.344624153215, 8803.911960880374, 8817.735467935972, 8835.293176545925, 5267.947320526822, 5346.1713434417725, 5392.325959255093, 5394.352677678665, 5404.891902161935, 3175.5077962915784, 3211.3898359311656, 3374.8481318340732, 3375.3080618473155, 3396.4056290149124, 1066.935983840972, 1077.2459278505, 1096.9177311701574, 1117.6423544465774, 1139.202558209257, 12235.32705701195, 12237.632871013884, 12239.32683702396, 12245.08161887862, 12293.262404255773, 4665.6967297125575, 4713.410823647044, 4812.687175333592, 4832.589229915497, 4934.629902757236, 9700.90299097014, 9722.368046076983, 9857.605695772232, 9865.309428339948, 9869.21046316293, 5361.731913404315, 5372.462753724674, 5407.864803379868, 5422.620416570802, 5429.239906413105, 4323.092150648399, 4790.616750659939, 4885.193942999436, 4892.755362231874, 5073.822416215415, 3848.13416981177, 3851.4607954886337, 3879.0690234343556, 3899.590542992945, 3981.427336202242, 1173.7124404520946, 1220.45079714129, 1222.9266244025387, 1223.6451429085466, 1233.272369302116, 872.6334939325499, 963.8746962894779, 968.7481254873784, 978.0512902484578, 981.7840075183448, 5691.231683722727, 5790.594658373873, 5814.912776308359, 5921.61509501881, 5932.3474417814, 445.7191969059472, 458.6308022042288, 459.8712360539054, 472.9101470720552, 1056.9947150264354, 4040.5353384360587, 4129.97935010329, 4140.213359461753, 4169.728967617095, 4183.979080104641, 10499.107575855985, 10939.726506837393, 10941.781164376667, 11018.44907754609, 11044.171687123498, 10642.095421889226, 10818.24272300947, 10876.401797901191, 10888.945555272332, 10895.237333386587, 8198.713045043514, 8251.422400431911, 8312.916870831214, 8442.240198382053, 8456.154384561618, 5680.403557626555, 5783.103618939072, 5805.94194058054, 5832.125181222681, 5865.090910908816, 9798.363106398061, 10051.547680354548, 10130.0, 10230.6419275325, 10313.432761198206, 10202.33684810485, 10315.587376505156, 10351.343784994364, 10458.424786636808, 10488.580456781643, 6634.137562116894, 6980.616066116412, 7085.964570177116, 7362.190159082389, 7494.138174110047, 8648.43785153963, 8692.521911294687, 8776.122387761172, 8791.780205494913, 8828.161324674145, 7741.690332386642, 7853.37173026168, 7885.802854928673, 7955.761327160194, 7977.561234131947, 7706.576138312446, 7721.729739459092, 7788.415868809749, 7856.882146767689, 7954.5624990623755, 7064.32888875556, 7142.071530700976, 7151.749688760869, 7154.785356439315, 7158.176809666955, 4747.430308363018, 4925.21196608541, 5024.698518088926, 5075.746212689424, 5114.923276150935, 4805.783739731791, 5032.716657252524, 5151.5363617274625, 5182.637215394886, 5243.030039442563], "value": 4555.095493235101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.74070965356674, 339.82668838892164, 348.4946827100704, 349.87451233754945, 354.0546740203658, 5499.945000550003, 5600.5799565032685, 5679.318481782187, 5760.9630266552, 5767.394423585521, 5572.58205634578, 5621.4659607337235, 5636.971815140919, 5646.548276137909, 5647.689377084259, 4312.870613881589, 4325.82696692132, 4326.242907491184, 4327.545607711192, 4368.62866656333, 4081.265372232997, 4324.524302326741, 4333.285007973681, 4360.21516127097, 4364.607185353318, 4259.936100958488, 4268.765217913014, 4280.0, 4286.992556749177, 4296.914061718764, 4296.710986703992, 4313.719608225471, 4322.330038843984, 4332.588404101605, 4343.956560434387, 3558.576569372246, 3801.486799282089, 3802.524684414448, 3804.8205056432594, 3806.8667596633986, 5300.814471493479, 5323.973380133113, 5341.732913354355, 5373.220882971987, 5412.891742165135, 4904.60763138948, 4926.261060840867, 4938.703677779309, 4956.653034287601, 4977.203647416432, 5579.218909352694, 5796.000379868939, 5800.9709951450395, 5824.126381042877, 5825.563082768809, 4114.7119701620895, 4141.358089496133, 4146.0, 4153.854615088458, 4163.500379954425, 6066.211392518989, 6093.512518998426, 6110.969445152746, 6139.969300153515, 6157.107219453199, 4148.8133034013545, 4189.685773566995, 4204.26425375558, 4267.594578515098, 4270.697437281597, 4248.171606536757, 4254.340577210537, 4272.487301523837, 4274.059706864485, 4279.465066866642, 4836.492168322346, 4900.142475066849, 4902.803887844518, 4911.189653707098, 4951.504849515091, 5762.74067666956, 5874.0, 5875.6474611523445, 5893.116032595145, 5942.37605051472, 1454.639911682559, 1492.1271056431892, 1498.4081287891222, 1501.1743541052379, 1506.540505145919, 923.8244733500613, 930.7859192385654, 934.2152591822901, 946.8485042393185, 963.426761077158, 5043.87390315245, 5048.469910659402, 5057.0, 5079.415867175322, 5126.436092029874, 5311.867203319871, 5320.281761962163, 5330.320948901084, 5334.3865455473115, 5357.919631205457, 5009.524095210949, 5082.771275292621, 5133.512316329943, 5268.81559145428, 5743.4256574342235, 3227.4836026236158, 3251.8211498367345, 3252.837358132131, 3273.688999545087, 3275.6560561141214, 6145.801568694151, 6293.748250070037, 6295.213098362705, 6301.275353334334, 6320.304766475684, 6145.692715364214, 6162.26052873649, 6172.722227499773, 6183.721732522047, 6189.907151392733, 6262.0, 6278.089676996809, 6284.214473190851, 6287.559870808999, 6331.258903801399, 5820.341202757194, 6026.035834266497, 6043.153958445733, 6065.090236464565, 6107.236595425572, 5897.587168898136, 5946.643201407929, 5947.940520594739, 5969.552283578662, 5997.0, 6032.4570788629235, 6247.5939063960695, 6273.466755325666, 6273.560850740587, 6297.779577714758, 4155.9584404156785, 4175.561566035644, 4179.725183818964, 4189.769562674082, 4234.597713217239, 6041.75832966694, 6055.818325450244, 6062.636241825505, 6064.939350606437, 6071.908921366095, 5564.693941833076, 5904.439078287728, 5930.703464826827, 5931.13998470228, 5957.599964008541, 5827.659638283303, 5874.559408044328, 5876.147958546072, 5895.145203945318, 5902.704864756831, 5656.264685590847, 5766.452187042224, 5778.653280803165, 5782.595218334676, 5795.478406943395, 5921.61509501881, 5957.195778569838, 5964.135200396005, 5969.552283578836, 5980.19267398913, 5762.8847423050465, 5827.504662103769, 5857.414258574108, 5863.618864773776, 5888.676122813115], "value": 4422.056337347121, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.1118101115403, 657.0538424668478, 805.0580820440084, 831.4927893984668, 875.4528419737663, 13136.146150500223, 13194.802077968838, 13984.510542131027, 14065.929670351634, 14068.929655351734, 12463.314517701523, 12466.750664986695, 12495.875041249585, 12502.56241031564, 12518.311492867912, 669.4343279928453, 795.4948607634136, 816.9714060007901, 817.8609636361833, 818.5088946632033, 821.5563595658338, 821.9342452603807, 824.1675907333577, 824.8886400335938, 827.3877330775243, 872.1017352127287, 872.9214370706635, 875.5928493250638, 881.1232823340785, 881.3698205782864, 872.6116877989328, 872.821071680304, 875.2822685397977, 876.4040452492303, 880.5861245214771, 640.1262276991872, 640.8686219325074, 641.4996302883758, 641.5188608543592, 641.6278558436096, 11872.940635296854, 11960.043196544255, 11975.46110425033, 11982.70043248917, 11985.820212696817, 13671.453141874314, 13726.595590766401, 13829.585112446643, 13897.374618142208, 13944.442222311096, 10917.126629869592, 10998.285111467729, 11115.221934464591, 11135.443227838576, 11204.15968802343, 3656.725745569093, 3671.1005803578296, 3676.3933950898067, 3706.240220754739, 3717.2937141942944, 53892.46107538914, 54087.72956135234, 54331.45668543303, 54984.45015549874, 56664.15003774988, 9993.850092248622, 10097.141742951784, 10540.578376864993, 10679.825219225879, 10680.839787403194, 18631.0, 19035.714464283046, 19055.714164287547, 19316.420507384802, 19321.90339048296, 7549.0, 7680.846383072308, 7705.1909549496495, 7752.7674169775, 7777.416693747991, 4330.328799036154, 4489.438820147481, 4571.679982401267, 4597.586217240398, 4609.976950115228, 3295.4727243641382, 3364.444866597033, 3365.764396492222, 3376.206591451007, 3376.2572234108457, 631.5515983651567, 633.0504243634548, 640.5484133685741, 647.847755777392, 648.0764910003321, 693.809202469325, 707.678006507038, 711.7544447165719, 741.1217707017095, 747.0064813797636, 8165.795855103551, 8396.06941912997, 8448.629387056288, 8480.279176269964, 8679.739607811649, 711.989320160198, 721.4661150748514, 723.2442098007594, 725.6117976882342, 742.985140297191, 3845.9230815383535, 4002.2795896738285, 4029.879103626896, 4036.8990775230855, 4134.37984302357, 56781.14828277579, 57875.71062144746, 58100.0, 58275.0, 58600.0, 52531.21203181955, 54456.18315725267, 55017.44982550123, 55022.0, 55156.72421637866, 48335.5166448331, 48663.0, 50440.49559504358, 50783.49216507788, 50897.23654145191, 8783.472991620523, 8843.204111629984, 8892.510911899908, 8993.505357205417, 9084.682036128705, 35397.82301088478, 35407.822960886064, 35422.291554169286, 35525.46711799273, 35573.46639800353, 43812.0, 45025.32462013138, 46198.769006154755, 46205.76897115493, 47289.7635511834, 12506.937465312616, 12656.0, 12702.667689762846, 12702.87297127017, 12826.74346513046, 13411.329433528479, 13575.728485430434, 13879.167249965034, 14252.643683907985, 14352.354144063333, 11518.596849110241, 11691.0, 12386.938065309976, 12611.49554017829, 12958.935205323913, 13152.145110567782, 13325.345115954278, 13466.259355735529, 13685.521006764715, 13775.104618199784, 10772.24594278393, 12021.459034343301, 12074.577389791315, 12392.070594705252, 12637.93681031589, 11232.775344493228, 11421.629394555395, 11429.828552571884, 11765.705857353634, 11829.0, 10623.683396064365, 10637.703986522445, 10947.50736216888, 11043.72390690207, 11316.717082072684], "value": 6641.601566579878, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 103.0, 112.0, 114.0, 110.0, 107.0, 110.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 155.0, 207.0, 127.0, 150.0, 160.0, 130.0, 192.0, 131.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 162.0, 165.0, 164.0, 172.0, 163.0, 161.0, 160.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 165.0, 77.0, 74.0, 75.0, 75.0, 162.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 188.0, 92.0, 92.0, 92.0, 148.0, 100.0, 92.0, 141.0], "value": 113.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 122.0, 120.0, 122.0, 122.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 111.0, 60.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 80.0, 80.0, 86.0, 86.0, 82.0, 81.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 133.0, 128.0, 126.0, 125.0, 122.0, 123.0, 135.0, 195.0, 128.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 173.0, 175.0, 177.0, 180.0, 176.0, 182.0, 174.0, 171.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 64.0, 64.0, 65.0, 69.0, 64.0, 66.0, 64.0], "value": 66.0, "unit": "score"}]}]} 04:22:15 INFO - Return code: 0 04:22:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:22:15 ERROR - # TBPL SUCCESS # 04:22:15 INFO - Running post-action listener: _resource_record_post_action 04:22:15 INFO - ##### 04:22:15 INFO - ##### Finished run-tests step (success) 04:22:15 INFO - ##### 04:22:15 INFO - Running post-run listener: _resource_record_post_run 04:22:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 671744; Write bytes: 360984576; Read time: 392; Write time: 312932 04:22:16 INFO - TinderboxPrint: CPU usage
13.4% 04:22:16 INFO - TinderboxPrint: I/O read bytes / time
671,744 / 392 04:22:16 INFO - TinderboxPrint: I/O write bytes / time
360,984,576 / 312,932 04:22:16 INFO - TinderboxPrint: CPU idle
8,230.8 (86.6%) 04:22:16 INFO - TinderboxPrint: CPU user
1,216.7 (12.8%) 04:22:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:22:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 75149312; Read time: 0; Write time: 48992 04:22:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 671744; Write bytes: 285835264; Read time: 392; Write time: 263940 04:22:16 INFO - Running post-run listener: _upload_blobber_files 04:22:16 INFO - Blob upload gear active. 04:22:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:16 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 04:22:16 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:22:16 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:22:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:17 INFO - (blobuploader) - INFO - Done attempting. 04:22:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:22:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:18 INFO - (blobuploader) - INFO - Done attempting. 04:22:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:18 INFO - Return code: 0 04:22:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cda478e3098057e1936eecde48f9aa2d81c1a362899fc100417e823242570ff9a9e7c75ba9112698fc213762244e836ed87b9950a7fc7bd1e8de64bf04b35659", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75a22c28338311b706ae9f939e99dd8d9df2449fd1452c4bed80b3ac8ce0b55d91ca83dfa8567646e608f602991a6f6764957fcc6d6688ddc309f7af7a3e73cc"} 04:22:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:18 INFO - Contents: 04:22:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cda478e3098057e1936eecde48f9aa2d81c1a362899fc100417e823242570ff9a9e7c75ba9112698fc213762244e836ed87b9950a7fc7bd1e8de64bf04b35659", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75a22c28338311b706ae9f939e99dd8d9df2449fd1452c4bed80b3ac8ce0b55d91ca83dfa8567646e608f602991a6f6764957fcc6d6688ddc309f7af7a3e73cc"} 04:22:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:18 INFO - Copying logs to upload dir... 04:22:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.906451 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-12 04:22:18.659779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 04:22:18.663207) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759 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/Mozilla-Inbound/sha512/cda478e3098057e1936eecde48f9aa2d81c1a362899fc100417e823242570ff9a9e7c75ba9112698fc213762244e836ed87b9950a7fc7bd1e8de64bf04b35659", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75a22c28338311b706ae9f939e99dd8d9df2449fd1452c4bed80b3ac8ce0b55d91ca83dfa8567646e608f602991a6f6764957fcc6d6688ddc309f7af7a3e73cc"} build_url:https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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/Mozilla-Inbound/sha512/cda478e3098057e1936eecde48f9aa2d81c1a362899fc100417e823242570ff9a9e7c75ba9112698fc213762244e836ed87b9950a7fc7bd1e8de64bf04b35659", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75a22c28338311b706ae9f939e99dd8d9df2449fd1452c4bed80b3ac8ce0b55d91ca83dfa8567646e608f602991a6f6764957fcc6d6688ddc309f7af7a3e73cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 04:22:18.691722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:22:18.692121) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463049386.511896-515960759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004321 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:22:18.773509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 04:22:18.776923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 04:22:18.777296) ========= ========= Total master_lag: 0.17 =========