builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1463584567.4 results: success (0) buildid: 20160518053011 builduid: ccaea75549fb4f6eafcefd5fc72a52a9 revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.399539) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.400042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.400359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.416683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.417167) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 08:16:07-- 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% 67.1M=0s 2016-05-18 08:16:07 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.518380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.519060) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016074 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:07.571157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 08:16:07.571981) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 08:16:07,654 truncating revision to first 12 chars 2016-05-18 08:16:07,654 Setting DEBUG logging. 2016-05-18 08:16:07,654 attempt 1/10 2016-05-18 08:16:07,654 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:16:08,753 unpacking tar archive at: fx-team-47b83c8478a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361231 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 08:16:08.951765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:08.952524) ========= script_repo_revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:08.953436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:08.954118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 08:16:08.965491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-18 08:16:08.965804) ========= /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=31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:09 INFO - MultiFileLogger online at 20160518 08:16:09 in /builds/slave/test 08:16:09 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:16:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:09 INFO - {'append_to_log': False, 08:16:09 INFO - 'base_work_dir': '/builds/slave/test', 08:16:09 INFO - 'blob_upload_branch': 'Fx-Team', 08:16:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:09 INFO - 'branch': 'Fx-Team', 08:16:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:09 INFO - 'config_files': ('talos/linux_config.py',), 08:16:09 INFO - 'default_actions': ('clobber', 08:16:09 INFO - 'read-buildbot-config', 08:16:09 INFO - 'download-and-extract', 08:16:09 INFO - 'populate-webroot', 08:16:09 INFO - 'create-virtualenv', 08:16:09 INFO - 'install', 08:16:09 INFO - 'run-tests'), 08:16:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:09 INFO - 'download_minidump_stackwalk': True, 08:16:09 INFO - 'download_symbols': 'ondemand', 08:16:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:09 INFO - 'installer_path': 'installer.exe', 08:16:09 INFO - 'log_level': 'info', 08:16:09 INFO - 'log_name': 'talos', 08:16:09 INFO - 'log_to_console': True, 08:16:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:09 INFO - 'opt_config_files': (), 08:16:09 INFO - 'pip_index': False, 08:16:09 INFO - 'sps_profile': False, 08:16:09 INFO - 'sps_profile_interval': 0, 08:16:09 INFO - 'suite': 'dromaeojs-e10s', 08:16:09 INFO - 'system_bits': '32', 08:16:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:09 INFO - 'title': 'talos-linux64-ix-014', 08:16:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:09 INFO - 'use_talos_json': True, 08:16:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:09 INFO - 'work_dir': 'build'} 08:16:09 INFO - ##### 08:16:09 INFO - ##### Running clobber step. 08:16:09 INFO - ##### 08:16:09 INFO - Running pre-action listener: _resource_record_pre_action 08:16:09 INFO - Running main action method: clobber 08:16:09 INFO - rmtree: /builds/slave/test/build 08:16:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:09 INFO - Running post-action listener: _resource_record_post_action 08:16:09 INFO - ##### 08:16:09 INFO - ##### Finished clobber step (success) 08:16:09 INFO - ##### 08:16:09 INFO - ##### 08:16:09 INFO - ##### Running read-buildbot-config step. 08:16:09 INFO - ##### 08:16:09 INFO - Running pre-action listener: _resource_record_pre_action 08:16:09 INFO - Running main action method: read_buildbot_config 08:16:09 INFO - Using buildbot properties: 08:16:09 INFO - { 08:16:09 INFO - "project": "", 08:16:09 INFO - "product": "firefox", 08:16:09 INFO - "script_repo_revision": "production", 08:16:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:16:09 INFO - "repository": "", 08:16:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:16:09 INFO - "buildid": "20160518053011", 08:16:09 INFO - "pgo_build": "True", 08:16:09 INFO - "basedir": "/builds/slave/test", 08:16:09 INFO - "buildnumber": 475, 08:16:09 INFO - "slavename": "talos-linux64-ix-014", 08:16:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:16:09 INFO - "platform": "ubuntu64_hw", 08:16:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:16:09 INFO - "branch": "fx-team", 08:16:09 INFO - "repo_path": "integration/fx-team", 08:16:09 INFO - "revision": "47b83c8478a06374aa9306122a778654b912f713", 08:16:09 INFO - "stage_platform": "linux64-pgo", 08:16:09 INFO - "builduid": "ccaea75549fb4f6eafcefd5fc72a52a9", 08:16:09 INFO - "slavebuilddir": "test" 08:16:09 INFO - } 08:16:09 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:16:09 INFO - Running post-action listener: _resource_record_post_action 08:16:09 INFO - ##### 08:16:09 INFO - ##### Finished read-buildbot-config step (success) 08:16:09 INFO - ##### 08:16:09 INFO - ##### 08:16:09 INFO - ##### Running download-and-extract step. 08:16:09 INFO - ##### 08:16:09 INFO - Running pre-action listener: _resource_record_pre_action 08:16:09 INFO - Running main action method: download_and_extract 08:16:09 INFO - mkdir: /builds/slave/test/build/tests 08:16: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:16:09 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:16: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.test_packages.json 08:16: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.test_packages.json 08:16: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.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:16: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.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:16:10 INFO - Downloaded 1361 bytes. 08:16:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:16:10 INFO - Using the following test package requirements: 08:16:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:16:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:16:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'jsshell-linux-x86_64.zip'], 08:16:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:16:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:16:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:16:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:16:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:16:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:10 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:16:10 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:16:10 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:16:10 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:16:10 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:16:11 INFO - Downloaded 24063278 bytes. 08:16:11 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:16:11 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:16:12 INFO - Return code: 0 08:16:12 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:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:12 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:16:12 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:16:12 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:16:12 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:16:12 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:16:13 INFO - Downloaded 24063278 bytes. 08:16:13 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:16:13 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:16:15 INFO - Return code: 0 08:16: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:16:15 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:16:15 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:16:15 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:16:15 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:16:15 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:16:16 INFO - Downloaded 10840194 bytes. 08:16:16 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:16:16 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:16:16 INFO - Return code: 0 08:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:16 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:16:16 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:16:16 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:16:16 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:16:16 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:16:17 INFO - Downloaded 58383497 bytes. 08:16:17 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:16:17 INFO - mkdir: /builds/slave/test/properties 08:16:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:17 INFO - Contents: 08:16:17 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:16:18 INFO - Running post-action listener: _resource_record_post_action 08:16:18 INFO - Running post-action listener: set_extra_try_arguments 08:16:18 INFO - ##### 08:16:18 INFO - ##### Finished download-and-extract step (success) 08:16:18 INFO - ##### 08:16:18 INFO - ##### 08:16:18 INFO - ##### Running populate-webroot step. 08:16:18 INFO - ##### 08:16:18 INFO - Running pre-action listener: _resource_record_pre_action 08:16:18 INFO - Running main action method: populate_webroot 08:16:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:18 INFO - '--tppagecycles', 08:16:18 INFO - '7'], 08:16:18 INFO - 'tests': ['tsvgm']}}, 08:16:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['damp', 'tps']}, 08:16:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'tests': ['damp', 'tps']}, 08:16:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['dromaeo_dom']}, 08:16:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['a11yr', 08:16:18 INFO - 'ts_paint', 08:16:18 INFO - 'tpaint', 08:16:18 INFO - 'sessionrestore', 08:16:18 INFO - 'sessionrestore_no_auto_restore', 08:16:18 INFO - 'tabpaint']}, 08:16:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:18 INFO - 'ts_paint', 08:16:18 INFO - 'tpaint', 08:16:18 INFO - 'sessionrestore', 08:16:18 INFO - 'sessionrestore_no_auto_restore', 08:16:18 INFO - 'tabpaint']}, 08:16:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:18 INFO - 'ts_paint', 08:16:18 INFO - 'tpaint', 08:16:18 INFO - 'sessionrestore', 08:16:18 INFO - 'sessionrestore_no_auto_restore', 08:16:18 INFO - 'tabpaint']}, 08:16:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:18 INFO - 'ts_paint', 08:16:18 INFO - 'tpaint', 08:16:18 INFO - 'sessionrestore', 08:16:18 INFO - 'sessionrestore_no_auto_restore', 08:16:18 INFO - 'tabpaint']}, 08:16:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['a11yr', 08:16:18 INFO - 'ts_paint', 08:16:18 INFO - 'tpaint', 08:16:18 INFO - 'sessionrestore', 08:16:18 INFO - 'sessionrestore_no_auto_restore', 08:16:18 INFO - 'tabpaint']}, 08:16:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['a11yr', 08:16:18 INFO - 'ts_paint', 08:16:18 INFO - 'tpaint', 08:16:18 INFO - 'sessionrestore', 08:16:18 INFO - 'sessionrestore_no_auto_restore', 08:16:18 INFO - 'tabpaint']}, 08:16:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['tsvgx', 08:16:18 INFO - 'tsvgr_opacity', 08:16:18 INFO - 'tart', 08:16:18 INFO - 'tscrollx', 08:16:18 INFO - 'cart']}, 08:16:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:18 INFO - 'tsvgr_opacity', 08:16:18 INFO - 'tart', 08:16:18 INFO - 'tscrollx', 08:16:18 INFO - 'cart']}, 08:16:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'talos_options': ['--disable-e10s'], 08:16:18 INFO - 'tests': ['tp5o']}, 08:16:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'tests': ['tp5o']}, 08:16:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'talos_options': ['--disable-e10s', 08:16:18 INFO - '--xperf_path', 08:16:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:18 INFO - 'tests': ['tp5n']}, 08:16:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:18 INFO - 'talos_options': ['--xperf_path', 08:16:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:18 INFO - 'tests': ['tp5n']}}, 08:16:18 INFO - 'talos.zip': {'path': '', 08:16:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:18 INFO - Running post-action listener: _resource_record_post_action 08:16:18 INFO - ##### 08:16:18 INFO - ##### Finished populate-webroot step (success) 08:16:18 INFO - ##### 08:16:18 INFO - ##### 08:16:18 INFO - ##### Running create-virtualenv step. 08:16:18 INFO - ##### 08:16:18 INFO - Running pre-action listener: _resource_record_pre_action 08:16:18 INFO - Running main action method: create_virtualenv 08:16:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:18 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:16:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:18 INFO - Using real prefix '/usr' 08:16:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:21 INFO - Installing pip.................done. 08:16:21 INFO - Return code: 0 08:16:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:21 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:21 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:16:21 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:16:21 INFO - Using env: {'DISPLAY': ':0', 08:16:21 INFO - 'HOME': '/home/cltbld', 08:16:21 INFO - 'LANG': 'en_US.UTF-8', 08:16:21 INFO - 'LANGUAGE': 'en_US:en', 08:16:21 INFO - 'LOGNAME': 'cltbld', 08:16:21 INFO - 'MAIL': '/var/mail/cltbld', 08:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:21 INFO - 'MOZ_NO_REMOTE': '1', 08:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:21 INFO - 'NO_EM_RESTART': '1', 08:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:21 INFO - 'PWD': '/builds/slave/test', 08:16:21 INFO - 'SHELL': '/bin/bash', 08:16:21 INFO - 'SHLVL': '1', 08:16:21 INFO - 'TERM': 'linux', 08:16:21 INFO - 'TMOUT': '86400', 08:16:21 INFO - 'USER': 'cltbld', 08:16:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:21 INFO - '_': '/tools/buildbot/bin/python'} 08:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:21 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:16:21 INFO - Cleaning up... 08:16:21 INFO - Return code: 0 08:16:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:21 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:21 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:16:21 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:16:21 INFO - Using env: {'DISPLAY': ':0', 08:16:21 INFO - 'HOME': '/home/cltbld', 08:16:21 INFO - 'LANG': 'en_US.UTF-8', 08:16:21 INFO - 'LANGUAGE': 'en_US:en', 08:16:21 INFO - 'LOGNAME': 'cltbld', 08:16:21 INFO - 'MAIL': '/var/mail/cltbld', 08:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:21 INFO - 'MOZ_NO_REMOTE': '1', 08:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:21 INFO - 'NO_EM_RESTART': '1', 08:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:21 INFO - 'PWD': '/builds/slave/test', 08:16:21 INFO - 'SHELL': '/bin/bash', 08:16:21 INFO - 'SHLVL': '1', 08:16:21 INFO - 'TERM': 'linux', 08:16:21 INFO - 'TMOUT': '86400', 08:16:21 INFO - 'USER': 'cltbld', 08:16:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:21 INFO - '_': '/tools/buildbot/bin/python'} 08:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:21 INFO - Downloading/unpacking psutil>=3.1.1 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:23 INFO - Installing collected packages: psutil 08:16:23 INFO - Running setup.py install for psutil 08:16:23 INFO - building 'psutil._psutil_linux' extension 08:16:23 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:16:23 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:16:23 INFO - building 'psutil._psutil_posix' extension 08:16:23 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:16:24 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:16:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:24 INFO - Successfully installed psutil 08:16:24 INFO - Cleaning up... 08:16:24 INFO - Return code: 0 08:16:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:16:24 INFO - Using env: {'DISPLAY': ':0', 08:16:24 INFO - 'HOME': '/home/cltbld', 08:16:24 INFO - 'LANG': 'en_US.UTF-8', 08:16:24 INFO - 'LANGUAGE': 'en_US:en', 08:16:24 INFO - 'LOGNAME': 'cltbld', 08:16:24 INFO - 'MAIL': '/var/mail/cltbld', 08:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:24 INFO - 'MOZ_NO_REMOTE': '1', 08:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:24 INFO - 'NO_EM_RESTART': '1', 08:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:24 INFO - 'PWD': '/builds/slave/test', 08:16:24 INFO - 'SHELL': '/bin/bash', 08:16:24 INFO - 'SHLVL': '1', 08:16:24 INFO - 'TERM': 'linux', 08:16:24 INFO - 'TMOUT': '86400', 08:16:24 INFO - 'USER': 'cltbld', 08:16:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:24 INFO - '_': '/tools/buildbot/bin/python'} 08:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:24 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:16:24 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:16:24 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:16:24 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:16:24 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:16:24 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:16:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:26 INFO - Installing collected packages: mozsystemmonitor 08:16:26 INFO - Running setup.py install for mozsystemmonitor 08:16:26 INFO - Successfully installed mozsystemmonitor 08:16:26 INFO - Cleaning up... 08:16:26 INFO - Return code: 0 08:16:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16: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:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:26 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:26 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:16:26 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:16:26 INFO - Using env: {'DISPLAY': ':0', 08:16:26 INFO - 'HOME': '/home/cltbld', 08:16:26 INFO - 'LANG': 'en_US.UTF-8', 08:16:26 INFO - 'LANGUAGE': 'en_US:en', 08:16:26 INFO - 'LOGNAME': 'cltbld', 08:16:26 INFO - 'MAIL': '/var/mail/cltbld', 08:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:26 INFO - 'MOZ_NO_REMOTE': '1', 08:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:26 INFO - 'NO_EM_RESTART': '1', 08:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:26 INFO - 'PWD': '/builds/slave/test', 08:16:26 INFO - 'SHELL': '/bin/bash', 08:16:26 INFO - 'SHLVL': '1', 08:16:26 INFO - 'TERM': 'linux', 08:16:26 INFO - 'TMOUT': '86400', 08:16:26 INFO - 'USER': 'cltbld', 08:16:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:26 INFO - '_': '/tools/buildbot/bin/python'} 08:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:26 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:16:26 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:16:26 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:16:26 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:16:26 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:16:26 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:16:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16: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:16: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:16: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:16: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:16: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:16: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:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:29 INFO - Downloading docopt-0.6.1.tar.gz 08:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:29 INFO - Running setup.py install for blobuploader 08:16:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:29 INFO - Running setup.py install for requests 08:16:29 INFO - Running setup.py install for docopt 08:16:29 INFO - Successfully installed blobuploader requests docopt 08:16:29 INFO - Cleaning up... 08:16:29 INFO - Return code: 0 08:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:29 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:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:29 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:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:29 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:29 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:16:29 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:16:29 INFO - Using env: {'DISPLAY': ':0', 08:16:29 INFO - 'HOME': '/home/cltbld', 08:16:29 INFO - 'LANG': 'en_US.UTF-8', 08:16:29 INFO - 'LANGUAGE': 'en_US:en', 08:16:29 INFO - 'LOGNAME': 'cltbld', 08:16:29 INFO - 'MAIL': '/var/mail/cltbld', 08:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:29 INFO - 'MOZ_NO_REMOTE': '1', 08:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:29 INFO - 'NO_EM_RESTART': '1', 08:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:29 INFO - 'PWD': '/builds/slave/test', 08:16:29 INFO - 'SHELL': '/bin/bash', 08:16:29 INFO - 'SHLVL': '1', 08:16:29 INFO - 'TERM': 'linux', 08:16:29 INFO - 'TMOUT': '86400', 08:16:29 INFO - 'USER': 'cltbld', 08:16:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:29 INFO - '_': '/tools/buildbot/bin/python'} 08:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:30 INFO - Running setup.py (path:/tmp/pip-owweHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:30 INFO - Running setup.py (path:/tmp/pip-GNamKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:30 INFO - Running setup.py (path:/tmp/pip-XCHo4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:30 INFO - Running setup.py (path:/tmp/pip-qf8OpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:30 INFO - Running setup.py (path:/tmp/pip-61IB74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:30 INFO - Running setup.py (path:/tmp/pip-CIqHdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:30 INFO - Running setup.py (path:/tmp/pip-0rl07Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:30 INFO - Running setup.py (path:/tmp/pip-dWbk5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:30 INFO - Running setup.py (path:/tmp/pip-qmMUZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:30 INFO - Running setup.py (path:/tmp/pip-isatCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:30 INFO - Running setup.py (path:/tmp/pip-3d0Sss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:30 INFO - Running setup.py (path:/tmp/pip-gFMjRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:31 INFO - Running setup.py (path:/tmp/pip-V7inOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:31 INFO - Running setup.py (path:/tmp/pip-uaUcN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:31 INFO - Running setup.py (path:/tmp/pip-w2gdkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:31 INFO - Running setup.py (path:/tmp/pip-nrHIVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:31 INFO - Running setup.py (path:/tmp/pip-G9iKcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:31 INFO - Running setup.py install for manifestparser 08:16:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:31 INFO - Running setup.py install for mozcrash 08:16:31 INFO - Running setup.py install for mozdebug 08:16:31 INFO - Running setup.py install for mozdevice 08:16:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:31 INFO - Running setup.py install for mozfile 08:16:31 INFO - Running setup.py install for mozhttpd 08:16:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for mozinfo 08:16:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for mozInstall 08:16:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for mozleak 08:16:32 INFO - Running setup.py install for mozlog 08:16:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for moznetwork 08:16:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for mozprocess 08:16:32 INFO - Running setup.py install for mozprofile 08:16:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for mozrunner 08:16:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:32 INFO - Running setup.py install for mozscreenshot 08:16:32 INFO - Running setup.py install for moztest 08:16:33 INFO - Running setup.py install for mozversion 08:16:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:33 INFO - Cleaning up... 08:16:33 INFO - Return code: 0 08:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16: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:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:33 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:33 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:16:33 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:16:33 INFO - Using env: {'DISPLAY': ':0', 08:16:33 INFO - 'HOME': '/home/cltbld', 08:16:33 INFO - 'LANG': 'en_US.UTF-8', 08:16:33 INFO - 'LANGUAGE': 'en_US:en', 08:16:33 INFO - 'LOGNAME': 'cltbld', 08:16:33 INFO - 'MAIL': '/var/mail/cltbld', 08:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:33 INFO - 'MOZ_NO_REMOTE': '1', 08:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:33 INFO - 'NO_EM_RESTART': '1', 08:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:33 INFO - 'PWD': '/builds/slave/test', 08:16:33 INFO - 'SHELL': '/bin/bash', 08:16:33 INFO - 'SHLVL': '1', 08:16:33 INFO - 'TERM': 'linux', 08:16:33 INFO - 'TMOUT': '86400', 08:16:33 INFO - 'USER': 'cltbld', 08:16:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:33 INFO - '_': '/tools/buildbot/bin/python'} 08:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:33 INFO - Running setup.py (path:/tmp/pip-7Irb9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:33 INFO - Running setup.py (path:/tmp/pip-RdOixu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:33 INFO - Running setup.py (path:/tmp/pip-oyHZdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:33 INFO - Running setup.py (path:/tmp/pip-c9A6ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:33 INFO - Running setup.py (path:/tmp/pip-46BQUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:33 INFO - Running setup.py (path:/tmp/pip-AvfvaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:33 INFO - Running setup.py (path:/tmp/pip-LpN_5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:33 INFO - Running setup.py (path:/tmp/pip-vcjUhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:33 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:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:33 INFO - Running setup.py (path:/tmp/pip-1tD_FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:34 INFO - Running setup.py (path:/tmp/pip-TzLmpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:34 INFO - Running setup.py (path:/tmp/pip-09t8JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:34 INFO - Running setup.py (path:/tmp/pip-BblAZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:34 INFO - Running setup.py (path:/tmp/pip-e7oOTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:34 INFO - Running setup.py (path:/tmp/pip-JGok9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:34 INFO - Running setup.py (path:/tmp/pip-2EsuTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:34 INFO - Running setup.py (path:/tmp/pip-HfHv6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:34 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:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:34 INFO - Running setup.py (path:/tmp/pip-ZLM3tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:34 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:16:34 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:16:34 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:16:34 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:16:34 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:16:34 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:16:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:34 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:16:34 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:16:34 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:16:34 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:16:34 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:16:34 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:16:36 INFO - Downloading blessings-1.6.tar.gz 08:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:36 INFO - Installing collected packages: blessings 08:16:36 INFO - Running setup.py install for blessings 08:16:36 INFO - Successfully installed blessings 08:16:36 INFO - Cleaning up... 08:16:36 INFO - Return code: 0 08:16:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:36 INFO - Reading from file tmpfile_stdout 08:16:36 INFO - Current package versions: 08:16:36 INFO - argparse == 1.2.1 08:16:36 INFO - blessings == 1.6 08:16:36 INFO - blobuploader == 1.2.4 08:16:36 INFO - docopt == 0.6.1 08:16:36 INFO - manifestparser == 1.1 08:16:36 INFO - mozInstall == 1.12 08:16:36 INFO - mozcrash == 0.17 08:16:36 INFO - mozdebug == 0.1 08:16:36 INFO - mozdevice == 0.48 08:16:36 INFO - mozfile == 1.2 08:16:36 INFO - mozhttpd == 0.7 08:16:36 INFO - mozinfo == 0.9 08:16:36 INFO - mozleak == 0.1 08:16:36 INFO - mozlog == 3.2 08:16:36 INFO - moznetwork == 0.27 08:16:36 INFO - mozprocess == 0.22 08:16:36 INFO - mozprofile == 0.28 08:16:36 INFO - mozrunner == 6.11 08:16:36 INFO - mozscreenshot == 0.1 08:16:36 INFO - mozsystemmonitor == 0.3 08:16:36 INFO - moztest == 0.7 08:16:36 INFO - mozversion == 1.4 08:16:36 INFO - psutil == 3.1.1 08:16:36 INFO - requests == 1.2.3 08:16:36 INFO - wsgiref == 0.1.2 08:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:36 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:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:36 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:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:36 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:36 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:16:36 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:16:36 INFO - Using env: {'DISPLAY': ':0', 08:16:36 INFO - 'HOME': '/home/cltbld', 08:16:36 INFO - 'LANG': 'en_US.UTF-8', 08:16:36 INFO - 'LANGUAGE': 'en_US:en', 08:16:36 INFO - 'LOGNAME': 'cltbld', 08:16:36 INFO - 'MAIL': '/var/mail/cltbld', 08:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:36 INFO - 'MOZ_NO_REMOTE': '1', 08:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:36 INFO - 'NO_EM_RESTART': '1', 08:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:36 INFO - 'PWD': '/builds/slave/test', 08:16:36 INFO - 'SHELL': '/bin/bash', 08:16:36 INFO - 'SHLVL': '1', 08:16:36 INFO - 'TERM': 'linux', 08:16:36 INFO - 'TMOUT': '86400', 08:16:36 INFO - 'USER': 'cltbld', 08:16:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:36 INFO - '_': '/tools/buildbot/bin/python'} 08:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 INFO - Cleaning up... 08:16:37 INFO - Return code: 0 08:16:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:37 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:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:37 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:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:37 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:37 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:16:37 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:16:37 INFO - Using env: {'DISPLAY': ':0', 08:16:37 INFO - 'HOME': '/home/cltbld', 08:16:37 INFO - 'LANG': 'en_US.UTF-8', 08:16:37 INFO - 'LANGUAGE': 'en_US:en', 08:16:37 INFO - 'LOGNAME': 'cltbld', 08:16:37 INFO - 'MAIL': '/var/mail/cltbld', 08:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:37 INFO - 'MOZ_NO_REMOTE': '1', 08:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:37 INFO - 'NO_EM_RESTART': '1', 08:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:37 INFO - 'PWD': '/builds/slave/test', 08:16:37 INFO - 'SHELL': '/bin/bash', 08:16:37 INFO - 'SHLVL': '1', 08:16:37 INFO - 'TERM': 'linux', 08:16:37 INFO - 'TMOUT': '86400', 08:16:37 INFO - 'USER': 'cltbld', 08:16:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:37 INFO - '_': '/tools/buildbot/bin/python'} 08:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:37 INFO - Downloading/unpacking jsonschema 08:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:37 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:16:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:39 INFO - Downloading/unpacking functools32 (from jsonschema) 08:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:39 INFO - warning: no files found matching '*.txt' 08:16:39 INFO - no previously-included directories found matching 'build' 08:16:39 INFO - no previously-included directories found matching 'dist' 08:16:39 INFO - no previously-included directories found matching '.git*' 08:16:39 INFO - Installing collected packages: jsonschema, functools32 08:16:39 INFO - Running setup.py install for functools32 08:16:39 INFO - warning: no files found matching '*.txt' 08:16:39 INFO - no previously-included directories found matching 'build' 08:16:39 INFO - no previously-included directories found matching 'dist' 08:16:39 INFO - no previously-included directories found matching '.git*' 08:16:39 INFO - Successfully installed jsonschema functools32 08:16:39 INFO - Cleaning up... 08:16:39 INFO - Return code: 0 08:16:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:39 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 0x7f624226ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2341770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, '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': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', '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:16:39 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:16:39 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:16:39 INFO - Using env: {'DISPLAY': ':0', 08:16:39 INFO - 'HOME': '/home/cltbld', 08:16:39 INFO - 'LANG': 'en_US.UTF-8', 08:16:39 INFO - 'LANGUAGE': 'en_US:en', 08:16:39 INFO - 'LOGNAME': 'cltbld', 08:16:39 INFO - 'MAIL': '/var/mail/cltbld', 08:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:39 INFO - 'MOZ_NO_REMOTE': '1', 08:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:39 INFO - 'NO_EM_RESTART': '1', 08:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:39 INFO - 'PWD': '/builds/slave/test', 08:16:39 INFO - 'SHELL': '/bin/bash', 08:16:39 INFO - 'SHLVL': '1', 08:16:39 INFO - 'TERM': 'linux', 08:16:39 INFO - 'TMOUT': '86400', 08:16:39 INFO - 'USER': 'cltbld', 08:16:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:39 INFO - '_': '/tools/buildbot/bin/python'} 08:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:39 INFO - Downloading/unpacking flake8 08:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:16:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:16:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:42 INFO - no previously-included directories found matching 'docs/_build' 08:16:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:16:42 INFO - Running setup.py install for pep8 08:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:16:42 INFO - no previously-included directories found matching 'docs/_build' 08:16:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:16:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:16:42 INFO - Cleaning up... 08:16:42 INFO - Return code: 0 08:16:42 INFO - Running post-action listener: _resource_record_post_action 08:16:42 INFO - Running post-action listener: _start_resource_monitoring 08:16:42 INFO - Starting resource monitoring. 08:16:42 INFO - ##### 08:16:42 INFO - ##### Finished create-virtualenv step (success) 08:16:42 INFO - ##### 08:16:42 INFO - ##### 08:16:42 INFO - ##### Running install step. 08:16:42 INFO - ##### 08:16:42 INFO - Running pre-action listener: _resource_record_pre_action 08:16:42 INFO - Running main action method: install 08:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:43 INFO - Reading from file tmpfile_stdout 08:16:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:43 INFO - Reading from file tmpfile_stdout 08:16:43 INFO - Output received: 08:16:43 INFO - Usage: mozinstall [options] installer 08:16:43 INFO - Options: 08:16:43 INFO - -h, --help show this help message and exit 08:16:43 INFO - -d DEST, --destination=DEST 08:16:43 INFO - Directory to install application into. [default: 08:16:43 INFO - "/builds/slave/test"] 08:16:43 INFO - --app=APP Application being installed. [default: firefox] 08:16:43 INFO - mkdir: /builds/slave/test/build/application 08:16:43 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:16:43 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:16:59 INFO - Reading from file tmpfile_stdout 08:16:59 INFO - Output received: 08:16:59 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:59 INFO - Running post-action listener: _resource_record_post_action 08:16:59 INFO - ##### 08:16:59 INFO - ##### Finished install step (success) 08:16:59 INFO - ##### 08:16:59 INFO - ##### 08:16:59 INFO - ##### Running run-tests step. 08:16:59 INFO - ##### 08:16:59 INFO - Running pre-action listener: _resource_record_pre_action 08:16:59 INFO - Running main action method: run_tests 08:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:59 INFO - Python 2.7.3 08:16:59 INFO - Return code: 0 08:16:59 INFO - grabbing minidump binary from tooltool 08:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:16:59 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 0x23d09c0>, '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 0x23d18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:59 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:16:59 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:16:59 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:16:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:59 INFO - Return code: 0 08:16:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:17:00 INFO - Return code: 0 08:17:00 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-014', '--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:17:00 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-014 --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:17:00 INFO - Using env: {'DISPLAY': ':0', 08:17:00 INFO - 'HOME': '/home/cltbld', 08:17:00 INFO - 'LANG': 'en_US.UTF-8', 08:17:00 INFO - 'LANGUAGE': 'en_US:en', 08:17:00 INFO - 'LOGNAME': 'cltbld', 08:17:00 INFO - 'MAIL': '/var/mail/cltbld', 08:17:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:00 INFO - 'MOZ_NO_REMOTE': '1', 08:17:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:00 INFO - 'NO_EM_RESTART': '1', 08:17:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:00 INFO - 'PWD': '/builds/slave/test', 08:17:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:00 INFO - 'SHELL': '/bin/bash', 08:17:00 INFO - 'SHLVL': '1', 08:17:00 INFO - 'TERM': 'linux', 08:17:00 INFO - 'TMOUT': '86400', 08:17:00 INFO - 'USER': 'cltbld', 08:17:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698', 08:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:00 INFO - '_': '/tools/buildbot/bin/python'} 08:17:00 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-014', '--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:17:00 INFO - mozversion application_buildid: 20160518053011 08:17:00 INFO - mozversion application_changeset: 47b83c8478a06374aa9306122a778654b912f713 08:17:00 INFO - mozversion application_display_name: Nightly 08:17:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:00 INFO - mozversion application_name: Firefox 08:17:00 INFO - mozversion application_remotingname: firefox 08:17:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:17:00 INFO - mozversion application_vendor: Mozilla 08:17:00 INFO - mozversion application_version: 49.0a1 08:17:00 INFO - mozversion platform_buildid: 20160518053011 08:17:00 INFO - mozversion platform_changeset: 47b83c8478a06374aa9306122a778654b912f713 08:17:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:17:00 INFO - mozversion platform_version: 49.0a1 08:17:00 INFO - using testdate: 1463584620 08:17:00 INFO - actual date: 1463584620 08:17:00 INFO - starting webserver on 'localhost:60059' 08:17:00 INFO - SUITE-START | Running 2 tests 08:17:00 INFO - TEST-START | dromaeo_css 08:17:00 INFO - operating with platform_type : linux_ 08:17:00 INFO - Initialising browser for dromaeo_css test... 08:17:00 INFO - TEST-INFO | started process 15083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAxR6di/profile http://localhost:60059/getInfo.html) 08:17:04 INFO - PROCESS | 15083 | 08:17:04 INFO - PROCESS | 15083 | (process:15154): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:17:05 INFO - PROCESS | 15083 | __metrics Screen width/height:1600/1200 08:17:05 INFO - PROCESS | 15083 | colorDepth:24 08:17:05 INFO - PROCESS | 15083 | Browser inner width/height: 1024/697 08:17:05 INFO - PROCESS | 15083 | __metrics 08:17:06 ERROR - PROCESS | 15083 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:17:06 INFO - TEST-INFO | 15083: exit 0 08:17:06 INFO - Browser initialized. 08:17:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:06 INFO - TEST-INFO | started process 15205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAxR6di/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:08 INFO - PROCESS | 15205 | 08:17:08 INFO - PROCESS | 15205 | (process:15267): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:17:18 INFO - PROCESS | 15205 | RSS: Main: 163774464 08:17:18 INFO - PROCESS | 15205 | 08:18:08 INFO - PROCESS | 15205 | 1463584688261 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:20:16 INFO - PROCESS | 15205 | Cycle 1(1): loaded http://localhost:60059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60059/tests/dromaeo/cssquery-ext.html) 08:20:17 INFO - PROCESS | 15205 | RSS: Main: 166973440 08:20:17 INFO - PROCESS | 15205 | 08:23:19 INFO - PROCESS | 15205 | Cycle 1(1): loaded http://localhost:60059/tests/dromaeo/cssquery-ext.html (next: http://localhost:60059/tests/dromaeo/cssquery-jquery.html) 08:23:19 INFO - PROCESS | 15205 | RSS: Main: 166019072 08:23:19 INFO - PROCESS | 15205 | 08:26:21 INFO - PROCESS | 15205 | Cycle 1(1): loaded http://localhost:60059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60059/tests/dromaeo/cssquery-mootools.html) 08:26:22 INFO - PROCESS | 15205 | RSS: Main: 167124992 08:26:22 INFO - PROCESS | 15205 | 08:29:23 INFO - PROCESS | 15205 | Cycle 1(1): loaded http://localhost:60059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60059/tests/dromaeo/cssquery-prototype.html) 08:29:24 INFO - PROCESS | 15205 | RSS: Main: 164675584 08:29:24 INFO - PROCESS | 15205 | 08:32:26 INFO - PROCESS | 15205 | Cycle 1(1): loaded http://localhost:60059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60059/tests/dromaeo/cssquery-yui.html) 08:32:27 INFO - PROCESS | 15205 | RSS: Main: 164966400 08:32:27 INFO - PROCESS | 15205 | 08:35:29 INFO - PROCESS | 15205 | Cycle 1(1): loaded http://localhost:60059/tests/dromaeo/cssquery-yui.html (next: http://localhost:60059/tests/dromaeo/cssquery-dojo.html) 08:35:30 INFO - PROCESS | 15205 | RSS: Main: 167518208 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | __start_tp_report 08:35:30 INFO - PROCESS | 15205 | _x_x_mozilla_page_load 08:35:30 INFO - PROCESS | 15205 | _x_x_mozilla_page_load_details 08:35:30 INFO - PROCESS | 15205 | |i|pagename|runs| 08:35:30 INFO - PROCESS | 15205 | |0;dojo.html;3151.795133316334;3179.5389668498083;3207.230264736464;3216.7265782408494;3232.4181647303476;5459.426760190182;5476.863078423042;5482.013237617227;5506.229127922084;5537.695426751527;5313.57491400688;5407.621466497337;5446.972765136179;5492.697901615409;5531.585131115163;4933.260010998352;4970.254461830737;5085.847424577269;5110.872228194287;5171.689698618095;662.678043228266;4858.805647774085;4948.950510494903;5039.899202015958;5064.113780088488;4954.677945933503;4991.951690145074;5005.899882002376;5008.098542262392;5034.144195486758;5025.949740502585;5034.043531728959;5034.723090230036;5050.545450909399;5052.444231134572;4883.8779030524165;4948.554630083274;4967.875803104916;4982.352294201767;5027.522385373383;5440.863978400532;5457.481539253765;5486.478784515464;5488.4785945335525;5489.58828087891;5802.854928626776;5920.141579470953;5921;5937;5963.910541341883;5885.646861188299;5910.527157827363;5935.970320148414;5993;6002.669853158074;5544.362398324204;5553.305836770403;5555.972220138914;5564;5565.165225216209;5891.970540147272;5956.076808094752;6051.969740151271;6082.330943596201;6083.513318934474;5801.216835727208;5809.477147056785;5817.970910145422;5850.268716410449;5856.619319744203;5910.143029260819;5918.437748413894;5925.437083477149;5928.614640048383;5930.406959304121;5714.028615135437;5835.416458354215;5862.149988251765;5905.232319798399;5926.674032928144;5856.033754430471;5913.58604897653;5934.43622855828;5974.492168165754;5988.311344195473;4489.685721999494;4508.842190523316;4520.796564154621;4530.932036019462;4563.498015218323;3940.0543869471694;3986.5216174059296;4005.759654420744;4008.8596899108393;4062.939055914164;5549.500544950893;5601.80393686219;5614.24207731951;5647.435256474319;5675;5918.704064796743;5925.970370148121;5963.5825492216;5970.791022314285;5971.4028597140805;5534.667919924817;5684.175794509773;5691.943080569225;5698.230738850285;5745.913811292834;5158.226266060121;5170.069387510209;5176.249443830623;5177.508136727005;5215.843524694265;6267.7806276781;6276.497880169667;6282.246130464374;6288.717007734663;6296.33888441707;5827.94172058274;5878.470937615635;5930.436608522184;5962.433568810956;6039.063945088518;6240.594361366497;6243.750249990131;6245.9063114052415;6247;6261.624302541862;5857.619254748428;5926.911096333472;5932.199153114274;5933.169356290036;5979.641221526548;5866.149408335682;5879.470847623735;5923.229980102559;5948.881022379442;6020.4280593343565;5815.621984570989;5831.271091113611;5841.912371314349;5845.269341332333;5849.561282903885;5789.1895134680335;5813.476787089182;5813.76744930198;5831.446012628793;5832.270966129234;5576.386597474356;5612.691301978431;5681.261436013292;5708.257926469532;5713.571482138773;5800.622959507618;5852.824415267549;5862.882742345215;5882.588218824812;5914.02418600926;5572.777088916398;5723.914141287967;5736.627119237236;5739.713014349182;5759.0209664356325 08:35:30 INFO - PROCESS | 15205 | |1;ext.html;595.9642421454713;627.2347735762369;644.9290578036419;648.4909346163262;663.5653646861305;43451.130977380475;44902.77548612256;44940.10119797602;44965.55034449654;49215.50784492154;44947.32579011317;45750.313745293846;45793.855153621174;45825.541744582544;45845.31232031514;8760.474371537697;8990.865137022949;8997.190252877239;9004.819903601923;9006.234470070052;8847.601857916408;8932;8950.283977281802;8950.955245223797;8951.015388307282;8989.95505022474;8998.145176208283;8999.41503802254;9053.456792592433;9076.773080673003;8929.330300227477;8984.955075224581;8986.326025548111;8994.325425593106;9012.594433250453;8733.170348816851;8805.383623146383;8817.867731984026;8819.250363719091;8824.294056475466;40705;40849.59150408488;41000.79499602513;41127.17745645071;41157.176856462705;3879.941800872989;3927.469791578129;4314.1371725655;4326.048269380763;4359.280718681413;31034.844825775726;31298.687013129806;31426.80012399133;31493.685063149303;31891;4408.096340250241;4426.424564806587;4496.123255965088;4560.7035542689955;4579.381783459224;293886.53056734795;294268;294397;294873.83320084127;295819;58265.41734582685;58293.708531457916;58445.70777146087;58472;58640;37248.81375593159;37959;38000.61999379971;40057.1988560233;63693.36306636967;17526.123693815258;17640.294388224327;17656.735148972777;17675.20461579232;17712;13254;13523.932380338036;13581.796273055912;13583.252921089435;13603.591892243248;20493.48766280825;20641.587168256552;20790.688139677917;20804.895975520027;20881.791182087985;7500.1374841893885;7578.4316176287;7601.7719468416035;7658.770236892902;7766.301032907066;1011.4437059617181;1117.3128525956479;1159.7796418680423;1237.808139738342;1243.8693937136652;33263.66736332654;33364;33708.662913371045;33758.662413375554;34251.314973700384;1136.198979719296;1148.7013376522164;1201.6154830454345;1212.3574505512092;1303.1789972317379;17786.46640600784;17854.732179017326;17878.28486860511;17885.37401190952;17896.373626922996;154981;156111;156689.21655391878;156709;547321;61272.69363653242;61916.69041654763;62364.688176558826;62380.06429903555;62447.68776156181;1384.3701115992199;1408.3873515020998;1412.8375236847894;1441.690036642106;1443.985560144385;32487.18782030468;32671.836640816644;33222.335553288314;33232;33262.33475330431;54136;54165.45834541604;54210.186847198114;54509.45490545044;54616;429417;432547;433144;434208;434609;29379.85310073436;29536.852315738284;30317.848410757804;30381;30432.543511847784;51078.744606276734;51645;52514;52851;54580.727096364266;42953.3556996639;43366;43776.56223437852;44692;44903.775481122386;42088.94777630584;42814.78592607017;43292.56707432885;43583.56416435922;43997.78001109974;43864;44305.11389772251;44812.10375792401;45020.32469512895;46559;38203.42694859635;38408.807955960045;38592.80703596464;39392.60607393889;39570.406443902786;28967.565486518142;29289.443588086462;29323.120306390843;29855.701442985293;30016.24959376033 08:35:30 INFO - PROCESS | 15205 | |2;jquery.html;397.72556935714334;400.1696479804406;400.2415422773844;412.266166224121;418.46190459663546;13913.93043034786;17962.37131700391;19015.61968760624;19345.516362090937;19578;18309.542261443472;18532.351367702133;18957;19510;19564.21743130273;5792.826215213539;5859.912101318484;5887.205227294325;5946.375630558794;5946.524278057745;5798.449147330997;5869.060950247961;5914.112883067532;5953.047512398017;5956.225690660208;5823.3012038555435;5846.619969701956;5917.408259174092;5923.526117910556;5937.703114844262;5673.744681489343;5800.390958949313;5865.824025279248;5868.207791948096;5946.43508866657;5143.485651434864;5152.278680984665;5168.147255702805;5175.249588809602;5188.273641690129;22317;22481.887590561942;22818.31545053651;22841.20055798039;22877.656835147485;2251.2570851618925;2366.857988520677;2369.57347677418;2424.2121310574134;2484.5900426429616;10194.388336699822;10473.057424831803;10478.63324783629;11172.60895868649;13920.651983700387;1924.7209154672635;1983.7421135252325;2013.808688174621;2033.6644453665128;2037.8777273363646;58950;80690.19309806885;81347.18652813455;81648.29134447493;81824;10879.238453308351;10926.071283940953;10965.945170274257;11097.223194376478;11193.328400296008;15220.086794792347;15307.387704491919;15317.617059573377;15359.308831102404;15408.460703875311;7909.564973926489;7916.643751031217;7938.920610793818;7978.680852765824;8014.959925200454;7480.139783924809;7490.962545187348;7535.246475352421;7541.321281084729;7605.505642133244;4757.9286310705365;4796.784144713496;4809.110314591811;4825.396825396825;4831.0096430231715;1939.2049259803696;1946.7274581558593;1966.9803301966797;1976.1305025788606;1985.612805502942;932.1703683721494;983.6753871222479;993.7167907146429;1000.229823036258;1068.0280944340614;18677.346292879956;19365.32221372245;19497.610047798964;19548.481273370646;19780;1020.3316827478013;1059.5338051257422;1071.4589132488043;1085.636311835544;1088.711491454765;10451.111655509367;10936.453177341102;10959.56161753521;10995.34027958309;11053.723656908482;495315;502662;504299;511534;516266;76104;91733;99018;99250;99359.50320248352;1015.9034891685426;1022.039283073923;1024.257413375297;1040.4173662748885;1044.9059584637419;16497.422590209284;16631.417900373428;16915.830841691426;17057.232424540678;17111.315547378465;35388.46917296294;38770.6122938767;39540.40689389719;42356.36465453082;42645;58049.4195058044;58917.410825891195;59423.40576594351;60063.69968150131;60247.69876150591;8604.827903442021;8680.522571258642;8770.210681038481;8827.955860220658;8974.282057435259;9756.512174391393;13342.799858002332;13361.933190334375;13565.59303220905;13577.59267221985;7243.420526357984;9672.93597704238;10057.195424365887;11884.643460696192;11952.223105498115;11230;11665;11682.70793230176;11687.532498700297;11847.170698051053;11882.76234475323;12030;12164.939175304067;12298.385080746106;12300.446479908605;8697.521636310064;8718.869216961624;8743.34424918121;8743.979620268421;8944.597493112955;9057.818843623223;11301;11931.463084161407;11947.402629868646;12047.578334758591 08:35:30 INFO - PROCESS | 15205 | |3;mootools.html;1549.0782984124442;1559.6568754873927;1703.1654489300238;1802.9459116226517;1830.588117673523;7943.880841787378;8251.257386835183;8525.658973641046;8881.777955551115;8906.955465222673;8524.744257672264;8809.339299552526;8831.779205519866;8844.601992910319;8855.468671879691;2309.0186670664943;2316.061994892071;2351.1183306260154;2353.576356255873;2354.7174339079247;2313.097891822191;2322.094383190557;2356.2106694257445;2360.0323867214447;2368.83418160728;2342.4261056041296;2348.7416384197722;2358.610829213186;2380.9285721428387;2384.4277373430427;2268.4669102761004;2270.2281224383705;2277.1233075265977;2278.3506700590333;2288.7367952685486;2192.5176461178517;2247.2471721973156;2250.8424410291286;2266.218154736613;2266.4900397410615;8904.287656987426;8952.8657070144;8964.372493925428;8966.730998070068;8991.14584114508;5261.394939581959;5392.676439413648;5400.21696853954;5401.5948803839865;5402.91895621566;3362.3443428531446;3419.9145021374416;3539.628339024391;3560.3413368526903;3561.216532362876;1179.9764004719857;1189.6787867275873;1192.2190964917993;1194.6475789642077;1210.074293165729;12338.136330456871;12377;12393.566225182076;12412.069094817925;12417.565385211565;4535.841245556389;4559.544045595414;4698.577128058491;4709.882252943704;4756.191447453941;10540.683779486628;10568.731752189633;10575.682729518127;10585.84121238182;10594.735131621772;5289.365276166807;5390.595705322116;5391.973040134774;5394.190871369326;5401.081816091274;4439.733615983051;4754.881127971828;4907.067657145131;4949.505049495022;4970.080535101018;4114.0948991221885;4144.854930077433;4185.058361868555;4195.035141917315;4257.318828987409;1302.5701518498872;1344.0524430276632;1352.749741297863;1365.269580774301;1372.5882235329361;917.1837065012145;981.5779214937645;991.0683957080322;1000.7698229407132;1001.5643195210107;5741.827745167651;5753.137029445533;5794.681292528951;5810.244668193108;5814.447627475383;391.8550136449532;394.1486389398885;394.16043826649053;396.44299758838304;396.90672691917376;3933.4099885016903;3934.291827471083;3944.2900277950243;3952.1898010907694;3967.504061992251;10833.67498975032;11099.611513597147;11189.384583847805;11206.943965280121;11217.270877392943;10934.125269978382;11070.667879963614;11086.501107450023;11090.667279981451;11149.777004459866;7947.960260198778;8251.29863961558;8270.172982701682;8370.12113728062;8386.454880432751;5907.675077870586;6095.299040610386;6097.573169878244;6112.786052488142;6135.202423684892;10060.195184385379;10340.896591033994;10505.842412363974;10532.21008424356;10548.208884333551;10526.736831579272;10665.146788257076;10715.571377144826;10719.249652524248;10782.245242832927;7374.889376659462;8095.676172953016;8194.057683366489;8242.216989386;8486.066532681523;8574.657013719381;8735.388522803343;8754.737357879274;8784.341174411817;8827.16141966512;7554.169041405551;7596.316331530189;7628.313451789366;7724.1117271514495;8053.758387248392;7629.160792312952;7726;7751.961240193763;7835.216478352348;7851.489653172525;7037.225905150532;7046.647667616701;7047.541909775849;7052.647367631495;7055.647217638995;4816.4220293564995;4896;4915.778789954389;4996.375453068366;5013.724245166405;5045.823396181116;5054.09026375256;5107.489251074863;5160.690358578498;5257.579393648422 08:35:30 INFO - PROCESS | 15205 | |4;prototype.html;304.8277723086456;305.8761201713306;307.1828935032813;312.39707364785954;316.5836924444357;5699.601027928052;5776.382612868399;5778.219940308057;5795.1886735857015;5840.824775256739;5507.834764957048;5605.990921634104;5632.155176723493;5687.516561092312;5758.481736643701;4137.193247316774;4187.769672668002;4293.570642935697;4296.324433470949;4317.373980772786;4301.741895486265;4336.241157797389;4355.71687840291;4355.978220108895;4373.169097871394;4297.806598703066;4299.570042995691;4324.178406102847;4325.87527242916;4343.695941284095;4017.5781542938007;4238.957610423887;4253.595908388729;4261.403403523509;4332.740035597874;3734.5518537775642;3735.906602334936;3737.215184811193;3737.5514938207316;3745.1573395985956;5389.083855744494;5403.243545903577;5426.21319908615;5455.699936503491;5472;4756.881077973078;4934.3108006136745;4952.950470495285;4976.154053810861;5016.219242169014;5874.853128671817;5875.148103524965;5882.6764527950945;5942.286925568959;5957.004403524825;4184.184084103601;4186.958130418718;4207.642350400189;4240.1307731914885;4253.978730106361;5976.641401515923;6108.205933228696;6131.478824299896;6145.446909778141;6187.16473276111;4245.87262382129;4253.829846806155;4270.12462445198;4277.03766652507;4279.651909648451;4291.742495450283;4322.200392927319;4331.137610827374;4340.066885619543;4341.891452713708;4785.665003449794;4890.902181956341;4896.681715688469;4911.877203069952;4946.724506726946;5810.593258471951;5842.824715258549;5848.385919478478;5898.410158984153;5960.940390596125;1471.2937789860928;1471.8446019874348;1475.4393330534328;1482.8072350594355;1487.5462983790048;937.8827646544182;941.6798288581915;941.6892425499706;945.1021529546958;949.2785483032944;5173.198154286091;5190.792368305301;5204.282586746364;5307.761150748225;5314.256004159421;5296.285001524822;5429.755660995264;5439.558516992921;5513.228148059275;5553.111941939679;5183.792648294026;5187.870303242449;5325.573954083664;5810.244668193192;5855.677937713466;3213.662565430643;3256.4301247281633;3263.7225835804225;3263.8694452221644;3295.505674148897;6074.791899614859;6376.171097757262;6396.936030639634;6396.968015159894;6414.775482858077;6190.380961903774;6213.875722485525;6274.525486510666;6280.937190628127;6313.337099604567;6197.070439434121;6347.5556711029785;6375.2668443128705;6410.166678331787;6428.357164283628;5900.291964964232;6185.567010309235;6219.906701399392;6246.281677607133;6252.406021427957;6093.817185484442;6123.663198524124;6160.966880929193;6163.753449862134;6171.47542458896;6004.189434426296;6320.841978950379;6383.96808015957;6407.597151068349;6448.290688024407;4178.143480586533;4203.579642035772;4219.303814870512;4221.514525829446;4235.534091250021;5838.649681019152;5962.463378295801;6206.72069756853;6206.844828879314;6244.126761971481;5869.94130058711;5915.201447804663;5932.96173169685;5962.642241465526;5989.64062156272;5950.613210141327;5962.940370596239;6009.7295621698;6015.195441367659;6036.547258955508;5651.813119245005;5831.94168058314;5848.181254624271;5854.648721076749;5893.970530147321;5983.162357269899;6007.609505382136;6016.608920420159;6017.127516510169;6028.577999540165;5675.000746187064;5819.418058194146;5873.706314684334;5881.9705901470215;5884.6469211847425 08:35:30 INFO - PROCESS | 15205 | |5;yui.html;776.1307335783923;807.4711064252913;860.1828263150007;875.8598624220118;886.9024407315196;14920.552383428501;15683.137427441487;15709.214539273033;15760.60598485037;15780.921095394508;14603.561893143222;14649.487267945624;14651.194184319858;14662.486812961522;14669.559913202595;681.1349586025732;796.8366484870617;828.3042244514606;831.7005877883956;849.9872501912477;839.5256679975824;841.5077179849795;846.1876598465481;848.2154007543029;848.6647774129216;893.740815163605;895.9955200224023;898.2544488074915;898.7303808857349;899.9910000900005;899.5502248875562;900.1088921967238;900.2348004196446;901.058393978291;903.2638399704285;645.8998855177455;649.6524359467709;651.7425616881305;651.8631087471637;653.8267359149829;14481.34833932465;14533.636659083608;14543.3455494503;14552.199629020399;14570.344334504973;14465.49370772018;14542.491012814606;14584.781228281585;14595.197264150467;14722.484713034992;11421.771564568662;11518.827217591743;11627.825582616268;11769.293842369485;11895.464704088337;3865.7873816940055;3886.553046399672;4016.598340165989;4062.7765472898977;4073.083556199861;56768.14847777287;56862;57096.714516427564;57259.427405726245;57522;11175.664730058112;11359.261647992855;11374.20380573352;11417.314961102195;11461.541538338373;20580.794192058187;20634.690479642817;20814.687779683012;20832.791672083084;20932.16271349129;8315.584220788936;8336.249737523653;8371.497710137412;8472.576371181416;8633.093525179891;4706.247000479907;4859.635527335464;4887.413510378778;4893.048661363979;4999.925001124986;3398.4732366483236;3482.7562070654812;3505.1938054247667;3506.403911335079;3510.543629328222;659.5037781995126;666.1007639686482;666.576723780403;670.9295523970011;678.1049015299757;620.6307247188006;673.7877568565887;743.9479236453396;762.4586543554138;770.1720650300837;9467.18408635186;9548.140667339972;9578.377405468762;9846.261530385107;9920.950395247977;631.5894668465534;725.1551941987631;759.9772006839804;773.4701729315437;780.7579650308309;4512.5261847505535;4602.930956035662;4742.454617718938;4774.427068751772;4811.975940120277;69917.30082699108;72907;72969;73430;73683.26316736871;54383.72808136013;57051;62311;62594;63974.68012659907;56991.715041424526;57083;58599;58766.41233587609;59322;9805.215582753506;9951.850722239316;10409.11522520564;10438.321509101885;10523.789524209626;38472.80763596276;38888.22223555457;38934.80532597319;39541.40687889742;40264;48665.5133448661;51451.228231575806;52151.73924130355;52312.47687523076;53324.46675533195;12879.806802897776;12984.805227921777;13012;13059.608211753663;13319.467221311039;14128.43486260538;14201.43194272259;14252.928735356258;14274.357653905392;14376.424943002163;13916.652083697989;14017.369218384993;14042.368093436024;14362.281885905872;14527.34626941769;12602.873971260537;12931.482740690268;13113.213207207598;13178.538751143664;13321.26733029654;12197.69505762363;13006;13604.024824358332;13938.651533711738;14094.590540946234;10658.25392222568;10738.409387483764;10861.185411094042;11022.50398732043;11027.338359698444;10607.469626518488;10654.254202205771;10780.568777248822;10928.235023548275;10954.178436617127 08:35:30 INFO - PROCESS | 15205 | __end_tp_report 08:35:30 INFO - PROCESS | 15205 | __start_cc_report 08:35:30 INFO - PROCESS | 15205 | _x_x_mozilla_cycle_collect,327 08:35:30 INFO - PROCESS | 15205 | __end_cc_report 08:35:30 INFO - PROCESS | 15205 | __startTimestamp1463585730107__endTimestamp 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | ------- Summary: start ------- 08:35:30 INFO - PROCESS | 15205 | Number of tests: 6 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | [#0] dojo.html Cycles:165 Average:5480.61 Median:5739.71 stddev:743.34 (13.0%) stddev-sans-first:722.82 08:35:30 INFO - PROCESS | 15205 | Values: 3151.8 3179.5 3207.2 3216.7 3232.4 5459.4 5476.9 5482.0 5506.2 5537.7 5313.6 5407.6 5447.0 5492.7 5531.6 4933.3 4970.3 5085.8 5110.9 5171.7 662.7 4858.8 4949.0 5039.9 5064.1 4954.7 4992.0 5005.9 5008.1 5034.1 5025.9 5034.0 5034.7 5050.5 5052.4 4883.9 4948.6 4967.9 4982.4 5027.5 5440.9 5457.5 5486.5 5488.5 5489.6 5802.9 5920.1 5921.0 5937.0 5963.9 5885.6 5910.5 5936.0 5993.0 6002.7 5544.4 5553.3 5556.0 5564.0 5565.2 5892.0 5956.1 6052.0 6082.3 6083.5 5801.2 5809.5 5818.0 5850.3 5856.6 5910.1 5918.4 5925.4 5928.6 5930.4 5714.0 5835.4 5862.1 5905.2 5926.7 5856.0 5913.6 5934.4 5974.5 5988.3 4489.7 4508.8 4520.8 4530.9 4563.5 3940.1 3986.5 4005.8 4008.9 4062.9 5549.5 5601.8 5614.2 5647.4 5675.0 5918.7 5926.0 5963.6 5970.8 5971.4 5534.7 5684.2 5691.9 5698.2 5745.9 5158.2 5170.1 5176.2 5177.5 5215.8 6267.8 6276.5 6282.2 6288.7 6296.3 5827.9 5878.5 5930.4 5962.4 6039.1 6240.6 6243.8 6245.9 6247.0 6261.6 5857.6 5926.9 5932.2 5933.2 5979.6 5866.1 5879.5 5923.2 5948.9 6020.4 5815.6 5831.3 5841.9 5845.3 5849.6 5789.2 5813.5 5813.8 5831.4 5832.3 5576.4 5612.7 5681.3 5708.3 5713.6 5800.6 5852.8 5862.9 5882.6 5914.0 5572.8 5723.9 5736.6 5739.7 5759.0 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | [#1] ext.html Cycles:180 Average:50782.23 Median:218436.52 stddev:90858.99 (41.6%) stddev-sans-first:91035.73 08:35:30 INFO - PROCESS | 15205 | Values: 596.0 627.2 644.9 648.5 663.6 43451.1 44902.8 44940.1 44965.6 49215.5 44947.3 45750.3 45793.9 45825.5 45845.3 8760.5 8990.9 8997.2 9004.8 9006.2 8847.6 8932.0 8950.3 8951.0 8951.0 8990.0 8998.1 8999.4 9053.5 9076.8 8929.3 8985.0 8986.3 8994.3 9012.6 8733.2 8805.4 8817.9 8819.3 8824.3 40705.0 40849.6 41000.8 41127.2 41157.2 3879.9 3927.5 4314.1 4326.0 4359.3 31034.8 31298.7 31426.8 31493.7 31891.0 4408.1 4426.4 4496.1 4560.7 4579.4 293886.5 294268.0 294397.0 294873.8 295819.0 58265.4 58293.7 58445.7 58472.0 58640.0 37248.8 37959.0 38000.6 40057.2 63693.4 17526.1 17640.3 17656.7 17675.2 17712.0 13254.0 13523.9 13581.8 13583.3 13603.6 20493.5 20641.6 20790.7 20804.9 20881.8 7500.1 7578.4 7601.8 7658.8 7766.3 1011.4 1117.3 1159.8 1237.8 1243.9 33263.7 33364.0 33708.7 33758.7 34251.3 1136.2 1148.7 1201.6 1212.4 1303.2 17786.5 17854.7 17878.3 17885.4 17896.4 154981.0 156111.0 156689.2 156709.0 547321.0 61272.7 61916.7 62364.7 62380.1 62447.7 1384.4 1408.4 1412.8 1441.7 1444.0 32487.2 32671.8 33222.3 33232.0 33262.3 54136.0 54165.5 54210.2 54509.5 54616.0 429417.0 432547.0 433144.0 434208.0 434609.0 29379.9 29536.9 30317.8 30381.0 30432.5 51078.7 51645.0 52514.0 52851.0 54580.7 42953.4 43366.0 43776.6 44692.0 44903.8 42088.9 42814.8 43292.6 43583.6 43997.8 43864.0 44305.1 44812.1 45020.3 46559.0 38203.4 38408.8 38592.8 39392.6 39570.4 28967.6 29289.4 29323.1 29855.7 30016.2 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | [#2] jquery.html Cycles:180 Average:29266.59 Median:2396.89 stddev:83354.88 (3477.6%) stddev-sans-first:83560.53 08:35:30 INFO - PROCESS | 15205 | Values: 397.7 400.2 400.2 412.3 418.5 13913.9 17962.4 19015.6 19345.5 19578.0 18309.5 18532.4 18957.0 19510.0 19564.2 5792.8 5859.9 5887.2 5946.4 5946.5 5798.4 5869.1 5914.1 5953.0 5956.2 5823.3 5846.6 5917.4 5923.5 5937.7 5673.7 5800.4 5865.8 5868.2 5946.4 5143.5 5152.3 5168.1 5175.2 5188.3 22317.0 22481.9 22818.3 22841.2 22877.7 2251.3 2366.9 2369.6 2424.2 2484.6 10194.4 10473.1 10478.6 11172.6 13920.7 1924.7 1983.7 2013.8 2033.7 2037.9 58950.0 80690.2 81347.2 81648.3 81824.0 10879.2 10926.1 10965.9 11097.2 11193.3 15220.1 15307.4 15317.6 15359.3 15408.5 7909.6 7916.6 7938.9 7978.7 8015.0 7480.1 7491.0 7535.2 7541.3 7605.5 4757.9 4796.8 4809.1 4825.4 4831.0 1939.2 1946.7 1967.0 1976.1 1985.6 932.2 983.7 993.7 1000.2 1068.0 18677.3 19365.3 19497.6 19548.5 19780.0 1020.3 1059.5 1071.5 1085.6 1088.7 10451.1 10936.5 10959.6 10995.3 11053.7 495315.0 502662.0 504299.0 511534.0 516266.0 76104.0 91733.0 99018.0 99250.0 99359.5 1015.9 1022.0 1024.3 1040.4 1044.9 16497.4 16631.4 16915.8 17057.2 17111.3 35388.5 38770.6 39540.4 42356.4 42645.0 58049.4 58917.4 59423.4 60063.7 60247.7 8604.8 8680.5 8770.2 8828.0 8974.3 9756.5 13342.8 13361.9 13565.6 13577.6 7243.4 9672.9 10057.2 11884.6 11952.2 11230.0 11665.0 11682.7 11687.5 11847.2 11882.8 12030.0 12164.9 12298.4 12300.4 8697.5 8718.9 8743.3 8744.0 8944.6 9057.8 11301.0 11931.5 11947.4 12047.6 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | [#3] mootools.html Cycles:180 Average:5858.70 Median:4226.18 stddev:3380.01 (80.0%) stddev-sans-first:3373.98 08:35:30 INFO - PROCESS | 15205 | Values: 1549.1 1559.7 1703.2 1802.9 1830.6 7943.9 8251.3 8525.7 8881.8 8907.0 8524.7 8809.3 8831.8 8844.6 8855.5 2309.0 2316.1 2351.1 2353.6 2354.7 2313.1 2322.1 2356.2 2360.0 2368.8 2342.4 2348.7 2358.6 2380.9 2384.4 2268.5 2270.2 2277.1 2278.4 2288.7 2192.5 2247.2 2250.8 2266.2 2266.5 8904.3 8952.9 8964.4 8966.7 8991.1 5261.4 5392.7 5400.2 5401.6 5402.9 3362.3 3419.9 3539.6 3560.3 3561.2 1180.0 1189.7 1192.2 1194.6 1210.1 12338.1 12377.0 12393.6 12412.1 12417.6 4535.8 4559.5 4698.6 4709.9 4756.2 10540.7 10568.7 10575.7 10585.8 10594.7 5289.4 5390.6 5392.0 5394.2 5401.1 4439.7 4754.9 4907.1 4949.5 4970.1 4114.1 4144.9 4185.1 4195.0 4257.3 1302.6 1344.1 1352.7 1365.3 1372.6 917.2 981.6 991.1 1000.8 1001.6 5741.8 5753.1 5794.7 5810.2 5814.4 391.9 394.1 394.2 396.4 396.9 3933.4 3934.3 3944.3 3952.2 3967.5 10833.7 11099.6 11189.4 11206.9 11217.3 10934.1 11070.7 11086.5 11090.7 11149.8 7948.0 8251.3 8270.2 8370.1 8386.5 5907.7 6095.3 6097.6 6112.8 6135.2 10060.2 10340.9 10505.8 10532.2 10548.2 10526.7 10665.1 10715.6 10719.2 10782.2 7374.9 8095.7 8194.1 8242.2 8486.1 8574.7 8735.4 8754.7 8784.3 8827.2 7554.2 7596.3 7628.3 7724.1 8053.8 7629.2 7726.0 7752.0 7835.2 7851.5 7037.2 7046.6 7047.5 7052.6 7055.6 4816.4 4896.0 4915.8 4996.4 5013.7 5045.8 5054.1 5107.5 5160.7 5257.6 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | [#4] prototype.html Cycles:180 Average:4939.12 Median:5641.98 stddev:1489.34 (26.4%) stddev-sans-first:1452.34 08:35:30 INFO - PROCESS | 15205 | Values: 304.8 305.9 307.2 312.4 316.6 5699.6 5776.4 5778.2 5795.2 5840.8 5507.8 5606.0 5632.2 5687.5 5758.5 4137.2 4187.8 4293.6 4296.3 4317.4 4301.7 4336.2 4355.7 4356.0 4373.2 4297.8 4299.6 4324.2 4325.9 4343.7 4017.6 4239.0 4253.6 4261.4 4332.7 3734.6 3735.9 3737.2 3737.6 3745.2 5389.1 5403.2 5426.2 5455.7 5472.0 4756.9 4934.3 4953.0 4976.2 5016.2 5874.9 5875.1 5882.7 5942.3 5957.0 4184.2 4187.0 4207.6 4240.1 4254.0 5976.6 6108.2 6131.5 6145.4 6187.2 4245.9 4253.8 4270.1 4277.0 4279.7 4291.7 4322.2 4331.1 4340.1 4341.9 4785.7 4890.9 4896.7 4911.9 4946.7 5810.6 5842.8 5848.4 5898.4 5960.9 1471.3 1471.8 1475.4 1482.8 1487.5 937.9 941.7 941.7 945.1 949.3 5173.2 5190.8 5204.3 5307.8 5314.3 5296.3 5429.8 5439.6 5513.2 5553.1 5183.8 5187.9 5325.6 5810.2 5855.7 3213.7 3256.4 3263.7 3263.9 3295.5 6074.8 6376.2 6396.9 6397.0 6414.8 6190.4 6213.9 6274.5 6280.9 6313.3 6197.1 6347.6 6375.3 6410.2 6428.4 5900.3 6185.6 6219.9 6246.3 6252.4 6093.8 6123.7 6161.0 6163.8 6171.5 6004.2 6320.8 6384.0 6407.6 6448.3 4178.1 4203.6 4219.3 4221.5 4235.5 5838.6 5962.5 6206.7 6206.8 6244.1 5869.9 5915.2 5933.0 5962.6 5989.6 5950.6 5962.9 6009.7 6015.2 6036.5 5651.8 5831.9 5848.2 5854.6 5894.0 5983.2 6007.6 6016.6 6017.1 6028.6 5675.0 5819.4 5873.7 5882.0 5884.6 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - PROCESS | 15205 | [#5] yui.html Cycles:180 Average:16214.08 Median:4724.35 stddev:19314.07 (408.8%) stddev-sans-first:19333.46 08:35:30 INFO - PROCESS | 15205 | Values: 776.1 807.5 860.2 875.9 886.9 14920.6 15683.1 15709.2 15760.6 15780.9 14603.6 14649.5 14651.2 14662.5 14669.6 681.1 796.8 828.3 831.7 850.0 839.5 841.5 846.2 848.2 848.7 893.7 896.0 898.3 898.7 900.0 899.6 900.1 900.2 901.1 903.3 645.9 649.7 651.7 651.9 653.8 14481.3 14533.6 14543.3 14552.2 14570.3 14465.5 14542.5 14584.8 14595.2 14722.5 11421.8 11518.8 11627.8 11769.3 11895.5 3865.8 3886.6 4016.6 4062.8 4073.1 56768.1 56862.0 57096.7 57259.4 57522.0 11175.7 11359.3 11374.2 11417.3 11461.5 20580.8 20634.7 20814.7 20832.8 20932.2 8315.6 8336.2 8371.5 8472.6 8633.1 4706.2 4859.6 4887.4 4893.0 4999.9 3398.5 3482.8 3505.2 3506.4 3510.5 659.5 666.1 666.6 670.9 678.1 620.6 673.8 743.9 762.5 770.2 9467.2 9548.1 9578.4 9846.3 9921.0 631.6 725.2 760.0 773.5 780.8 4512.5 4602.9 4742.5 4774.4 4812.0 69917.3 72907.0 72969.0 73430.0 73683.3 54383.7 57051.0 62311.0 62594.0 63974.7 56991.7 57083.0 58599.0 58766.4 59322.0 9805.2 9951.9 10409.1 10438.3 10523.8 38472.8 38888.2 38934.8 39541.4 40264.0 48665.5 51451.2 52151.7 52312.5 53324.5 12879.8 12984.8 13012.0 13059.6 13319.5 14128.4 14201.4 14252.9 14274.4 14376.4 13916.7 14017.4 14042.4 14362.3 14527.3 12602.9 12931.5 13113.2 13178.5 13321.3 12197.7 13006.0 13604.0 13938.7 14094.6 10658.3 10738.4 10861.2 11022.5 11027.3 10607.5 10654.3 10780.6 10928.2 10954.2 08:35:30 INFO - PROCESS | 15205 | -------- Summary: end -------- 08:35:30 INFO - PROCESS | 15205 | 08:35:30 INFO - TEST-INFO | 15205: exit 0 08:35:30 INFO - TEST-OK | dromaeo_css | took 1109923ms 08:35:30 INFO - TEST-START | kraken 08:35:30 INFO - operating with platform_type : linux_ 08:35:30 INFO - Initialising browser for kraken test... 08:35:30 INFO - TEST-INFO | started process 15440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9IAMy/profile http://localhost:60059/getInfo.html) 08:35:34 INFO - PROCESS | 15440 | 08:35:34 INFO - PROCESS | 15440 | (process:15510): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:35:35 INFO - PROCESS | 15440 | __metrics Screen width/height:1600/1200 08:35:35 INFO - PROCESS | 15440 | colorDepth:24 08:35:35 INFO - PROCESS | 15440 | Browser inner width/height: 1024/697 08:35:35 INFO - PROCESS | 15440 | __metrics 08:35:35 ERROR - PROCESS | 15440 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:35:36 INFO - TEST-INFO | 15440: exit 0 08:35:36 INFO - Browser initialized. 08:35:36 INFO - Running cycle 1/1 for kraken test... 08:35:36 INFO - TEST-INFO | started process 15561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9IAMy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:38 INFO - PROCESS | 15561 | 08:35:38 INFO - PROCESS | 15561 | (process:15625): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:35:48 INFO - PROCESS | 15561 | RSS: Main: 163721216 08:35:48 INFO - PROCESS | 15561 | 08:35:50 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60059/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:51 INFO - PROCESS | 15561 | RSS: Main: 168714240 08:35:51 INFO - PROCESS | 15561 | 08:35:54 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60059/tests/kraken/driver.html?testName=audio-dft) 08:35:55 INFO - PROCESS | 15561 | RSS: Main: 169148416 08:35:55 INFO - PROCESS | 15561 | 08:35:58 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60059/tests/kraken/driver.html?testName=audio-fft) 08:35:58 INFO - PROCESS | 15561 | RSS: Main: 163389440 08:35:58 INFO - PROCESS | 15561 | 08:36:00 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60059/tests/kraken/driver.html?testName=audio-oscillator) 08:36:01 INFO - PROCESS | 15561 | RSS: Main: 163450880 08:36:01 INFO - PROCESS | 15561 | 08:36:03 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:04 INFO - PROCESS | 15561 | RSS: Main: 163758080 08:36:04 INFO - PROCESS | 15561 | 08:36:07 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60059/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:08 INFO - PROCESS | 15561 | RSS: Main: 164384768 08:36:08 INFO - PROCESS | 15561 | 08:36:11 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60059/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:12 INFO - PROCESS | 15561 | RSS: Main: 163098624 08:36:12 INFO - PROCESS | 15561 | 08:36:15 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60059/tests/kraken/driver.html?testName=json-parse-financial) 08:36:15 INFO - PROCESS | 15561 | RSS: Main: 163180544 08:36:15 INFO - PROCESS | 15561 | 08:36:17 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:18 INFO - PROCESS | 15561 | RSS: Main: 163635200 08:36:18 INFO - PROCESS | 15561 | 08:36:19 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:20 INFO - PROCESS | 15561 | RSS: Main: 163876864 08:36:20 INFO - PROCESS | 15561 | 08:36:22 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:23 INFO - PROCESS | 15561 | RSS: Main: 163766272 08:36:23 INFO - PROCESS | 15561 | 08:36:26 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:26 INFO - PROCESS | 15561 | RSS: Main: 164327424 08:36:26 INFO - PROCESS | 15561 | 08:36:29 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:30 INFO - PROCESS | 15561 | RSS: Main: 164749312 08:36:30 INFO - PROCESS | 15561 | 08:36:31 INFO - PROCESS | 15561 | Cycle 1(1): loaded http://localhost:60059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60059/tests/kraken/driver.html?testName=ai-astar) 08:36:32 INFO - PROCESS | 15561 | RSS: Main: 165912576 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | __start_tp_report 08:36:32 INFO - PROCESS | 15561 | _x_x_mozilla_page_load 08:36:32 INFO - PROCESS | 15561 | _x_x_mozilla_page_load_details 08:36:32 INFO - PROCESS | 15561 | |i|pagename|runs| 08:36:32 INFO - PROCESS | 15561 | |0;ai-astar;107;109;105;110;111;112;105;109;111;109 08:36:32 INFO - PROCESS | 15561 | |1;audio-beat-detection;155;125;152;202;125;159;156;132;179;129 08:36:32 INFO - PROCESS | 15561 | |2;audio-dft;164;164;162;161;163;171;165;162;162;163 08:36:32 INFO - PROCESS | 15561 | |3;audio-fft;74;75;76;160;76;75;73;74;162;76 08:36:32 INFO - PROCESS | 15561 | |4;audio-oscillator;91;92;176;92;95;91;155;92;93;148 08:36:32 INFO - PROCESS | 15561 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;118 08:36:32 INFO - PROCESS | 15561 | |6;imaging-darkroom;147;147;148;148;146;146;148;146;146;147 08:36:32 INFO - PROCESS | 15561 | |7;imaging-desaturate;95;95;96;95;95;96;96;96;96;96 08:36:32 INFO - PROCESS | 15561 | |8;json-parse-financial;54;56;54;55;55;58;59;114;52;53 08:36:32 INFO - PROCESS | 15561 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;60;60;60 08:36:32 INFO - PROCESS | 15561 | |10;stanford-crypto-aes;85;77;78;78;80;84;79;80;80;81 08:36:32 INFO - PROCESS | 15561 | |11;stanford-crypto-ccm;134;118;120;127;141;128;122;129;255;140 08:36:32 INFO - PROCESS | 15561 | |12;stanford-crypto-pbkdf2;158;162;160;160;161;161;160;158;168;160 08:36:32 INFO - PROCESS | 15561 | |13;stanford-crypto-sha256-iterative;64;64;61;62;62;62;62;61;61;61 08:36:32 INFO - PROCESS | 15561 | __end_tp_report 08:36:32 INFO - PROCESS | 15561 | __start_cc_report 08:36:32 INFO - PROCESS | 15561 | _x_x_mozilla_cycle_collect,842 08:36:32 INFO - PROCESS | 15561 | __end_cc_report 08:36:32 INFO - PROCESS | 15561 | __startTimestamp1463585792040__endTimestamp 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | ------- Summary: start ------- 08:36:32 INFO - PROCESS | 15561 | Number of tests: 14 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.50 stddev:2.44 (2.2%) stddev-sans-first:2.50 08:36:32 INFO - PROCESS | 15561 | Values: 107.0 109.0 105.0 110.0 111.0 112.0 105.0 109.0 111.0 109.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.50 stddev:25.14 (16.2%) stddev-sans-first:26.63 08:36:32 INFO - PROCESS | 15561 | Values: 155.0 125.0 152.0 202.0 125.0 159.0 156.0 132.0 179.0 129.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.83 (1.7%) stddev-sans-first:3.00 08:36:32 INFO - PROCESS | 15561 | Values: 164.0 164.0 162.0 161.0 163.0 171.0 165.0 162.0 162.0 163.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.00 stddev:36.33 (48.4%) stddev-sans-first:37.94 08:36:32 INFO - PROCESS | 15561 | Values: 74.0 75.0 76.0 160.0 76.0 75.0 73.0 74.0 162.0 76.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:92.00 stddev:33.28 (36.2%) stddev-sans-first:34.38 08:36:32 INFO - PROCESS | 15561 | Values: 91.0 92.0 176.0 92.0 95.0 91.0 155.0 92.0 93.0 148.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:36:32 INFO - PROCESS | 15561 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 08:36:32 INFO - PROCESS | 15561 | Values: 147.0 147.0 148.0 148.0 146.0 146.0 148.0 146.0 146.0 147.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:36:32 INFO - PROCESS | 15561 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:55.00 stddev:18.74 (34.1%) stddev-sans-first:19.71 08:36:32 INFO - PROCESS | 15561 | Values: 54.0 56.0 54.0 55.0 55.0 58.0 59.0 114.0 52.0 53.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:36:32 INFO - PROCESS | 15561 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.57 (3.2%) stddev-sans-first:2.06 08:36:32 INFO - PROCESS | 15561 | Values: 85.0 77.0 78.0 78.0 80.0 84.0 79.0 80.0 80.0 81.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:131.50 stddev:40.67 (30.9%) stddev-sans-first:43.05 08:36:32 INFO - PROCESS | 15561 | Values: 134.0 118.0 120.0 127.0 141.0 128.0 122.0 129.0 255.0 140.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:2.82 (1.8%) stddev-sans-first:2.80 08:36:32 INFO - PROCESS | 15561 | Values: 158.0 162.0 160.0 160.0 161.0 161.0 160.0 158.0 168.0 160.0 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - PROCESS | 15561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.15 (1.9%) stddev-sans-first:0.97 08:36:32 INFO - PROCESS | 15561 | Values: 64.0 64.0 61.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 08:36:32 INFO - PROCESS | 15561 | -------- Summary: end -------- 08:36:32 INFO - PROCESS | 15561 | 08:36:32 INFO - TEST-INFO | 15561: exit 0 08:36:33 INFO - TEST-OK | kraken | took 62217ms 08:36:33 INFO - SUITE-END | took 1172s 08:36:33 INFO - Completed test suite (00:19:32) 08:36:33 INFO - javascript benchmark 08:36:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7272.138849987796, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.795133316334, 3179.5389668498083, 3207.230264736464, 3216.7265782408494, 3232.4181647303476, 5459.426760190182, 5476.863078423042, 5482.013237617227, 5506.229127922084, 5537.695426751527, 5313.57491400688, 5407.621466497337, 5446.972765136179, 5492.697901615409, 5531.585131115163, 4933.260010998352, 4970.254461830737, 5085.847424577269, 5110.872228194287, 5171.689698618095, 662.678043228266, 4858.805647774085, 4948.950510494903, 5039.899202015958, 5064.113780088488, 4954.677945933503, 4991.951690145074, 5005.899882002376, 5008.098542262392, 5034.144195486758, 5025.949740502585, 5034.043531728959, 5034.723090230036, 5050.545450909399, 5052.444231134572, 4883.8779030524165, 4948.554630083274, 4967.875803104916, 4982.352294201767, 5027.522385373383, 5440.863978400532, 5457.481539253765, 5486.478784515464, 5488.4785945335525, 5489.58828087891, 5802.854928626776, 5920.141579470953, 5921.0, 5937.0, 5963.910541341883, 5885.646861188299, 5910.527157827363, 5935.970320148414, 5993.0, 6002.669853158074, 5544.362398324204, 5553.305836770403, 5555.972220138914, 5564.0, 5565.165225216209, 5891.970540147272, 5956.076808094752, 6051.969740151271, 6082.330943596201, 6083.513318934474, 5801.216835727208, 5809.477147056785, 5817.970910145422, 5850.268716410449, 5856.619319744203, 5910.143029260819, 5918.437748413894, 5925.437083477149, 5928.614640048383, 5930.406959304121, 5714.028615135437, 5835.416458354215, 5862.149988251765, 5905.232319798399, 5926.674032928144, 5856.033754430471, 5913.58604897653, 5934.43622855828, 5974.492168165754, 5988.311344195473, 4489.685721999494, 4508.842190523316, 4520.796564154621, 4530.932036019462, 4563.498015218323, 3940.0543869471694, 3986.5216174059296, 4005.759654420744, 4008.8596899108393, 4062.939055914164, 5549.500544950893, 5601.80393686219, 5614.24207731951, 5647.435256474319, 5675.0, 5918.704064796743, 5925.970370148121, 5963.5825492216, 5970.791022314285, 5971.4028597140805, 5534.667919924817, 5684.175794509773, 5691.943080569225, 5698.230738850285, 5745.913811292834, 5158.226266060121, 5170.069387510209, 5176.249443830623, 5177.508136727005, 5215.843524694265, 6267.7806276781, 6276.497880169667, 6282.246130464374, 6288.717007734663, 6296.33888441707, 5827.94172058274, 5878.470937615635, 5930.436608522184, 5962.433568810956, 6039.063945088518, 6240.594361366497, 6243.750249990131, 6245.9063114052415, 6247.0, 6261.624302541862, 5857.619254748428, 5926.911096333472, 5932.199153114274, 5933.169356290036, 5979.641221526548, 5866.149408335682, 5879.470847623735, 5923.229980102559, 5948.881022379442, 6020.4280593343565, 5815.621984570989, 5831.271091113611, 5841.912371314349, 5845.269341332333, 5849.561282903885, 5789.1895134680335, 5813.476787089182, 5813.76744930198, 5831.446012628793, 5832.270966129234, 5576.386597474356, 5612.691301978431, 5681.261436013292, 5708.257926469532, 5713.571482138773, 5800.622959507618, 5852.824415267549, 5862.882742345215, 5882.588218824812, 5914.02418600926, 5572.777088916398, 5723.914141287967, 5736.627119237236, 5739.713014349182, 5759.0209664356325], "value": 5431.013957564664, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9642421454713, 627.2347735762369, 644.9290578036419, 648.4909346163262, 663.5653646861305, 43451.130977380475, 44902.77548612256, 44940.10119797602, 44965.55034449654, 49215.50784492154, 44947.32579011317, 45750.313745293846, 45793.855153621174, 45825.541744582544, 45845.31232031514, 8760.474371537697, 8990.865137022949, 8997.190252877239, 9004.819903601923, 9006.234470070052, 8847.601857916408, 8932.0, 8950.283977281802, 8950.955245223797, 8951.015388307282, 8989.95505022474, 8998.145176208283, 8999.41503802254, 9053.456792592433, 9076.773080673003, 8929.330300227477, 8984.955075224581, 8986.326025548111, 8994.325425593106, 9012.594433250453, 8733.170348816851, 8805.383623146383, 8817.867731984026, 8819.250363719091, 8824.294056475466, 40705.0, 40849.59150408488, 41000.79499602513, 41127.17745645071, 41157.176856462705, 3879.941800872989, 3927.469791578129, 4314.1371725655, 4326.048269380763, 4359.280718681413, 31034.844825775726, 31298.687013129806, 31426.80012399133, 31493.685063149303, 31891.0, 4408.096340250241, 4426.424564806587, 4496.123255965088, 4560.7035542689955, 4579.381783459224, 293886.53056734795, 294268.0, 294397.0, 294873.83320084127, 295819.0, 58265.41734582685, 58293.708531457916, 58445.70777146087, 58472.0, 58640.0, 37248.81375593159, 37959.0, 38000.61999379971, 40057.1988560233, 63693.36306636967, 17526.123693815258, 17640.294388224327, 17656.735148972777, 17675.20461579232, 17712.0, 13254.0, 13523.932380338036, 13581.796273055912, 13583.252921089435, 13603.591892243248, 20493.48766280825, 20641.587168256552, 20790.688139677917, 20804.895975520027, 20881.791182087985, 7500.1374841893885, 7578.4316176287, 7601.7719468416035, 7658.770236892902, 7766.301032907066, 1011.4437059617181, 1117.3128525956479, 1159.7796418680423, 1237.808139738342, 1243.8693937136652, 33263.66736332654, 33364.0, 33708.662913371045, 33758.662413375554, 34251.314973700384, 1136.198979719296, 1148.7013376522164, 1201.6154830454345, 1212.3574505512092, 1303.1789972317379, 17786.46640600784, 17854.732179017326, 17878.28486860511, 17885.37401190952, 17896.373626922996, 154981.0, 156111.0, 156689.21655391878, 156709.0, 547321.0, 61272.69363653242, 61916.69041654763, 62364.688176558826, 62380.06429903555, 62447.68776156181, 1384.3701115992199, 1408.3873515020998, 1412.8375236847894, 1441.690036642106, 1443.985560144385, 32487.18782030468, 32671.836640816644, 33222.335553288314, 33232.0, 33262.33475330431, 54136.0, 54165.45834541604, 54210.186847198114, 54509.45490545044, 54616.0, 429417.0, 432547.0, 433144.0, 434208.0, 434609.0, 29379.85310073436, 29536.852315738284, 30317.848410757804, 30381.0, 30432.543511847784, 51078.744606276734, 51645.0, 52514.0, 52851.0, 54580.727096364266, 42953.3556996639, 43366.0, 43776.56223437852, 44692.0, 44903.775481122386, 42088.94777630584, 42814.78592607017, 43292.56707432885, 43583.56416435922, 43997.78001109974, 43864.0, 44305.11389772251, 44812.10375792401, 45020.32469512895, 46559.0, 38203.42694859635, 38408.807955960045, 38592.80703596464, 39392.60607393889, 39570.406443902786, 28967.565486518142, 29289.443588086462, 29323.120306390843, 29855.701442985293, 30016.24959376033], "value": 20235.900647682472, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.72556935714334, 400.1696479804406, 400.2415422773844, 412.266166224121, 418.46190459663546, 13913.93043034786, 17962.37131700391, 19015.61968760624, 19345.516362090937, 19578.0, 18309.542261443472, 18532.351367702133, 18957.0, 19510.0, 19564.21743130273, 5792.826215213539, 5859.912101318484, 5887.205227294325, 5946.375630558794, 5946.524278057745, 5798.449147330997, 5869.060950247961, 5914.112883067532, 5953.047512398017, 5956.225690660208, 5823.3012038555435, 5846.619969701956, 5917.408259174092, 5923.526117910556, 5937.703114844262, 5673.744681489343, 5800.390958949313, 5865.824025279248, 5868.207791948096, 5946.43508866657, 5143.485651434864, 5152.278680984665, 5168.147255702805, 5175.249588809602, 5188.273641690129, 22317.0, 22481.887590561942, 22818.31545053651, 22841.20055798039, 22877.656835147485, 2251.2570851618925, 2366.857988520677, 2369.57347677418, 2424.2121310574134, 2484.5900426429616, 10194.388336699822, 10473.057424831803, 10478.63324783629, 11172.60895868649, 13920.651983700387, 1924.7209154672635, 1983.7421135252325, 2013.808688174621, 2033.6644453665128, 2037.8777273363646, 58950.0, 80690.19309806885, 81347.18652813455, 81648.29134447493, 81824.0, 10879.238453308351, 10926.071283940953, 10965.945170274257, 11097.223194376478, 11193.328400296008, 15220.086794792347, 15307.387704491919, 15317.617059573377, 15359.308831102404, 15408.460703875311, 7909.564973926489, 7916.643751031217, 7938.920610793818, 7978.680852765824, 8014.959925200454, 7480.139783924809, 7490.962545187348, 7535.246475352421, 7541.321281084729, 7605.505642133244, 4757.9286310705365, 4796.784144713496, 4809.110314591811, 4825.396825396825, 4831.0096430231715, 1939.2049259803696, 1946.7274581558593, 1966.9803301966797, 1976.1305025788606, 1985.612805502942, 932.1703683721494, 983.6753871222479, 993.7167907146429, 1000.229823036258, 1068.0280944340614, 18677.346292879956, 19365.32221372245, 19497.610047798964, 19548.481273370646, 19780.0, 1020.3316827478013, 1059.5338051257422, 1071.4589132488043, 1085.636311835544, 1088.711491454765, 10451.111655509367, 10936.453177341102, 10959.56161753521, 10995.34027958309, 11053.723656908482, 495315.0, 502662.0, 504299.0, 511534.0, 516266.0, 76104.0, 91733.0, 99018.0, 99250.0, 99359.50320248352, 1015.9034891685426, 1022.039283073923, 1024.257413375297, 1040.4173662748885, 1044.9059584637419, 16497.422590209284, 16631.417900373428, 16915.830841691426, 17057.232424540678, 17111.315547378465, 35388.46917296294, 38770.6122938767, 39540.40689389719, 42356.36465453082, 42645.0, 58049.4195058044, 58917.410825891195, 59423.40576594351, 60063.69968150131, 60247.69876150591, 8604.827903442021, 8680.522571258642, 8770.210681038481, 8827.955860220658, 8974.282057435259, 9756.512174391393, 13342.799858002332, 13361.933190334375, 13565.59303220905, 13577.59267221985, 7243.420526357984, 9672.93597704238, 10057.195424365887, 11884.643460696192, 11952.223105498115, 11230.0, 11665.0, 11682.70793230176, 11687.532498700297, 11847.170698051053, 11882.76234475323, 12030.0, 12164.939175304067, 12298.385080746106, 12300.446479908605, 8697.521636310064, 8718.869216961624, 8743.34424918121, 8743.979620268421, 8944.597493112955, 9057.818843623223, 11301.0, 11931.463084161407, 11947.402629868646, 12047.578334758591], "value": 9210.192915020281, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.0782984124442, 1559.6568754873927, 1703.1654489300238, 1802.9459116226517, 1830.588117673523, 7943.880841787378, 8251.257386835183, 8525.658973641046, 8881.777955551115, 8906.955465222673, 8524.744257672264, 8809.339299552526, 8831.779205519866, 8844.601992910319, 8855.468671879691, 2309.0186670664943, 2316.061994892071, 2351.1183306260154, 2353.576356255873, 2354.7174339079247, 2313.097891822191, 2322.094383190557, 2356.2106694257445, 2360.0323867214447, 2368.83418160728, 2342.4261056041296, 2348.7416384197722, 2358.610829213186, 2380.9285721428387, 2384.4277373430427, 2268.4669102761004, 2270.2281224383705, 2277.1233075265977, 2278.3506700590333, 2288.7367952685486, 2192.5176461178517, 2247.2471721973156, 2250.8424410291286, 2266.218154736613, 2266.4900397410615, 8904.287656987426, 8952.8657070144, 8964.372493925428, 8966.730998070068, 8991.14584114508, 5261.394939581959, 5392.676439413648, 5400.21696853954, 5401.5948803839865, 5402.91895621566, 3362.3443428531446, 3419.9145021374416, 3539.628339024391, 3560.3413368526903, 3561.216532362876, 1179.9764004719857, 1189.6787867275873, 1192.2190964917993, 1194.6475789642077, 1210.074293165729, 12338.136330456871, 12377.0, 12393.566225182076, 12412.069094817925, 12417.565385211565, 4535.841245556389, 4559.544045595414, 4698.577128058491, 4709.882252943704, 4756.191447453941, 10540.683779486628, 10568.731752189633, 10575.682729518127, 10585.84121238182, 10594.735131621772, 5289.365276166807, 5390.595705322116, 5391.973040134774, 5394.190871369326, 5401.081816091274, 4439.733615983051, 4754.881127971828, 4907.067657145131, 4949.505049495022, 4970.080535101018, 4114.0948991221885, 4144.854930077433, 4185.058361868555, 4195.035141917315, 4257.318828987409, 1302.5701518498872, 1344.0524430276632, 1352.749741297863, 1365.269580774301, 1372.5882235329361, 917.1837065012145, 981.5779214937645, 991.0683957080322, 1000.7698229407132, 1001.5643195210107, 5741.827745167651, 5753.137029445533, 5794.681292528951, 5810.244668193108, 5814.447627475383, 391.8550136449532, 394.1486389398885, 394.16043826649053, 396.44299758838304, 396.90672691917376, 3933.4099885016903, 3934.291827471083, 3944.2900277950243, 3952.1898010907694, 3967.504061992251, 10833.67498975032, 11099.611513597147, 11189.384583847805, 11206.943965280121, 11217.270877392943, 10934.125269978382, 11070.667879963614, 11086.501107450023, 11090.667279981451, 11149.777004459866, 7947.960260198778, 8251.29863961558, 8270.172982701682, 8370.12113728062, 8386.454880432751, 5907.675077870586, 6095.299040610386, 6097.573169878244, 6112.786052488142, 6135.202423684892, 10060.195184385379, 10340.896591033994, 10505.842412363974, 10532.21008424356, 10548.208884333551, 10526.736831579272, 10665.146788257076, 10715.571377144826, 10719.249652524248, 10782.245242832927, 7374.889376659462, 8095.676172953016, 8194.057683366489, 8242.216989386, 8486.066532681523, 8574.657013719381, 8735.388522803343, 8754.737357879274, 8784.341174411817, 8827.16141966512, 7554.169041405551, 7596.316331530189, 7628.313451789366, 7724.1117271514495, 8053.758387248392, 7629.160792312952, 7726.0, 7751.961240193763, 7835.216478352348, 7851.489653172525, 7037.225905150532, 7046.647667616701, 7047.541909775849, 7052.647367631495, 7055.647217638995, 4816.4220293564995, 4896.0, 4915.778789954389, 4996.375453068366, 5013.724245166405, 5045.823396181116, 5054.09026375256, 5107.489251074863, 5160.690358578498, 5257.579393648422], "value": 4590.587344000244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.8277723086456, 305.8761201713306, 307.1828935032813, 312.39707364785954, 316.5836924444357, 5699.601027928052, 5776.382612868399, 5778.219940308057, 5795.1886735857015, 5840.824775256739, 5507.834764957048, 5605.990921634104, 5632.155176723493, 5687.516561092312, 5758.481736643701, 4137.193247316774, 4187.769672668002, 4293.570642935697, 4296.324433470949, 4317.373980772786, 4301.741895486265, 4336.241157797389, 4355.71687840291, 4355.978220108895, 4373.169097871394, 4297.806598703066, 4299.570042995691, 4324.178406102847, 4325.87527242916, 4343.695941284095, 4017.5781542938007, 4238.957610423887, 4253.595908388729, 4261.403403523509, 4332.740035597874, 3734.5518537775642, 3735.906602334936, 3737.215184811193, 3737.5514938207316, 3745.1573395985956, 5389.083855744494, 5403.243545903577, 5426.21319908615, 5455.699936503491, 5472.0, 4756.881077973078, 4934.3108006136745, 4952.950470495285, 4976.154053810861, 5016.219242169014, 5874.853128671817, 5875.148103524965, 5882.6764527950945, 5942.286925568959, 5957.004403524825, 4184.184084103601, 4186.958130418718, 4207.642350400189, 4240.1307731914885, 4253.978730106361, 5976.641401515923, 6108.205933228696, 6131.478824299896, 6145.446909778141, 6187.16473276111, 4245.87262382129, 4253.829846806155, 4270.12462445198, 4277.03766652507, 4279.651909648451, 4291.742495450283, 4322.200392927319, 4331.137610827374, 4340.066885619543, 4341.891452713708, 4785.665003449794, 4890.902181956341, 4896.681715688469, 4911.877203069952, 4946.724506726946, 5810.593258471951, 5842.824715258549, 5848.385919478478, 5898.410158984153, 5960.940390596125, 1471.2937789860928, 1471.8446019874348, 1475.4393330534328, 1482.8072350594355, 1487.5462983790048, 937.8827646544182, 941.6798288581915, 941.6892425499706, 945.1021529546958, 949.2785483032944, 5173.198154286091, 5190.792368305301, 5204.282586746364, 5307.761150748225, 5314.256004159421, 5296.285001524822, 5429.755660995264, 5439.558516992921, 5513.228148059275, 5553.111941939679, 5183.792648294026, 5187.870303242449, 5325.573954083664, 5810.244668193192, 5855.677937713466, 3213.662565430643, 3256.4301247281633, 3263.7225835804225, 3263.8694452221644, 3295.505674148897, 6074.791899614859, 6376.171097757262, 6396.936030639634, 6396.968015159894, 6414.775482858077, 6190.380961903774, 6213.875722485525, 6274.525486510666, 6280.937190628127, 6313.337099604567, 6197.070439434121, 6347.5556711029785, 6375.2668443128705, 6410.166678331787, 6428.357164283628, 5900.291964964232, 6185.567010309235, 6219.906701399392, 6246.281677607133, 6252.406021427957, 6093.817185484442, 6123.663198524124, 6160.966880929193, 6163.753449862134, 6171.47542458896, 6004.189434426296, 6320.841978950379, 6383.96808015957, 6407.597151068349, 6448.290688024407, 4178.143480586533, 4203.579642035772, 4219.303814870512, 4221.514525829446, 4235.534091250021, 5838.649681019152, 5962.463378295801, 6206.72069756853, 6206.844828879314, 6244.126761971481, 5869.94130058711, 5915.201447804663, 5932.96173169685, 5962.642241465526, 5989.64062156272, 5950.613210141327, 5962.940370596239, 6009.7295621698, 6015.195441367659, 6036.547258955508, 5651.813119245005, 5831.94168058314, 5848.181254624271, 5854.648721076749, 5893.970530147321, 5983.162357269899, 6007.609505382136, 6016.608920420159, 6017.127516510169, 6028.577999540165, 5675.000746187064, 5819.418058194146, 5873.706314684334, 5881.9705901470215, 5884.6469211847425], "value": 4448.66746681466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.1307335783923, 807.4711064252913, 860.1828263150007, 875.8598624220118, 886.9024407315196, 14920.552383428501, 15683.137427441487, 15709.214539273033, 15760.60598485037, 15780.921095394508, 14603.561893143222, 14649.487267945624, 14651.194184319858, 14662.486812961522, 14669.559913202595, 681.1349586025732, 796.8366484870617, 828.3042244514606, 831.7005877883956, 849.9872501912477, 839.5256679975824, 841.5077179849795, 846.1876598465481, 848.2154007543029, 848.6647774129216, 893.740815163605, 895.9955200224023, 898.2544488074915, 898.7303808857349, 899.9910000900005, 899.5502248875562, 900.1088921967238, 900.2348004196446, 901.058393978291, 903.2638399704285, 645.8998855177455, 649.6524359467709, 651.7425616881305, 651.8631087471637, 653.8267359149829, 14481.34833932465, 14533.636659083608, 14543.3455494503, 14552.199629020399, 14570.344334504973, 14465.49370772018, 14542.491012814606, 14584.781228281585, 14595.197264150467, 14722.484713034992, 11421.771564568662, 11518.827217591743, 11627.825582616268, 11769.293842369485, 11895.464704088337, 3865.7873816940055, 3886.553046399672, 4016.598340165989, 4062.7765472898977, 4073.083556199861, 56768.14847777287, 56862.0, 57096.714516427564, 57259.427405726245, 57522.0, 11175.664730058112, 11359.261647992855, 11374.20380573352, 11417.314961102195, 11461.541538338373, 20580.794192058187, 20634.690479642817, 20814.687779683012, 20832.791672083084, 20932.16271349129, 8315.584220788936, 8336.249737523653, 8371.497710137412, 8472.576371181416, 8633.093525179891, 4706.247000479907, 4859.635527335464, 4887.413510378778, 4893.048661363979, 4999.925001124986, 3398.4732366483236, 3482.7562070654812, 3505.1938054247667, 3506.403911335079, 3510.543629328222, 659.5037781995126, 666.1007639686482, 666.576723780403, 670.9295523970011, 678.1049015299757, 620.6307247188006, 673.7877568565887, 743.9479236453396, 762.4586543554138, 770.1720650300837, 9467.18408635186, 9548.140667339972, 9578.377405468762, 9846.261530385107, 9920.950395247977, 631.5894668465534, 725.1551941987631, 759.9772006839804, 773.4701729315437, 780.7579650308309, 4512.5261847505535, 4602.930956035662, 4742.454617718938, 4774.427068751772, 4811.975940120277, 69917.30082699108, 72907.0, 72969.0, 73430.0, 73683.26316736871, 54383.72808136013, 57051.0, 62311.0, 62594.0, 63974.68012659907, 56991.715041424526, 57083.0, 58599.0, 58766.41233587609, 59322.0, 9805.215582753506, 9951.850722239316, 10409.11522520564, 10438.321509101885, 10523.789524209626, 38472.80763596276, 38888.22223555457, 38934.80532597319, 39541.40687889742, 40264.0, 48665.5133448661, 51451.228231575806, 52151.73924130355, 52312.47687523076, 53324.46675533195, 12879.806802897776, 12984.805227921777, 13012.0, 13059.608211753663, 13319.467221311039, 14128.43486260538, 14201.43194272259, 14252.928735356258, 14274.357653905392, 14376.424943002163, 13916.652083697989, 14017.369218384993, 14042.368093436024, 14362.281885905872, 14527.34626941769, 12602.873971260537, 12931.482740690268, 13113.213207207598, 13178.538751143664, 13321.26733029654, 12197.69505762363, 13006.0, 13604.024824358332, 13938.651533711738, 14094.590540946234, 10658.25392222568, 10738.409387483764, 10861.185411094042, 11022.50398732043, 11027.338359698444, 10607.469626518488, 10654.254202205771, 10780.568777248822, 10928.235023548275, 10954.178436617127], "value": 7154.172537848429, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 105.0, 110.0, 111.0, 112.0, 105.0, 109.0, 111.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 152.0, 202.0, 125.0, 159.0, 156.0, 132.0, 179.0, 129.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 161.0, 163.0, 171.0, 165.0, 162.0, 162.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 160.0, 76.0, 75.0, 73.0, 74.0, 162.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 176.0, 92.0, 95.0, 91.0, 155.0, 92.0, 93.0, 148.0], "value": 112.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 55.0, 58.0, 59.0, 114.0, 52.0, 53.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 78.0, 78.0, 80.0, 84.0, 79.0, 80.0, 80.0, 81.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 118.0, 120.0, 127.0, 141.0, 128.0, 122.0, 129.0, 255.0, 140.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 160.0, 160.0, 161.0, 161.0, 160.0, 158.0, 168.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0], "value": 62.0, "unit": "score"}]}]} 08:36:33 INFO - Return code: 0 08:36:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:36:33 ERROR - # TBPL SUCCESS # 08:36:33 INFO - Running post-action listener: _resource_record_post_action 08:36:33 INFO - ##### 08:36:33 INFO - ##### Finished run-tests step (success) 08:36:33 INFO - ##### 08:36:33 INFO - Running post-run listener: _resource_record_post_run 08:36:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539033600; Read time: 8; Write time: 415580 08:36:33 INFO - TinderboxPrint: CPU usage
13.4% 08:36:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:36:33 INFO - TinderboxPrint: I/O write bytes / time
539,033,600 / 415,580 08:36:33 INFO - TinderboxPrint: CPU idle
8,222.6 (86.6%) 08:36:33 INFO - TinderboxPrint: CPU user
1,217.5 (12.8%) 08:36:33 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246542336; Read time: 0; Write time: 202052 08:36:33 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292491264; Read time: 8; Write time: 213528 08:36:33 INFO - Running post-run listener: _upload_blobber_files 08:36:33 INFO - Blob upload gear active. 08:36:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:33 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:36:33 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:36:33 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:36:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:38 INFO - (blobuploader) - INFO - Done attempting. 08:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:39 INFO - (blobuploader) - INFO - Done attempting. 08:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:39 INFO - (blobuploader) - INFO - Done attempting. 08:36:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:40 INFO - Return code: 0 08:36:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c30ed52c53b23b5839d494cc87cedc05781d7c4e83c05b031d4807c3532559003cbb404b38dacaf8d2d5436cf529c08124a0e6d86b4ef0e1390a44814b2f608", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3176d9734b6a4eb25fad0405fa031755865822b79d074a1b0269d7b344d32eb653db981d3d659835fedb34e48746ea846d59dd58a762b9738026cf0df804cd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ceb9ea1f3f9e1c523596e426f2195b1ddbf96d2ed0948543a63ac7b9dd861a89983b93f776b3e992c9d20178980ade64e72d17021c07562fa65cd6e02b26d3a"} 08:36:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:40 INFO - Contents: 08:36:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c30ed52c53b23b5839d494cc87cedc05781d7c4e83c05b031d4807c3532559003cbb404b38dacaf8d2d5436cf529c08124a0e6d86b4ef0e1390a44814b2f608", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3176d9734b6a4eb25fad0405fa031755865822b79d074a1b0269d7b344d32eb653db981d3d659835fedb34e48746ea846d59dd58a762b9738026cf0df804cd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ceb9ea1f3f9e1c523596e426f2195b1ddbf96d2ed0948543a63ac7b9dd861a89983b93f776b3e992c9d20178980ade64e72d17021c07562fa65cd6e02b26d3a"} 08:36:40 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:40 INFO - Copying logs to upload dir... 08:36:40 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.032326 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-18 08:36:40.022285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 08:36:40.025954) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698 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/3c30ed52c53b23b5839d494cc87cedc05781d7c4e83c05b031d4807c3532559003cbb404b38dacaf8d2d5436cf529c08124a0e6d86b4ef0e1390a44814b2f608", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3176d9734b6a4eb25fad0405fa031755865822b79d074a1b0269d7b344d32eb653db981d3d659835fedb34e48746ea846d59dd58a762b9738026cf0df804cd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ceb9ea1f3f9e1c523596e426f2195b1ddbf96d2ed0948543a63ac7b9dd861a89983b93f776b3e992c9d20178980ade64e72d17021c07562fa65cd6e02b26d3a"} 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.011059 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/3c30ed52c53b23b5839d494cc87cedc05781d7c4e83c05b031d4807c3532559003cbb404b38dacaf8d2d5436cf529c08124a0e6d86b4ef0e1390a44814b2f608", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3176d9734b6a4eb25fad0405fa031755865822b79d074a1b0269d7b344d32eb653db981d3d659835fedb34e48746ea846d59dd58a762b9738026cf0df804cd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ceb9ea1f3f9e1c523596e426f2195b1ddbf96d2ed0948543a63ac7b9dd861a89983b93f776b3e992c9d20178980ade64e72d17021c07562fa65cd6e02b26d3a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 08:36:40.051272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:36:40.051975) ========= 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=31acecf42b6a79ec49471d4a000001bb-1463584566.723365-561224698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 08:36:40.137306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 08:36:40.138035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 08:36:40.138768) ========= ========= Total master_lag: 0.19 =========