builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1463584076.55 results: success (0) buildid: 20160518053011 builduid: ccaea75549fb4f6eafcefd5fc72a52a9 revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.548080) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.548524) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.548864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.564663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.564934) ========= 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=745a4373a2a16df560f216e000000264-1463584076.201394-279180856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 08:07:56-- 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% 70.8M=0s 2016-05-18 08:07:57 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145798 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.723914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.724234) ========= 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=745a4373a2a16df560f216e000000264-1463584076.201394-279180856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019664 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:07:56.773348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-18 08:07:56.773694) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47b83c8478a06374aa9306122a778654b912f713 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 47b83c8478a06374aa9306122a778654b912f713 --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=745a4373a2a16df560f216e000000264-1463584076.201394-279180856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 08:07:57,140 truncating revision to first 12 chars 2016-05-18 08:07:57,140 Setting DEBUG logging. 2016-05-18 08:07:57,140 attempt 1/10 2016-05-18 08:07:57,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47b83c8478a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 08:08:00,432 unpacking tar archive at: fx-team-47b83c8478a0/testing/mozharness/ program finished with exit code 0 elapsedTime=3.576093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-18 08:08:00.362476) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 08:08:00.362820) ========= script_repo_revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 08:08:00.363219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 08:08:00.363490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 08:08:00.372270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-18 08:08:00.372687) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1463584076.201394-279180856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:00 INFO - MultiFileLogger online at 20160518 08:08:00 in /builds/slave/test 08:08:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:08:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:00 INFO - {'append_to_log': False, 08:08:00 INFO - 'base_work_dir': '/builds/slave/test', 08:08:00 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:00 INFO - 'branch': 'Fx-Team', 08:08:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:00 INFO - 'config_files': ('talos/linux_config.py',), 08:08:00 INFO - 'default_actions': ('clobber', 08:08:00 INFO - 'read-buildbot-config', 08:08:00 INFO - 'download-and-extract', 08:08:00 INFO - 'populate-webroot', 08:08:00 INFO - 'create-virtualenv', 08:08:00 INFO - 'install', 08:08:00 INFO - 'run-tests'), 08:08:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:00 INFO - 'download_minidump_stackwalk': True, 08:08:00 INFO - 'download_symbols': 'ondemand', 08:08:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:00 INFO - 'installer_path': 'installer.exe', 08:08:00 INFO - 'log_level': 'info', 08:08:00 INFO - 'log_name': 'talos', 08:08:00 INFO - 'log_to_console': True, 08:08:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:00 INFO - 'opt_config_files': (), 08:08:00 INFO - 'pip_index': False, 08:08:00 INFO - 'sps_profile': False, 08:08:00 INFO - 'sps_profile_interval': 0, 08:08:00 INFO - 'suite': 'dromaeojs-e10s', 08:08:00 INFO - 'system_bits': '32', 08:08:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:00 INFO - 'title': 'talos-linux64-ix-032', 08:08:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:00 INFO - 'use_talos_json': True, 08:08:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:00 INFO - 'work_dir': 'build'} 08:08:00 INFO - ##### 08:08:00 INFO - ##### Running clobber step. 08:08:00 INFO - ##### 08:08:00 INFO - Running pre-action listener: _resource_record_pre_action 08:08:00 INFO - Running main action method: clobber 08:08:00 INFO - rmtree: /builds/slave/test/build 08:08:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:01 INFO - Running post-action listener: _resource_record_post_action 08:08:01 INFO - ##### 08:08:01 INFO - ##### Finished clobber step (success) 08:08:01 INFO - ##### 08:08:01 INFO - ##### 08:08:01 INFO - ##### Running read-buildbot-config step. 08:08:01 INFO - ##### 08:08:01 INFO - Running pre-action listener: _resource_record_pre_action 08:08:01 INFO - Running main action method: read_buildbot_config 08:08:01 INFO - Using buildbot properties: 08:08:01 INFO - { 08:08:01 INFO - "project": "", 08:08:01 INFO - "product": "firefox", 08:08:01 INFO - "script_repo_revision": "production", 08:08:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:08:01 INFO - "repository": "", 08:08:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:08:01 INFO - "buildid": "20160518053011", 08:08:01 INFO - "pgo_build": "True", 08:08:01 INFO - "basedir": "/builds/slave/test", 08:08:01 INFO - "buildnumber": 756, 08:08:01 INFO - "slavename": "talos-linux64-ix-032", 08:08:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:08:01 INFO - "platform": "ubuntu64_hw", 08:08:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:08:01 INFO - "branch": "fx-team", 08:08:01 INFO - "repo_path": "integration/fx-team", 08:08:01 INFO - "revision": "47b83c8478a06374aa9306122a778654b912f713", 08:08:01 INFO - "stage_platform": "linux64-pgo", 08:08:01 INFO - "builduid": "ccaea75549fb4f6eafcefd5fc72a52a9", 08:08:01 INFO - "slavebuilddir": "test" 08:08:01 INFO - } 08:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:08:01 INFO - Running post-action listener: _resource_record_post_action 08:08:01 INFO - ##### 08:08:01 INFO - ##### Finished read-buildbot-config step (success) 08:08:01 INFO - ##### 08:08:01 INFO - ##### 08:08:01 INFO - ##### Running download-and-extract step. 08:08:01 INFO - ##### 08:08:01 INFO - Running pre-action listener: _resource_record_pre_action 08:08:01 INFO - Running main action method: download_and_extract 08:08:01 INFO - mkdir: /builds/slave/test/build/tests 08:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:01 INFO - https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:02 INFO - Downloaded 1361 bytes. 08:08:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:08:02 INFO - Using the following test package requirements: 08:08:02 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:02 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:02 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:08:02 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'jsshell-linux-x86_64.zip'], 08:08:02 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:02 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:02 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:02 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:02 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:02 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:02 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:02 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08: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')]} 08:08:02 INFO - https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:03 INFO - Downloaded 24063278 bytes. 08:08:03 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'] 08:08:03 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 08:08:04 INFO - Return code: 0 08:08:04 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 08:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:04 INFO - https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:06 INFO - Downloaded 24063278 bytes. 08:08:06 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'] 08:08:06 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 08:08:07 INFO - Return code: 0 08:08: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')]} 08:08:07 INFO - https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:08 INFO - Downloaded 10840194 bytes. 08:08:08 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'] 08:08:08 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 08:08:09 INFO - Return code: 0 08:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:09 INFO - https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9-9u3h3RbO9FltpLrrAhw/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 08:08:11 INFO - Downloaded 58383497 bytes. 08:08:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:08:11 INFO - mkdir: /builds/slave/test/properties 08:08:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:08:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:08:11 INFO - Contents: 08:08:11 INFO - build_url:https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:08:12 INFO - Running post-action listener: _resource_record_post_action 08:08:12 INFO - Running post-action listener: set_extra_try_arguments 08:08:12 INFO - ##### 08:08:12 INFO - ##### Finished download-and-extract step (success) 08:08:12 INFO - ##### 08:08:12 INFO - ##### 08:08:12 INFO - ##### Running populate-webroot step. 08:08:12 INFO - ##### 08:08:12 INFO - Running pre-action listener: _resource_record_pre_action 08:08:12 INFO - Running main action method: populate_webroot 08:08:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:12 INFO - '--tppagecycles', 08:08:12 INFO - '7'], 08:08:12 INFO - 'tests': ['tsvgm']}}, 08:08:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:08:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:08:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:08:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['damp', 'tps']}, 08:08:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'tests': ['damp', 'tps']}, 08:08:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['dromaeo_dom']}, 08:08:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tsvgx', 08:08:12 INFO - 'tsvgr_opacity', 08:08:12 INFO - 'tart', 08:08:12 INFO - 'tscrollx', 08:08:12 INFO - 'cart']}, 08:08:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:08:12 INFO - 'tsvgr_opacity', 08:08:12 INFO - 'tart', 08:08:12 INFO - 'tscrollx', 08:08:12 INFO - 'cart']}, 08:08:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tp5o']}, 08:08:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'tests': ['tp5o']}, 08:08:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s', 08:08:12 INFO - '--xperf_path', 08:08:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:12 INFO - 'tests': ['tp5n']}, 08:08:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--xperf_path', 08:08:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:12 INFO - 'tests': ['tp5n']}}, 08:08:12 INFO - 'talos.zip': {'path': '', 08:08:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:12 INFO - Running post-action listener: _resource_record_post_action 08:08:12 INFO - ##### 08:08:12 INFO - ##### Finished populate-webroot step (success) 08:08:12 INFO - ##### 08:08:12 INFO - ##### 08:08:12 INFO - ##### Running create-virtualenv step. 08:08:12 INFO - ##### 08:08:12 INFO - Running pre-action listener: _resource_record_pre_action 08:08:12 INFO - Running main action method: create_virtualenv 08:08:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:08:12 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 08:08:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:08:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:12 INFO - Using real prefix '/usr' 08:08:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:14 INFO - Installing pip.................done. 08:08:14 INFO - Return code: 0 08:08:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:14 INFO - Using env: {'DISPLAY': ':0', 08:08:14 INFO - 'HOME': '/home/cltbld', 08:08:14 INFO - 'LANG': 'en_US.UTF-8', 08:08:14 INFO - 'LANGUAGE': 'en_US:en', 08:08:14 INFO - 'LOGNAME': 'cltbld', 08:08:14 INFO - 'MAIL': '/var/mail/cltbld', 08:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:14 INFO - 'MOZ_NO_REMOTE': '1', 08:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:14 INFO - 'NO_EM_RESTART': '1', 08:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:14 INFO - 'PWD': '/builds/slave/test', 08:08:14 INFO - 'SHELL': '/bin/bash', 08:08:14 INFO - 'SHLVL': '1', 08:08:14 INFO - 'TERM': 'linux', 08:08:14 INFO - 'TMOUT': '86400', 08:08:14 INFO - 'USER': 'cltbld', 08:08:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:14 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 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 08:08:15 INFO - Cleaning up... 08:08:15 INFO - Return code: 0 08:08:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:08:15 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')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 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')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:08:15 INFO - Using env: {'DISPLAY': ':0', 08:08:15 INFO - 'HOME': '/home/cltbld', 08:08:15 INFO - 'LANG': 'en_US.UTF-8', 08:08:15 INFO - 'LANGUAGE': 'en_US:en', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MAIL': '/var/mail/cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SHLVL': '1', 08:08:15 INFO - 'TERM': 'linux', 08:08:15 INFO - 'TMOUT': '86400', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 INFO - Downloading/unpacking psutil>=3.1.1 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:17 INFO - Installing collected packages: psutil 08:08:17 INFO - Running setup.py install for psutil 08:08:17 INFO - building 'psutil._psutil_linux' extension 08:08:17 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 08:08:17 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 08:08:17 INFO - building 'psutil._psutil_posix' extension 08:08:17 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 08:08:17 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 08:08:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:17 INFO - Successfully installed psutil 08:08:17 INFO - Cleaning up... 08:08:17 INFO - Return code: 0 08:08:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:08:17 INFO - Using env: {'DISPLAY': ':0', 08:08:17 INFO - 'HOME': '/home/cltbld', 08:08:17 INFO - 'LANG': 'en_US.UTF-8', 08:08:17 INFO - 'LANGUAGE': 'en_US:en', 08:08:17 INFO - 'LOGNAME': 'cltbld', 08:08:17 INFO - 'MAIL': '/var/mail/cltbld', 08:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:17 INFO - 'MOZ_NO_REMOTE': '1', 08:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:17 INFO - 'NO_EM_RESTART': '1', 08:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:17 INFO - 'PWD': '/builds/slave/test', 08:08:17 INFO - 'SHELL': '/bin/bash', 08:08:17 INFO - 'SHLVL': '1', 08:08:17 INFO - 'TERM': 'linux', 08:08:17 INFO - 'TMOUT': '86400', 08:08:17 INFO - 'USER': 'cltbld', 08:08:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:17 INFO - '_': '/tools/buildbot/bin/python'} 08:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:20 INFO - Installing collected packages: mozsystemmonitor 08:08:20 INFO - Running setup.py install for mozsystemmonitor 08:08:20 INFO - Successfully installed mozsystemmonitor 08:08:20 INFO - Cleaning up... 08:08:20 INFO - Return code: 0 08:08:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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', '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 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:08: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 blobuploader==1.2.4 08:08:20 INFO - Using env: {'DISPLAY': ':0', 08:08:20 INFO - 'HOME': '/home/cltbld', 08:08:20 INFO - 'LANG': 'en_US.UTF-8', 08:08:20 INFO - 'LANGUAGE': 'en_US:en', 08:08:20 INFO - 'LOGNAME': 'cltbld', 08:08:20 INFO - 'MAIL': '/var/mail/cltbld', 08:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:20 INFO - 'MOZ_NO_REMOTE': '1', 08:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:20 INFO - 'NO_EM_RESTART': '1', 08:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:20 INFO - 'PWD': '/builds/slave/test', 08:08:20 INFO - 'SHELL': '/bin/bash', 08:08:20 INFO - 'SHLVL': '1', 08:08:20 INFO - 'TERM': 'linux', 08:08:20 INFO - 'TMOUT': '86400', 08:08:20 INFO - 'USER': 'cltbld', 08:08:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:20 INFO - '_': '/tools/buildbot/bin/python'} 08:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:20 INFO - Downloading/unpacking blobuploader==1.2.4 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:22 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08: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 08:08:23 INFO - Downloading docopt-0.6.1.tar.gz 08:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:23 INFO - Running setup.py install for blobuploader 08:08:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:23 INFO - Running setup.py install for requests 08:08:23 INFO - Running setup.py install for docopt 08:08:23 INFO - Successfully installed blobuploader requests docopt 08:08:23 INFO - Cleaning up... 08:08:23 INFO - Return code: 0 08:08:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:23 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')]} 08:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:23 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')]} 08:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:23 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 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:23 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 08:08:23 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 08:08:23 INFO - Using env: {'DISPLAY': ':0', 08:08:23 INFO - 'HOME': '/home/cltbld', 08:08:23 INFO - 'LANG': 'en_US.UTF-8', 08:08:23 INFO - 'LANGUAGE': 'en_US:en', 08:08:23 INFO - 'LOGNAME': 'cltbld', 08:08:23 INFO - 'MAIL': '/var/mail/cltbld', 08:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:23 INFO - 'MOZ_NO_REMOTE': '1', 08:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:23 INFO - 'NO_EM_RESTART': '1', 08:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:23 INFO - 'PWD': '/builds/slave/test', 08:08:23 INFO - 'SHELL': '/bin/bash', 08:08:23 INFO - 'SHLVL': '1', 08:08:23 INFO - 'TERM': 'linux', 08:08:23 INFO - 'TMOUT': '86400', 08:08:23 INFO - 'USER': 'cltbld', 08:08:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:23 INFO - '_': '/tools/buildbot/bin/python'} 08:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:23 INFO - Running setup.py (path:/tmp/pip-vhPoee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:23 INFO - Running setup.py (path:/tmp/pip-xqoQ0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:24 INFO - Running setup.py (path:/tmp/pip-66bNHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:24 INFO - Running setup.py (path:/tmp/pip-NffKqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:24 INFO - Running setup.py (path:/tmp/pip-52YJ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:24 INFO - Running setup.py (path:/tmp/pip-kBQ26S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:24 INFO - Running setup.py (path:/tmp/pip-o9Vz_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:24 INFO - Running setup.py (path:/tmp/pip-tyMmDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:24 INFO - Running setup.py (path:/tmp/pip-35EsCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:24 INFO - Running setup.py (path:/tmp/pip-fAVFqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:24 INFO - Running setup.py (path:/tmp/pip-pE92Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:24 INFO - Running setup.py (path:/tmp/pip-wYQDQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:24 INFO - Running setup.py (path:/tmp/pip-JtDbwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:24 INFO - Running setup.py (path:/tmp/pip-_bQ8Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:24 INFO - Running setup.py (path:/tmp/pip-U2PYUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:25 INFO - Running setup.py (path:/tmp/pip-a8J_Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:25 INFO - Running setup.py (path:/tmp/pip-qapRIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:25 INFO - Running setup.py install for manifestparser 08:08:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Running setup.py install for mozcrash 08:08:25 INFO - Running setup.py install for mozdebug 08:08:25 INFO - Running setup.py install for mozdevice 08:08:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Running setup.py install for mozfile 08:08:25 INFO - Running setup.py install for mozhttpd 08:08:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Running setup.py install for mozinfo 08:08:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Running setup.py install for mozInstall 08:08:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:25 INFO - Running setup.py install for mozleak 08:08:26 INFO - Running setup.py install for mozlog 08:08:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Running setup.py install for moznetwork 08:08:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Running setup.py install for mozprocess 08:08:26 INFO - Running setup.py install for mozprofile 08:08:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Running setup.py install for mozrunner 08:08:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Running setup.py install for mozscreenshot 08:08:26 INFO - Running setup.py install for moztest 08:08:26 INFO - Running setup.py install for mozversion 08:08:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:26 INFO - Cleaning up... 08:08:26 INFO - Return code: 0 08:08:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:26 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')]} 08:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:26 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')]} 08:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:26 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 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:26 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 08:08:26 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 08:08:26 INFO - Using env: {'DISPLAY': ':0', 08:08:26 INFO - 'HOME': '/home/cltbld', 08:08:26 INFO - 'LANG': 'en_US.UTF-8', 08:08:26 INFO - 'LANGUAGE': 'en_US:en', 08:08:26 INFO - 'LOGNAME': 'cltbld', 08:08:26 INFO - 'MAIL': '/var/mail/cltbld', 08:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:26 INFO - 'MOZ_NO_REMOTE': '1', 08:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:26 INFO - 'NO_EM_RESTART': '1', 08:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:26 INFO - 'PWD': '/builds/slave/test', 08:08:26 INFO - 'SHELL': '/bin/bash', 08:08:26 INFO - 'SHLVL': '1', 08:08:26 INFO - 'TERM': 'linux', 08:08:26 INFO - 'TMOUT': '86400', 08:08:26 INFO - 'USER': 'cltbld', 08:08:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:26 INFO - '_': '/tools/buildbot/bin/python'} 08:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:27 INFO - Running setup.py (path:/tmp/pip-gTd8qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:27 INFO - Running setup.py (path:/tmp/pip-jdW5Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:27 INFO - Running setup.py (path:/tmp/pip-ApKChm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:27 INFO - Running setup.py (path:/tmp/pip-3X0vtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:27 INFO - Running setup.py (path:/tmp/pip-QZsYPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:27 INFO - Running setup.py (path:/tmp/pip-HEBg5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:27 INFO - Running setup.py (path:/tmp/pip-UzNrtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:27 INFO - Running setup.py (path:/tmp/pip-gX7OTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:27 INFO - Running setup.py (path:/tmp/pip-CzQsO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:27 INFO - Running setup.py (path:/tmp/pip-RTbjFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:27 INFO - Running setup.py (path:/tmp/pip-UAqpa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:27 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)) 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:27 INFO - Running setup.py (path:/tmp/pip-Ay4zIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:28 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)) 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:28 INFO - Running setup.py (path:/tmp/pip-4w50IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:28 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)) 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:28 INFO - Running setup.py (path:/tmp/pip-Zyis0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:28 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)) 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:28 INFO - Running setup.py (path:/tmp/pip-W3zR7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:28 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)) 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:28 INFO - Running setup.py (path:/tmp/pip-y_2zk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:28 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)) 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:28 INFO - Running setup.py (path:/tmp/pip-RKUQDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:28 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)) 08:08:28 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)) 08:08:28 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)) 08:08:28 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)) 08:08:28 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)) 08:08:28 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)) 08:08:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:30 INFO - Downloading blessings-1.6.tar.gz 08:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:30 INFO - Installing collected packages: blessings 08:08:30 INFO - Running setup.py install for blessings 08:08:30 INFO - Successfully installed blessings 08:08:30 INFO - Cleaning up... 08:08:30 INFO - Return code: 0 08:08:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:30 INFO - Reading from file tmpfile_stdout 08:08:30 INFO - Current package versions: 08:08:30 INFO - argparse == 1.2.1 08:08:30 INFO - blessings == 1.6 08:08:30 INFO - blobuploader == 1.2.4 08:08:30 INFO - docopt == 0.6.1 08:08:30 INFO - manifestparser == 1.1 08:08:30 INFO - mozInstall == 1.12 08:08:30 INFO - mozcrash == 0.17 08:08:30 INFO - mozdebug == 0.1 08:08:30 INFO - mozdevice == 0.48 08:08:30 INFO - mozfile == 1.2 08:08:30 INFO - mozhttpd == 0.7 08:08:30 INFO - mozinfo == 0.9 08:08:30 INFO - mozleak == 0.1 08:08:30 INFO - mozlog == 3.2 08:08:30 INFO - moznetwork == 0.27 08:08:30 INFO - mozprocess == 0.22 08:08:30 INFO - mozprofile == 0.28 08:08:30 INFO - mozrunner == 6.11 08:08:30 INFO - mozscreenshot == 0.1 08:08:30 INFO - mozsystemmonitor == 0.3 08:08:30 INFO - moztest == 0.7 08:08:30 INFO - mozversion == 1.4 08:08:30 INFO - psutil == 3.1.1 08:08:30 INFO - requests == 1.2.3 08:08:30 INFO - wsgiref == 0.1.2 08:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:30 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')]} 08:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:30 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')]} 08:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:30 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 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:30 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 08:08:30 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 08:08:30 INFO - Using env: {'DISPLAY': ':0', 08:08:30 INFO - 'HOME': '/home/cltbld', 08:08:30 INFO - 'LANG': 'en_US.UTF-8', 08:08:30 INFO - 'LANGUAGE': 'en_US:en', 08:08:30 INFO - 'LOGNAME': 'cltbld', 08:08:30 INFO - 'MAIL': '/var/mail/cltbld', 08:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:30 INFO - 'MOZ_NO_REMOTE': '1', 08:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:30 INFO - 'NO_EM_RESTART': '1', 08:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:30 INFO - 'PWD': '/builds/slave/test', 08:08:30 INFO - 'SHELL': '/bin/bash', 08:08:30 INFO - 'SHLVL': '1', 08:08:30 INFO - 'TERM': 'linux', 08:08:30 INFO - 'TMOUT': '86400', 08:08:30 INFO - 'USER': 'cltbld', 08:08:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:30 INFO - '_': '/tools/buildbot/bin/python'} 08:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 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)) 08:08:30 INFO - Cleaning up... 08:08:30 INFO - Return code: 0 08:08:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:30 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')]} 08:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:31 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')]} 08:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:31 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 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:31 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 08:08:31 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 08:08:31 INFO - Using env: {'DISPLAY': ':0', 08:08:31 INFO - 'HOME': '/home/cltbld', 08:08:31 INFO - 'LANG': 'en_US.UTF-8', 08:08:31 INFO - 'LANGUAGE': 'en_US:en', 08:08:31 INFO - 'LOGNAME': 'cltbld', 08:08:31 INFO - 'MAIL': '/var/mail/cltbld', 08:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:31 INFO - 'MOZ_NO_REMOTE': '1', 08:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:31 INFO - 'NO_EM_RESTART': '1', 08:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:31 INFO - 'PWD': '/builds/slave/test', 08:08:31 INFO - 'SHELL': '/bin/bash', 08:08:31 INFO - 'SHLVL': '1', 08:08:31 INFO - 'TERM': 'linux', 08:08:31 INFO - 'TMOUT': '86400', 08:08:31 INFO - 'USER': 'cltbld', 08:08:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:31 INFO - '_': '/tools/buildbot/bin/python'} 08:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:31 INFO - Downloading/unpacking jsonschema 08:08:31 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 08:08:31 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 08:08:31 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 08:08:31 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 08:08:31 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 08:08:31 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 08:08:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:33 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:33 INFO - warning: no files found matching '*.txt' 08:08:33 INFO - no previously-included directories found matching 'build' 08:08:33 INFO - no previously-included directories found matching 'dist' 08:08:33 INFO - no previously-included directories found matching '.git*' 08:08:33 INFO - Installing collected packages: jsonschema, functools32 08:08:33 INFO - Running setup.py install for functools32 08:08:33 INFO - warning: no files found matching '*.txt' 08:08:33 INFO - no previously-included directories found matching 'build' 08:08:33 INFO - no previously-included directories found matching 'dist' 08:08:33 INFO - no previously-included directories found matching '.git*' 08:08:33 INFO - Successfully installed jsonschema functools32 08:08:33 INFO - Cleaning up... 08:08:33 INFO - Return code: 0 08:08:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7314c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, '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': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', '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 08:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:08:33 INFO - Using env: {'DISPLAY': ':0', 08:08:33 INFO - 'HOME': '/home/cltbld', 08:08:33 INFO - 'LANG': 'en_US.UTF-8', 08:08:33 INFO - 'LANGUAGE': 'en_US:en', 08:08:33 INFO - 'LOGNAME': 'cltbld', 08:08:33 INFO - 'MAIL': '/var/mail/cltbld', 08:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:33 INFO - 'MOZ_NO_REMOTE': '1', 08:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:33 INFO - 'NO_EM_RESTART': '1', 08:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:33 INFO - 'PWD': '/builds/slave/test', 08:08:33 INFO - 'SHELL': '/bin/bash', 08:08:33 INFO - 'SHLVL': '1', 08:08:33 INFO - 'TERM': 'linux', 08:08:33 INFO - 'TMOUT': '86400', 08:08:33 INFO - 'USER': 'cltbld', 08:08:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:33 INFO - '_': '/tools/buildbot/bin/python'} 08:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:33 INFO - Downloading/unpacking flake8 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:36 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 08:08:36 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 08:08:36 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 08:08:36 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 08:08:36 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 08:08:36 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 08:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:36 INFO - no previously-included directories found matching 'docs/_build' 08:08:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:36 INFO - Running setup.py install for pep8 08:08:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:36 INFO - no previously-included directories found matching 'docs/_build' 08:08:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:08:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:36 INFO - Cleaning up... 08:08:36 INFO - Return code: 0 08:08:36 INFO - Running post-action listener: _resource_record_post_action 08:08:36 INFO - Running post-action listener: _start_resource_monitoring 08:08:36 INFO - Starting resource monitoring. 08:08:36 INFO - ##### 08:08:36 INFO - ##### Finished create-virtualenv step (success) 08:08:36 INFO - ##### 08:08:36 INFO - ##### 08:08:36 INFO - ##### Running install step. 08:08:36 INFO - ##### 08:08:36 INFO - Running pre-action listener: _resource_record_pre_action 08:08:36 INFO - Running main action method: install 08:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:36 INFO - Reading from file tmpfile_stdout 08:08:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:36 INFO - Reading from file tmpfile_stdout 08:08:36 INFO - Output received: 08:08:36 INFO - Usage: mozinstall [options] installer 08:08:36 INFO - Options: 08:08:36 INFO - -h, --help show this help message and exit 08:08:36 INFO - -d DEST, --destination=DEST 08:08:36 INFO - Directory to install application into. [default: 08:08:36 INFO - "/builds/slave/test"] 08:08:36 INFO - --app=APP Application being installed. [default: firefox] 08:08:36 INFO - mkdir: /builds/slave/test/build/application 08:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:53 INFO - Reading from file tmpfile_stdout 08:08:53 INFO - Output received: 08:08:53 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:53 INFO - Running post-action listener: _resource_record_post_action 08:08:53 INFO - ##### 08:08:53 INFO - ##### Finished install step (success) 08:08:53 INFO - ##### 08:08:53 INFO - ##### 08:08:53 INFO - ##### Running run-tests step. 08:08:53 INFO - ##### 08:08:53 INFO - Running pre-action listener: _resource_record_pre_action 08:08:53 INFO - Running main action method: run_tests 08:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:53 INFO - Python 2.7.3 08:08:53 INFO - Return code: 0 08:08:53 INFO - grabbing minidump binary from tooltool 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 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 0x27f19c0>, '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 0x27f28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:53 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 08:08:53 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 08:08:53 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 08:08:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:53 INFO - Return code: 0 08:08:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:54 INFO - Return code: 0 08:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 08:08:54 INFO - Using env: {'DISPLAY': ':0', 08:08:54 INFO - 'HOME': '/home/cltbld', 08:08:54 INFO - 'LANG': 'en_US.UTF-8', 08:08:54 INFO - 'LANGUAGE': 'en_US:en', 08:08:54 INFO - 'LOGNAME': 'cltbld', 08:08:54 INFO - 'MAIL': '/var/mail/cltbld', 08:08:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:54 INFO - 'MOZ_NO_REMOTE': '1', 08:08:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:54 INFO - 'NO_EM_RESTART': '1', 08:08:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:54 INFO - 'PWD': '/builds/slave/test', 08:08:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:54 INFO - 'SHELL': '/bin/bash', 08:08:54 INFO - 'SHLVL': '1', 08:08:54 INFO - 'TERM': 'linux', 08:08:54 INFO - 'TMOUT': '86400', 08:08:54 INFO - 'USER': 'cltbld', 08:08:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1463584076.201394-279180856', 08:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:54 INFO - '_': '/tools/buildbot/bin/python'} 08:08:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:08:54 INFO - mozversion application_buildid: 20160518053011 08:08:54 INFO - mozversion application_changeset: 47b83c8478a06374aa9306122a778654b912f713 08:08:54 INFO - mozversion application_display_name: Nightly 08:08:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:54 INFO - mozversion application_name: Firefox 08:08:54 INFO - mozversion application_remotingname: firefox 08:08:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:54 INFO - mozversion application_vendor: Mozilla 08:08:54 INFO - mozversion application_version: 49.0a1 08:08:54 INFO - mozversion platform_buildid: 20160518053011 08:08:54 INFO - mozversion platform_changeset: 47b83c8478a06374aa9306122a778654b912f713 08:08:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:54 INFO - mozversion platform_version: 49.0a1 08:08:54 INFO - using testdate: 1463584134 08:08:54 INFO - actual date: 1463584134 08:08:54 INFO - starting webserver on 'localhost:59253' 08:08:54 INFO - SUITE-START | Running 2 tests 08:08:54 INFO - TEST-START | dromaeo_css 08:08:54 INFO - operating with platform_type : linux_ 08:08:54 INFO - Initialising browser for dromaeo_css test... 08:08:54 INFO - TEST-INFO | started process 3414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6MRCtS/profile http://localhost:59253/getInfo.html) 08:08:59 INFO - PROCESS | 3414 | 08:08:59 INFO - PROCESS | 3414 | (process:3481): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:08:59 INFO - PROCESS | 3414 | __metrics Screen width/height:1600/1200 08:08:59 INFO - PROCESS | 3414 | colorDepth:24 08:08:59 INFO - PROCESS | 3414 | Browser inner width/height: 1024/697 08:08:59 INFO - PROCESS | 3414 | __metrics 08:09:00 ERROR - PROCESS | 3414 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:09:01 INFO - TEST-INFO | 3414: exit 0 08:09:01 INFO - Browser initialized. 08:09:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:01 INFO - TEST-INFO | started process 3532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6MRCtS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:03 INFO - PROCESS | 3532 | 08:09:03 INFO - PROCESS | 3532 | (process:3594): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:09:13 INFO - PROCESS | 3532 | RSS: Main: 163332096 08:09:13 INFO - PROCESS | 3532 | 08:10:03 INFO - PROCESS | 3532 | 1463584203231 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] 08:12:11 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:59253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59253/tests/dromaeo/cssquery-ext.html) 08:12:12 INFO - PROCESS | 3532 | RSS: Main: 166207488 08:12:12 INFO - PROCESS | 3532 | 08:15:14 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:59253/tests/dromaeo/cssquery-ext.html (next: http://localhost:59253/tests/dromaeo/cssquery-jquery.html) 08:15:14 INFO - PROCESS | 3532 | RSS: Main: 166547456 08:15:14 INFO - PROCESS | 3532 | 08:18:16 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:59253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59253/tests/dromaeo/cssquery-mootools.html) 08:18:17 INFO - PROCESS | 3532 | RSS: Main: 166879232 08:18:17 INFO - PROCESS | 3532 | 08:21:18 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:59253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59253/tests/dromaeo/cssquery-prototype.html) 08:21:19 INFO - PROCESS | 3532 | RSS: Main: 164376576 08:21:19 INFO - PROCESS | 3532 | 08:24:21 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:59253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59253/tests/dromaeo/cssquery-yui.html) 08:24:22 INFO - PROCESS | 3532 | RSS: Main: 165507072 08:24:22 INFO - PROCESS | 3532 | 08:27:24 INFO - PROCESS | 3532 | Cycle 1(1): loaded http://localhost:59253/tests/dromaeo/cssquery-yui.html (next: http://localhost:59253/tests/dromaeo/cssquery-dojo.html) 08:27:25 INFO - PROCESS | 3532 | RSS: Main: 167321600 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | __start_tp_report 08:27:25 INFO - PROCESS | 3532 | _x_x_mozilla_page_load 08:27:25 INFO - PROCESS | 3532 | _x_x_mozilla_page_load_details 08:27:25 INFO - PROCESS | 3532 | |i|pagename|runs| 08:27:25 INFO - PROCESS | 3532 | |0;dojo.html;3126.85929133189;3184.6815318468143;3184.7133757961788;3225.9032229033123;3227.8708851645933;5455.127179651252;5489.560835133185;5502.312210973629;5516.255305533757;5532;5347.0909945309295;5415.83752487425;5455.945440545594;5467.808626698066;5528.723563821813;4934.777934992916;4965.875853103666;5081.8221362252325;5100.9489905100845;5140.023395554833;665.7044390114584;5044.092063428599;5061.5950723942;5086.618503612244;5113.5909127269915;4961.925571116436;4966.850994470172;4996.975015124919;5000.424951130612;5033.874153146164;4896.779644915988;4961.330220420233;4968.87577810554;5006.649534532584;5070.594352451832;4933.975330123362;4938.654294199408;4943.876403089916;4947.084789313988;4948.752562371867;5333;5357.544608708265;5387.676739395649;5391.973040134813;5406.837794866121;5709.143628455723;5734.283214598176;5790.88418231633;5840.386759390245;5882.205902203191;5724.5992780505385;5774.989376859075;5784.797532086399;5785.884282314372;5834.6790926499025;5372.247885296062;5429.755660995264;5435.864103397407;5447.019536483432;5447.400785913546;5836.474717275466;5960.344362120163;5994.490468310242;5998.670073145931;6023;5794.768209271666;5830.591858569945;5830.7959221427045;5834.649921004753;5836.824895253149;5915.7633694652595;5919.141724449931;5934.465898069195;5940.079287710412;5943.227380440515;5704;5777.393373695785;5808.6224395414165;5837.211976383134;5874.706264686749;5683;5804.04233301509;5831.679257640871;5853.151293062482;5854.502367298827;4454.420925279757;4463.218936686067;4470.262406702923;4494.685372023992;4529.071540334224;3907.9218415631526;3950.288947989332;3978.423128646388;3995.180987897474;4004.0990777074926;5692;5692.686902220417;5723.112917497794;5731;5745.224394706661;5901;5970.701464926737;5981.102834574762;5991.370906054889;5997.610155339889;5588.748506317225;5668.404817494104;5672.404397538282;5709.971450142806;5711;5110.7955681773055;5113.923291150636;5118.795248190105;5120.462351453119;5131.743412829418;5985.551083668743;6189.659568723673;6194.473469755121;6194.659293738798;6216.098665693539;5777.306723193327;5797.710114494174;5805.854853628524;5831.212786273968;5852.356240813422;6003.099535069775;6016.217891674054;6029.909551356645;6034.336223015553;6046.274447066205;5711.143328500592;5725.08398656213;5741.885162296814;5747.942520574741;5759.510441612342;5858.179854820414;5900.498457631149;5926.555508336805;5960.850978725566;5968.134620479919;5726.856828579319;5750.971245143747;5779.508741756998;5783.566232532493;5787.623804452697;5587.8882422352135;5669.773209071591;5677.8864422710485;5693.715314234355;5750.079987202028;5478.972605136949;5502.58730595199;5516.172574113915;5597.720113994203;5698.373178950395;5654.547636189177;5735.11105778605;5762.0780675093465;5785.9132113017495;5792.9710351447975;5624.240727501735;5636.802711905064;5639.069553523623;5646.548276137982;5649 08:27:25 INFO - PROCESS | 3532 | |1;ext.html;599.1821164110987;625.4371066040563;634.2737565487514;648.8021153548169;663.0750103605473;42325;42431.57568424319;42552.361714574305;43085.138297234036;47398.526014739844;45083.77458112713;45654;45847.31229031559;45957.31064034042;46109.30836037462;8906.10938906109;9038.457692538468;9066.546672666373;9073.682421115262;9091.409058411215;8959.283257339397;9094.136057074567;9100.226480749112;9110.088991100904;9122.498262595554;9066.818663626724;9159.313051521129;9166.083391660814;9172.266218702522;9173.220276276525;9068.682596109138;9160.17558419742;9169.908300916972;9175.128362805523;9190.310726695525;8963.731088067369;8987.955060224722;8992.77518062047;9000.594973226154;9013.729588112366;42252;42489.57510424887;42619.9345016374;42740.78629606832;42758.358624620654;3489.8778542750883;3701.222743223899;3944.1717239379764;4059.72470023026;4334.501532323791;31370.843145784354;31556.842215789005;31787.523187152212;31913.680863191534;32992;4352.717073390219;4380.54004329544;4448.377227188196;4500.167469018242;4636.072785442925;365181;365952;366170;366230;367685;57465;58954.41045589489;59060.70469647624;59147;59220.70389648111;61739.38260617336;61812;61950.69024654848;62059.68970155211;62213.68893155505;16184.514464566082;16266.674666506604;16316.510504684878;16343.346266149221;16364.754528682079;12952.158109722837;13018.479260829461;13053.804192937114;13054;13071.41178646963;15219.391224350902;16284;16383.918080409521;16403.097829619248;16566.420175293806;6496.512761542903;6571;6583.769568065095;6669.366410191024;6707.256113410548;971.5773638467148;1042.4370839746603;1092.547549742809;1108.95564177432;1238.8946939510063;33667.15832104217;34307.828460857534;34887;36841;36948.815255923546;1136.4147464056018;1139.4302848575712;1178.0340121100787;1185.3717529709268;1255.893249073839;16443.424480143378;16639.584010399838;16821;16965.575860603585;17073.48779536616;514751;518512;519048;520169;521316;55098.72450637721;56689;56852.431475684716;56892.71553642205;56991.715041425356;1330.1154732103043;1426.2227086238024;1444.1768192130594;1476.7489526780473;1477.394268349993;32221.67778322187;33002.66997329996;33498.49752253767;33581.66418335883;33873.983780486626;48192.277115843994;48299.75850120727;48719;48726.75636621936;48838.26742598793;408597;410729;413154;414075;418249;27490.725092748817;27938.441231175668;28046.85976570104;28124;28131;47099.29351059668;47601.761991191204;47994.76002619965;48330.275045873634;48589.5141048585;40406.595934041456;41011.384829228184;41707.7914610425;41732.79133604313;42615;39887.40168897411;40686.59313406828;41625.79187104045;41689.37465938074;42275.57724422839;42081.15837683168;42436.1512769749;42620.78689606656;42748.78625606852;43148.56851431446;35018.649813501535;37217.25565488729;37270.62729372671;37914.62085379111;38043.23913521769;29623.407531849673;29712.405751885275;29747.405051899274;29906.10281691553;29944.700552994193 08:27:25 INFO - PROCESS | 3532 | |2;jquery.html;401.9517657881054;408.29772790799825;411.3110539845758;412.7605988526657;424.8661671573454;13389.799153012687;17715.64568708625;19054.333098341544;19176.71234931477;19251.807481925178;18732.344367947124;18902.243910243607;19215.903920480414;19447.222111115538;19650;5586.35756887958;5655.4061823508355;5658.745356458949;5769.3076830780365;5787.160861675055;5398.352197736277;5692.715364231793;5726.914096288559;5731.856703582402;5736.512396446307;5744.913826292609;5745.971270143665;5752.395998420168;5757.539396848242;5760.740766665489;5850.502707269866;6137.386261373849;6207.224096987854;6266.530010249204;6278.434940855299;5420.891582168335;5671.262735844314;5690.260266165372;5710.2862142232225;5710.800121995751;13401.86598134016;13687.863121368759;13995.930020349935;22942.885285573633;22970.7702922972;2328.781413463011;2453.8405003674884;2460.3726049857173;2559.948801023988;2826.8869245230167;10030.2477314201;10219.7445063874;10220.744481388025;10242.590296388136;10442;1975.8715683480527;2033.6339458897392;2050.3746357361;2068.979310206894;2074.802893725094;75049.24950750532;75946.24053759447;77248;77478;77982.99999999943;10632.734181645521;10709;10973.670789876316;11029.22795404314;11120.332780033224;15119.16844573537;15173.393064277527;15274.618134546503;15275;15299.388024479118;7692.153863075057;7846.058472983164;7950.165232650604;7980.760577182694;8060.274575288252;7500.287472690085;7536.623168841536;7539;7632.389408847279;7651.655675494616;4619.445666520039;4650.139724151043;4684.5549672781035;4750.192467280571;4765.093293091211;1935.419374187738;1991.3528103366464;2011.054804242004;2023.3323003409134;2027.9797202027792;1036.6371769880632;1074.258761454594;1126.819708846597;1147.4836323654388;1182.3254709513997;19135.13891874869;19435.708464373045;19737.802621973595;20053.197872084955;20073.096710648057;1008.7377281906757;1013.0426746724422;1013.2299452416216;1036.2228777646221;1043.5147656339839;10589.523471443803;11242.831357529643;11281.379524126087;11319.434028298552;11331.660050198507;431089;434183;434695;456843;457588;90031;93990;94040.52979735058;94104.52947735217;95329;1035.9896401036044;1053.0680347892016;1070.0423121306542;1071.0895738622264;1089.1395797320188;17189.14054297305;17315.307387704856;17391.7391239129;17613.38353157633;17670.646587068444;41227;41448.171036579704;41913.58086419097;41954.580454195064;42719.786401067795;55914;57795.42204578069;58002.709986449794;58150.4184958145;59221.70389148027;7407.59258240802;7650.6174691264105;8525.74422767318;8708.521031343083;8906.599203036008;12968.416421260878;13118;13242.735145297233;13366.86633133695;13532.323383830966;11709;11916.948237599257;11928.224665396721;12242.081843861924;12252.816207757069;11397.259178153725;11584.362860042778;11683.88316116862;11985.22096063753;11999.40002999829;12012.279263244232;12049.397530123284;12094.39528023613;12268.87731122713;12400.937995309965;7830.177831327628;7941.642626081955;7968;8186.631601577824;8275.83448331018;10265.067702896391;12168.148229623841;12182.939085304517;12415.130940834055;12479.31363775001 08:27:25 INFO - PROCESS | 3532 | |3;mootools.html;1532.3104602928681;1558.8207356154041;1724.7412888066788;1813.2475022865503;1849.7780266368038;8009.159038300982;8685;8713.912860871389;9243.306751993603;9256.537173141332;9013.05362936892;9074.546272686372;9124.224440922513;9136.817263654722;9149.085091490848;2317.18898385565;2340.414896275931;2346.730126035502;2347.3310106619615;2350.7296660884044;2309.1802410144323;2326.26722582386;2365.95268094638;2367.550165468564;2372.5136347048815;2293.5642227976714;2300.9884950575224;2316.293530473205;2334.253039027512;2339.9415014624688;2236.7315922089374;2239.6192647250004;2241.9103235870543;2245.62947113726;2273.4202778291597;2214.723159605049;2233.3411643565187;2236.809871160953;2237.3623517297656;2239.6080685879906;8931.062238464932;8995.145461181242;9056.366054376196;9059.094090590954;9087.954560227223;5248.239005344242;5368.0605893968395;5387.380451248078;5407.3781515125875;5410.269613602152;3352.6312105668358;3357.2781851901714;3481.0601137692934;3498.3528047311074;3503.2468019375956;1102.393683474086;1114.5151858941385;1150.896419322265;1152.4180288954108;1214.9757004859941;12640.367981600883;12756.936215318863;12780.424880880382;12785.041121915801;12786.552470663575;4524.479684836286;4525.502194758574;4570.108828778356;4574.290984897346;4591.724496530219;10121.797564048678;10131.848022279672;10209.642662506925;10211.285210035374;10227.386356818615;5164.1995490699;5270.288511051036;5274.604404669665;5280;5324.520793128637;4321.5678432157165;4842.394700662418;4947.208446648519;4961.8511444656715;4982.103221420107;3843.7693738375788;3858.9421158682644;3885.7279990400966;3926.469926559935;3978.42312864633;1090.3784842639777;1127.8195488721765;1130.9642643242132;1144.4506636814376;1154.8556430446195;963.4989805301204;979.0747743382577;996.9601215951426;1002.4436437776958;1009.4266297307596;5743.167240750068;6057.273127224761;6059.545534084961;6080.847978800477;6109.358517355702;399.3929227574071;405.87417900450953;408.11642793352655;410.67351455592876;420.01087439080527;3929.685625149981;4092.4475195848777;4247.660187185018;4250.978745106317;4277.615014648696;11211.159163062639;11430.25703329281;11600.709982250512;11604;11612.593559225386;11256.887431125584;11471.426428678533;11496.367699776592;11532.654020379403;11549.942250288696;8129.552874591836;8421.915780842113;8430.15698430152;8458.577071146417;8648.481091134552;5680.943190568207;5704.629199102045;5788.363280039276;5893;5904.0553511437965;9571.234301255743;9746.31775775689;9792;9807.13664403761;9827.803443931225;9498.620055197714;9717.22262219035;9833.606655733976;9941.751456213364;9947.701568952943;7273.163586187445;7482.139553951148;7677.347425468898;7874.606269686378;8059.234372734581;8761.737147885573;8810.03089660124;8921.955390223007;9017.188453039258;9056.909430905871;7791.415643826623;7905;8057.637406316612;8093.069297030681;8187.426880118334;7895.7236496722335;7906.051273847175;7930.603469826601;8006.959965200137;8079.757607271791;7221.4222862169845;7236.710531578889;7302.634868256459;7309.561426314438;7323.414126869731;4988.9501104988485;5099.770510327118;5129.204973229155;5134.76893539799;5151.356080489939;4908.410990681141;5147.5881929446305;5161.7677204525135;5202.505761952609;5236.947630523646 08:27:25 INFO - PROCESS | 3532 | |4;prototype.html;308.77922285565813;309.86365998960457;309.9969000309997;312.6389020681111;313.7881929697455;5600.691961942097;5606.859828504289;5611.438856114387;5695.430456954303;5751.223584816049;5555.527780138693;5609.439056094388;5610.4670056344685;5623.710129574204;5701.971490142543;4150.837765425678;4176.770277634729;4275.572442755731;4275.8075886585175;4275.947545178316;4251;4278.315469524877;4281.636060934824;4293.162833247518;4297.462817147856;4271.765052922088;4282.357646353056;4289.871303860889;4295.613394794468;4306.332518459643;4016.337304344794;4214.2414365414215;4221.303484924983;4244.448221731186;4292.97853510732;3656.561212654472;3663.432168013962;3677.2093999790172;3681.4845921571;3695.9630403695887;5416.864578385533;5428.782848686048;5432.64687795296;5450.672959622435;5469.304515600176;4583.885402864922;4876.707397556158;4891.679246603398;4903.975480122613;4933.975330123327;5815.110089220978;5828.242328497311;5851.473367396955;5867.530597552186;5893.347993402986;4024.9597504024878;4041.3533834586324;4043.4945631796027;4046;4073.9185216295805;5961.970190149022;6077.908831367533;6078.45293923549;6107.786227482061;6120.44915957566;4112.362583799456;4114.897127571775;4129.401236820644;4145.108801607669;4155.688323375759;4164.66682665386;4182.874513764592;4189.680250721013;4191.769452680071;4215.199112168678;4658.650601204923;4864.3218089758975;4882.707037577757;4895.216765317532;4920.901581968412;5888.587798854039;5920.437558431942;5924.289085309791;5934.910976335358;5935.1987481690285;1439.9344485081174;1454.156589178274;1455.432381371266;1458.190704159202;1468.7943687883705;897.4301318662697;904.8734325764334;917.788908551037;926.8053708721244;952.3524003677566;5621.7189140542805;5646.717664116778;5656.5757568181725;5684.801031963944;5694.316681998187;5901.557383196277;5925;5972.492338151305;6001.489873360813;6008.969955150284;5439.891202176013;5651.463111004448;5831.562632802472;5836.358000619928;5845.9707701462075;3198.4882418813345;3231.8222497762376;3239.886603968897;3250.902472925816;3257.4299497587826;6113.510919126459;6292.804367170223;6318.71565779541;6329.68351582419;6375.481684734504;6142.57002009855;6177.166082578884;6200.937990620127;6218.751249950042;6220.315765265817;6120.8775824484155;6231.532635052389;6289.654069026156;6318.873622527615;6351.396617321347;5997.640141591519;6100.725467353891;6136.7852125175405;6141.170941922784;6142.78500252489;5947.762089516371;5991.490723288395;6069.726862291119;6073.392660734068;6081.5742897996715;6055.6063855849225;6294.685265736786;6301.212348456443;6301.527385446201;6311.2426508819235;4177.895552611088;4212.599803018708;4215.283401821636;4221.446025154737;4243.172581346607;5962.940370596412;6042.3655516170165;6043.516518678407;6061.636301821904;6092.603980741238;5827.562932779973;5853.531717462678;5891.558133140117;5895.793647222326;5905.734241959036;5858.619189752652;5881.38245484218;5928.466438020599;5953.9404605955115;5982.192404025401;5242.659227150223;5721.113227449752;5741.473751549472;5797.5361971041375;5858.560607954335;5911.970440147772;5914.674692891932;5919.763209471573;5929.466348028698;5943.068502736542;5605.355384130877;5802.912956305743;5804.6807425592;5835.649861008353;5881.97065513542 08:27:25 INFO - PROCESS | 3532 | |5;yui.html;741.2698491985394;788.8067423481247;833.8290650416665;863.5034854958401;870.1733353314353;14642.853571464282;15321.92339038306;15546.455874044383;15598.376064957401;15662.295196716146;14091.577252682411;14114.858851411484;14150.221737804417;14156.50452234172;14209.644758881033;660.1121491593823;788.5111231036765;808.2442915873647;809.0332053196432;814.1451475950244;810.6838333050115;814.5112932240638;816.942814003017;821.1911267401634;823.320760372695;847.5126802088793;856.9271611912994;865.6407590849822;865.9956700216521;869.9304055675531;861.8577934640776;861.9827603447895;862.2412277196058;863.1023735315296;863.3007264116055;617.0559044661675;618.1623899616045;619.6684773646077;623.9781607643711;628.8585068359582;13233.669158271025;13245.07284490086;13269.270190139538;13282.73434531304;13360.599182024458;13269;14285.714285714332;14721.337539810627;14864.479743208936;14877;11408.54365825366;11460.713482163013;11685.591004314809;11877.22798018126;11991.04071674264;3817.522809648794;3880.4567360569545;3904.297226499229;3933.429652700371;3982.1637456134245;56772.864542708914;57069.85860282813;57181.714091429276;57354.71322643402;57557;10383.636572719919;10426.5829366826;10903.509342079626;10994.287194250395;11206.439678016066;20526.38420847377;20625.381238562866;20679.172833086508;20716.689249661267;20757;8280;8487.405881588353;8498.66005359791;8500.70247541333;8528.701495447629;4941.110600091946;4978.103941290602;4985.451600323961;5033.5721463676;5246;3124.4376012318003;3224.0489055728617;3259.250372414358;3346.54821599081;3347.313800670857;667.512715717529;676.7800464848943;684.3225207045089;697.6197972105215;702.0592406175749;680.3561981141867;719.3382088478508;721.5923003503004;751.7896187138812;777.6413203991658;9403.43579385239;9704.664477519742;9734.172595329477;9799.755006124904;9937.900620993698;618.2410941475906;709.9574025558483;743.7099531182843;796.1600511460465;800.667722894992;4370.978145109254;4651.441826980784;4698.201305778026;4733.219018861918;4739.786709598076;69658;70193.64903175451;71003;71287;71449.64275178695;57652.71173644189;64634;65122;66104.73511439344;66147.33852661509;51569.48430515647;53460.19809702857;53894.73052634712;57337.42662573404;58969.705151473965;9856.507174641096;9883.950580247052;9884.258680599127;10060.800447635447;10280.86910439836;37676.623233767314;37740.81129594334;38410.42384364181;38594.80702596469;38770.80614596909;44664.55335446604;48852.5114748848;50117;50625;51828;12660.240385576895;12860.678483037998;12899.419526121159;12928.159669621444;13191.34043297812;13825.377857996213;13841.100328478617;14397.208153551655;14632.268386580416;14989.250537473301;13382.197068175941;13661.248631325372;13783.862161378258;13871.653208669864;13999.510017149758;12921.224726516439;13675.316234188449;13768.724625507633;13830.585082447542;14174.858251417354;11846.229995050295;12359.38203089824;12525.874741252472;12687.365631718561;12875.291858947474;10815.297005694605;11116.388598626829;11132.590233017898;11235.606753763906;11692;11839.881601183877;11877.406129693654;12199.451024703732;12266.815997759863;12305.26168429897 08:27:25 INFO - PROCESS | 3532 | __end_tp_report 08:27:25 INFO - PROCESS | 3532 | __start_cc_report 08:27:25 INFO - PROCESS | 3532 | _x_x_mozilla_cycle_collect,327 08:27:25 INFO - PROCESS | 3532 | __end_cc_report 08:27:25 INFO - PROCESS | 3532 | __startTimestamp1463585245218__endTimestamp 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | ------- Summary: start ------- 08:27:25 INFO - PROCESS | 3532 | Number of tests: 6 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | [#0] dojo.html Cycles:165 Average:5422.71 Median:5692.69 stddev:719.78 (12.6%) stddev-sans-first:699.09 08:27:25 INFO - PROCESS | 3532 | Values: 3126.9 3184.7 3184.7 3225.9 3227.9 5455.1 5489.6 5502.3 5516.3 5532.0 5347.1 5415.8 5455.9 5467.8 5528.7 4934.8 4965.9 5081.8 5100.9 5140.0 665.7 5044.1 5061.6 5086.6 5113.6 4961.9 4966.9 4997.0 5000.4 5033.9 4896.8 4961.3 4968.9 5006.6 5070.6 4934.0 4938.7 4943.9 4947.1 4948.8 5333.0 5357.5 5387.7 5392.0 5406.8 5709.1 5734.3 5790.9 5840.4 5882.2 5724.6 5775.0 5784.8 5785.9 5834.7 5372.2 5429.8 5435.9 5447.0 5447.4 5836.5 5960.3 5994.5 5998.7 6023.0 5794.8 5830.6 5830.8 5834.6 5836.8 5915.8 5919.1 5934.5 5940.1 5943.2 5704.0 5777.4 5808.6 5837.2 5874.7 5683.0 5804.0 5831.7 5853.2 5854.5 4454.4 4463.2 4470.3 4494.7 4529.1 3907.9 3950.3 3978.4 3995.2 4004.1 5692.0 5692.7 5723.1 5731.0 5745.2 5901.0 5970.7 5981.1 5991.4 5997.6 5588.7 5668.4 5672.4 5710.0 5711.0 5110.8 5113.9 5118.8 5120.5 5131.7 5985.6 6189.7 6194.5 6194.7 6216.1 5777.3 5797.7 5805.9 5831.2 5852.4 6003.1 6016.2 6029.9 6034.3 6046.3 5711.1 5725.1 5741.9 5747.9 5759.5 5858.2 5900.5 5926.6 5960.9 5968.1 5726.9 5751.0 5779.5 5783.6 5787.6 5587.9 5669.8 5677.9 5693.7 5750.1 5479.0 5502.6 5516.2 5597.7 5698.4 5654.5 5735.1 5762.1 5785.9 5793.0 5624.2 5636.8 5639.1 5646.5 5649.0 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | [#1] ext.html Cycles:180 Average:59755.09 Median:42433.86 stddev:115711.74 (272.7%) stddev-sans-first:115951.10 08:27:25 INFO - PROCESS | 3532 | Values: 599.2 625.4 634.3 648.8 663.1 42325.0 42431.6 42552.4 43085.1 47398.5 45083.8 45654.0 45847.3 45957.3 46109.3 8906.1 9038.5 9066.5 9073.7 9091.4 8959.3 9094.1 9100.2 9110.1 9122.5 9066.8 9159.3 9166.1 9172.3 9173.2 9068.7 9160.2 9169.9 9175.1 9190.3 8963.7 8988.0 8992.8 9000.6 9013.7 42252.0 42489.6 42619.9 42740.8 42758.4 3489.9 3701.2 3944.2 4059.7 4334.5 31370.8 31556.8 31787.5 31913.7 32992.0 4352.7 4380.5 4448.4 4500.2 4636.1 365181.0 365952.0 366170.0 366230.0 367685.0 57465.0 58954.4 59060.7 59147.0 59220.7 61739.4 61812.0 61950.7 62059.7 62213.7 16184.5 16266.7 16316.5 16343.3 16364.8 12952.2 13018.5 13053.8 13054.0 13071.4 15219.4 16284.0 16383.9 16403.1 16566.4 6496.5 6571.0 6583.8 6669.4 6707.3 971.6 1042.4 1092.5 1109.0 1238.9 33667.2 34307.8 34887.0 36841.0 36948.8 1136.4 1139.4 1178.0 1185.4 1255.9 16443.4 16639.6 16821.0 16965.6 17073.5 514751.0 518512.0 519048.0 520169.0 521316.0 55098.7 56689.0 56852.4 56892.7 56991.7 1330.1 1426.2 1444.2 1476.7 1477.4 32221.7 33002.7 33498.5 33581.7 33874.0 48192.3 48299.8 48719.0 48726.8 48838.3 408597.0 410729.0 413154.0 414075.0 418249.0 27490.7 27938.4 28046.9 28124.0 28131.0 47099.3 47601.8 47994.8 48330.3 48589.5 40406.6 41011.4 41707.8 41732.8 42615.0 39887.4 40686.6 41625.8 41689.4 42275.6 42081.2 42436.2 42620.8 42748.8 43148.6 35018.6 37217.3 37270.6 37914.6 38043.2 29623.4 29712.4 29747.4 29906.1 29944.7 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | [#2] jquery.html Cycles:180 Average:27452.66 Median:2059.68 stddev:73304.13 (3559.0%) stddev-sans-first:73481.63 08:27:25 INFO - PROCESS | 3532 | Values: 402.0 408.3 411.3 412.8 424.9 13389.8 17715.6 19054.3 19176.7 19251.8 18732.3 18902.2 19215.9 19447.2 19650.0 5586.4 5655.4 5658.7 5769.3 5787.2 5398.4 5692.7 5726.9 5731.9 5736.5 5744.9 5746.0 5752.4 5757.5 5760.7 5850.5 6137.4 6207.2 6266.5 6278.4 5420.9 5671.3 5690.3 5710.3 5710.8 13401.9 13687.9 13995.9 22942.9 22970.8 2328.8 2453.8 2460.4 2559.9 2826.9 10030.2 10219.7 10220.7 10242.6 10442.0 1975.9 2033.6 2050.4 2069.0 2074.8 75049.2 75946.2 77248.0 77478.0 77983.0 10632.7 10709.0 10973.7 11029.2 11120.3 15119.2 15173.4 15274.6 15275.0 15299.4 7692.2 7846.1 7950.2 7980.8 8060.3 7500.3 7536.6 7539.0 7632.4 7651.7 4619.4 4650.1 4684.6 4750.2 4765.1 1935.4 1991.4 2011.1 2023.3 2028.0 1036.6 1074.3 1126.8 1147.5 1182.3 19135.1 19435.7 19737.8 20053.2 20073.1 1008.7 1013.0 1013.2 1036.2 1043.5 10589.5 11242.8 11281.4 11319.4 11331.7 431089.0 434183.0 434695.0 456843.0 457588.0 90031.0 93990.0 94040.5 94104.5 95329.0 1036.0 1053.1 1070.0 1071.1 1089.1 17189.1 17315.3 17391.7 17613.4 17670.6 41227.0 41448.2 41913.6 41954.6 42719.8 55914.0 57795.4 58002.7 58150.4 59221.7 7407.6 7650.6 8525.7 8708.5 8906.6 12968.4 13118.0 13242.7 13366.9 13532.3 11709.0 11916.9 11928.2 12242.1 12252.8 11397.3 11584.4 11683.9 11985.2 11999.4 12012.3 12049.4 12094.4 12268.9 12400.9 7830.2 7941.6 7968.0 8186.6 8275.8 10265.1 12168.1 12182.9 12415.1 12479.3 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | [#3] mootools.html Cycles:180 Average:5860.20 Median:4954.53 stddev:3407.22 (68.8%) stddev-sans-first:3401.25 08:27:25 INFO - PROCESS | 3532 | Values: 1532.3 1558.8 1724.7 1813.2 1849.8 8009.2 8685.0 8713.9 9243.3 9256.5 9013.1 9074.5 9124.2 9136.8 9149.1 2317.2 2340.4 2346.7 2347.3 2350.7 2309.2 2326.3 2366.0 2367.6 2372.5 2293.6 2301.0 2316.3 2334.3 2339.9 2236.7 2239.6 2241.9 2245.6 2273.4 2214.7 2233.3 2236.8 2237.4 2239.6 8931.1 8995.1 9056.4 9059.1 9088.0 5248.2 5368.1 5387.4 5407.4 5410.3 3352.6 3357.3 3481.1 3498.4 3503.2 1102.4 1114.5 1150.9 1152.4 1215.0 12640.4 12756.9 12780.4 12785.0 12786.6 4524.5 4525.5 4570.1 4574.3 4591.7 10121.8 10131.8 10209.6 10211.3 10227.4 5164.2 5270.3 5274.6 5280.0 5324.5 4321.6 4842.4 4947.2 4961.9 4982.1 3843.8 3858.9 3885.7 3926.5 3978.4 1090.4 1127.8 1131.0 1144.5 1154.9 963.5 979.1 997.0 1002.4 1009.4 5743.2 6057.3 6059.5 6080.8 6109.4 399.4 405.9 408.1 410.7 420.0 3929.7 4092.4 4247.7 4251.0 4277.6 11211.2 11430.3 11600.7 11604.0 11612.6 11256.9 11471.4 11496.4 11532.7 11549.9 8129.6 8421.9 8430.2 8458.6 8648.5 5680.9 5704.6 5788.4 5893.0 5904.1 9571.2 9746.3 9792.0 9807.1 9827.8 9498.6 9717.2 9833.6 9941.8 9947.7 7273.2 7482.1 7677.3 7874.6 8059.2 8761.7 8810.0 8922.0 9017.2 9056.9 7791.4 7905.0 8057.6 8093.1 8187.4 7895.7 7906.1 7930.6 8007.0 8079.8 7221.4 7236.7 7302.6 7309.6 7323.4 4989.0 5099.8 5129.2 5134.8 5151.4 4908.4 5147.6 5161.8 5202.5 5236.9 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | [#4] prototype.html Cycles:180 Average:4919.56 Median:5694.87 stddev:1494.87 (26.2%) stddev-sans-first:1458.45 08:27:25 INFO - PROCESS | 3532 | Values: 308.8 309.9 310.0 312.6 313.8 5600.7 5606.9 5611.4 5695.4 5751.2 5555.5 5609.4 5610.5 5623.7 5702.0 4150.8 4176.8 4275.6 4275.8 4275.9 4251.0 4278.3 4281.6 4293.2 4297.5 4271.8 4282.4 4289.9 4295.6 4306.3 4016.3 4214.2 4221.3 4244.4 4293.0 3656.6 3663.4 3677.2 3681.5 3696.0 5416.9 5428.8 5432.6 5450.7 5469.3 4583.9 4876.7 4891.7 4904.0 4934.0 5815.1 5828.2 5851.5 5867.5 5893.3 4025.0 4041.4 4043.5 4046.0 4073.9 5962.0 6077.9 6078.5 6107.8 6120.4 4112.4 4114.9 4129.4 4145.1 4155.7 4164.7 4182.9 4189.7 4191.8 4215.2 4658.7 4864.3 4882.7 4895.2 4920.9 5888.6 5920.4 5924.3 5934.9 5935.2 1439.9 1454.2 1455.4 1458.2 1468.8 897.4 904.9 917.8 926.8 952.4 5621.7 5646.7 5656.6 5684.8 5694.3 5901.6 5925.0 5972.5 6001.5 6009.0 5439.9 5651.5 5831.6 5836.4 5846.0 3198.5 3231.8 3239.9 3250.9 3257.4 6113.5 6292.8 6318.7 6329.7 6375.5 6142.6 6177.2 6200.9 6218.8 6220.3 6120.9 6231.5 6289.7 6318.9 6351.4 5997.6 6100.7 6136.8 6141.2 6142.8 5947.8 5991.5 6069.7 6073.4 6081.6 6055.6 6294.7 6301.2 6301.5 6311.2 4177.9 4212.6 4215.3 4221.4 4243.2 5962.9 6042.4 6043.5 6061.6 6092.6 5827.6 5853.5 5891.6 5895.8 5905.7 5858.6 5881.4 5928.5 5953.9 5982.2 5242.7 5721.1 5741.5 5797.5 5858.6 5912.0 5914.7 5919.8 5929.5 5943.1 5605.4 5802.9 5804.7 5835.6 5882.0 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - PROCESS | 3532 | [#5] yui.html Cycles:180 Average:16027.18 Median:4715.71 stddev:19107.18 (405.2%) stddev-sans-first:19126.30 08:27:25 INFO - PROCESS | 3532 | Values: 741.3 788.8 833.8 863.5 870.2 14642.9 15321.9 15546.5 15598.4 15662.3 14091.6 14114.9 14150.2 14156.5 14209.6 660.1 788.5 808.2 809.0 814.1 810.7 814.5 816.9 821.2 823.3 847.5 856.9 865.6 866.0 869.9 861.9 862.0 862.2 863.1 863.3 617.1 618.2 619.7 624.0 628.9 13233.7 13245.1 13269.3 13282.7 13360.6 13269.0 14285.7 14721.3 14864.5 14877.0 11408.5 11460.7 11685.6 11877.2 11991.0 3817.5 3880.5 3904.3 3933.4 3982.2 56772.9 57069.9 57181.7 57354.7 57557.0 10383.6 10426.6 10903.5 10994.3 11206.4 20526.4 20625.4 20679.2 20716.7 20757.0 8280.0 8487.4 8498.7 8500.7 8528.7 4941.1 4978.1 4985.5 5033.6 5246.0 3124.4 3224.0 3259.3 3346.5 3347.3 667.5 676.8 684.3 697.6 702.1 680.4 719.3 721.6 751.8 777.6 9403.4 9704.7 9734.2 9799.8 9937.9 618.2 710.0 743.7 796.2 800.7 4371.0 4651.4 4698.2 4733.2 4739.8 69658.0 70193.6 71003.0 71287.0 71449.6 57652.7 64634.0 65122.0 66104.7 66147.3 51569.5 53460.2 53894.7 57337.4 58969.7 9856.5 9884.0 9884.3 10060.8 10280.9 37676.6 37740.8 38410.4 38594.8 38770.8 44664.6 48852.5 50117.0 50625.0 51828.0 12660.2 12860.7 12899.4 12928.2 13191.3 13825.4 13841.1 14397.2 14632.3 14989.3 13382.2 13661.2 13783.9 13871.7 13999.5 12921.2 13675.3 13768.7 13830.6 14174.9 11846.2 12359.4 12525.9 12687.4 12875.3 10815.3 11116.4 11132.6 11235.6 11692.0 11839.9 11877.4 12199.5 12266.8 12305.3 08:27:25 INFO - PROCESS | 3532 | -------- Summary: end -------- 08:27:25 INFO - PROCESS | 3532 | 08:27:25 INFO - TEST-INFO | 3532: exit 0 08:27:25 INFO - TEST-OK | dromaeo_css | took 1111184ms 08:27:25 INFO - TEST-START | kraken 08:27:25 INFO - operating with platform_type : linux_ 08:27:25 INFO - Initialising browser for kraken test... 08:27:25 INFO - TEST-INFO | started process 3780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65dyWI/profile http://localhost:59253/getInfo.html) 08:27:29 INFO - PROCESS | 3780 | 08:27:29 INFO - PROCESS | 3780 | (process:3847): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:30 INFO - PROCESS | 3780 | __metrics Screen width/height:1600/1200 08:27:30 INFO - PROCESS | 3780 | colorDepth:24 08:27:30 INFO - PROCESS | 3780 | Browser inner width/height: 1024/697 08:27:30 INFO - PROCESS | 3780 | __metrics 08:27:31 ERROR - PROCESS | 3780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:27:32 INFO - TEST-INFO | 3780: exit 0 08:27:32 INFO - Browser initialized. 08:27:32 INFO - Running cycle 1/1 for kraken test... 08:27:32 INFO - TEST-INFO | started process 3898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp65dyWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:34 INFO - PROCESS | 3898 | 08:27:34 INFO - PROCESS | 3898 | (process:3960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:44 INFO - PROCESS | 3898 | RSS: Main: 163495936 08:27:44 INFO - PROCESS | 3898 | 08:27:46 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59253/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:47 INFO - PROCESS | 3898 | RSS: Main: 167444480 08:27:47 INFO - PROCESS | 3898 | 08:27:50 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59253/tests/kraken/driver.html?testName=audio-dft) 08:27:51 INFO - PROCESS | 3898 | RSS: Main: 168321024 08:27:51 INFO - PROCESS | 3898 | 08:27:54 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59253/tests/kraken/driver.html?testName=audio-fft) 08:27:54 INFO - PROCESS | 3898 | RSS: Main: 163000320 08:27:54 INFO - PROCESS | 3898 | 08:27:56 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59253/tests/kraken/driver.html?testName=audio-oscillator) 08:27:57 INFO - PROCESS | 3898 | RSS: Main: 163356672 08:27:57 INFO - PROCESS | 3898 | 08:27:59 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:00 INFO - PROCESS | 3898 | RSS: Main: 162316288 08:28:00 INFO - PROCESS | 3898 | 08:28:03 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59253/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:04 INFO - PROCESS | 3898 | RSS: Main: 162504704 08:28:04 INFO - PROCESS | 3898 | 08:28:07 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59253/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:08 INFO - PROCESS | 3898 | RSS: Main: 161193984 08:28:08 INFO - PROCESS | 3898 | 08:28:11 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59253/tests/kraken/driver.html?testName=json-parse-financial) 08:28:11 INFO - PROCESS | 3898 | RSS: Main: 162459648 08:28:11 INFO - PROCESS | 3898 | 08:28:13 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:14 INFO - PROCESS | 3898 | RSS: Main: 163655680 08:28:14 INFO - PROCESS | 3898 | 08:28:15 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:16 INFO - PROCESS | 3898 | RSS: Main: 162713600 08:28:16 INFO - PROCESS | 3898 | 08:28:18 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:19 INFO - PROCESS | 3898 | RSS: Main: 162807808 08:28:19 INFO - PROCESS | 3898 | 08:28:22 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:22 INFO - PROCESS | 3898 | RSS: Main: 163037184 08:28:22 INFO - PROCESS | 3898 | 08:28:25 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:26 INFO - PROCESS | 3898 | RSS: Main: 163885056 08:28:26 INFO - PROCESS | 3898 | 08:28:27 INFO - PROCESS | 3898 | Cycle 1(1): loaded http://localhost:59253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59253/tests/kraken/driver.html?testName=ai-astar) 08:28:28 INFO - PROCESS | 3898 | RSS: Main: 165003264 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | __start_tp_report 08:28:28 INFO - PROCESS | 3898 | _x_x_mozilla_page_load 08:28:28 INFO - PROCESS | 3898 | _x_x_mozilla_page_load_details 08:28:28 INFO - PROCESS | 3898 | |i|pagename|runs| 08:28:28 INFO - PROCESS | 3898 | |0;ai-astar;108;110;105;110;111;111;102;110;111;110 08:28:28 INFO - PROCESS | 3898 | |1;audio-beat-detection;156;139;148;209;126;161;151;128;186;133 08:28:28 INFO - PROCESS | 3898 | |2;audio-dft;162;163;162;163;165;167;168;163;161;162 08:28:28 INFO - PROCESS | 3898 | |3;audio-fft;76;75;76;172;76;75;75;74;160;75 08:28:28 INFO - PROCESS | 3898 | |4;audio-oscillator;93;93;172;93;92;93;152;91;92;157 08:28:28 INFO - PROCESS | 3898 | |5;imaging-gaussian-blur;117;118;118;118;118;118;118;117;117;118 08:28:28 INFO - PROCESS | 3898 | |6;imaging-darkroom;147;147;147;147;148;147;148;146;147;147 08:28:28 INFO - PROCESS | 3898 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;95;95 08:28:28 INFO - PROCESS | 3898 | |8;json-parse-financial;56;56;59;58;56;61;56;105;53;53 08:28:28 INFO - PROCESS | 3898 | |9;json-stringify-tinderbox;60;61;61;61;62;61;62;61;60;60 08:28:28 INFO - PROCESS | 3898 | |10;stanford-crypto-aes;79;78;80;83;86;78;79;84;82;79 08:28:28 INFO - PROCESS | 3898 | |11;stanford-crypto-ccm;130;119;134;133;122;120;121;135;205;124 08:28:28 INFO - PROCESS | 3898 | |12;stanford-crypto-pbkdf2;162;156;159;163;157;158;160;162;159;157 08:28:28 INFO - PROCESS | 3898 | |13;stanford-crypto-sha256-iterative;62;63;63;62;61;61;65;62;65;62 08:28:28 INFO - PROCESS | 3898 | __end_tp_report 08:28:28 INFO - PROCESS | 3898 | __start_cc_report 08:28:28 INFO - PROCESS | 3898 | _x_x_mozilla_cycle_collect,833 08:28:28 INFO - PROCESS | 3898 | __end_cc_report 08:28:28 INFO - PROCESS | 3898 | __startTimestamp1463585308044__endTimestamp 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | ------- Summary: start ------- 08:28:28 INFO - PROCESS | 3898 | Number of tests: 14 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.01 (2.7%) stddev-sans-first:3.18 08:28:28 INFO - PROCESS | 3898 | Values: 108.0 110.0 105.0 110.0 111.0 111.0 102.0 110.0 111.0 110.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:153.50 stddev:26.40 (17.2%) stddev-sans-first:27.99 08:28:28 INFO - PROCESS | 3898 | Values: 156.0 139.0 148.0 209.0 126.0 161.0 151.0 128.0 186.0 133.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.39 08:28:28 INFO - PROCESS | 3898 | Values: 162.0 163.0 162.0 163.0 165.0 167.0 168.0 163.0 161.0 162.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.37 (51.2%) stddev-sans-first:40.18 08:28:28 INFO - PROCESS | 3898 | Values: 76.0 75.0 76.0 172.0 76.0 75.0 75.0 74.0 160.0 75.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:92.50 stddev:33.17 (35.9%) stddev-sans-first:34.40 08:28:28 INFO - PROCESS | 3898 | Values: 93.0 93.0 172.0 93.0 92.0 93.0 152.0 91.0 92.0 157.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:28:28 INFO - PROCESS | 3898 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:28:28 INFO - PROCESS | 3898 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 147.0 147.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:28:28 INFO - PROCESS | 3898 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:56.00 stddev:15.55 (27.8%) stddev-sans-first:16.37 08:28:28 INFO - PROCESS | 3898 | Values: 56.0 56.0 59.0 58.0 56.0 61.0 56.0 105.0 53.0 53.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 08:28:28 INFO - PROCESS | 3898 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 62.0 61.0 60.0 60.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:2.78 (3.4%) stddev-sans-first:2.87 08:28:28 INFO - PROCESS | 3898 | Values: 79.0 78.0 80.0 83.0 86.0 78.0 79.0 84.0 82.0 79.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:131.50 stddev:25.59 (19.5%) stddev-sans-first:27.09 08:28:28 INFO - PROCESS | 3898 | Values: 130.0 119.0 134.0 133.0 122.0 120.0 121.0 135.0 205.0 124.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.50 stddev:2.41 (1.5%) stddev-sans-first:2.35 08:28:28 INFO - PROCESS | 3898 | Values: 162.0 156.0 159.0 163.0 157.0 158.0 160.0 162.0 159.0 157.0 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - PROCESS | 3898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.50 08:28:28 INFO - PROCESS | 3898 | Values: 62.0 63.0 63.0 62.0 61.0 61.0 65.0 62.0 65.0 62.0 08:28:28 INFO - PROCESS | 3898 | -------- Summary: end -------- 08:28:28 INFO - PROCESS | 3898 | 08:28:28 INFO - TEST-INFO | 3898: exit 0 08:28:29 INFO - TEST-OK | kraken | took 63084ms 08:28:29 INFO - SUITE-END | took 1174s 08:28:29 INFO - Completed test suite (00:19:34) 08:28:29 INFO - javascript benchmark 08:28:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7238.110351206168, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.85929133189, 3184.6815318468143, 3184.7133757961788, 3225.9032229033123, 3227.8708851645933, 5455.127179651252, 5489.560835133185, 5502.312210973629, 5516.255305533757, 5532.0, 5347.0909945309295, 5415.83752487425, 5455.945440545594, 5467.808626698066, 5528.723563821813, 4934.777934992916, 4965.875853103666, 5081.8221362252325, 5100.9489905100845, 5140.023395554833, 665.7044390114584, 5044.092063428599, 5061.5950723942, 5086.618503612244, 5113.5909127269915, 4961.925571116436, 4966.850994470172, 4996.975015124919, 5000.424951130612, 5033.874153146164, 4896.779644915988, 4961.330220420233, 4968.87577810554, 5006.649534532584, 5070.594352451832, 4933.975330123362, 4938.654294199408, 4943.876403089916, 4947.084789313988, 4948.752562371867, 5333.0, 5357.544608708265, 5387.676739395649, 5391.973040134813, 5406.837794866121, 5709.143628455723, 5734.283214598176, 5790.88418231633, 5840.386759390245, 5882.205902203191, 5724.5992780505385, 5774.989376859075, 5784.797532086399, 5785.884282314372, 5834.6790926499025, 5372.247885296062, 5429.755660995264, 5435.864103397407, 5447.019536483432, 5447.400785913546, 5836.474717275466, 5960.344362120163, 5994.490468310242, 5998.670073145931, 6023.0, 5794.768209271666, 5830.591858569945, 5830.7959221427045, 5834.649921004753, 5836.824895253149, 5915.7633694652595, 5919.141724449931, 5934.465898069195, 5940.079287710412, 5943.227380440515, 5704.0, 5777.393373695785, 5808.6224395414165, 5837.211976383134, 5874.706264686749, 5683.0, 5804.04233301509, 5831.679257640871, 5853.151293062482, 5854.502367298827, 4454.420925279757, 4463.218936686067, 4470.262406702923, 4494.685372023992, 4529.071540334224, 3907.9218415631526, 3950.288947989332, 3978.423128646388, 3995.180987897474, 4004.0990777074926, 5692.0, 5692.686902220417, 5723.112917497794, 5731.0, 5745.224394706661, 5901.0, 5970.701464926737, 5981.102834574762, 5991.370906054889, 5997.610155339889, 5588.748506317225, 5668.404817494104, 5672.404397538282, 5709.971450142806, 5711.0, 5110.7955681773055, 5113.923291150636, 5118.795248190105, 5120.462351453119, 5131.743412829418, 5985.551083668743, 6189.659568723673, 6194.473469755121, 6194.659293738798, 6216.098665693539, 5777.306723193327, 5797.710114494174, 5805.854853628524, 5831.212786273968, 5852.356240813422, 6003.099535069775, 6016.217891674054, 6029.909551356645, 6034.336223015553, 6046.274447066205, 5711.143328500592, 5725.08398656213, 5741.885162296814, 5747.942520574741, 5759.510441612342, 5858.179854820414, 5900.498457631149, 5926.555508336805, 5960.850978725566, 5968.134620479919, 5726.856828579319, 5750.971245143747, 5779.508741756998, 5783.566232532493, 5787.623804452697, 5587.8882422352135, 5669.773209071591, 5677.8864422710485, 5693.715314234355, 5750.079987202028, 5478.972605136949, 5502.58730595199, 5516.172574113915, 5597.720113994203, 5698.373178950395, 5654.547636189177, 5735.11105778605, 5762.0780675093465, 5785.9132113017495, 5792.9710351447975, 5624.240727501735, 5636.802711905064, 5639.069553523623, 5646.548276137982, 5649.0], "value": 5376.6945872960705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1821164110987, 625.4371066040563, 634.2737565487514, 648.8021153548169, 663.0750103605473, 42325.0, 42431.57568424319, 42552.361714574305, 43085.138297234036, 47398.526014739844, 45083.77458112713, 45654.0, 45847.31229031559, 45957.31064034042, 46109.30836037462, 8906.10938906109, 9038.457692538468, 9066.546672666373, 9073.682421115262, 9091.409058411215, 8959.283257339397, 9094.136057074567, 9100.226480749112, 9110.088991100904, 9122.498262595554, 9066.818663626724, 9159.313051521129, 9166.083391660814, 9172.266218702522, 9173.220276276525, 9068.682596109138, 9160.17558419742, 9169.908300916972, 9175.128362805523, 9190.310726695525, 8963.731088067369, 8987.955060224722, 8992.77518062047, 9000.594973226154, 9013.729588112366, 42252.0, 42489.57510424887, 42619.9345016374, 42740.78629606832, 42758.358624620654, 3489.8778542750883, 3701.222743223899, 3944.1717239379764, 4059.72470023026, 4334.501532323791, 31370.843145784354, 31556.842215789005, 31787.523187152212, 31913.680863191534, 32992.0, 4352.717073390219, 4380.54004329544, 4448.377227188196, 4500.167469018242, 4636.072785442925, 365181.0, 365952.0, 366170.0, 366230.0, 367685.0, 57465.0, 58954.41045589489, 59060.70469647624, 59147.0, 59220.70389648111, 61739.38260617336, 61812.0, 61950.69024654848, 62059.68970155211, 62213.68893155505, 16184.514464566082, 16266.674666506604, 16316.510504684878, 16343.346266149221, 16364.754528682079, 12952.158109722837, 13018.479260829461, 13053.804192937114, 13054.0, 13071.41178646963, 15219.391224350902, 16284.0, 16383.918080409521, 16403.097829619248, 16566.420175293806, 6496.512761542903, 6571.0, 6583.769568065095, 6669.366410191024, 6707.256113410548, 971.5773638467148, 1042.4370839746603, 1092.547549742809, 1108.95564177432, 1238.8946939510063, 33667.15832104217, 34307.828460857534, 34887.0, 36841.0, 36948.815255923546, 1136.4147464056018, 1139.4302848575712, 1178.0340121100787, 1185.3717529709268, 1255.893249073839, 16443.424480143378, 16639.584010399838, 16821.0, 16965.575860603585, 17073.48779536616, 514751.0, 518512.0, 519048.0, 520169.0, 521316.0, 55098.72450637721, 56689.0, 56852.431475684716, 56892.71553642205, 56991.715041425356, 1330.1154732103043, 1426.2227086238024, 1444.1768192130594, 1476.7489526780473, 1477.394268349993, 32221.67778322187, 33002.66997329996, 33498.49752253767, 33581.66418335883, 33873.983780486626, 48192.277115843994, 48299.75850120727, 48719.0, 48726.75636621936, 48838.26742598793, 408597.0, 410729.0, 413154.0, 414075.0, 418249.0, 27490.725092748817, 27938.441231175668, 28046.85976570104, 28124.0, 28131.0, 47099.29351059668, 47601.761991191204, 47994.76002619965, 48330.275045873634, 48589.5141048585, 40406.595934041456, 41011.384829228184, 41707.7914610425, 41732.79133604313, 42615.0, 39887.40168897411, 40686.59313406828, 41625.79187104045, 41689.37465938074, 42275.57724422839, 42081.15837683168, 42436.1512769749, 42620.78689606656, 42748.78625606852, 43148.56851431446, 35018.649813501535, 37217.25565488729, 37270.62729372671, 37914.62085379111, 38043.23913521769, 29623.407531849673, 29712.405751885275, 29747.405051899274, 29906.10281691553, 29944.700552994193], "value": 20353.441883810476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.9517657881054, 408.29772790799825, 411.3110539845758, 412.7605988526657, 424.8661671573454, 13389.799153012687, 17715.64568708625, 19054.333098341544, 19176.71234931477, 19251.807481925178, 18732.344367947124, 18902.243910243607, 19215.903920480414, 19447.222111115538, 19650.0, 5586.35756887958, 5655.4061823508355, 5658.745356458949, 5769.3076830780365, 5787.160861675055, 5398.352197736277, 5692.715364231793, 5726.914096288559, 5731.856703582402, 5736.512396446307, 5744.913826292609, 5745.971270143665, 5752.395998420168, 5757.539396848242, 5760.740766665489, 5850.502707269866, 6137.386261373849, 6207.224096987854, 6266.530010249204, 6278.434940855299, 5420.891582168335, 5671.262735844314, 5690.260266165372, 5710.2862142232225, 5710.800121995751, 13401.86598134016, 13687.863121368759, 13995.930020349935, 22942.885285573633, 22970.7702922972, 2328.781413463011, 2453.8405003674884, 2460.3726049857173, 2559.948801023988, 2826.8869245230167, 10030.2477314201, 10219.7445063874, 10220.744481388025, 10242.590296388136, 10442.0, 1975.8715683480527, 2033.6339458897392, 2050.3746357361, 2068.979310206894, 2074.802893725094, 75049.24950750532, 75946.24053759447, 77248.0, 77478.0, 77982.99999999943, 10632.734181645521, 10709.0, 10973.670789876316, 11029.22795404314, 11120.332780033224, 15119.16844573537, 15173.393064277527, 15274.618134546503, 15275.0, 15299.388024479118, 7692.153863075057, 7846.058472983164, 7950.165232650604, 7980.760577182694, 8060.274575288252, 7500.287472690085, 7536.623168841536, 7539.0, 7632.389408847279, 7651.655675494616, 4619.445666520039, 4650.139724151043, 4684.5549672781035, 4750.192467280571, 4765.093293091211, 1935.419374187738, 1991.3528103366464, 2011.054804242004, 2023.3323003409134, 2027.9797202027792, 1036.6371769880632, 1074.258761454594, 1126.819708846597, 1147.4836323654388, 1182.3254709513997, 19135.13891874869, 19435.708464373045, 19737.802621973595, 20053.197872084955, 20073.096710648057, 1008.7377281906757, 1013.0426746724422, 1013.2299452416216, 1036.2228777646221, 1043.5147656339839, 10589.523471443803, 11242.831357529643, 11281.379524126087, 11319.434028298552, 11331.660050198507, 431089.0, 434183.0, 434695.0, 456843.0, 457588.0, 90031.0, 93990.0, 94040.52979735058, 94104.52947735217, 95329.0, 1035.9896401036044, 1053.0680347892016, 1070.0423121306542, 1071.0895738622264, 1089.1395797320188, 17189.14054297305, 17315.307387704856, 17391.7391239129, 17613.38353157633, 17670.646587068444, 41227.0, 41448.171036579704, 41913.58086419097, 41954.580454195064, 42719.786401067795, 55914.0, 57795.42204578069, 58002.709986449794, 58150.4184958145, 59221.70389148027, 7407.59258240802, 7650.6174691264105, 8525.74422767318, 8708.521031343083, 8906.599203036008, 12968.416421260878, 13118.0, 13242.735145297233, 13366.86633133695, 13532.323383830966, 11709.0, 11916.948237599257, 11928.224665396721, 12242.081843861924, 12252.816207757069, 11397.259178153725, 11584.362860042778, 11683.88316116862, 11985.22096063753, 11999.40002999829, 12012.279263244232, 12049.397530123284, 12094.39528023613, 12268.87731122713, 12400.937995309965, 7830.177831327628, 7941.642626081955, 7968.0, 8186.631601577824, 8275.83448331018, 10265.067702896391, 12168.148229623841, 12182.939085304517, 12415.130940834055, 12479.31363775001], "value": 9198.141152833607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.3104602928681, 1558.8207356154041, 1724.7412888066788, 1813.2475022865503, 1849.7780266368038, 8009.159038300982, 8685.0, 8713.912860871389, 9243.306751993603, 9256.537173141332, 9013.05362936892, 9074.546272686372, 9124.224440922513, 9136.817263654722, 9149.085091490848, 2317.18898385565, 2340.414896275931, 2346.730126035502, 2347.3310106619615, 2350.7296660884044, 2309.1802410144323, 2326.26722582386, 2365.95268094638, 2367.550165468564, 2372.5136347048815, 2293.5642227976714, 2300.9884950575224, 2316.293530473205, 2334.253039027512, 2339.9415014624688, 2236.7315922089374, 2239.6192647250004, 2241.9103235870543, 2245.62947113726, 2273.4202778291597, 2214.723159605049, 2233.3411643565187, 2236.809871160953, 2237.3623517297656, 2239.6080685879906, 8931.062238464932, 8995.145461181242, 9056.366054376196, 9059.094090590954, 9087.954560227223, 5248.239005344242, 5368.0605893968395, 5387.380451248078, 5407.3781515125875, 5410.269613602152, 3352.6312105668358, 3357.2781851901714, 3481.0601137692934, 3498.3528047311074, 3503.2468019375956, 1102.393683474086, 1114.5151858941385, 1150.896419322265, 1152.4180288954108, 1214.9757004859941, 12640.367981600883, 12756.936215318863, 12780.424880880382, 12785.041121915801, 12786.552470663575, 4524.479684836286, 4525.502194758574, 4570.108828778356, 4574.290984897346, 4591.724496530219, 10121.797564048678, 10131.848022279672, 10209.642662506925, 10211.285210035374, 10227.386356818615, 5164.1995490699, 5270.288511051036, 5274.604404669665, 5280.0, 5324.520793128637, 4321.5678432157165, 4842.394700662418, 4947.208446648519, 4961.8511444656715, 4982.103221420107, 3843.7693738375788, 3858.9421158682644, 3885.7279990400966, 3926.469926559935, 3978.42312864633, 1090.3784842639777, 1127.8195488721765, 1130.9642643242132, 1144.4506636814376, 1154.8556430446195, 963.4989805301204, 979.0747743382577, 996.9601215951426, 1002.4436437776958, 1009.4266297307596, 5743.167240750068, 6057.273127224761, 6059.545534084961, 6080.847978800477, 6109.358517355702, 399.3929227574071, 405.87417900450953, 408.11642793352655, 410.67351455592876, 420.01087439080527, 3929.685625149981, 4092.4475195848777, 4247.660187185018, 4250.978745106317, 4277.615014648696, 11211.159163062639, 11430.25703329281, 11600.709982250512, 11604.0, 11612.593559225386, 11256.887431125584, 11471.426428678533, 11496.367699776592, 11532.654020379403, 11549.942250288696, 8129.552874591836, 8421.915780842113, 8430.15698430152, 8458.577071146417, 8648.481091134552, 5680.943190568207, 5704.629199102045, 5788.363280039276, 5893.0, 5904.0553511437965, 9571.234301255743, 9746.31775775689, 9792.0, 9807.13664403761, 9827.803443931225, 9498.620055197714, 9717.22262219035, 9833.606655733976, 9941.751456213364, 9947.701568952943, 7273.163586187445, 7482.139553951148, 7677.347425468898, 7874.606269686378, 8059.234372734581, 8761.737147885573, 8810.03089660124, 8921.955390223007, 9017.188453039258, 9056.909430905871, 7791.415643826623, 7905.0, 8057.637406316612, 8093.069297030681, 8187.426880118334, 7895.7236496722335, 7906.051273847175, 7930.603469826601, 8006.959965200137, 8079.757607271791, 7221.4222862169845, 7236.710531578889, 7302.634868256459, 7309.561426314438, 7323.414126869731, 4988.9501104988485, 5099.770510327118, 5129.204973229155, 5134.76893539799, 5151.356080489939, 4908.410990681141, 5147.5881929446305, 5161.7677204525135, 5202.505761952609, 5236.947630523646], "value": 4568.43928383446, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.77922285565813, 309.86365998960457, 309.9969000309997, 312.6389020681111, 313.7881929697455, 5600.691961942097, 5606.859828504289, 5611.438856114387, 5695.430456954303, 5751.223584816049, 5555.527780138693, 5609.439056094388, 5610.4670056344685, 5623.710129574204, 5701.971490142543, 4150.837765425678, 4176.770277634729, 4275.572442755731, 4275.8075886585175, 4275.947545178316, 4251.0, 4278.315469524877, 4281.636060934824, 4293.162833247518, 4297.462817147856, 4271.765052922088, 4282.357646353056, 4289.871303860889, 4295.613394794468, 4306.332518459643, 4016.337304344794, 4214.2414365414215, 4221.303484924983, 4244.448221731186, 4292.97853510732, 3656.561212654472, 3663.432168013962, 3677.2093999790172, 3681.4845921571, 3695.9630403695887, 5416.864578385533, 5428.782848686048, 5432.64687795296, 5450.672959622435, 5469.304515600176, 4583.885402864922, 4876.707397556158, 4891.679246603398, 4903.975480122613, 4933.975330123327, 5815.110089220978, 5828.242328497311, 5851.473367396955, 5867.530597552186, 5893.347993402986, 4024.9597504024878, 4041.3533834586324, 4043.4945631796027, 4046.0, 4073.9185216295805, 5961.970190149022, 6077.908831367533, 6078.45293923549, 6107.786227482061, 6120.44915957566, 4112.362583799456, 4114.897127571775, 4129.401236820644, 4145.108801607669, 4155.688323375759, 4164.66682665386, 4182.874513764592, 4189.680250721013, 4191.769452680071, 4215.199112168678, 4658.650601204923, 4864.3218089758975, 4882.707037577757, 4895.216765317532, 4920.901581968412, 5888.587798854039, 5920.437558431942, 5924.289085309791, 5934.910976335358, 5935.1987481690285, 1439.9344485081174, 1454.156589178274, 1455.432381371266, 1458.190704159202, 1468.7943687883705, 897.4301318662697, 904.8734325764334, 917.788908551037, 926.8053708721244, 952.3524003677566, 5621.7189140542805, 5646.717664116778, 5656.5757568181725, 5684.801031963944, 5694.316681998187, 5901.557383196277, 5925.0, 5972.492338151305, 6001.489873360813, 6008.969955150284, 5439.891202176013, 5651.463111004448, 5831.562632802472, 5836.358000619928, 5845.9707701462075, 3198.4882418813345, 3231.8222497762376, 3239.886603968897, 3250.902472925816, 3257.4299497587826, 6113.510919126459, 6292.804367170223, 6318.71565779541, 6329.68351582419, 6375.481684734504, 6142.57002009855, 6177.166082578884, 6200.937990620127, 6218.751249950042, 6220.315765265817, 6120.8775824484155, 6231.532635052389, 6289.654069026156, 6318.873622527615, 6351.396617321347, 5997.640141591519, 6100.725467353891, 6136.7852125175405, 6141.170941922784, 6142.78500252489, 5947.762089516371, 5991.490723288395, 6069.726862291119, 6073.392660734068, 6081.5742897996715, 6055.6063855849225, 6294.685265736786, 6301.212348456443, 6301.527385446201, 6311.2426508819235, 4177.895552611088, 4212.599803018708, 4215.283401821636, 4221.446025154737, 4243.172581346607, 5962.940370596412, 6042.3655516170165, 6043.516518678407, 6061.636301821904, 6092.603980741238, 5827.562932779973, 5853.531717462678, 5891.558133140117, 5895.793647222326, 5905.734241959036, 5858.619189752652, 5881.38245484218, 5928.466438020599, 5953.9404605955115, 5982.192404025401, 5242.659227150223, 5721.113227449752, 5741.473751549472, 5797.5361971041375, 5858.560607954335, 5911.970440147772, 5914.674692891932, 5919.763209471573, 5929.466348028698, 5943.068502736542, 5605.355384130877, 5802.912956305743, 5804.6807425592, 5835.649861008353, 5881.97065513542], "value": 4425.80344912013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2698491985394, 788.8067423481247, 833.8290650416665, 863.5034854958401, 870.1733353314353, 14642.853571464282, 15321.92339038306, 15546.455874044383, 15598.376064957401, 15662.295196716146, 14091.577252682411, 14114.858851411484, 14150.221737804417, 14156.50452234172, 14209.644758881033, 660.1121491593823, 788.5111231036765, 808.2442915873647, 809.0332053196432, 814.1451475950244, 810.6838333050115, 814.5112932240638, 816.942814003017, 821.1911267401634, 823.320760372695, 847.5126802088793, 856.9271611912994, 865.6407590849822, 865.9956700216521, 869.9304055675531, 861.8577934640776, 861.9827603447895, 862.2412277196058, 863.1023735315296, 863.3007264116055, 617.0559044661675, 618.1623899616045, 619.6684773646077, 623.9781607643711, 628.8585068359582, 13233.669158271025, 13245.07284490086, 13269.270190139538, 13282.73434531304, 13360.599182024458, 13269.0, 14285.714285714332, 14721.337539810627, 14864.479743208936, 14877.0, 11408.54365825366, 11460.713482163013, 11685.591004314809, 11877.22798018126, 11991.04071674264, 3817.522809648794, 3880.4567360569545, 3904.297226499229, 3933.429652700371, 3982.1637456134245, 56772.864542708914, 57069.85860282813, 57181.714091429276, 57354.71322643402, 57557.0, 10383.636572719919, 10426.5829366826, 10903.509342079626, 10994.287194250395, 11206.439678016066, 20526.38420847377, 20625.381238562866, 20679.172833086508, 20716.689249661267, 20757.0, 8280.0, 8487.405881588353, 8498.66005359791, 8500.70247541333, 8528.701495447629, 4941.110600091946, 4978.103941290602, 4985.451600323961, 5033.5721463676, 5246.0, 3124.4376012318003, 3224.0489055728617, 3259.250372414358, 3346.54821599081, 3347.313800670857, 667.512715717529, 676.7800464848943, 684.3225207045089, 697.6197972105215, 702.0592406175749, 680.3561981141867, 719.3382088478508, 721.5923003503004, 751.7896187138812, 777.6413203991658, 9403.43579385239, 9704.664477519742, 9734.172595329477, 9799.755006124904, 9937.900620993698, 618.2410941475906, 709.9574025558483, 743.7099531182843, 796.1600511460465, 800.667722894992, 4370.978145109254, 4651.441826980784, 4698.201305778026, 4733.219018861918, 4739.786709598076, 69658.0, 70193.64903175451, 71003.0, 71287.0, 71449.64275178695, 57652.71173644189, 64634.0, 65122.0, 66104.73511439344, 66147.33852661509, 51569.48430515647, 53460.19809702857, 53894.73052634712, 57337.42662573404, 58969.705151473965, 9856.507174641096, 9883.950580247052, 9884.258680599127, 10060.800447635447, 10280.86910439836, 37676.623233767314, 37740.81129594334, 38410.42384364181, 38594.80702596469, 38770.80614596909, 44664.55335446604, 48852.5114748848, 50117.0, 50625.0, 51828.0, 12660.240385576895, 12860.678483037998, 12899.419526121159, 12928.159669621444, 13191.34043297812, 13825.377857996213, 13841.100328478617, 14397.208153551655, 14632.268386580416, 14989.250537473301, 13382.197068175941, 13661.248631325372, 13783.862161378258, 13871.653208669864, 13999.510017149758, 12921.224726516439, 13675.316234188449, 13768.724625507633, 13830.585082447542, 14174.858251417354, 11846.229995050295, 12359.38203089824, 12525.874741252472, 12687.365631718561, 12875.291858947474, 10815.297005694605, 11116.388598626829, 11132.590233017898, 11235.606753763906, 11692.0, 11839.881601183877, 11877.406129693654, 12199.451024703732, 12266.815997759863, 12305.26168429897], "value": 7064.703609044726, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 105.0, 110.0, 111.0, 111.0, 102.0, 110.0, 111.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 139.0, 148.0, 209.0, 126.0, 161.0, 151.0, 128.0, 186.0, 133.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 165.0, 167.0, 168.0, 163.0, 161.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 172.0, 76.0, 75.0, 75.0, 74.0, 160.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 172.0, 93.0, 92.0, 93.0, 152.0, 91.0, 92.0, 157.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 59.0, 58.0, 56.0, 61.0, 56.0, 105.0, 53.0, 53.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 83.0, 86.0, 78.0, 79.0, 84.0, 82.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 119.0, 134.0, 133.0, 122.0, 120.0, 121.0, 135.0, 205.0, 124.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 159.0, 163.0, 157.0, 158.0, 160.0, 162.0, 159.0, 157.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 61.0, 61.0, 65.0, 62.0, 65.0, 62.0], "value": 62.6, "unit": "score"}]}]} 08:28:29 INFO - Return code: 0 08:28:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:28:29 ERROR - # TBPL SUCCESS # 08:28:29 INFO - Running post-action listener: _resource_record_post_action 08:28:29 INFO - ##### 08:28:29 INFO - ##### Finished run-tests step (success) 08:28:29 INFO - ##### 08:28:29 INFO - Running post-run listener: _resource_record_post_run 08:28:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542883840; Read time: 68; Write time: 1239772 08:28:29 INFO - TinderboxPrint: CPU usage
13.5% 08:28:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 68 08:28:29 INFO - TinderboxPrint: I/O write bytes / time
542,883,840 / 1,239,772 08:28:29 INFO - TinderboxPrint: CPU idle
8,226.5 (86.5%) 08:28:29 INFO - TinderboxPrint: CPU user
1,217.3 (12.8%) 08:28:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:28:29 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 253157376; Read time: 0; Write time: 689288 08:28:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289726464; Read time: 68; Write time: 550484 08:28:29 INFO - Running post-run listener: _upload_blobber_files 08:28:29 INFO - Blob upload gear active. 08:28:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:29 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 08:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:35 INFO - (blobuploader) - INFO - Done attempting. 08:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:28:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:36 INFO - (blobuploader) - INFO - Done attempting. 08:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:37 INFO - (blobuploader) - INFO - Done attempting. 08:28:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:37 INFO - Return code: 0 08:28:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f51022fb5f06e3a3958dfd7b33dd95ca3faf7bf930f166adc33e1a78cffc3baf9f6bebd334b0f48db02ce78f5a807b881ce2665319888c4b94fc2f42790d7fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cff40636b62c04a501b14542ddc97742d30b504350ad71e980f31be76e50d7cd0fc3dc2e11b86b36e4564e8330cde6dbfe4d482f35d415afc11785e4c2f5e0f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f313ac3579e5e456a8a5a0da4d9095415f52fba8628b0cafd493abf39c3a5a4f345bc1bdafa585ea6d3b8944ab4208a525694b297a28d448c1c6fd993af7d08"} 08:28:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:37 INFO - Contents: 08:28:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f51022fb5f06e3a3958dfd7b33dd95ca3faf7bf930f166adc33e1a78cffc3baf9f6bebd334b0f48db02ce78f5a807b881ce2665319888c4b94fc2f42790d7fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cff40636b62c04a501b14542ddc97742d30b504350ad71e980f31be76e50d7cd0fc3dc2e11b86b36e4564e8330cde6dbfe4d482f35d415afc11785e4c2f5e0f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f313ac3579e5e456a8a5a0da4d9095415f52fba8628b0cafd493abf39c3a5a4f345bc1bdafa585ea6d3b8944ab4208a525694b297a28d448c1c6fd993af7d08"} 08:28:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:37 INFO - Copying logs to upload dir... 08:28:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.882721 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-18 08:28:37.269411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 08:28:37.273088) ========= 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=745a4373a2a16df560f216e000000264-1463584076.201394-279180856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f51022fb5f06e3a3958dfd7b33dd95ca3faf7bf930f166adc33e1a78cffc3baf9f6bebd334b0f48db02ce78f5a807b881ce2665319888c4b94fc2f42790d7fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cff40636b62c04a501b14542ddc97742d30b504350ad71e980f31be76e50d7cd0fc3dc2e11b86b36e4564e8330cde6dbfe4d482f35d415afc11785e4c2f5e0f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f313ac3579e5e456a8a5a0da4d9095415f52fba8628b0cafd493abf39c3a5a4f345bc1bdafa585ea6d3b8944ab4208a525694b297a28d448c1c6fd993af7d08"} build_url:https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/C9-9u3h3RbO9FltpLrrAhw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f51022fb5f06e3a3958dfd7b33dd95ca3faf7bf930f166adc33e1a78cffc3baf9f6bebd334b0f48db02ce78f5a807b881ce2665319888c4b94fc2f42790d7fc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cff40636b62c04a501b14542ddc97742d30b504350ad71e980f31be76e50d7cd0fc3dc2e11b86b36e4564e8330cde6dbfe4d482f35d415afc11785e4c2f5e0f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f313ac3579e5e456a8a5a0da4d9095415f52fba8628b0cafd493abf39c3a5a4f345bc1bdafa585ea6d3b8944ab4208a525694b297a28d448c1c6fd993af7d08"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 08:28:37.296949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:28:37.297268) ========= 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=745a4373a2a16df560f216e000000264-1463584076.201394-279180856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:28:37.380251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 08:28:37.380555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 08:28:37.380845) ========= ========= Total master_lag: 0.16 =========