builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1463639237.73 results: success (0) buildid: 20160518203028 builduid: a7a0ccee54854a178af8d048424ec083 revision: eb54f97ddfd410d426df5989a8ddd962d97bee44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.729771) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.730302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.730820) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.751766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.752137) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 23:27:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-18 23:27:18 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.885634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.886363) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014772 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.937662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 23:27:17.938073) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb54f97ddfd410d426df5989a8ddd962d97bee44 --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 eb54f97ddfd410d426df5989a8ddd962d97bee44 --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=a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 23:27:18,286 truncating revision to first 12 chars 2016-05-18 23:27:18,286 Setting DEBUG logging. 2016-05-18 23:27:18,286 attempt 1/10 2016-05-18 23:27:18,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb54f97ddfd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 23:27:19,595 unpacking tar archive at: fx-team-eb54f97ddfd4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 23:27:19.541759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.542119) ========= script_repo_revision: eb54f97ddfd410d426df5989a8ddd962d97bee44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.542584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.542897) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.555600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-18 23:27:19.555933) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:27:19 INFO - MultiFileLogger online at 20160518 23:27:19 in /builds/slave/test 23:27:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:27:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:27:19 INFO - {'append_to_log': False, 23:27:19 INFO - 'base_work_dir': '/builds/slave/test', 23:27:19 INFO - 'blob_upload_branch': 'Fx-Team', 23:27:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:27:19 INFO - 'branch': 'Fx-Team', 23:27:19 INFO - 'buildbot_json_path': 'buildprops.json', 23:27:19 INFO - 'config_files': ('talos/linux_config.py',), 23:27:19 INFO - 'default_actions': ('clobber', 23:27:19 INFO - 'read-buildbot-config', 23:27:19 INFO - 'download-and-extract', 23:27:19 INFO - 'populate-webroot', 23:27:19 INFO - 'create-virtualenv', 23:27:19 INFO - 'install', 23:27:19 INFO - 'run-tests'), 23:27:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:27:19 INFO - 'download_minidump_stackwalk': True, 23:27:19 INFO - 'download_symbols': 'ondemand', 23:27:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:27:19 INFO - 'tooltool.py': '/tools/tooltool.py', 23:27:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:27:19 INFO - '/tools/misc-python/virtualenv.py')}, 23:27:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:27:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:27:19 INFO - 'installer_path': 'installer.exe', 23:27:19 INFO - 'log_level': 'info', 23:27:19 INFO - 'log_name': 'talos', 23:27:19 INFO - 'log_to_console': True, 23:27:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:27:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:27:19 INFO - 'opt_config_files': (), 23:27:19 INFO - 'pip_index': False, 23:27:19 INFO - 'sps_profile': False, 23:27:19 INFO - 'sps_profile_interval': 0, 23:27:19 INFO - 'suite': 'dromaeojs-e10s', 23:27:19 INFO - 'system_bits': '32', 23:27:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:27:19 INFO - 'title': 'talos-linux64-ix-064', 23:27:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:27:19 INFO - 'use_talos_json': True, 23:27:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:27:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:27:19 INFO - 'work_dir': 'build'} 23:27:19 INFO - ##### 23:27:19 INFO - ##### Running clobber step. 23:27:19 INFO - ##### 23:27:19 INFO - Running pre-action listener: _resource_record_pre_action 23:27:19 INFO - Running main action method: clobber 23:27:19 INFO - rmtree: /builds/slave/test/build 23:27:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:27:20 INFO - Running post-action listener: _resource_record_post_action 23:27:20 INFO - ##### 23:27:20 INFO - ##### Finished clobber step (success) 23:27:20 INFO - ##### 23:27:20 INFO - ##### 23:27:20 INFO - ##### Running read-buildbot-config step. 23:27:20 INFO - ##### 23:27:20 INFO - Running pre-action listener: _resource_record_pre_action 23:27:20 INFO - Running main action method: read_buildbot_config 23:27:20 INFO - Using buildbot properties: 23:27:20 INFO - { 23:27:20 INFO - "project": "", 23:27:20 INFO - "product": "firefox", 23:27:20 INFO - "script_repo_revision": "production", 23:27:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:27:20 INFO - "repository": "", 23:27:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:27:20 INFO - "buildid": "20160518203028", 23:27:20 INFO - "pgo_build": "True", 23:27:20 INFO - "basedir": "/builds/slave/test", 23:27:20 INFO - "buildnumber": 349, 23:27:20 INFO - "slavename": "talos-linux64-ix-064", 23:27:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:27:20 INFO - "platform": "ubuntu64_hw", 23:27:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:27:20 INFO - "branch": "fx-team", 23:27:20 INFO - "repo_path": "integration/fx-team", 23:27:20 INFO - "revision": "eb54f97ddfd410d426df5989a8ddd962d97bee44", 23:27:20 INFO - "stage_platform": "linux64-pgo", 23:27:20 INFO - "builduid": "a7a0ccee54854a178af8d048424ec083", 23:27:20 INFO - "slavebuilddir": "test" 23:27:20 INFO - } 23:27:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:27:20 INFO - Running post-action listener: _resource_record_post_action 23:27:20 INFO - ##### 23:27:20 INFO - ##### Finished read-buildbot-config step (success) 23:27:20 INFO - ##### 23:27:20 INFO - ##### 23:27:20 INFO - ##### Running download-and-extract step. 23:27:20 INFO - ##### 23:27:20 INFO - Running pre-action listener: _resource_record_pre_action 23:27:20 INFO - Running main action method: download_and_extract 23:27:20 INFO - mkdir: /builds/slave/test/build/tests 23:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:20 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:27:24 INFO - Downloaded 1361 bytes. 23:27:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:24 INFO - Using the following test package requirements: 23:27:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:27:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:27:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:27:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'jsshell-linux-x86_64.zip'], 23:27:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:27:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:27:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:27:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:27:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:27:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:27:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:24 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:27:28 INFO - Downloaded 24386200 bytes. 23:27:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:27:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:27:29 INFO - Return code: 0 23:27:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:27: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')]} 23:27:29 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:27:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:27:31 INFO - Downloaded 24386200 bytes. 23:27:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:27:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:27:32 INFO - Return code: 0 23:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:32 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:27:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:27:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:27:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:27:33 INFO - Downloaded 10840194 bytes. 23:27:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:27:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:27:33 INFO - Return code: 0 23:27: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')]} 23:27:33 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:27:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:27:35 INFO - Downloaded 58423860 bytes. 23:27:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:35 INFO - mkdir: /builds/slave/test/properties 23:27:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:27:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:27:35 INFO - Contents: 23:27:35 INFO - build_url:https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:36 INFO - Running post-action listener: _resource_record_post_action 23:27:36 INFO - Running post-action listener: set_extra_try_arguments 23:27:36 INFO - ##### 23:27:36 INFO - ##### Finished download-and-extract step (success) 23:27:36 INFO - ##### 23:27:36 INFO - ##### 23:27:36 INFO - ##### Running populate-webroot step. 23:27:36 INFO - ##### 23:27:36 INFO - Running pre-action listener: _resource_record_pre_action 23:27:36 INFO - Running main action method: populate_webroot 23:27:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:27:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:27:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:27:36 INFO - '--tppagecycles', 23:27:36 INFO - '7'], 23:27:36 INFO - 'tests': ['tsvgm']}}, 23:27:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:27:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:27:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:27:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:27:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['damp', 'tps']}, 23:27:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'tests': ['damp', 'tps']}, 23:27:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['dromaeo_dom']}, 23:27:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:27:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['a11yr', 23:27:36 INFO - 'ts_paint', 23:27:36 INFO - 'tpaint', 23:27:36 INFO - 'sessionrestore', 23:27:36 INFO - 'sessionrestore_no_auto_restore', 23:27:36 INFO - 'tabpaint']}, 23:27:36 INFO - 'other-e10s': {'tests': ['a11yr', 23:27:36 INFO - 'ts_paint', 23:27:36 INFO - 'tpaint', 23:27:36 INFO - 'sessionrestore', 23:27:36 INFO - 'sessionrestore_no_auto_restore', 23:27:36 INFO - 'tabpaint']}, 23:27:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:27:36 INFO - 'ts_paint', 23:27:36 INFO - 'tpaint', 23:27:36 INFO - 'sessionrestore', 23:27:36 INFO - 'sessionrestore_no_auto_restore', 23:27:36 INFO - 'tabpaint']}, 23:27:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:27:36 INFO - 'ts_paint', 23:27:36 INFO - 'tpaint', 23:27:36 INFO - 'sessionrestore', 23:27:36 INFO - 'sessionrestore_no_auto_restore', 23:27:36 INFO - 'tabpaint']}, 23:27:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['a11yr', 23:27:36 INFO - 'ts_paint', 23:27:36 INFO - 'tpaint', 23:27:36 INFO - 'sessionrestore', 23:27:36 INFO - 'sessionrestore_no_auto_restore', 23:27:36 INFO - 'tabpaint']}, 23:27:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['a11yr', 23:27:36 INFO - 'ts_paint', 23:27:36 INFO - 'tpaint', 23:27:36 INFO - 'sessionrestore', 23:27:36 INFO - 'sessionrestore_no_auto_restore', 23:27:36 INFO - 'tabpaint']}, 23:27:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['tsvgx', 23:27:36 INFO - 'tsvgr_opacity', 23:27:36 INFO - 'tart', 23:27:36 INFO - 'tscrollx', 23:27:36 INFO - 'cart']}, 23:27:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:27:36 INFO - 'tsvgr_opacity', 23:27:36 INFO - 'tart', 23:27:36 INFO - 'tscrollx', 23:27:36 INFO - 'cart']}, 23:27:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'talos_options': ['--disable-e10s'], 23:27:36 INFO - 'tests': ['tp5o']}, 23:27:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'tests': ['tp5o']}, 23:27:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'talos_options': ['--disable-e10s', 23:27:36 INFO - '--xperf_path', 23:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:36 INFO - 'tests': ['tp5n']}, 23:27:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:36 INFO - 'talos_options': ['--xperf_path', 23:27:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:36 INFO - 'tests': ['tp5n']}}, 23:27:36 INFO - 'talos.zip': {'path': '', 23:27:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:27:36 INFO - Running post-action listener: _resource_record_post_action 23:27:36 INFO - ##### 23:27:36 INFO - ##### Finished populate-webroot step (success) 23:27:36 INFO - ##### 23:27:36 INFO - ##### 23:27:36 INFO - ##### Running create-virtualenv step. 23:27:36 INFO - ##### 23:27:36 INFO - Running pre-action listener: _resource_record_pre_action 23:27:36 INFO - Running main action method: create_virtualenv 23:27:36 INFO - Creating virtualenv /builds/slave/test/build/venv 23:27:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:27:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:27:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:27:36 INFO - Using real prefix '/usr' 23:27:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:27:37 INFO - Installing distribute.............................................................................................................................................................................................done. 23:27:39 INFO - Installing pip.................done. 23:27:39 INFO - Return code: 0 23:27:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:27: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')]} 23:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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')]} 23:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27: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', 'pip>=1.5'] in /builds/slave/test/build 23:27: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 pip>=1.5 23:27:39 INFO - Using env: {'DISPLAY': ':0', 23:27:39 INFO - 'HOME': '/home/cltbld', 23:27:39 INFO - 'LANG': 'en_US.UTF-8', 23:27:39 INFO - 'LANGUAGE': 'en_US:en', 23:27:39 INFO - 'LOGNAME': 'cltbld', 23:27:39 INFO - 'MAIL': '/var/mail/cltbld', 23:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:39 INFO - 'MOZ_NO_REMOTE': '1', 23:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:39 INFO - 'NO_EM_RESTART': '1', 23:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:39 INFO - 'PWD': '/builds/slave/test', 23:27:39 INFO - 'SHELL': '/bin/bash', 23:27:39 INFO - 'SHLVL': '1', 23:27:39 INFO - 'TERM': 'linux', 23:27:39 INFO - 'TMOUT': '86400', 23:27:39 INFO - 'USER': 'cltbld', 23:27:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:39 INFO - '_': '/tools/buildbot/bin/python'} 23:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:27:39 INFO - Cleaning up... 23:27:39 INFO - Return code: 0 23:27:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:27: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')]} 23:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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')]} 23:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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', '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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:27: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 psutil>=3.1.1 23:27:39 INFO - Using env: {'DISPLAY': ':0', 23:27:39 INFO - 'HOME': '/home/cltbld', 23:27:39 INFO - 'LANG': 'en_US.UTF-8', 23:27:39 INFO - 'LANGUAGE': 'en_US:en', 23:27:39 INFO - 'LOGNAME': 'cltbld', 23:27:39 INFO - 'MAIL': '/var/mail/cltbld', 23:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:39 INFO - 'MOZ_NO_REMOTE': '1', 23:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:39 INFO - 'NO_EM_RESTART': '1', 23:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:39 INFO - 'PWD': '/builds/slave/test', 23:27:39 INFO - 'SHELL': '/bin/bash', 23:27:39 INFO - 'SHLVL': '1', 23:27:39 INFO - 'TERM': 'linux', 23:27:39 INFO - 'TMOUT': '86400', 23:27:39 INFO - 'USER': 'cltbld', 23:27:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:39 INFO - '_': '/tools/buildbot/bin/python'} 23:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:39 INFO - Downloading/unpacking psutil>=3.1.1 23:27: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 23:27: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 23:27: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 23:27: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 23:27: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 23:27: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 23:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:27:41 INFO - Installing collected packages: psutil 23:27:41 INFO - Running setup.py install for psutil 23:27:41 INFO - building 'psutil._psutil_linux' extension 23:27:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:27:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:27:41 INFO - building 'psutil._psutil_posix' extension 23:27:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:27:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:27:41 INFO - Successfully installed psutil 23:27:41 INFO - Cleaning up... 23:27:41 INFO - Return code: 0 23:27:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:41 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:27:41 INFO - Using env: {'DISPLAY': ':0', 23:27:41 INFO - 'HOME': '/home/cltbld', 23:27:41 INFO - 'LANG': 'en_US.UTF-8', 23:27:41 INFO - 'LANGUAGE': 'en_US:en', 23:27:41 INFO - 'LOGNAME': 'cltbld', 23:27:41 INFO - 'MAIL': '/var/mail/cltbld', 23:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:41 INFO - 'MOZ_NO_REMOTE': '1', 23:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:41 INFO - 'NO_EM_RESTART': '1', 23:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:41 INFO - 'PWD': '/builds/slave/test', 23:27:41 INFO - 'SHELL': '/bin/bash', 23:27:41 INFO - 'SHLVL': '1', 23:27:41 INFO - 'TERM': 'linux', 23:27:41 INFO - 'TMOUT': '86400', 23:27:41 INFO - 'USER': 'cltbld', 23:27:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:41 INFO - '_': '/tools/buildbot/bin/python'} 23:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:27: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 23:27: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 23:27: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 23:27: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 23:27: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 23:27: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 23:27:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:27:44 INFO - Installing collected packages: mozsystemmonitor 23:27:44 INFO - Running setup.py install for mozsystemmonitor 23:27:44 INFO - Successfully installed mozsystemmonitor 23:27:44 INFO - Cleaning up... 23:27:44 INFO - Return code: 0 23:27:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:44 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:27:44 INFO - Using env: {'DISPLAY': ':0', 23:27:44 INFO - 'HOME': '/home/cltbld', 23:27:44 INFO - 'LANG': 'en_US.UTF-8', 23:27:44 INFO - 'LANGUAGE': 'en_US:en', 23:27:44 INFO - 'LOGNAME': 'cltbld', 23:27:44 INFO - 'MAIL': '/var/mail/cltbld', 23:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:44 INFO - 'MOZ_NO_REMOTE': '1', 23:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:44 INFO - 'NO_EM_RESTART': '1', 23:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:44 INFO - 'PWD': '/builds/slave/test', 23:27:44 INFO - 'SHELL': '/bin/bash', 23:27:44 INFO - 'SHLVL': '1', 23:27:44 INFO - 'TERM': 'linux', 23:27:44 INFO - 'TMOUT': '86400', 23:27:44 INFO - 'USER': 'cltbld', 23:27:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:44 INFO - '_': '/tools/buildbot/bin/python'} 23:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:44 INFO - Downloading/unpacking blobuploader==1.2.4 23:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:46 INFO - Downloading blobuploader-1.2.4.tar.gz 23:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:27:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:27:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:47 INFO - Downloading docopt-0.6.1.tar.gz 23:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:27:47 INFO - Installing collected packages: blobuploader, requests, docopt 23:27:47 INFO - Running setup.py install for blobuploader 23:27:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:27:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:27:47 INFO - Running setup.py install for requests 23:27:47 INFO - Running setup.py install for docopt 23:27:47 INFO - Successfully installed blobuploader requests docopt 23:27:47 INFO - Cleaning up... 23:27:47 INFO - Return code: 0 23:27:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:47 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:27:47 INFO - Using env: {'DISPLAY': ':0', 23:27:47 INFO - 'HOME': '/home/cltbld', 23:27:47 INFO - 'LANG': 'en_US.UTF-8', 23:27:47 INFO - 'LANGUAGE': 'en_US:en', 23:27:47 INFO - 'LOGNAME': 'cltbld', 23:27:47 INFO - 'MAIL': '/var/mail/cltbld', 23:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:47 INFO - 'MOZ_NO_REMOTE': '1', 23:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:47 INFO - 'NO_EM_RESTART': '1', 23:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:47 INFO - 'PWD': '/builds/slave/test', 23:27:47 INFO - 'SHELL': '/bin/bash', 23:27:47 INFO - 'SHLVL': '1', 23:27:47 INFO - 'TERM': 'linux', 23:27:47 INFO - 'TMOUT': '86400', 23:27:47 INFO - 'USER': 'cltbld', 23:27:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:47 INFO - '_': '/tools/buildbot/bin/python'} 23:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:47 INFO - Running setup.py (path:/tmp/pip-ke7O9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:48 INFO - Running setup.py (path:/tmp/pip-IlxA9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:48 INFO - Running setup.py (path:/tmp/pip-BxBLeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:48 INFO - Running setup.py (path:/tmp/pip-MR3810-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:48 INFO - Running setup.py (path:/tmp/pip-XnZpQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:48 INFO - Running setup.py (path:/tmp/pip-6W__ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:48 INFO - Running setup.py (path:/tmp/pip-arGu1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:48 INFO - Running setup.py (path:/tmp/pip-kPn3jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:48 INFO - Running setup.py (path:/tmp/pip-zYXV4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:48 INFO - Running setup.py (path:/tmp/pip-T2UTA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:48 INFO - Running setup.py (path:/tmp/pip-MSEqDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:48 INFO - Running setup.py (path:/tmp/pip-sfx43t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:48 INFO - Running setup.py (path:/tmp/pip-oJ2gqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:48 INFO - Running setup.py (path:/tmp/pip-HJQ_S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:48 INFO - Running setup.py (path:/tmp/pip-hvi0sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:49 INFO - Running setup.py (path:/tmp/pip-Gyszpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:49 INFO - Running setup.py (path:/tmp/pip-0K1o9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:27:49 INFO - Running setup.py install for manifestparser 23:27:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Running setup.py install for mozcrash 23:27:49 INFO - Running setup.py install for mozdebug 23:27:49 INFO - Running setup.py install for mozdevice 23:27:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Running setup.py install for mozfile 23:27:49 INFO - Running setup.py install for mozhttpd 23:27:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Running setup.py install for mozinfo 23:27:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Running setup.py install for mozInstall 23:27:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:27:49 INFO - Running setup.py install for mozleak 23:27:50 INFO - Running setup.py install for mozlog 23:27:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Running setup.py install for moznetwork 23:27:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Running setup.py install for mozprocess 23:27:50 INFO - Running setup.py install for mozprofile 23:27:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Running setup.py install for mozrunner 23:27:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Running setup.py install for mozscreenshot 23:27:50 INFO - Running setup.py install for moztest 23:27:50 INFO - Running setup.py install for mozversion 23:27:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:27:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:27:50 INFO - Cleaning up... 23:27:50 INFO - Return code: 0 23:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:50 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:27:50 INFO - Using env: {'DISPLAY': ':0', 23:27:50 INFO - 'HOME': '/home/cltbld', 23:27:50 INFO - 'LANG': 'en_US.UTF-8', 23:27:50 INFO - 'LANGUAGE': 'en_US:en', 23:27:50 INFO - 'LOGNAME': 'cltbld', 23:27:50 INFO - 'MAIL': '/var/mail/cltbld', 23:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:50 INFO - 'MOZ_NO_REMOTE': '1', 23:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:50 INFO - 'NO_EM_RESTART': '1', 23:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:50 INFO - 'PWD': '/builds/slave/test', 23:27:50 INFO - 'SHELL': '/bin/bash', 23:27:50 INFO - 'SHLVL': '1', 23:27:50 INFO - 'TERM': 'linux', 23:27:50 INFO - 'TMOUT': '86400', 23:27:50 INFO - 'USER': 'cltbld', 23:27:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:50 INFO - '_': '/tools/buildbot/bin/python'} 23:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:51 INFO - Running setup.py (path:/tmp/pip-taa_ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:51 INFO - Running setup.py (path:/tmp/pip-3j0JbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:51 INFO - Running setup.py (path:/tmp/pip-fgF7YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:51 INFO - Running setup.py (path:/tmp/pip-5eQQ2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:51 INFO - Running setup.py (path:/tmp/pip-kQ6D5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:51 INFO - Running setup.py (path:/tmp/pip-7YcpNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:51 INFO - Running setup.py (path:/tmp/pip-tZgXJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:51 INFO - Running setup.py (path:/tmp/pip-QckHWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:51 INFO - Running setup.py (path:/tmp/pip-qsD_jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:51 INFO - Running setup.py (path:/tmp/pip-w2Oz8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:51 INFO - Running setup.py (path:/tmp/pip-ElB_Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:51 INFO - Running setup.py (path:/tmp/pip-GLBHuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:52 INFO - Running setup.py (path:/tmp/pip-i_oF4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:52 INFO - Running setup.py (path:/tmp/pip-1vETBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:52 INFO - Running setup.py (path:/tmp/pip-T1vmZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:52 INFO - Running setup.py (path:/tmp/pip-s1b73J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:52 INFO - Running setup.py (path:/tmp/pip-yogTjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:27:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:54 INFO - Downloading blessings-1.6.tar.gz 23:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:27:54 INFO - Installing collected packages: blessings 23:27:54 INFO - Running setup.py install for blessings 23:27:54 INFO - Successfully installed blessings 23:27:54 INFO - Cleaning up... 23:27:54 INFO - Return code: 0 23:27:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:54 INFO - Reading from file tmpfile_stdout 23:27:54 INFO - Current package versions: 23:27:54 INFO - argparse == 1.2.1 23:27:54 INFO - blessings == 1.6 23:27:54 INFO - blobuploader == 1.2.4 23:27:54 INFO - docopt == 0.6.1 23:27:54 INFO - manifestparser == 1.1 23:27:54 INFO - mozInstall == 1.12 23:27:54 INFO - mozcrash == 0.17 23:27:54 INFO - mozdebug == 0.1 23:27:54 INFO - mozdevice == 0.48 23:27:54 INFO - mozfile == 1.2 23:27:54 INFO - mozhttpd == 0.7 23:27:54 INFO - mozinfo == 0.9 23:27:54 INFO - mozleak == 0.1 23:27:54 INFO - mozlog == 3.2 23:27:54 INFO - moznetwork == 0.27 23:27:54 INFO - mozprocess == 0.22 23:27:54 INFO - mozprofile == 0.28 23:27:54 INFO - mozrunner == 6.11 23:27:54 INFO - mozscreenshot == 0.1 23:27:54 INFO - mozsystemmonitor == 0.3 23:27:54 INFO - moztest == 0.7 23:27:54 INFO - mozversion == 1.4 23:27:54 INFO - psutil == 3.1.1 23:27:54 INFO - requests == 1.2.3 23:27:54 INFO - wsgiref == 0.1.2 23:27:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:54 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:27:54 INFO - Using env: {'DISPLAY': ':0', 23:27:54 INFO - 'HOME': '/home/cltbld', 23:27:54 INFO - 'LANG': 'en_US.UTF-8', 23:27:54 INFO - 'LANGUAGE': 'en_US:en', 23:27:54 INFO - 'LOGNAME': 'cltbld', 23:27:54 INFO - 'MAIL': '/var/mail/cltbld', 23:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:54 INFO - 'MOZ_NO_REMOTE': '1', 23:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:54 INFO - 'NO_EM_RESTART': '1', 23:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:54 INFO - 'PWD': '/builds/slave/test', 23:27:54 INFO - 'SHELL': '/bin/bash', 23:27:54 INFO - 'SHLVL': '1', 23:27:54 INFO - 'TERM': 'linux', 23:27:54 INFO - 'TMOUT': '86400', 23:27:54 INFO - 'USER': 'cltbld', 23:27:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:54 INFO - '_': '/tools/buildbot/bin/python'} 23:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:27:54 INFO - Cleaning up... 23:27:54 INFO - Return code: 0 23:27:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:54 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:27:54 INFO - Using env: {'DISPLAY': ':0', 23:27:54 INFO - 'HOME': '/home/cltbld', 23:27:54 INFO - 'LANG': 'en_US.UTF-8', 23:27:54 INFO - 'LANGUAGE': 'en_US:en', 23:27:54 INFO - 'LOGNAME': 'cltbld', 23:27:54 INFO - 'MAIL': '/var/mail/cltbld', 23:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:54 INFO - 'MOZ_NO_REMOTE': '1', 23:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:54 INFO - 'NO_EM_RESTART': '1', 23:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:54 INFO - 'PWD': '/builds/slave/test', 23:27:54 INFO - 'SHELL': '/bin/bash', 23:27:54 INFO - 'SHLVL': '1', 23:27:54 INFO - 'TERM': 'linux', 23:27:54 INFO - 'TMOUT': '86400', 23:27:54 INFO - 'USER': 'cltbld', 23:27:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:54 INFO - '_': '/tools/buildbot/bin/python'} 23:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:55 INFO - Downloading/unpacking jsonschema 23:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:27:57 INFO - Downloading/unpacking functools32 (from jsonschema) 23:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:57 INFO - Downloading functools32-3.2.3-2.tar.gz 23:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:27:57 INFO - warning: no files found matching '*.txt' 23:27:57 INFO - no previously-included directories found matching 'build' 23:27:57 INFO - no previously-included directories found matching 'dist' 23:27:57 INFO - no previously-included directories found matching '.git*' 23:27:57 INFO - Installing collected packages: jsonschema, functools32 23:27:57 INFO - Running setup.py install for functools32 23:27:57 INFO - warning: no files found matching '*.txt' 23:27:57 INFO - no previously-included directories found matching 'build' 23:27:57 INFO - no previously-included directories found matching 'dist' 23:27:57 INFO - no previously-included directories found matching '.git*' 23:27:57 INFO - Successfully installed jsonschema functools32 23:27:57 INFO - Cleaning up... 23:27:57 INFO - Return code: 0 23:27:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:57 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 0x7fcfabb3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1590770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:27:57 INFO - Using env: {'DISPLAY': ':0', 23:27:57 INFO - 'HOME': '/home/cltbld', 23:27:57 INFO - 'LANG': 'en_US.UTF-8', 23:27:57 INFO - 'LANGUAGE': 'en_US:en', 23:27:57 INFO - 'LOGNAME': 'cltbld', 23:27:57 INFO - 'MAIL': '/var/mail/cltbld', 23:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:57 INFO - 'MOZ_NO_REMOTE': '1', 23:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:57 INFO - 'NO_EM_RESTART': '1', 23:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:57 INFO - 'PWD': '/builds/slave/test', 23:27:57 INFO - 'SHELL': '/bin/bash', 23:27:57 INFO - 'SHLVL': '1', 23:27:57 INFO - 'TERM': 'linux', 23:27:57 INFO - 'TMOUT': '86400', 23:27:57 INFO - 'USER': 'cltbld', 23:27:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:57 INFO - '_': '/tools/buildbot/bin/python'} 23:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:57 INFO - Downloading/unpacking flake8 23:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:27:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:27:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:28:00 INFO - no previously-included directories found matching 'docs/_build' 23:28:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:28:00 INFO - Running setup.py install for pep8 23:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:28:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:28:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:28:00 INFO - no previously-included directories found matching 'docs/_build' 23:28:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:28:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:28:00 INFO - Cleaning up... 23:28:00 INFO - Return code: 0 23:28:00 INFO - Running post-action listener: _resource_record_post_action 23:28:00 INFO - Running post-action listener: _start_resource_monitoring 23:28:00 INFO - Starting resource monitoring. 23:28:00 INFO - ##### 23:28:00 INFO - ##### Finished create-virtualenv step (success) 23:28:00 INFO - ##### 23:28:00 INFO - ##### 23:28:00 INFO - ##### Running install step. 23:28:00 INFO - ##### 23:28:00 INFO - Running pre-action listener: _resource_record_pre_action 23:28:00 INFO - Running main action method: install 23:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:28:00 INFO - Reading from file tmpfile_stdout 23:28:00 INFO - Detecting whether we're running mozinstall >=1.0... 23:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:28:00 INFO - Reading from file tmpfile_stdout 23:28:00 INFO - Output received: 23:28:00 INFO - Usage: mozinstall [options] installer 23:28:00 INFO - Options: 23:28:00 INFO - -h, --help show this help message and exit 23:28:00 INFO - -d DEST, --destination=DEST 23:28:00 INFO - Directory to install application into. [default: 23:28:00 INFO - "/builds/slave/test"] 23:28:00 INFO - --app=APP Application being installed. [default: firefox] 23:28:00 INFO - mkdir: /builds/slave/test/build/application 23:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:28:17 INFO - Reading from file tmpfile_stdout 23:28:17 INFO - Output received: 23:28:17 INFO - /builds/slave/test/build/application/firefox/firefox 23:28:17 INFO - Running post-action listener: _resource_record_post_action 23:28:17 INFO - ##### 23:28:17 INFO - ##### Finished install step (success) 23:28:17 INFO - ##### 23:28:17 INFO - ##### 23:28:17 INFO - ##### Running run-tests step. 23:28:17 INFO - ##### 23:28:17 INFO - Running pre-action listener: _resource_record_pre_action 23:28:17 INFO - Running main action method: run_tests 23:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:28:17 INFO - Python 2.7.3 23:28:17 INFO - Return code: 0 23:28:17 INFO - grabbing minidump binary from tooltool 23:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:17 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 0x161f9c0>, '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 0x16208c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1620d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:28:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:28:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:28:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:28:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:28:17 INFO - Return code: 0 23:28:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:28:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:28:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:28:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:28:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:28:18 INFO - Return code: 0 23:28:18 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/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:28:18 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/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:28:18 INFO - Using env: {'DISPLAY': ':0', 23:28:18 INFO - 'HOME': '/home/cltbld', 23:28:18 INFO - 'LANG': 'en_US.UTF-8', 23:28:18 INFO - 'LANGUAGE': 'en_US:en', 23:28:18 INFO - 'LOGNAME': 'cltbld', 23:28:18 INFO - 'MAIL': '/var/mail/cltbld', 23:28:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:28:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:18 INFO - 'MOZ_NO_REMOTE': '1', 23:28:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:18 INFO - 'NO_EM_RESTART': '1', 23:28:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:18 INFO - 'PWD': '/builds/slave/test', 23:28:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:28:18 INFO - 'SHELL': '/bin/bash', 23:28:18 INFO - 'SHLVL': '1', 23:28:18 INFO - 'TERM': 'linux', 23:28:18 INFO - 'TMOUT': '86400', 23:28:18 INFO - 'USER': 'cltbld', 23:28:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147', 23:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:18 INFO - '_': '/tools/buildbot/bin/python'} 23:28:18 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/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:28:18 INFO - mozversion application_buildid: 20160518203028 23:28:18 INFO - mozversion application_changeset: eb54f97ddfd410d426df5989a8ddd962d97bee44 23:28:18 INFO - mozversion application_display_name: Nightly 23:28:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:28:18 INFO - mozversion application_name: Firefox 23:28:18 INFO - mozversion application_remotingname: firefox 23:28:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:28:18 INFO - mozversion application_vendor: Mozilla 23:28:18 INFO - mozversion application_version: 49.0a1 23:28:18 INFO - mozversion platform_buildid: 20160518203028 23:28:18 INFO - mozversion platform_changeset: eb54f97ddfd410d426df5989a8ddd962d97bee44 23:28:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:28:18 INFO - mozversion platform_version: 49.0a1 23:28:18 INFO - using testdate: 1463639298 23:28:18 INFO - actual date: 1463639298 23:28:18 INFO - starting webserver on 'localhost:56600' 23:28:18 INFO - SUITE-START | Running 2 tests 23:28:18 INFO - TEST-START | dromaeo_css 23:28:18 INFO - operating with platform_type : linux_ 23:28:18 INFO - Initialising browser for dromaeo_css test... 23:28:18 INFO - TEST-INFO | started process 18661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_z7sV9/profile http://localhost:56600/getInfo.html) 23:28:22 INFO - PROCESS | 18661 | 23:28:22 INFO - PROCESS | 18661 | (process:18729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:23 INFO - PROCESS | 18661 | __metrics Screen width/height:1600/1200 23:28:23 INFO - PROCESS | 18661 | colorDepth:24 23:28:23 INFO - PROCESS | 18661 | Browser inner width/height: 1024/697 23:28:23 INFO - PROCESS | 18661 | __metrics 23:28:24 ERROR - PROCESS | 18661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:28:25 INFO - TEST-INFO | 18661: exit 0 23:28:25 INFO - Browser initialized. 23:28:25 INFO - Running cycle 1/1 for dromaeo_css test... 23:28:25 INFO - TEST-INFO | started process 18780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_z7sV9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:27 INFO - PROCESS | 18780 | 23:28:27 INFO - PROCESS | 18780 | (process:18843): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:37 INFO - PROCESS | 18780 | RSS: Main: 163704832 23:28:37 INFO - PROCESS | 18780 | 23:29:26 INFO - PROCESS | 18780 | 1463639366730 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:31:34 INFO - PROCESS | 18780 | Cycle 1(1): loaded http://localhost:56600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56600/tests/dromaeo/cssquery-ext.html) 23:31:35 INFO - PROCESS | 18780 | RSS: Main: 167174144 23:31:35 INFO - PROCESS | 18780 | 23:34:37 INFO - PROCESS | 18780 | Cycle 1(1): loaded http://localhost:56600/tests/dromaeo/cssquery-ext.html (next: http://localhost:56600/tests/dromaeo/cssquery-jquery.html) 23:34:37 INFO - PROCESS | 18780 | RSS: Main: 166477824 23:34:37 INFO - PROCESS | 18780 | 23:37:39 INFO - PROCESS | 18780 | Cycle 1(1): loaded http://localhost:56600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56600/tests/dromaeo/cssquery-mootools.html) 23:37:40 INFO - PROCESS | 18780 | RSS: Main: 168169472 23:37:40 INFO - PROCESS | 18780 | 23:40:41 INFO - PROCESS | 18780 | Cycle 1(1): loaded http://localhost:56600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56600/tests/dromaeo/cssquery-prototype.html) 23:40:42 INFO - PROCESS | 18780 | RSS: Main: 165576704 23:40:42 INFO - PROCESS | 18780 | 23:43:44 INFO - PROCESS | 18780 | Cycle 1(1): loaded http://localhost:56600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56600/tests/dromaeo/cssquery-yui.html) 23:43:45 INFO - PROCESS | 18780 | RSS: Main: 166129664 23:43:45 INFO - PROCESS | 18780 | 23:46:47 INFO - PROCESS | 18780 | Cycle 1(1): loaded http://localhost:56600/tests/dromaeo/cssquery-yui.html (next: http://localhost:56600/tests/dromaeo/cssquery-dojo.html) 23:46:48 INFO - PROCESS | 18780 | RSS: Main: 167665664 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | __start_tp_report 23:46:48 INFO - PROCESS | 18780 | _x_x_mozilla_page_load 23:46:48 INFO - PROCESS | 18780 | _x_x_mozilla_page_load_details 23:46:48 INFO - PROCESS | 18780 | |i|pagename|runs| 23:46:48 INFO - PROCESS | 18780 | |0;dojo.html;3105.5496952941826;3136;3179.4118088153687;3183.936321273575;3201.231704390947;5447.45525447455;5476.096444086726;5535.169724541321;5586.301712285965;5643.548516118711;5333.653312534682;5409.6213265071465;5523.005858945388;5537.529310008654;5548.306461692288;4928.753562321878;4955.157623204046;5008.098542262392;5018.623603229772;5100.362454693163;299.5940693232388;5096.082705113078;5097.439281679012;5103.795848166069;5141.82003629873;4927.310176575283;4939.950600493985;4942.728149951751;4992.87517812054;4995.60035197187;4980.526849949249;4987.027529631723;5000.599952003831;5002.59979201663;5045.899082018339;4953.083679519301;4980.003999200138;4980.978899325666;4983.526564976321;5000.62495312853;5387.955804970179;5431.755570999275;5434.565234781208;5451.591130665216;5468.890622187574;5879.0593505039415;5905.114232865061;5907.793227237026;5909.054551271776;5910.172575839386;5751.511121554631;5869.618474799125;5913.467787899067;5945.1973983512535;5960.940390596125;5455.1544510600925;5480.588955828289;5565.332160140809;5573.662321042961;5581.944180558183;6061.666608336495;6088.330283668793;6098.634081955097;6099.3900609938655;6108.816735497942;5821.650700957956;5823.82528524145;5903.055511118287;5911.054231322968;5951.4048595141;5963.403659634088;5975.312839023481;5982.820515384546;5986.102084687244;5987.970060149672;5725.742341594639;5868.823935281948;5923.318818335861;5928.9407105928385;5931.644101353846;6002.219711437485;6004.459598636144;6012.488938440281;6028.125921741323;6033.78881739137;4516.81932722694;4525.343825145335;4529.275315949432;4548.226801443762;4568.543145685405;3954.8813535593977;3958.346872766019;3973.7019723520852;4002.4396584478195;4033.5361433434946;5524.4199359066715;5667.008273552112;5675.460831221028;5700.230468886647;5742.13867919807;6041.395860413923;6066.726997285133;6075.088736689532;6089.573729838958;6108.297545782292;5513.228148059195;5676.659400435987;5708.514776243983;5764.769409223584;5779.190913272145;5086.5422112009355;5150.562202212779;5159.277701121846;5160.48395160481;5176.922346164811;6204.7828326008375;6211.65835879022;6213.03697926822;6224.657643829632;6236.719347629368;5817.38917413674;6003.429674181033;6053.515718742402;6062;6080.300765412034;6189.783357582463;6194.721237544231;6199.5660303780105;6205.03821907605;6226.283977342482;5690.2887139107615;5929.347771745191;5935.7032148391545;5944.464998150187;5989.131575921379;5942.465178133816;6008.218931538872;6022.518198544193;6052.243469566304;6060.545459090674;5853.239078919713;5895.852603684943;5902.763889444374;5908.793192238251;5936.673482958478;5661.405552416937;5735.7418916148035;5904.261967254093;5911.054231322968;5920.230370051866;5654.038813401649;5683.204351390726;5711.685857277889;5720.199172115824;5781.306243250837;5806.767729290781;5823.155642431909;5825.50483208932;5852.4147585241135;5857.882842343044;5585.944140558542;5590.357108932525;5615.213870058114;5708.914366284426;5739.311282646109 23:46:48 INFO - PROCESS | 18780 | |1;ext.html;601.3415310235293;637.4708991537025;642.8457170279133;659.9274079851217;666.9766558170465;39467.40798888016;43234.78382608083;43263.13473730528;43422.78288608552;43496;42314.365284520754;42385.364219536656;42578.787106064425;42668;42939.92650183739;8870.689525866579;8985.460872347647;9053.637854485845;9053.909460905372;9081.409708368968;8924.062973387798;8936.910630893706;9006.504642244674;9011.143941325596;9061.048589898064;9086.273098152133;9117.45295282282;9143.542822858864;9145.359824812265;9150.169966006792;9011.504367259799;9013.053629368953;9028.503432311252;9030.413023153507;9102.453852768822;8861.911380886173;8962.955185224033;8967.686130985385;8971.551422428918;8996.550172491348;33681;40900;41228.38157427641;41489.792551037055;41518.58481415177;3555.839987200582;3651.1054791575966;3805.2389522095414;3936.921261574781;3953.782541960191;30922.84538577315;33416;33707;34090;34581.308373832384;4362.179900264712;4408.29467285236;4419.9337009944875;4462.286034234539;4463.732176069446;361403;367938;367986;368206;369199;66642.66678666673;68259;68370;68606;68619.3138068623;38214.23571528554;38999.61000390017;39024;40726;40938.1812363757;15019.549413517612;15138.848611513964;15159.317830697644;15174.924125379302;15200.923995379952;11800.940995295141;11984.940075299568;12022.338771367658;12028.097892658086;12053.276803391824;21645.077914481342;21744.456388590414;21798.56402871934;21851.125954961622;21865.781342186376;7974.252101512396;8178.345732341399;8287.12985136564;8346.248837604644;8466.872996905051;988.8318985772293;1026.5483187397522;1084.5661735305941;1094.266841216371;1147.4033502578613;32549.186270342958;32827.50758738621;33143.83428082844;33162.66837331596;33357.83321083379;1135.3471753741633;1179.2511755035614;1190.7142285851332;1193.164784650748;1200.8018676918384;17025.744613830804;17368.044757538202;17439.21523531444;17451.65096698059;17619.647607048042;518578;522451;524143;524812;525294;61780;62171;62249;62318.376816232165;62557.374426256065;1389.5553422904572;1417.3480199108526;1424.3163281624877;1436.8132142821366;1441.92069436182;32317;32353;32775;32902.40659087913;33819.830900845336;52458.47541524536;53837;53971.46028539664;54000;54035.45964540462;448416;451066;452771;453160;454080;29625;29904.70095299019;30125.397492050473;30202.848985754932;30237.092887213417;49573.75213123911;49889.501104988485;50041;50375.74812125916;51121.48878511167;42170.78914605407;42336;42799.57200427956;43309.7834510838;43701;41639;42391.57608423876;43001;43837.34243986279;44092.55907440885;37435.43846842354;42254.366184506645;42583;43717.56282437135;44101;34663.30673386468;37044.814775925945;37228.813855930544;37616.43575346317;38071.61928380681;29576.408471830873;29589.408211836075;29745.851270743507;29830.552541712324;29867.551986719784 23:46:48 INFO - PROCESS | 18780 | |2;jquery.html;391.79039214020503;397.34438177007934;408.889599808052;412.16330848377805;432.8355225014494;13667.3166341683;18103.18535665895;18310.816891831077;20298.1880724771;20318.288859889926;17929.193186306617;18398.540036499093;18435.81564184358;18568.535786605342;18693;5593.580481463886;5792.594518383726;5827.35899051104;5832.591718579701;5983.10253461982;5435.347758269013;5746.454086861741;5900;5920.703964801764;5952.345242023374;5710;5732.684702341369;5753;5775.884482310351;5798.42015798421;5495.862603434906;5808.593398462131;5849.532037436995;5917.437843404869;5928.7924922627935;4931.3589233399425;5233.869153271161;5244.977229440261;5259.421463638997;5702.54379649627;13841.792373114411;14010.719785604333;18752.343667971556;22371.32886013422;22575.209867654554;2176.216562037665;2211.391867236523;2275.3117206982542;2347.248880358286;2475.1460746042585;9936.652217172437;10085.294029417944;10087.293889427743;10493.895061049368;10664.520096595672;1910.8884682425996;1988.135161204866;2025.8581899267058;2033.6034473277716;2095.067694875781;77942;81275;81383.5930820348;82170.58914705388;82748.58625706832;10024.298299118991;10368.326058806153;11822.290662560274;12020.158588898694;12057.336846473352;15644.217789110726;15679.921600391925;15746.76379854303;15837.68324633501;15838.28727707233;7782.805429864298;7929.643166057541;7974.720884769005;8070.47541909774;8140.470869393471;7200.675969581382;7407.259274072658;7504.774856754306;7558.697652093964;7628.275313845176;4807.423109226846;4825.517448255217;4838.782254798472;4902.215645496774;4978.203487442064;2001.9199232030846;2018.5660083082207;2028.695695645665;2045.7749647538758;2081.8230450411584;930.7254359963827;1018.9643362482277;1058.3914249306679;1135.1259530161894;1180.9055275577932;17989.7301540477;18269.725954110698;18810.905945470186;19106.140223689967;20063.799362006193;1025.5795123999123;1025.9281850270559;1045.7281106912105;1064.1699474409972;1083.853679753239;10514.421706806046;10783.946080269705;10817.675469735921;10841.83737243942;10883.727906802393;468775;472722;479439;485057;489851;78634.6068269655;79340.60329698314;86564;98026;100768.96924122953;1071.3411252079916;1092.6285063078592;1098.6703988803326;1125.8423820665114;1141.965741027754;17257.39599114025;17549.561260968578;17728.822711773235;17745.645087098444;17843.464696059138;39637;40189;41045.794771025954;41290.79354603208;42816.78591607022;54660.180097299366;55113.17330239969;58482.415175847695;58909;59708.70145649244;5206.375234971676;5405.8918821622565;8288.129746376544;8806.471611703319;8808.326417980563;12419.813702794285;13156.342182891009;13246.933765331112;13259.469621215429;13588.59234222975;11293.943530282297;11588.304701717923;11620.709482263012;11769.588064417705;11771.352575608424;10934.945325273322;11002.33985960845;11230.775384492428;11294.43527823622;11302.378369189773;8983.01186869457;11640.476178571815;11844.46699898524;12010.63968080959;12156.270623762603;8358.45670031446;8889.73330800077;8911.331650126396;8959.328050396116;8989.55052247398;11164.888351116384;11686.357250351311;11822.34977076269;11907.940460297643;12053.698657533632 23:46:48 INFO - PROCESS | 18780 | |3;mootools.html;1555.1446704312625;1586.2386054693748;1744.9912750436247;1830;1868.8131186881315;7988.640511176996;8851.114888511145;8872.866906996383;9380.155785979252;9397.389169703973;8894.332925030616;9145.359824812265;9173;9223.584938677759;9242;2347.3192774095533;2373.32360277321;2377.6314671225987;2384.475415408616;2385.3917251100943;2343.496148328109;2367.597508423572;2371.5849726297915;2382.9761702383016;2388.5700573896693;2342.652974539638;2354.8587084774967;2358.8820558971984;2372.6441033844976;2376.4177776444794;2288.1648198407543;2327.1273272522803;2335.544568809083;2337.661039149331;2353.352827972304;2352.800011998965;2367.2188177901426;2388.7014123234594;2392.079049565912;2394.892229849661;9151.176394124494;9221.90778092224;9222.21611163052;9224.169824715807;9247.49138797366;5171.327727395452;5255.369355677305;5261.789528418859;5309.469053094698;5317.73411329432;3522.8766993155373;3575.106223444139;3588.5873124590485;3679.3745063339297;3706.3328600851837;1098.4672433869566;1099.8295264234057;1130.2145009218596;1138.0724709361843;1156.7570810129882;12486.937565312206;12633.368331583384;12662.620121396281;12684.619461416172;12693.11148219625;4652.092841895866;4661.627069834405;4701.106789709944;4744.454387745384;4759.524047595212;9677.70966870995;9712.611495540099;9759.463229522302;9763.365381250196;9854.901450985542;5224.50367215114;5233.162693968947;5244.475552444725;5246.842594722164;5265.447128051576;4378.190034843564;4858.951410485921;5008.874778130576;5013.874653133628;5062.215356619657;3899.161680238762;3936.6653834423823;4002.519697636244;4010.298197815429;4084.223997440477;1174.8825117488184;1183.2131632464316;1197.9640610781692;1200.039968025576;1209.8729633388543;868.7133246028795;969.7042402067437;971.8687977122997;983.8671779309844;999.84018538495;5550.783122902294;6003.8198854034445;6006.579539432198;6103.450689437972;6159.045347971071;459.9379083823708;464.94420669519195;468.18068380334415;475.4366076199714;476.5377583743763;3838;3910.2179564086728;3921.822482260675;3980.6577170545324;4092.7135100543273;11430;11926.88073119275;11933.70165745846;11936.582219622445;11975.880241197476;11301;11365.147613928988;11371.260868043551;11779.646610601696;11798.705032374088;8570.700025499078;8704.869426958601;8752.56237188138;8797.076306987801;8808.427452215585;5913.793017244376;5936.643801371932;6036.33600303975;6059.151718759289;6127.785527506516;10563.419011954109;10656.25406221557;10692.19808514349;11105.722356941142;11117.666470005914;10615.522301496605;10696.1977851663;10784.568617255221;10809.45952702346;10817.729556760829;6948.131483564554;7516.549007059594;7687.423443241891;7710.151883292945;7819.882701759592;8993.370464067453;9011.909880901107;9044.547772611211;9065;9086.954565227132;7591.658375373232;7923.643436045277;8082.434229603871;8111.229433203836;8130;7824.687012519663;7854.293113619801;7878.684852605831;8019.478733882279;8068.1528439513;7201.13586369639;7202.315780001101;7247.166575843846;7291.781246562611;7293;5216.817411390583;5217.243499692448;5258.447862974485;5264.078786212474;5308.46915308466;5209.296744939385;5215.426303106731;5220.034293655686;5325.627206095536;5340.626156169031 23:46:48 INFO - PROCESS | 18780 | |4;prototype.html;338.47536318706;345.7113310385828;350.9035015370774;352.105651644822;355.236242079529;5474.671519708821;5609.1305847593585;5630.296212973379;5655.745491452884;5697.6610496533285;5602.551795856332;5626.268585083933;5634.295713035871;5666.121751128571;5681.375048744635;4384.846530371437;4438.400815889846;4466.5980061794435;4471.306947423154;4475.843345482909;4141.792910354486;4338.696291259613;4393.758343291118;4500.009997800478;4511.436070491189;4318.1363727254675;4319;4333.566643335673;4351.303791393378;4366.08312254427;4265.466816647934;4269.978650106761;4315.13697260546;4364.752152641392;4365.410669559632;3773.716971227169;3842.500474938268;3849.7305188636806;3850.133719912997;3870.806459677005;5371.704556249405;5371.865703357408;5393.919091213635;5460.836174914759;5464.590155738296;5024;5026.974865125651;5033.270175824521;5047.343845300087;5049.798008079672;5790.623609465371;5871.970640146815;5875.794347197828;5913.319968203668;5921.644701317935;4185.539590645027;4203.7687927164;4214.578542145761;4230.492340919079;4231.42875711778;6095.6952152392205;6114.816555503342;6135.355787642278;6147.754089836401;6160.0759886017;4034.3141665916864;4273.098471180295;4298.398224248608;4300;4302.806373713191;4373.518912919576;4381.978090109529;4382.715123516961;4401.449818772653;4408.404865343202;5031.949680503149;5041.420236672756;5046.722430266297;5061.240813877874;5062.164742817467;5734.799282025109;5885.9987604214775;5975.641461512237;5989.790357337472;6008.579399441997;1485.4281101775678;1488.2633096617028;1488.8064551608438;1496.9550913472613;1500.9699806003819;942.6936245720168;964.8697425847561;988.7874107067015;991.9435800872193;997.7455748784014;5045.309821209862;5095.414027386898;5104.243708397498;5129.7175706073485;5166.43169251382;5382.623216374816;5394.865128371822;5426.457354264621;5444.782208711607;5459.771551400903;4891.804327826918;5087.491250874883;5093.490650934951;5108.693478391308;5115.718635475085;2901.9274518137217;2902.3759891623404;2908.5927970084203;2935.1488068459907;2936.265933516621;5536.806211782568;5568.329501149639;5605.859853503695;5609.971950140223;5689.743961521742;5292.338457692788;5384.838454846361;5388.36285507281;5455.236266922634;5496.890062198813;5471.890562188813;5510.91733623996;5514.6691198528215;5534.612577119644;5607.775688972559;5375.569954403716;5456.536194423518;5493.917591236055;5533.197686335539;5832.987619271345;6045.274567051806;6050.667213303311;6054.667973045923;6076.179715738319;6077.878442431038;5964.910526342195;6009.7295621698;6277.372262773686;6289.779857704958;6293.55945083858;4182.66538676899;4186.895327616712;4224.957750422456;4260.169266992907;4271.743695378163;6028.728707208274;6042.274927008787;6067.484263837623;6149.877002459836;6163.938360616516;5759.337676167294;5863.912041319469;5921.786033862962;5944.197533332945;5976.7908123215475;5892.734826932884;5894.793682221273;5903.203067585821;5909.763609455574;5913.349531551612;5551.666899986014;5819.912701309399;5830.82507524775;5835.94164058371;5851.771128063155;6044.546659000681;6049.758009679564;6062.666213433037;6082;6103.969480152571;5876.559258055749;5877.735501902339;5895.616784908967;5901.232839730807;5932.466078052996 23:46:48 INFO - PROCESS | 18780 | |5;yui.html;788.1842293226512;815.6451943404616;817.3787921179902;827.5903427803242;831.1356189562855;14127.929360353197;14897.62755931101;14988.175650339226;15077.170755608464;15089.698206035873;13973.371198296076;13992;14011.789823152661;14045.92977035116;14049.43802247909;683.4464084091877;806.5563939833069;819.7868554175927;824;832.3008672714949;827.6151589510877;830.7009476588423;832.2135581875131;834.4159088637978;834.7120243515977;884.8009197930446;886.5522910929972;886.6719313853883;887.7913690282778;892.2326798952895;879.7624641346832;881.5812489067673;884.5621417398364;887.3344991256557;888.258304315897;639.5203597302024;645.5771469687362;645.8062581225661;646.034178902539;646.2438946432638;14243.145411275356;14247.430102795875;14248.92875535626;14288.785668214881;14296.213708246043;13610.795838062437;13615.31923403826;13643.590692279247;13757.656058598515;13807.654808629764;10402.635907743193;10681.504589357497;10819.515210736798;10920.453977301104;10921.945390272998;3790.0918161685813;3829.17672700368;3835.7506762060375;3851.2297540492013;3935.9803200984097;55401.16898246529;55847.44152558504;56650.150247746315;56771.43228567744;56873.14690279691;10052.145567626687;10054.64808731691;10176.491175441199;10324.432156231329;10381.169506439466;19390.03049847502;19442.222311107398;19481.902590486956;19540.413787586396;19590.804091958897;7802.531848089133;7954.920450795534;7981.960090199512;8225.876611850827;8340.457870238415;4555.088982203572;4632.698874573142;4656.557627025427;4718.127146477913;4738.881527961759;3485.9128521787156;3577.624349443323;3582.5880023797076;3586.9282614347567;3598.9280214395567;650.0996120373317;666.0342503370133;672.653583404547;676.2966514824626;683.6547543490506;747.7382915979364;769.8075481129717;799.9161136659859;818.1613845807975;823.2878560045517;9133.908660913306;9523.90476095244;9639.084286992724;9779.511024448891;9902.950485247527;813.6582635293191;833.8707500337457;835.4861760017667;835.7116794705817;842.5450256861349;4645.442546894326;4799.496052914464;4841.588464980516;4844.418669759581;4896.608271338285;74897.62551187209;75657.62171189109;77340.61329693315;77513;77548;69516;70606;70917.64541177261;71937;73065.63467182737;62400;62887.74224515484;63001;63590.36409635845;63896;9044.366894317598;9449.811003780023;9492.430454172772;9555.713328600154;9619.51902404891;34619.30761384808;35068.82465587656;37485;40853.59146408498;42460;49978.50021499739;50184.74907625438;51062;51206;51507.227391589906;12346.320952347707;12412.317322547347;12639;12899.226046437243;12928.095033347952;12973.805392918925;13024.348782560644;13956.720865582834;14329.140251584939;14479.348429320495;12475.438605262603;12515.74968500643;12901.741965160456;13032.804507932198;13485.528006520117;12411.75176496483;12541.498340066295;12553.49786008586;13707.270991507914;13724.176549407068;12440.751184976069;12537.749245015231;12575.685607859878;12861;13139.802902956271;10974.176936729618;11280;11332.546698131982;11404.030657394214;11773.234739741889;10888.455577221266;11003.17476189305;11150.944245278723;11280.210385272952;11316.886831131584 23:46:48 INFO - PROCESS | 18780 | __end_tp_report 23:46:48 INFO - PROCESS | 18780 | __start_cc_report 23:46:48 INFO - PROCESS | 18780 | _x_x_mozilla_cycle_collect,333 23:46:48 INFO - PROCESS | 18780 | __end_cc_report 23:46:48 INFO - PROCESS | 18780 | __startTimestamp1463640408178__endTimestamp 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | ------- Summary: start ------- 23:46:48 INFO - PROCESS | 18780 | Number of tests: 6 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | [#0] dojo.html Cycles:165 Average:5491.38 Median:5725.74 stddev:770.60 (13.5%) stddev-sans-first:749.89 23:46:48 INFO - PROCESS | 18780 | Values: 3105.5 3136.0 3179.4 3183.9 3201.2 5447.5 5476.1 5535.2 5586.3 5643.5 5333.7 5409.6 5523.0 5537.5 5548.3 4928.8 4955.2 5008.1 5018.6 5100.4 299.6 5096.1 5097.4 5103.8 5141.8 4927.3 4940.0 4942.7 4992.9 4995.6 4980.5 4987.0 5000.6 5002.6 5045.9 4953.1 4980.0 4981.0 4983.5 5000.6 5388.0 5431.8 5434.6 5451.6 5468.9 5879.1 5905.1 5907.8 5909.1 5910.2 5751.5 5869.6 5913.5 5945.2 5960.9 5455.2 5480.6 5565.3 5573.7 5581.9 6061.7 6088.3 6098.6 6099.4 6108.8 5821.7 5823.8 5903.1 5911.1 5951.4 5963.4 5975.3 5982.8 5986.1 5988.0 5725.7 5868.8 5923.3 5928.9 5931.6 6002.2 6004.5 6012.5 6028.1 6033.8 4516.8 4525.3 4529.3 4548.2 4568.5 3954.9 3958.3 3973.7 4002.4 4033.5 5524.4 5667.0 5675.5 5700.2 5742.1 6041.4 6066.7 6075.1 6089.6 6108.3 5513.2 5676.7 5708.5 5764.8 5779.2 5086.5 5150.6 5159.3 5160.5 5176.9 6204.8 6211.7 6213.0 6224.7 6236.7 5817.4 6003.4 6053.5 6062.0 6080.3 6189.8 6194.7 6199.6 6205.0 6226.3 5690.3 5929.3 5935.7 5944.5 5989.1 5942.5 6008.2 6022.5 6052.2 6060.5 5853.2 5895.9 5902.8 5908.8 5936.7 5661.4 5735.7 5904.3 5911.1 5920.2 5654.0 5683.2 5711.7 5720.2 5781.3 5806.8 5823.2 5825.5 5852.4 5857.9 5585.9 5590.4 5615.2 5708.9 5739.3 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | [#1] ext.html Cycles:180 Average:61012.74 Median:42360.68 stddev:119671.62 (282.5%) stddev-sans-first:119921.37 23:46:48 INFO - PROCESS | 18780 | Values: 601.3 637.5 642.8 659.9 667.0 39467.4 43234.8 43263.1 43422.8 43496.0 42314.4 42385.4 42578.8 42668.0 42939.9 8870.7 8985.5 9053.6 9053.9 9081.4 8924.1 8936.9 9006.5 9011.1 9061.0 9086.3 9117.5 9143.5 9145.4 9150.2 9011.5 9013.1 9028.5 9030.4 9102.5 8861.9 8963.0 8967.7 8971.6 8996.6 33681.0 40900.0 41228.4 41489.8 41518.6 3555.8 3651.1 3805.2 3936.9 3953.8 30922.8 33416.0 33707.0 34090.0 34581.3 4362.2 4408.3 4419.9 4462.3 4463.7 361403.0 367938.0 367986.0 368206.0 369199.0 66642.7 68259.0 68370.0 68606.0 68619.3 38214.2 38999.6 39024.0 40726.0 40938.2 15019.5 15138.8 15159.3 15174.9 15200.9 11800.9 11984.9 12022.3 12028.1 12053.3 21645.1 21744.5 21798.6 21851.1 21865.8 7974.3 8178.3 8287.1 8346.2 8466.9 988.8 1026.5 1084.6 1094.3 1147.4 32549.2 32827.5 33143.8 33162.7 33357.8 1135.3 1179.3 1190.7 1193.2 1200.8 17025.7 17368.0 17439.2 17451.7 17619.6 518578.0 522451.0 524143.0 524812.0 525294.0 61780.0 62171.0 62249.0 62318.4 62557.4 1389.6 1417.3 1424.3 1436.8 1441.9 32317.0 32353.0 32775.0 32902.4 33819.8 52458.5 53837.0 53971.5 54000.0 54035.5 448416.0 451066.0 452771.0 453160.0 454080.0 29625.0 29904.7 30125.4 30202.8 30237.1 49573.8 49889.5 50041.0 50375.7 51121.5 42170.8 42336.0 42799.6 43309.8 43701.0 41639.0 42391.6 43001.0 43837.3 44092.6 37435.4 42254.4 42583.0 43717.6 44101.0 34663.3 37044.8 37228.8 37616.4 38071.6 29576.4 29589.4 29745.9 29830.6 29867.6 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | [#2] jquery.html Cycles:180 Average:28345.82 Median:2135.64 stddev:79045.41 (3701.2%) stddev-sans-first:79239.29 23:46:48 INFO - PROCESS | 18780 | Values: 391.8 397.3 408.9 412.2 432.8 13667.3 18103.2 18310.8 20298.2 20318.3 17929.2 18398.5 18435.8 18568.5 18693.0 5593.6 5792.6 5827.4 5832.6 5983.1 5435.3 5746.5 5900.0 5920.7 5952.3 5710.0 5732.7 5753.0 5775.9 5798.4 5495.9 5808.6 5849.5 5917.4 5928.8 4931.4 5233.9 5245.0 5259.4 5702.5 13841.8 14010.7 18752.3 22371.3 22575.2 2176.2 2211.4 2275.3 2347.2 2475.1 9936.7 10085.3 10087.3 10493.9 10664.5 1910.9 1988.1 2025.9 2033.6 2095.1 77942.0 81275.0 81383.6 82170.6 82748.6 10024.3 10368.3 11822.3 12020.2 12057.3 15644.2 15679.9 15746.8 15837.7 15838.3 7782.8 7929.6 7974.7 8070.5 8140.5 7200.7 7407.3 7504.8 7558.7 7628.3 4807.4 4825.5 4838.8 4902.2 4978.2 2001.9 2018.6 2028.7 2045.8 2081.8 930.7 1019.0 1058.4 1135.1 1180.9 17989.7 18269.7 18810.9 19106.1 20063.8 1025.6 1025.9 1045.7 1064.2 1083.9 10514.4 10783.9 10817.7 10841.8 10883.7 468775.0 472722.0 479439.0 485057.0 489851.0 78634.6 79340.6 86564.0 98026.0 100769.0 1071.3 1092.6 1098.7 1125.8 1142.0 17257.4 17549.6 17728.8 17745.6 17843.5 39637.0 40189.0 41045.8 41290.8 42816.8 54660.2 55113.2 58482.4 58909.0 59708.7 5206.4 5405.9 8288.1 8806.5 8808.3 12419.8 13156.3 13246.9 13259.5 13588.6 11293.9 11588.3 11620.7 11769.6 11771.4 10934.9 11002.3 11230.8 11294.4 11302.4 8983.0 11640.5 11844.5 12010.6 12156.3 8358.5 8889.7 8911.3 8959.3 8989.6 11164.9 11686.4 11822.3 11907.9 12053.7 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | [#3] mootools.html Cycles:180 Average:5955.84 Median:2667.74 stddev:3475.61 (130.3%) stddev-sans-first:3469.63 23:46:48 INFO - PROCESS | 18780 | Values: 1555.1 1586.2 1745.0 1830.0 1868.8 7988.6 8851.1 8872.9 9380.2 9397.4 8894.3 9145.4 9173.0 9223.6 9242.0 2347.3 2373.3 2377.6 2384.5 2385.4 2343.5 2367.6 2371.6 2383.0 2388.6 2342.7 2354.9 2358.9 2372.6 2376.4 2288.2 2327.1 2335.5 2337.7 2353.4 2352.8 2367.2 2388.7 2392.1 2394.9 9151.2 9221.9 9222.2 9224.2 9247.5 5171.3 5255.4 5261.8 5309.5 5317.7 3522.9 3575.1 3588.6 3679.4 3706.3 1098.5 1099.8 1130.2 1138.1 1156.8 12486.9 12633.4 12662.6 12684.6 12693.1 4652.1 4661.6 4701.1 4744.5 4759.5 9677.7 9712.6 9759.5 9763.4 9854.9 5224.5 5233.2 5244.5 5246.8 5265.4 4378.2 4859.0 5008.9 5013.9 5062.2 3899.2 3936.7 4002.5 4010.3 4084.2 1174.9 1183.2 1198.0 1200.0 1209.9 868.7 969.7 971.9 983.9 999.8 5550.8 6003.8 6006.6 6103.5 6159.0 459.9 464.9 468.2 475.4 476.5 3838.0 3910.2 3921.8 3980.7 4092.7 11430.0 11926.9 11933.7 11936.6 11975.9 11301.0 11365.1 11371.3 11779.6 11798.7 8570.7 8704.9 8752.6 8797.1 8808.4 5913.8 5936.6 6036.3 6059.2 6127.8 10563.4 10656.3 10692.2 11105.7 11117.7 10615.5 10696.2 10784.6 10809.5 10817.7 6948.1 7516.5 7687.4 7710.2 7819.9 8993.4 9011.9 9044.5 9065.0 9087.0 7591.7 7923.6 8082.4 8111.2 8130.0 7824.7 7854.3 7878.7 8019.5 8068.2 7201.1 7202.3 7247.2 7291.8 7293.0 5216.8 5217.2 5258.4 5264.1 5308.5 5209.3 5215.4 5220.0 5325.6 5340.6 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | [#4] prototype.html Cycles:180 Average:4842.14 Median:5450.01 stddev:1416.28 (26.0%) stddev-sans-first:1379.33 23:46:48 INFO - PROCESS | 18780 | Values: 338.5 345.7 350.9 352.1 355.2 5474.7 5609.1 5630.3 5655.7 5697.7 5602.6 5626.3 5634.3 5666.1 5681.4 4384.8 4438.4 4466.6 4471.3 4475.8 4141.8 4338.7 4393.8 4500.0 4511.4 4318.1 4319.0 4333.6 4351.3 4366.1 4265.5 4270.0 4315.1 4364.8 4365.4 3773.7 3842.5 3849.7 3850.1 3870.8 5371.7 5371.9 5393.9 5460.8 5464.6 5024.0 5027.0 5033.3 5047.3 5049.8 5790.6 5872.0 5875.8 5913.3 5921.6 4185.5 4203.8 4214.6 4230.5 4231.4 6095.7 6114.8 6135.4 6147.8 6160.1 4034.3 4273.1 4298.4 4300.0 4302.8 4373.5 4382.0 4382.7 4401.4 4408.4 5031.9 5041.4 5046.7 5061.2 5062.2 5734.8 5886.0 5975.6 5989.8 6008.6 1485.4 1488.3 1488.8 1497.0 1501.0 942.7 964.9 988.8 991.9 997.7 5045.3 5095.4 5104.2 5129.7 5166.4 5382.6 5394.9 5426.5 5444.8 5459.8 4891.8 5087.5 5093.5 5108.7 5115.7 2901.9 2902.4 2908.6 2935.1 2936.3 5536.8 5568.3 5605.9 5610.0 5689.7 5292.3 5384.8 5388.4 5455.2 5496.9 5471.9 5510.9 5514.7 5534.6 5607.8 5375.6 5456.5 5493.9 5533.2 5833.0 6045.3 6050.7 6054.7 6076.2 6077.9 5964.9 6009.7 6277.4 6289.8 6293.6 4182.7 4186.9 4225.0 4260.2 4271.7 6028.7 6042.3 6067.5 6149.9 6163.9 5759.3 5863.9 5921.8 5944.2 5976.8 5892.7 5894.8 5903.2 5909.8 5913.3 5551.7 5819.9 5830.8 5835.9 5851.8 6044.5 6049.8 6062.7 6082.0 6104.0 5876.6 5877.7 5895.6 5901.2 5932.5 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - PROCESS | 18780 | [#5] yui.html Cycles:180 Average:16443.55 Median:4769.19 stddev:20630.02 (432.6%) stddev-sans-first:20654.40 23:46:48 INFO - PROCESS | 18780 | Values: 788.2 815.6 817.4 827.6 831.1 14127.9 14897.6 14988.2 15077.2 15089.7 13973.4 13992.0 14011.8 14045.9 14049.4 683.4 806.6 819.8 824.0 832.3 827.6 830.7 832.2 834.4 834.7 884.8 886.6 886.7 887.8 892.2 879.8 881.6 884.6 887.3 888.3 639.5 645.6 645.8 646.0 646.2 14243.1 14247.4 14248.9 14288.8 14296.2 13610.8 13615.3 13643.6 13757.7 13807.7 10402.6 10681.5 10819.5 10920.5 10921.9 3790.1 3829.2 3835.8 3851.2 3936.0 55401.2 55847.4 56650.2 56771.4 56873.1 10052.1 10054.6 10176.5 10324.4 10381.2 19390.0 19442.2 19481.9 19540.4 19590.8 7802.5 7954.9 7982.0 8225.9 8340.5 4555.1 4632.7 4656.6 4718.1 4738.9 3485.9 3577.6 3582.6 3586.9 3598.9 650.1 666.0 672.7 676.3 683.7 747.7 769.8 799.9 818.2 823.3 9133.9 9523.9 9639.1 9779.5 9903.0 813.7 833.9 835.5 835.7 842.5 4645.4 4799.5 4841.6 4844.4 4896.6 74897.6 75657.6 77340.6 77513.0 77548.0 69516.0 70606.0 70917.6 71937.0 73065.6 62400.0 62887.7 63001.0 63590.4 63896.0 9044.4 9449.8 9492.4 9555.7 9619.5 34619.3 35068.8 37485.0 40853.6 42460.0 49978.5 50184.7 51062.0 51206.0 51507.2 12346.3 12412.3 12639.0 12899.2 12928.1 12973.8 13024.3 13956.7 14329.1 14479.3 12475.4 12515.7 12901.7 13032.8 13485.5 12411.8 12541.5 12553.5 13707.3 13724.2 12440.8 12537.7 12575.7 12861.0 13139.8 10974.2 11280.0 11332.5 11404.0 11773.2 10888.5 11003.2 11150.9 11280.2 11316.9 23:46:48 INFO - PROCESS | 18780 | -------- Summary: end -------- 23:46:48 INFO - PROCESS | 18780 | 23:46:48 INFO - TEST-INFO | 18780: exit 0 23:46:48 INFO - TEST-OK | dromaeo_css | took 1110171ms 23:46:48 INFO - TEST-START | kraken 23:46:48 INFO - operating with platform_type : linux_ 23:46:48 INFO - Initialising browser for kraken test... 23:46:48 INFO - TEST-INFO | started process 19013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpskX91s/profile http://localhost:56600/getInfo.html) 23:46:53 INFO - PROCESS | 19013 | 23:46:53 INFO - PROCESS | 19013 | (process:19079): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:46:53 INFO - PROCESS | 19013 | __metrics Screen width/height:1600/1200 23:46:53 INFO - PROCESS | 19013 | colorDepth:24 23:46:53 INFO - PROCESS | 19013 | Browser inner width/height: 1024/697 23:46:53 INFO - PROCESS | 19013 | __metrics 23:46:54 ERROR - PROCESS | 19013 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:46:55 INFO - TEST-INFO | 19013: exit 0 23:46:55 INFO - Browser initialized. 23:46:55 INFO - Running cycle 1/1 for kraken test... 23:46:55 INFO - TEST-INFO | started process 19130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpskX91s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:46:57 INFO - PROCESS | 19130 | 23:46:57 INFO - PROCESS | 19130 | (process:19191): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:47:07 INFO - PROCESS | 19130 | RSS: Main: 163913728 23:47:07 INFO - PROCESS | 19130 | 23:47:09 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56600/tests/kraken/driver.html?testName=audio-beat-detection) 23:47:10 INFO - PROCESS | 19130 | RSS: Main: 168222720 23:47:10 INFO - PROCESS | 19130 | 23:47:13 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56600/tests/kraken/driver.html?testName=audio-dft) 23:47:14 INFO - PROCESS | 19130 | RSS: Main: 168341504 23:47:14 INFO - PROCESS | 19130 | 23:47:16 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56600/tests/kraken/driver.html?testName=audio-fft) 23:47:17 INFO - PROCESS | 19130 | RSS: Main: 163041280 23:47:17 INFO - PROCESS | 19130 | 23:47:19 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56600/tests/kraken/driver.html?testName=audio-oscillator) 23:47:20 INFO - PROCESS | 19130 | RSS: Main: 164012032 23:47:20 INFO - PROCESS | 19130 | 23:47:22 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:47:23 INFO - PROCESS | 19130 | RSS: Main: 163995648 23:47:23 INFO - PROCESS | 19130 | 23:47:26 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56600/tests/kraken/driver.html?testName=imaging-darkroom) 23:47:27 INFO - PROCESS | 19130 | RSS: Main: 163917824 23:47:27 INFO - PROCESS | 19130 | 23:47:30 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56600/tests/kraken/driver.html?testName=imaging-desaturate) 23:47:31 INFO - PROCESS | 19130 | RSS: Main: 162779136 23:47:31 INFO - PROCESS | 19130 | 23:47:34 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56600/tests/kraken/driver.html?testName=json-parse-financial) 23:47:34 INFO - PROCESS | 19130 | RSS: Main: 163340288 23:47:34 INFO - PROCESS | 19130 | 23:47:36 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:47:37 INFO - PROCESS | 19130 | RSS: Main: 163561472 23:47:37 INFO - PROCESS | 19130 | 23:47:38 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:47:39 INFO - PROCESS | 19130 | RSS: Main: 163876864 23:47:39 INFO - PROCESS | 19130 | 23:47:41 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:47:42 INFO - PROCESS | 19130 | RSS: Main: 164077568 23:47:42 INFO - PROCESS | 19130 | 23:47:45 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:47:45 INFO - PROCESS | 19130 | RSS: Main: 164626432 23:47:45 INFO - PROCESS | 19130 | 23:47:48 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:47:49 INFO - PROCESS | 19130 | RSS: Main: 164995072 23:47:49 INFO - PROCESS | 19130 | 23:47:50 INFO - PROCESS | 19130 | Cycle 1(1): loaded http://localhost:56600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56600/tests/kraken/driver.html?testName=ai-astar) 23:47:51 INFO - PROCESS | 19130 | RSS: Main: 165994496 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | __start_tp_report 23:47:51 INFO - PROCESS | 19130 | _x_x_mozilla_page_load 23:47:51 INFO - PROCESS | 19130 | _x_x_mozilla_page_load_details 23:47:51 INFO - PROCESS | 19130 | |i|pagename|runs| 23:47:51 INFO - PROCESS | 19130 | |0;ai-astar;105;111;103;109;110;109;104;109;110;110 23:47:51 INFO - PROCESS | 19130 | |1;audio-beat-detection;149;132;147;212;124;148;156;126;177;124 23:47:51 INFO - PROCESS | 19130 | |2;audio-dft;162;161;161;162;163;166;167;164;161;162 23:47:51 INFO - PROCESS | 19130 | |3;audio-fft;76;74;75;157;76;77;75;74;173;75 23:47:51 INFO - PROCESS | 19130 | |4;audio-oscillator;92;92;180;94;94;95;141;94;92;154 23:47:51 INFO - PROCESS | 19130 | |5;imaging-gaussian-blur;116;117;118;117;117;117;117;118;117;118 23:47:51 INFO - PROCESS | 19130 | |6;imaging-darkroom;146;147;148;146;146;147;147;146;146;148 23:47:51 INFO - PROCESS | 19130 | |7;imaging-desaturate;100;97;95;96;96;96;95;95;95;96 23:47:51 INFO - PROCESS | 19130 | |8;json-parse-financial;55;55;56;55;55;55;56;107;54;54 23:47:51 INFO - PROCESS | 19130 | |9;json-stringify-tinderbox;60;60;59;60;60;60;60;61;60;60 23:47:51 INFO - PROCESS | 19130 | |10;stanford-crypto-aes;82;78;80;81;81;79;80;82;85;86 23:47:51 INFO - PROCESS | 19130 | |11;stanford-crypto-ccm;122;137;131;129;133;139;119;122;190;124 23:47:51 INFO - PROCESS | 19130 | |12;stanford-crypto-pbkdf2;157;158;166;157;156;158;159;157;162;157 23:47:51 INFO - PROCESS | 19130 | |13;stanford-crypto-sha256-iterative;63;62;63;64;62;67;63;63;61;64 23:47:51 INFO - PROCESS | 19130 | __end_tp_report 23:47:51 INFO - PROCESS | 19130 | __start_cc_report 23:47:51 INFO - PROCESS | 19130 | _x_x_mozilla_cycle_collect,867 23:47:51 INFO - PROCESS | 19130 | __end_cc_report 23:47:51 INFO - PROCESS | 19130 | __startTimestamp1463640471005__endTimestamp 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | ------- Summary: start ------- 23:47:51 INFO - PROCESS | 19130 | Number of tests: 14 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.50 stddev:2.87 (2.6%) stddev-sans-first:2.83 23:47:51 INFO - PROCESS | 19130 | Values: 105.0 111.0 103.0 109.0 110.0 109.0 104.0 109.0 110.0 110.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:148.50 stddev:27.63 (18.6%) stddev-sans-first:29.31 23:47:51 INFO - PROCESS | 19130 | Values: 149.0 132.0 147.0 212.0 124.0 148.0 156.0 126.0 177.0 124.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.13 (1.3%) stddev-sans-first:2.24 23:47:51 INFO - PROCESS | 19130 | Values: 162.0 161.0 161.0 162.0 163.0 166.0 167.0 164.0 161.0 162.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.04 (50.7%) stddev-sans-first:39.84 23:47:51 INFO - PROCESS | 19130 | Values: 76.0 74.0 75.0 157.0 76.0 77.0 75.0 74.0 173.0 75.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:93.00 stddev:32.80 (35.3%) stddev-sans-first:33.92 23:47:51 INFO - PROCESS | 19130 | Values: 92.0 92.0 180.0 94.0 94.0 95.0 141.0 94.0 92.0 154.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 23:47:51 INFO - PROCESS | 19130 | Values: 116.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 23:47:51 INFO - PROCESS | 19130 | Values: 146.0 147.0 148.0 146.0 146.0 147.0 147.0 146.0 146.0 148.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:0.71 23:47:51 INFO - PROCESS | 19130 | Values: 100.0 97.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:55.00 stddev:16.46 (29.9%) stddev-sans-first:17.35 23:47:51 INFO - PROCESS | 19130 | Values: 55.0 55.0 56.0 55.0 55.0 55.0 56.0 107.0 54.0 54.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 23:47:51 INFO - PROCESS | 19130 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:2.50 (3.1%) stddev-sans-first:2.65 23:47:51 INFO - PROCESS | 19130 | Values: 82.0 78.0 80.0 81.0 81.0 79.0 80.0 82.0 85.0 86.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:132.00 stddev:20.59 (15.6%) stddev-sans-first:21.32 23:47:51 INFO - PROCESS | 19130 | Values: 122.0 137.0 131.0 129.0 133.0 139.0 119.0 122.0 190.0 124.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:158.00 stddev:3.06 (1.9%) stddev-sans-first:3.18 23:47:51 INFO - PROCESS | 19130 | Values: 157.0 158.0 166.0 157.0 156.0 158.0 159.0 157.0 162.0 157.0 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - PROCESS | 19130 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.62 (2.6%) stddev-sans-first:1.72 23:47:51 INFO - PROCESS | 19130 | Values: 63.0 62.0 63.0 64.0 62.0 67.0 63.0 63.0 61.0 64.0 23:47:51 INFO - PROCESS | 19130 | -------- Summary: end -------- 23:47:51 INFO - PROCESS | 19130 | 23:47:51 INFO - TEST-INFO | 19130: exit 0 23:47:51 INFO - TEST-OK | kraken | took 63082ms 23:47:51 INFO - SUITE-END | took 1173s 23:47:52 INFO - Completed test suite (00:19:33) 23:47:52 INFO - javascript benchmark 23:47:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7269.509498636343, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.5496952941826, 3136.0, 3179.4118088153687, 3183.936321273575, 3201.231704390947, 5447.45525447455, 5476.096444086726, 5535.169724541321, 5586.301712285965, 5643.548516118711, 5333.653312534682, 5409.6213265071465, 5523.005858945388, 5537.529310008654, 5548.306461692288, 4928.753562321878, 4955.157623204046, 5008.098542262392, 5018.623603229772, 5100.362454693163, 299.5940693232388, 5096.082705113078, 5097.439281679012, 5103.795848166069, 5141.82003629873, 4927.310176575283, 4939.950600493985, 4942.728149951751, 4992.87517812054, 4995.60035197187, 4980.526849949249, 4987.027529631723, 5000.599952003831, 5002.59979201663, 5045.899082018339, 4953.083679519301, 4980.003999200138, 4980.978899325666, 4983.526564976321, 5000.62495312853, 5387.955804970179, 5431.755570999275, 5434.565234781208, 5451.591130665216, 5468.890622187574, 5879.0593505039415, 5905.114232865061, 5907.793227237026, 5909.054551271776, 5910.172575839386, 5751.511121554631, 5869.618474799125, 5913.467787899067, 5945.1973983512535, 5960.940390596125, 5455.1544510600925, 5480.588955828289, 5565.332160140809, 5573.662321042961, 5581.944180558183, 6061.666608336495, 6088.330283668793, 6098.634081955097, 6099.3900609938655, 6108.816735497942, 5821.650700957956, 5823.82528524145, 5903.055511118287, 5911.054231322968, 5951.4048595141, 5963.403659634088, 5975.312839023481, 5982.820515384546, 5986.102084687244, 5987.970060149672, 5725.742341594639, 5868.823935281948, 5923.318818335861, 5928.9407105928385, 5931.644101353846, 6002.219711437485, 6004.459598636144, 6012.488938440281, 6028.125921741323, 6033.78881739137, 4516.81932722694, 4525.343825145335, 4529.275315949432, 4548.226801443762, 4568.543145685405, 3954.8813535593977, 3958.346872766019, 3973.7019723520852, 4002.4396584478195, 4033.5361433434946, 5524.4199359066715, 5667.008273552112, 5675.460831221028, 5700.230468886647, 5742.13867919807, 6041.395860413923, 6066.726997285133, 6075.088736689532, 6089.573729838958, 6108.297545782292, 5513.228148059195, 5676.659400435987, 5708.514776243983, 5764.769409223584, 5779.190913272145, 5086.5422112009355, 5150.562202212779, 5159.277701121846, 5160.48395160481, 5176.922346164811, 6204.7828326008375, 6211.65835879022, 6213.03697926822, 6224.657643829632, 6236.719347629368, 5817.38917413674, 6003.429674181033, 6053.515718742402, 6062.0, 6080.300765412034, 6189.783357582463, 6194.721237544231, 6199.5660303780105, 6205.03821907605, 6226.283977342482, 5690.2887139107615, 5929.347771745191, 5935.7032148391545, 5944.464998150187, 5989.131575921379, 5942.465178133816, 6008.218931538872, 6022.518198544193, 6052.243469566304, 6060.545459090674, 5853.239078919713, 5895.852603684943, 5902.763889444374, 5908.793192238251, 5936.673482958478, 5661.405552416937, 5735.7418916148035, 5904.261967254093, 5911.054231322968, 5920.230370051866, 5654.038813401649, 5683.204351390726, 5711.685857277889, 5720.199172115824, 5781.306243250837, 5806.767729290781, 5823.155642431909, 5825.50483208932, 5852.4147585241135, 5857.882842343044, 5585.944140558542, 5590.357108932525, 5615.213870058114, 5708.914366284426, 5739.311282646109], "value": 5439.769865288497, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.3415310235293, 637.4708991537025, 642.8457170279133, 659.9274079851217, 666.9766558170465, 39467.40798888016, 43234.78382608083, 43263.13473730528, 43422.78288608552, 43496.0, 42314.365284520754, 42385.364219536656, 42578.787106064425, 42668.0, 42939.92650183739, 8870.689525866579, 8985.460872347647, 9053.637854485845, 9053.909460905372, 9081.409708368968, 8924.062973387798, 8936.910630893706, 9006.504642244674, 9011.143941325596, 9061.048589898064, 9086.273098152133, 9117.45295282282, 9143.542822858864, 9145.359824812265, 9150.169966006792, 9011.504367259799, 9013.053629368953, 9028.503432311252, 9030.413023153507, 9102.453852768822, 8861.911380886173, 8962.955185224033, 8967.686130985385, 8971.551422428918, 8996.550172491348, 33681.0, 40900.0, 41228.38157427641, 41489.792551037055, 41518.58481415177, 3555.839987200582, 3651.1054791575966, 3805.2389522095414, 3936.921261574781, 3953.782541960191, 30922.84538577315, 33416.0, 33707.0, 34090.0, 34581.308373832384, 4362.179900264712, 4408.29467285236, 4419.9337009944875, 4462.286034234539, 4463.732176069446, 361403.0, 367938.0, 367986.0, 368206.0, 369199.0, 66642.66678666673, 68259.0, 68370.0, 68606.0, 68619.3138068623, 38214.23571528554, 38999.61000390017, 39024.0, 40726.0, 40938.1812363757, 15019.549413517612, 15138.848611513964, 15159.317830697644, 15174.924125379302, 15200.923995379952, 11800.940995295141, 11984.940075299568, 12022.338771367658, 12028.097892658086, 12053.276803391824, 21645.077914481342, 21744.456388590414, 21798.56402871934, 21851.125954961622, 21865.781342186376, 7974.252101512396, 8178.345732341399, 8287.12985136564, 8346.248837604644, 8466.872996905051, 988.8318985772293, 1026.5483187397522, 1084.5661735305941, 1094.266841216371, 1147.4033502578613, 32549.186270342958, 32827.50758738621, 33143.83428082844, 33162.66837331596, 33357.83321083379, 1135.3471753741633, 1179.2511755035614, 1190.7142285851332, 1193.164784650748, 1200.8018676918384, 17025.744613830804, 17368.044757538202, 17439.21523531444, 17451.65096698059, 17619.647607048042, 518578.0, 522451.0, 524143.0, 524812.0, 525294.0, 61780.0, 62171.0, 62249.0, 62318.376816232165, 62557.374426256065, 1389.5553422904572, 1417.3480199108526, 1424.3163281624877, 1436.8132142821366, 1441.92069436182, 32317.0, 32353.0, 32775.0, 32902.40659087913, 33819.830900845336, 52458.47541524536, 53837.0, 53971.46028539664, 54000.0, 54035.45964540462, 448416.0, 451066.0, 452771.0, 453160.0, 454080.0, 29625.0, 29904.70095299019, 30125.397492050473, 30202.848985754932, 30237.092887213417, 49573.75213123911, 49889.501104988485, 50041.0, 50375.74812125916, 51121.48878511167, 42170.78914605407, 42336.0, 42799.57200427956, 43309.7834510838, 43701.0, 41639.0, 42391.57608423876, 43001.0, 43837.34243986279, 44092.55907440885, 37435.43846842354, 42254.366184506645, 42583.0, 43717.56282437135, 44101.0, 34663.30673386468, 37044.814775925945, 37228.813855930544, 37616.43575346317, 38071.61928380681, 29576.408471830873, 29589.408211836075, 29745.851270743507, 29830.552541712324, 29867.551986719784], "value": 20510.621758396042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.79039214020503, 397.34438177007934, 408.889599808052, 412.16330848377805, 432.8355225014494, 13667.3166341683, 18103.18535665895, 18310.816891831077, 20298.1880724771, 20318.288859889926, 17929.193186306617, 18398.540036499093, 18435.81564184358, 18568.535786605342, 18693.0, 5593.580481463886, 5792.594518383726, 5827.35899051104, 5832.591718579701, 5983.10253461982, 5435.347758269013, 5746.454086861741, 5900.0, 5920.703964801764, 5952.345242023374, 5710.0, 5732.684702341369, 5753.0, 5775.884482310351, 5798.42015798421, 5495.862603434906, 5808.593398462131, 5849.532037436995, 5917.437843404869, 5928.7924922627935, 4931.3589233399425, 5233.869153271161, 5244.977229440261, 5259.421463638997, 5702.54379649627, 13841.792373114411, 14010.719785604333, 18752.343667971556, 22371.32886013422, 22575.209867654554, 2176.216562037665, 2211.391867236523, 2275.3117206982542, 2347.248880358286, 2475.1460746042585, 9936.652217172437, 10085.294029417944, 10087.293889427743, 10493.895061049368, 10664.520096595672, 1910.8884682425996, 1988.135161204866, 2025.8581899267058, 2033.6034473277716, 2095.067694875781, 77942.0, 81275.0, 81383.5930820348, 82170.58914705388, 82748.58625706832, 10024.298299118991, 10368.326058806153, 11822.290662560274, 12020.158588898694, 12057.336846473352, 15644.217789110726, 15679.921600391925, 15746.76379854303, 15837.68324633501, 15838.28727707233, 7782.805429864298, 7929.643166057541, 7974.720884769005, 8070.47541909774, 8140.470869393471, 7200.675969581382, 7407.259274072658, 7504.774856754306, 7558.697652093964, 7628.275313845176, 4807.423109226846, 4825.517448255217, 4838.782254798472, 4902.215645496774, 4978.203487442064, 2001.9199232030846, 2018.5660083082207, 2028.695695645665, 2045.7749647538758, 2081.8230450411584, 930.7254359963827, 1018.9643362482277, 1058.3914249306679, 1135.1259530161894, 1180.9055275577932, 17989.7301540477, 18269.725954110698, 18810.905945470186, 19106.140223689967, 20063.799362006193, 1025.5795123999123, 1025.9281850270559, 1045.7281106912105, 1064.1699474409972, 1083.853679753239, 10514.421706806046, 10783.946080269705, 10817.675469735921, 10841.83737243942, 10883.727906802393, 468775.0, 472722.0, 479439.0, 485057.0, 489851.0, 78634.6068269655, 79340.60329698314, 86564.0, 98026.0, 100768.96924122953, 1071.3411252079916, 1092.6285063078592, 1098.6703988803326, 1125.8423820665114, 1141.965741027754, 17257.39599114025, 17549.561260968578, 17728.822711773235, 17745.645087098444, 17843.464696059138, 39637.0, 40189.0, 41045.794771025954, 41290.79354603208, 42816.78591607022, 54660.180097299366, 55113.17330239969, 58482.415175847695, 58909.0, 59708.70145649244, 5206.375234971676, 5405.8918821622565, 8288.129746376544, 8806.471611703319, 8808.326417980563, 12419.813702794285, 13156.342182891009, 13246.933765331112, 13259.469621215429, 13588.59234222975, 11293.943530282297, 11588.304701717923, 11620.709482263012, 11769.588064417705, 11771.352575608424, 10934.945325273322, 11002.33985960845, 11230.775384492428, 11294.43527823622, 11302.378369189773, 8983.01186869457, 11640.476178571815, 11844.46699898524, 12010.63968080959, 12156.270623762603, 8358.45670031446, 8889.73330800077, 8911.331650126396, 8959.328050396116, 8989.55052247398, 11164.888351116384, 11686.357250351311, 11822.34977076269, 11907.940460297643, 12053.698657533632], "value": 9134.279985234207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.1446704312625, 1586.2386054693748, 1744.9912750436247, 1830.0, 1868.8131186881315, 7988.640511176996, 8851.114888511145, 8872.866906996383, 9380.155785979252, 9397.389169703973, 8894.332925030616, 9145.359824812265, 9173.0, 9223.584938677759, 9242.0, 2347.3192774095533, 2373.32360277321, 2377.6314671225987, 2384.475415408616, 2385.3917251100943, 2343.496148328109, 2367.597508423572, 2371.5849726297915, 2382.9761702383016, 2388.5700573896693, 2342.652974539638, 2354.8587084774967, 2358.8820558971984, 2372.6441033844976, 2376.4177776444794, 2288.1648198407543, 2327.1273272522803, 2335.544568809083, 2337.661039149331, 2353.352827972304, 2352.800011998965, 2367.2188177901426, 2388.7014123234594, 2392.079049565912, 2394.892229849661, 9151.176394124494, 9221.90778092224, 9222.21611163052, 9224.169824715807, 9247.49138797366, 5171.327727395452, 5255.369355677305, 5261.789528418859, 5309.469053094698, 5317.73411329432, 3522.8766993155373, 3575.106223444139, 3588.5873124590485, 3679.3745063339297, 3706.3328600851837, 1098.4672433869566, 1099.8295264234057, 1130.2145009218596, 1138.0724709361843, 1156.7570810129882, 12486.937565312206, 12633.368331583384, 12662.620121396281, 12684.619461416172, 12693.11148219625, 4652.092841895866, 4661.627069834405, 4701.106789709944, 4744.454387745384, 4759.524047595212, 9677.70966870995, 9712.611495540099, 9759.463229522302, 9763.365381250196, 9854.901450985542, 5224.50367215114, 5233.162693968947, 5244.475552444725, 5246.842594722164, 5265.447128051576, 4378.190034843564, 4858.951410485921, 5008.874778130576, 5013.874653133628, 5062.215356619657, 3899.161680238762, 3936.6653834423823, 4002.519697636244, 4010.298197815429, 4084.223997440477, 1174.8825117488184, 1183.2131632464316, 1197.9640610781692, 1200.039968025576, 1209.8729633388543, 868.7133246028795, 969.7042402067437, 971.8687977122997, 983.8671779309844, 999.84018538495, 5550.783122902294, 6003.8198854034445, 6006.579539432198, 6103.450689437972, 6159.045347971071, 459.9379083823708, 464.94420669519195, 468.18068380334415, 475.4366076199714, 476.5377583743763, 3838.0, 3910.2179564086728, 3921.822482260675, 3980.6577170545324, 4092.7135100543273, 11430.0, 11926.88073119275, 11933.70165745846, 11936.582219622445, 11975.880241197476, 11301.0, 11365.147613928988, 11371.260868043551, 11779.646610601696, 11798.705032374088, 8570.700025499078, 8704.869426958601, 8752.56237188138, 8797.076306987801, 8808.427452215585, 5913.793017244376, 5936.643801371932, 6036.33600303975, 6059.151718759289, 6127.785527506516, 10563.419011954109, 10656.25406221557, 10692.19808514349, 11105.722356941142, 11117.666470005914, 10615.522301496605, 10696.1977851663, 10784.568617255221, 10809.45952702346, 10817.729556760829, 6948.131483564554, 7516.549007059594, 7687.423443241891, 7710.151883292945, 7819.882701759592, 8993.370464067453, 9011.909880901107, 9044.547772611211, 9065.0, 9086.954565227132, 7591.658375373232, 7923.643436045277, 8082.434229603871, 8111.229433203836, 8130.0, 7824.687012519663, 7854.293113619801, 7878.684852605831, 8019.478733882279, 8068.1528439513, 7201.13586369639, 7202.315780001101, 7247.166575843846, 7291.781246562611, 7293.0, 5216.817411390583, 5217.243499692448, 5258.447862974485, 5264.078786212474, 5308.46915308466, 5209.296744939385, 5215.426303106731, 5220.034293655686, 5325.627206095536, 5340.626156169031], "value": 4652.4081285533675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.47536318706, 345.7113310385828, 350.9035015370774, 352.105651644822, 355.236242079529, 5474.671519708821, 5609.1305847593585, 5630.296212973379, 5655.745491452884, 5697.6610496533285, 5602.551795856332, 5626.268585083933, 5634.295713035871, 5666.121751128571, 5681.375048744635, 4384.846530371437, 4438.400815889846, 4466.5980061794435, 4471.306947423154, 4475.843345482909, 4141.792910354486, 4338.696291259613, 4393.758343291118, 4500.009997800478, 4511.436070491189, 4318.1363727254675, 4319.0, 4333.566643335673, 4351.303791393378, 4366.08312254427, 4265.466816647934, 4269.978650106761, 4315.13697260546, 4364.752152641392, 4365.410669559632, 3773.716971227169, 3842.500474938268, 3849.7305188636806, 3850.133719912997, 3870.806459677005, 5371.704556249405, 5371.865703357408, 5393.919091213635, 5460.836174914759, 5464.590155738296, 5024.0, 5026.974865125651, 5033.270175824521, 5047.343845300087, 5049.798008079672, 5790.623609465371, 5871.970640146815, 5875.794347197828, 5913.319968203668, 5921.644701317935, 4185.539590645027, 4203.7687927164, 4214.578542145761, 4230.492340919079, 4231.42875711778, 6095.6952152392205, 6114.816555503342, 6135.355787642278, 6147.754089836401, 6160.0759886017, 4034.3141665916864, 4273.098471180295, 4298.398224248608, 4300.0, 4302.806373713191, 4373.518912919576, 4381.978090109529, 4382.715123516961, 4401.449818772653, 4408.404865343202, 5031.949680503149, 5041.420236672756, 5046.722430266297, 5061.240813877874, 5062.164742817467, 5734.799282025109, 5885.9987604214775, 5975.641461512237, 5989.790357337472, 6008.579399441997, 1485.4281101775678, 1488.2633096617028, 1488.8064551608438, 1496.9550913472613, 1500.9699806003819, 942.6936245720168, 964.8697425847561, 988.7874107067015, 991.9435800872193, 997.7455748784014, 5045.309821209862, 5095.414027386898, 5104.243708397498, 5129.7175706073485, 5166.43169251382, 5382.623216374816, 5394.865128371822, 5426.457354264621, 5444.782208711607, 5459.771551400903, 4891.804327826918, 5087.491250874883, 5093.490650934951, 5108.693478391308, 5115.718635475085, 2901.9274518137217, 2902.3759891623404, 2908.5927970084203, 2935.1488068459907, 2936.265933516621, 5536.806211782568, 5568.329501149639, 5605.859853503695, 5609.971950140223, 5689.743961521742, 5292.338457692788, 5384.838454846361, 5388.36285507281, 5455.236266922634, 5496.890062198813, 5471.890562188813, 5510.91733623996, 5514.6691198528215, 5534.612577119644, 5607.775688972559, 5375.569954403716, 5456.536194423518, 5493.917591236055, 5533.197686335539, 5832.987619271345, 6045.274567051806, 6050.667213303311, 6054.667973045923, 6076.179715738319, 6077.878442431038, 5964.910526342195, 6009.7295621698, 6277.372262773686, 6289.779857704958, 6293.55945083858, 4182.66538676899, 4186.895327616712, 4224.957750422456, 4260.169266992907, 4271.743695378163, 6028.728707208274, 6042.274927008787, 6067.484263837623, 6149.877002459836, 6163.938360616516, 5759.337676167294, 5863.912041319469, 5921.786033862962, 5944.197533332945, 5976.7908123215475, 5892.734826932884, 5894.793682221273, 5903.203067585821, 5909.763609455574, 5913.349531551612, 5551.666899986014, 5819.912701309399, 5830.82507524775, 5835.94164058371, 5851.771128063155, 6044.546659000681, 6049.758009679564, 6062.666213433037, 6082.0, 6103.969480152571, 5876.559258055749, 5877.735501902339, 5895.616784908967, 5901.232839730807, 5932.466078052996], "value": 4391.485066321405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.1842293226512, 815.6451943404616, 817.3787921179902, 827.5903427803242, 831.1356189562855, 14127.929360353197, 14897.62755931101, 14988.175650339226, 15077.170755608464, 15089.698206035873, 13973.371198296076, 13992.0, 14011.789823152661, 14045.92977035116, 14049.43802247909, 683.4464084091877, 806.5563939833069, 819.7868554175927, 824.0, 832.3008672714949, 827.6151589510877, 830.7009476588423, 832.2135581875131, 834.4159088637978, 834.7120243515977, 884.8009197930446, 886.5522910929972, 886.6719313853883, 887.7913690282778, 892.2326798952895, 879.7624641346832, 881.5812489067673, 884.5621417398364, 887.3344991256557, 888.258304315897, 639.5203597302024, 645.5771469687362, 645.8062581225661, 646.034178902539, 646.2438946432638, 14243.145411275356, 14247.430102795875, 14248.92875535626, 14288.785668214881, 14296.213708246043, 13610.795838062437, 13615.31923403826, 13643.590692279247, 13757.656058598515, 13807.654808629764, 10402.635907743193, 10681.504589357497, 10819.515210736798, 10920.453977301104, 10921.945390272998, 3790.0918161685813, 3829.17672700368, 3835.7506762060375, 3851.2297540492013, 3935.9803200984097, 55401.16898246529, 55847.44152558504, 56650.150247746315, 56771.43228567744, 56873.14690279691, 10052.145567626687, 10054.64808731691, 10176.491175441199, 10324.432156231329, 10381.169506439466, 19390.03049847502, 19442.222311107398, 19481.902590486956, 19540.413787586396, 19590.804091958897, 7802.531848089133, 7954.920450795534, 7981.960090199512, 8225.876611850827, 8340.457870238415, 4555.088982203572, 4632.698874573142, 4656.557627025427, 4718.127146477913, 4738.881527961759, 3485.9128521787156, 3577.624349443323, 3582.5880023797076, 3586.9282614347567, 3598.9280214395567, 650.0996120373317, 666.0342503370133, 672.653583404547, 676.2966514824626, 683.6547543490506, 747.7382915979364, 769.8075481129717, 799.9161136659859, 818.1613845807975, 823.2878560045517, 9133.908660913306, 9523.90476095244, 9639.084286992724, 9779.511024448891, 9902.950485247527, 813.6582635293191, 833.8707500337457, 835.4861760017667, 835.7116794705817, 842.5450256861349, 4645.442546894326, 4799.496052914464, 4841.588464980516, 4844.418669759581, 4896.608271338285, 74897.62551187209, 75657.62171189109, 77340.61329693315, 77513.0, 77548.0, 69516.0, 70606.0, 70917.64541177261, 71937.0, 73065.63467182737, 62400.0, 62887.74224515484, 63001.0, 63590.36409635845, 63896.0, 9044.366894317598, 9449.811003780023, 9492.430454172772, 9555.713328600154, 9619.51902404891, 34619.30761384808, 35068.82465587656, 37485.0, 40853.59146408498, 42460.0, 49978.50021499739, 50184.74907625438, 51062.0, 51206.0, 51507.227391589906, 12346.320952347707, 12412.317322547347, 12639.0, 12899.226046437243, 12928.095033347952, 12973.805392918925, 13024.348782560644, 13956.720865582834, 14329.140251584939, 14479.348429320495, 12475.438605262603, 12515.74968500643, 12901.741965160456, 13032.804507932198, 13485.528006520117, 12411.75176496483, 12541.498340066295, 12553.49786008586, 13707.270991507914, 13724.176549407068, 12440.751184976069, 12537.749245015231, 12575.685607859878, 12861.0, 13139.802902956271, 10974.176936729618, 11280.0, 11332.546698131982, 11404.030657394214, 11773.234739741889, 10888.455577221266, 11003.17476189305, 11150.944245278723, 11280.210385272952, 11316.886831131584], "value": 7087.027942232153, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 103.0, 109.0, 110.0, 109.0, 104.0, 109.0, 110.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 147.0, 212.0, 124.0, 148.0, 156.0, 126.0, 177.0, 124.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 166.0, 167.0, 164.0, 161.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 157.0, 76.0, 77.0, 75.0, 74.0, 173.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 180.0, 94.0, 94.0, 95.0, 141.0, 94.0, 92.0, 154.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0, 107.0, 54.0, 54.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 80.0, 81.0, 81.0, 79.0, 80.0, 82.0, 85.0, 86.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 137.0, 131.0, 129.0, 133.0, 139.0, 119.0, 122.0, 190.0, 124.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 166.0, 157.0, 156.0, 158.0, 159.0, 157.0, 162.0, 157.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 62.0, 67.0, 63.0, 63.0, 61.0, 64.0], "value": 63.2, "unit": "score"}]}]} 23:47:52 INFO - Return code: 0 23:47:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:47:52 ERROR - # TBPL SUCCESS # 23:47:52 INFO - Running post-action listener: _resource_record_post_action 23:47:52 INFO - ##### 23:47:52 INFO - ##### Finished run-tests step (success) 23:47:52 INFO - ##### 23:47:52 INFO - Running post-run listener: _resource_record_post_run 23:47:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 536776704; Read time: 0; Write time: 612552 23:47:52 INFO - TinderboxPrint: CPU usage
13.5% 23:47:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:47:52 INFO - TinderboxPrint: I/O write bytes / time
536,776,704 / 612,552 23:47:52 INFO - TinderboxPrint: CPU idle
8,221.9 (86.5%) 23:47:52 INFO - TinderboxPrint: CPU user
1,221.1 (12.9%) 23:47:52 INFO - TinderboxPrint: Swap in / out
0 / 0 23:47:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246849536; Read time: 0; Write time: 279172 23:47:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289927168; Read time: 0; Write time: 333380 23:47:52 INFO - Running post-run listener: _upload_blobber_files 23:47:52 INFO - Blob upload gear active. 23:47:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:47:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 23:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:54 INFO - (blobuploader) - INFO - Done attempting. 23:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:47:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:58 INFO - (blobuploader) - INFO - Done attempting. 23:47:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:47:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:59 INFO - (blobuploader) - INFO - Done attempting. 23:47:59 INFO - (blobuploader) - INFO - Iteration through files over. 23:47:59 INFO - Return code: 0 23:47:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:47:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:47:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c1bcf9d9e5c3e94fef7c4d4d1590e925fb8520e03fc477968a48708ca6b7ba9938ba3add3cbdafbc6a56a7d5cf5a4efd1c29ef3cde1ea9a10bf27e984ed5273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80af443860440bfb0017ed28353f77aa23783e2471edf666db22394b0c141be1c41c72f8ca4e04338996b8051bab5e7a0e0ffbb5ad64e1846aa5647d46f3dc30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d31ab2e4820f9053a87f180e43e7cdb3a93523e2f9ebe670c717b1252e6bfeac09ceae05d89aea4fd66801e4d76d9b5d75ead53f82ea39f5653ce6693cf0541"} 23:47:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:47:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:47:59 INFO - Contents: 23:47:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4c1bcf9d9e5c3e94fef7c4d4d1590e925fb8520e03fc477968a48708ca6b7ba9938ba3add3cbdafbc6a56a7d5cf5a4efd1c29ef3cde1ea9a10bf27e984ed5273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80af443860440bfb0017ed28353f77aa23783e2471edf666db22394b0c141be1c41c72f8ca4e04338996b8051bab5e7a0e0ffbb5ad64e1846aa5647d46f3dc30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d31ab2e4820f9053a87f180e43e7cdb3a93523e2f9ebe670c717b1252e6bfeac09ceae05d89aea4fd66801e4d76d9b5d75ead53f82ea39f5653ce6693cf0541"} 23:47:59 INFO - Running post-run listener: copy_logs_to_upload_dir 23:47:59 INFO - Copying logs to upload dir... 23:47:59 INFO - mkdir: /builds/slave/test/build/upload/logs 23:47:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.718896 ========= master_lag: 0.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-18 23:48:00.200719) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 23:48:00.204919) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147 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/4c1bcf9d9e5c3e94fef7c4d4d1590e925fb8520e03fc477968a48708ca6b7ba9938ba3add3cbdafbc6a56a7d5cf5a4efd1c29ef3cde1ea9a10bf27e984ed5273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80af443860440bfb0017ed28353f77aa23783e2471edf666db22394b0c141be1c41c72f8ca4e04338996b8051bab5e7a0e0ffbb5ad64e1846aa5647d46f3dc30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d31ab2e4820f9053a87f180e43e7cdb3a93523e2f9ebe670c717b1252e6bfeac09ceae05d89aea4fd66801e4d76d9b5d75ead53f82ea39f5653ce6693cf0541"} build_url:https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/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/4c1bcf9d9e5c3e94fef7c4d4d1590e925fb8520e03fc477968a48708ca6b7ba9938ba3add3cbdafbc6a56a7d5cf5a4efd1c29ef3cde1ea9a10bf27e984ed5273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80af443860440bfb0017ed28353f77aa23783e2471edf666db22394b0c141be1c41c72f8ca4e04338996b8051bab5e7a0e0ffbb5ad64e1846aa5647d46f3dc30", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d31ab2e4820f9053a87f180e43e7cdb3a93523e2f9ebe670c717b1252e6bfeac09ceae05d89aea4fd66801e4d76d9b5d75ead53f82ea39f5653ce6693cf0541"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 23:48:00.232374) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:48:00.232720) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463638962.166143-1518877147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:48:00.519465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 23:48:00.519825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 23:48:00.520104) ========= ========= Total master_lag: 1.29 =========