builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1461111973.63 results: success (0) buildid: 20160419163752 builduid: 174eada632af4cf794b390a57d2a1342 revision: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.628214) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.628705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.629027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.646615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.646922) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 17:26:13-- 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% 37.1M=0s 2016-04-19 17:26:13 (37.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093822 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.754836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.755239) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013599 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.805040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:13.805452) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 --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 f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 --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=78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 17:26:13,951 truncating revision to first 12 chars 2016-04-19 17:26:13,951 Setting DEBUG logging. 2016-04-19 17:26:13,951 attempt 1/10 2016-04-19 17:26:13,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f60bd9567a05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 17:26:14,215 unpacking tar archive at: fx-team-f60bd9567a05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:14.350841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:14.351240) ========= script_repo_revision: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:14.351729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:14.352044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 17:26:14.366944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-19 17:26:14.367285) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:14 INFO - MultiFileLogger online at 20160419 17:26:14 in /builds/slave/test 17:26:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:26:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:14 INFO - {'append_to_log': False, 17:26:14 INFO - 'base_work_dir': '/builds/slave/test', 17:26:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:26:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:14 INFO - 'branch': 'Fx-Team-Non-PGO', 17:26:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:14 INFO - 'config_files': ('talos/linux_config.py',), 17:26:14 INFO - 'default_actions': ('clobber', 17:26:14 INFO - 'read-buildbot-config', 17:26:14 INFO - 'download-and-extract', 17:26:14 INFO - 'populate-webroot', 17:26:14 INFO - 'create-virtualenv', 17:26:14 INFO - 'install', 17:26:14 INFO - 'run-tests'), 17:26:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:14 INFO - 'download_minidump_stackwalk': True, 17:26:14 INFO - 'download_symbols': 'ondemand', 17:26:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:26:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:26:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:26:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:26:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:14 INFO - 'installer_path': 'installer.exe', 17:26:14 INFO - 'log_level': 'info', 17:26:14 INFO - 'log_name': 'talos', 17:26:14 INFO - 'log_to_console': True, 17:26:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:14 INFO - 'opt_config_files': (), 17:26:14 INFO - 'pip_index': False, 17:26:14 INFO - 'sps_profile': False, 17:26:14 INFO - 'sps_profile_interval': 0, 17:26:14 INFO - 'suite': 'dromaeojs-e10s', 17:26:14 INFO - 'system_bits': '32', 17:26:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:14 INFO - 'title': 'talos-linux64-ix-019', 17:26:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:14 INFO - 'use_talos_json': True, 17:26:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:14 INFO - 'work_dir': 'build'} 17:26:14 INFO - ##### 17:26:14 INFO - ##### Running clobber step. 17:26:14 INFO - ##### 17:26:14 INFO - Running pre-action listener: _resource_record_pre_action 17:26:14 INFO - Running main action method: clobber 17:26:14 INFO - rmtree: /builds/slave/test/build 17:26:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:15 INFO - Running post-action listener: _resource_record_post_action 17:26:15 INFO - ##### 17:26:15 INFO - ##### Running read-buildbot-config step. 17:26:15 INFO - ##### 17:26:15 INFO - Running pre-action listener: _resource_record_pre_action 17:26:15 INFO - Running main action method: read_buildbot_config 17:26:15 INFO - Using buildbot properties: 17:26:15 INFO - { 17:26:15 INFO - "project": "", 17:26:15 INFO - "product": "firefox", 17:26:15 INFO - "script_repo_revision": "production", 17:26:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:26:15 INFO - "repository": "", 17:26:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:26:15 INFO - "buildid": "20160419163752", 17:26:15 INFO - "pgo_build": "False", 17:26:15 INFO - "basedir": "/builds/slave/test", 17:26:15 INFO - "buildnumber": 1175, 17:26:15 INFO - "slavename": "talos-linux64-ix-019", 17:26:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:26:15 INFO - "platform": "ubuntu64_hw", 17:26:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:26:15 INFO - "branch": "fx-team", 17:26:15 INFO - "repo_path": "integration/fx-team", 17:26:15 INFO - "revision": "f60bd9567a058bf0d4d5b35f0d53a46eba0aa500", 17:26:15 INFO - "stage_platform": "linux64", 17:26:15 INFO - "builduid": "174eada632af4cf794b390a57d2a1342", 17:26:15 INFO - "slavebuilddir": "test" 17:26:15 INFO - } 17:26:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:26:15 INFO - Running post-action listener: _resource_record_post_action 17:26:15 INFO - ##### 17:26:15 INFO - ##### Running download-and-extract step. 17:26:15 INFO - ##### 17:26:15 INFO - Running pre-action listener: _resource_record_pre_action 17:26:15 INFO - Running main action method: download_and_extract 17:26:15 INFO - mkdir: /builds/slave/test/build/tests 17:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:15 INFO - https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:26:15 INFO - Downloaded 1361 bytes. 17:26:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:26:15 INFO - Using the following test package requirements: 17:26:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:26:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:26:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:26:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'jsshell-linux-x86_64.zip'], 17:26:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:26:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:26:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:26:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:26:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:26:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:26:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:15 INFO - https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:26:16 INFO - Downloaded 22267191 bytes. 17:26:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:26:18 INFO - Return code: 0 17:26:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:18 INFO - https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:26:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:26:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:26:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:26:19 INFO - Downloaded 22267191 bytes. 17:26:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:26:20 INFO - Return code: 0 17:26: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')]} 17:26:20 INFO - https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:26:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:26:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:26:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:26:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:26:22 INFO - Downloaded 10845952 bytes. 17:26:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:26:22 INFO - Return code: 0 17:26:22 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')]} 17:26:22 INFO - https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:26:24 INFO - Downloaded 54503809 bytes. 17:26:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:26:24 INFO - mkdir: /builds/slave/test/properties 17:26:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:24 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:24 INFO - Contents: 17:26:24 INFO - build_url:https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:26:25 INFO - Running post-action listener: _resource_record_post_action 17:26:25 INFO - Running post-action listener: set_extra_try_arguments 17:26:25 INFO - ##### 17:26:25 INFO - ##### Running populate-webroot step. 17:26:25 INFO - ##### 17:26:25 INFO - Running pre-action listener: _resource_record_pre_action 17:26:25 INFO - Running main action method: populate_webroot 17:26:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:25 INFO - '--tppagecycles', 17:26:25 INFO - '7'], 17:26:25 INFO - 'tests': ['tsvgm']}}, 17:26:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['damp', 'tps']}, 17:26:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'tests': ['damp', 'tps']}, 17:26:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['dromaeo_dom']}, 17:26:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['a11yr', 17:26:25 INFO - 'ts_paint', 17:26:25 INFO - 'tpaint', 17:26:25 INFO - 'sessionrestore', 17:26:25 INFO - 'sessionrestore_no_auto_restore', 17:26:25 INFO - 'tabpaint']}, 17:26:25 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:25 INFO - 'ts_paint', 17:26:25 INFO - 'tpaint', 17:26:25 INFO - 'sessionrestore', 17:26:25 INFO - 'sessionrestore_no_auto_restore', 17:26:25 INFO - 'tabpaint']}, 17:26:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:26:25 INFO - 'ts_paint', 17:26:25 INFO - 'tpaint', 17:26:25 INFO - 'sessionrestore', 17:26:25 INFO - 'sessionrestore_no_auto_restore', 17:26:25 INFO - 'tabpaint']}, 17:26:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:26:25 INFO - 'ts_paint', 17:26:25 INFO - 'tpaint', 17:26:25 INFO - 'sessionrestore', 17:26:25 INFO - 'sessionrestore_no_auto_restore', 17:26:25 INFO - 'tabpaint']}, 17:26:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['a11yr', 17:26:25 INFO - 'ts_paint', 17:26:25 INFO - 'tpaint', 17:26:25 INFO - 'sessionrestore', 17:26:25 INFO - 'sessionrestore_no_auto_restore', 17:26:25 INFO - 'tabpaint']}, 17:26:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['a11yr', 17:26:25 INFO - 'ts_paint', 17:26:25 INFO - 'tpaint', 17:26:25 INFO - 'sessionrestore', 17:26:25 INFO - 'sessionrestore_no_auto_restore', 17:26:25 INFO - 'tabpaint']}, 17:26:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['tsvgx', 17:26:25 INFO - 'tsvgr_opacity', 17:26:25 INFO - 'tart', 17:26:25 INFO - 'tscrollx', 17:26:25 INFO - 'cart']}, 17:26:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:25 INFO - 'tsvgr_opacity', 17:26:25 INFO - 'tart', 17:26:25 INFO - 'tscrollx', 17:26:25 INFO - 'cart']}, 17:26:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'talos_options': ['--disable-e10s'], 17:26:25 INFO - 'tests': ['tp5o']}, 17:26:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'tests': ['tp5o']}, 17:26:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'talos_options': ['--disable-e10s', 17:26:25 INFO - '--xperf_path', 17:26:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:25 INFO - 'tests': ['tp5n']}, 17:26:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:25 INFO - 'talos_options': ['--xperf_path', 17:26:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:25 INFO - 'tests': ['tp5n']}}, 17:26:25 INFO - 'talos.zip': {'path': '', 17:26:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:25 INFO - Running post-action listener: _resource_record_post_action 17:26:25 INFO - ##### 17:26:25 INFO - ##### Running create-virtualenv step. 17:26:25 INFO - ##### 17:26:25 INFO - Running pre-action listener: _resource_record_pre_action 17:26:25 INFO - Running main action method: create_virtualenv 17:26:25 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:25 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 17:26:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:25 INFO - Using real prefix '/usr' 17:26:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:28 INFO - Installing pip.................done. 17:26:28 INFO - Return code: 0 17:26:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:28 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')]} 17:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:28 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')]} 17:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:28 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 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:28 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 17:26:28 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 17:26:28 INFO - Using env: {'DISPLAY': ':0', 17:26:28 INFO - 'HOME': '/home/cltbld', 17:26:28 INFO - 'LANG': 'en_US.UTF-8', 17:26:28 INFO - 'LANGUAGE': 'en_US:en', 17:26:28 INFO - 'LOGNAME': 'cltbld', 17:26:28 INFO - 'MAIL': '/var/mail/cltbld', 17:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:28 INFO - 'MOZ_NO_REMOTE': '1', 17:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:28 INFO - 'NO_EM_RESTART': '1', 17:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:28 INFO - 'PWD': '/builds/slave/test', 17:26:28 INFO - 'SHELL': '/bin/bash', 17:26:28 INFO - 'SHLVL': '1', 17:26:28 INFO - 'TERM': 'linux', 17:26:28 INFO - 'TMOUT': '86400', 17:26:28 INFO - 'USER': 'cltbld', 17:26:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:28 INFO - '_': '/tools/buildbot/bin/python'} 17:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:28 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 17:26:28 INFO - Cleaning up... 17:26:28 INFO - Return code: 0 17:26:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:26:28 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')]} 17:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:28 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')]} 17:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:26:28 INFO - Using env: {'DISPLAY': ':0', 17:26:28 INFO - 'HOME': '/home/cltbld', 17:26:28 INFO - 'LANG': 'en_US.UTF-8', 17:26:28 INFO - 'LANGUAGE': 'en_US:en', 17:26:28 INFO - 'LOGNAME': 'cltbld', 17:26:28 INFO - 'MAIL': '/var/mail/cltbld', 17:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:28 INFO - 'MOZ_NO_REMOTE': '1', 17:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:28 INFO - 'NO_EM_RESTART': '1', 17:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:28 INFO - 'PWD': '/builds/slave/test', 17:26:28 INFO - 'SHELL': '/bin/bash', 17:26:28 INFO - 'SHLVL': '1', 17:26:28 INFO - 'TERM': 'linux', 17:26:28 INFO - 'TMOUT': '86400', 17:26:28 INFO - 'USER': 'cltbld', 17:26:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:28 INFO - '_': '/tools/buildbot/bin/python'} 17:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:28 INFO - Downloading/unpacking psutil>=0.7.1 17:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:30 INFO - Installing collected packages: psutil 17:26:30 INFO - Running setup.py install for psutil 17:26:30 INFO - building 'psutil._psutil_linux' extension 17:26:30 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 17:26:30 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 17:26:30 INFO - building 'psutil._psutil_posix' extension 17:26:30 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 17:26:31 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 17:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:31 INFO - Successfully installed psutil 17:26:31 INFO - Cleaning up... 17:26:31 INFO - Return code: 0 17:26:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:26:31 INFO - Using env: {'DISPLAY': ':0', 17:26:31 INFO - 'HOME': '/home/cltbld', 17:26:31 INFO - 'LANG': 'en_US.UTF-8', 17:26:31 INFO - 'LANGUAGE': 'en_US:en', 17:26:31 INFO - 'LOGNAME': 'cltbld', 17:26:31 INFO - 'MAIL': '/var/mail/cltbld', 17:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:31 INFO - 'MOZ_NO_REMOTE': '1', 17:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:31 INFO - 'NO_EM_RESTART': '1', 17:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:31 INFO - 'PWD': '/builds/slave/test', 17:26:31 INFO - 'SHELL': '/bin/bash', 17:26:31 INFO - 'SHLVL': '1', 17:26:31 INFO - 'TERM': 'linux', 17:26:31 INFO - 'TMOUT': '86400', 17:26:31 INFO - 'USER': 'cltbld', 17:26:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:31 INFO - '_': '/tools/buildbot/bin/python'} 17:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:26:33 INFO - Installing collected packages: mozsystemmonitor 17:26:33 INFO - Running setup.py install for mozsystemmonitor 17:26:33 INFO - Successfully installed mozsystemmonitor 17:26:33 INFO - Cleaning up... 17:26:33 INFO - Return code: 0 17:26:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:26:33 INFO - Using env: {'DISPLAY': ':0', 17:26:33 INFO - 'HOME': '/home/cltbld', 17:26:33 INFO - 'LANG': 'en_US.UTF-8', 17:26:33 INFO - 'LANGUAGE': 'en_US:en', 17:26:33 INFO - 'LOGNAME': 'cltbld', 17:26:33 INFO - 'MAIL': '/var/mail/cltbld', 17:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:33 INFO - 'MOZ_NO_REMOTE': '1', 17:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:33 INFO - 'NO_EM_RESTART': '1', 17:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:33 INFO - 'PWD': '/builds/slave/test', 17:26:33 INFO - 'SHELL': '/bin/bash', 17:26:33 INFO - 'SHLVL': '1', 17:26:33 INFO - 'TERM': 'linux', 17:26:33 INFO - 'TMOUT': '86400', 17:26:33 INFO - 'USER': 'cltbld', 17:26:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:33 INFO - '_': '/tools/buildbot/bin/python'} 17:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:36 INFO - Downloading docopt-0.6.1.tar.gz 17:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:36 INFO - Running setup.py install for blobuploader 17:26:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:36 INFO - Running setup.py install for requests 17:26:36 INFO - Running setup.py install for docopt 17:26:36 INFO - Successfully installed blobuploader requests docopt 17:26:36 INFO - Cleaning up... 17:26:36 INFO - Return code: 0 17:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 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 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:36 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 17:26:36 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 17:26:36 INFO - Using env: {'DISPLAY': ':0', 17:26:36 INFO - 'HOME': '/home/cltbld', 17:26:36 INFO - 'LANG': 'en_US.UTF-8', 17:26:36 INFO - 'LANGUAGE': 'en_US:en', 17:26:36 INFO - 'LOGNAME': 'cltbld', 17:26:36 INFO - 'MAIL': '/var/mail/cltbld', 17:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:36 INFO - 'MOZ_NO_REMOTE': '1', 17:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:36 INFO - 'NO_EM_RESTART': '1', 17:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:36 INFO - 'PWD': '/builds/slave/test', 17:26:36 INFO - 'SHELL': '/bin/bash', 17:26:36 INFO - 'SHLVL': '1', 17:26:36 INFO - 'TERM': 'linux', 17:26:36 INFO - 'TMOUT': '86400', 17:26:36 INFO - 'USER': 'cltbld', 17:26:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:36 INFO - '_': '/tools/buildbot/bin/python'} 17:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:37 INFO - Running setup.py (path:/tmp/pip-g77LWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:37 INFO - Running setup.py (path:/tmp/pip-JEUwVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:37 INFO - Running setup.py (path:/tmp/pip-xDZMrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:37 INFO - Running setup.py (path:/tmp/pip-mR16Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:37 INFO - Running setup.py (path:/tmp/pip-WgegfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:37 INFO - Running setup.py (path:/tmp/pip-SBX2Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:37 INFO - Running setup.py (path:/tmp/pip-6HRWk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:37 INFO - Running setup.py (path:/tmp/pip-8SHLBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:37 INFO - Running setup.py (path:/tmp/pip-W2IWnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:37 INFO - Running setup.py (path:/tmp/pip-ljd5ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:37 INFO - Running setup.py (path:/tmp/pip-I8Bd_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:37 INFO - Running setup.py (path:/tmp/pip-DSzrOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:37 INFO - Running setup.py (path:/tmp/pip-ui6vSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:38 INFO - Running setup.py (path:/tmp/pip-D6wBt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:38 INFO - Running setup.py (path:/tmp/pip-n5wKKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:38 INFO - Running setup.py (path:/tmp/pip-3HvVv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:38 INFO - Running setup.py (path:/tmp/pip-7SLV4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:38 INFO - Running setup.py install for manifestparser 17:26:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:26:38 INFO - Running setup.py install for mozcrash 17:26:38 INFO - Running setup.py install for mozdebug 17:26:38 INFO - Running setup.py install for mozdevice 17:26:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:26:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:26:38 INFO - Running setup.py install for mozfile 17:26:38 INFO - Running setup.py install for mozhttpd 17:26:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:38 INFO - Running setup.py install for mozinfo 17:26:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Running setup.py install for mozInstall 17:26:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Running setup.py install for mozleak 17:26:39 INFO - Running setup.py install for mozlog 17:26:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Running setup.py install for moznetwork 17:26:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Running setup.py install for mozprocess 17:26:39 INFO - Running setup.py install for mozprofile 17:26:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Running setup.py install for mozrunner 17:26:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:39 INFO - Running setup.py install for mozscreenshot 17:26:39 INFO - Running setup.py install for moztest 17:26:40 INFO - Running setup.py install for mozversion 17:26:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:40 INFO - Cleaning up... 17:26:40 INFO - Return code: 0 17:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:40 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 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:40 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 17:26:40 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 17:26:40 INFO - Using env: {'DISPLAY': ':0', 17:26:40 INFO - 'HOME': '/home/cltbld', 17:26:40 INFO - 'LANG': 'en_US.UTF-8', 17:26:40 INFO - 'LANGUAGE': 'en_US:en', 17:26:40 INFO - 'LOGNAME': 'cltbld', 17:26:40 INFO - 'MAIL': '/var/mail/cltbld', 17:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:40 INFO - 'MOZ_NO_REMOTE': '1', 17:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:40 INFO - 'NO_EM_RESTART': '1', 17:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:40 INFO - 'PWD': '/builds/slave/test', 17:26:40 INFO - 'SHELL': '/bin/bash', 17:26:40 INFO - 'SHLVL': '1', 17:26:40 INFO - 'TERM': 'linux', 17:26:40 INFO - 'TMOUT': '86400', 17:26:40 INFO - 'USER': 'cltbld', 17:26:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:40 INFO - '_': '/tools/buildbot/bin/python'} 17:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:40 INFO - Running setup.py (path:/tmp/pip-hbqDUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:40 INFO - Running setup.py (path:/tmp/pip-zSrGmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:40 INFO - Running setup.py (path:/tmp/pip-Ka1qlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:40 INFO - Running setup.py (path:/tmp/pip-HZEyN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:40 INFO - Running setup.py (path:/tmp/pip-I0bEgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:40 INFO - Running setup.py (path:/tmp/pip-2j7B0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:40 INFO - Running setup.py (path:/tmp/pip-gLst2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:40 INFO - Running setup.py (path:/tmp/pip-iLqzS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:40 INFO - Running setup.py (path:/tmp/pip-A4g7m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:40 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)) 17:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:40 INFO - Running setup.py (path:/tmp/pip-yDNGC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:41 INFO - Running setup.py (path:/tmp/pip-G6hoDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:41 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:41 INFO - Running setup.py (path:/tmp/pip-WKxFgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:41 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:41 INFO - Running setup.py (path:/tmp/pip-vOD9V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:41 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:41 INFO - Running setup.py (path:/tmp/pip-8p7hfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:41 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:41 INFO - Running setup.py (path:/tmp/pip-IKdNxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:41 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:41 INFO - Running setup.py (path:/tmp/pip-rZag3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:41 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)) 17:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:41 INFO - Running setup.py (path:/tmp/pip-ZtVv5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:41 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)) 17:26:41 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)) 17:26:41 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)) 17:26:41 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)) 17:26:41 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)) 17:26:41 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)) 17:26:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:43 INFO - Downloading blessings-1.6.tar.gz 17:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:43 INFO - Installing collected packages: blessings 17:26:43 INFO - Running setup.py install for blessings 17:26:43 INFO - Successfully installed blessings 17:26:43 INFO - Cleaning up... 17:26:43 INFO - Return code: 0 17:26:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:43 INFO - Reading from file tmpfile_stdout 17:26:43 INFO - Current package versions: 17:26:43 INFO - argparse == 1.2.1 17:26:43 INFO - blessings == 1.6 17:26:43 INFO - blobuploader == 1.2.4 17:26:43 INFO - docopt == 0.6.1 17:26:43 INFO - manifestparser == 1.1 17:26:43 INFO - mozInstall == 1.12 17:26:43 INFO - mozcrash == 0.17 17:26:43 INFO - mozdebug == 0.1 17:26:43 INFO - mozdevice == 0.48 17:26:43 INFO - mozfile == 1.2 17:26:43 INFO - mozhttpd == 0.7 17:26:43 INFO - mozinfo == 0.9 17:26:43 INFO - mozleak == 0.1 17:26:43 INFO - mozlog == 3.1 17:26:43 INFO - moznetwork == 0.27 17:26:43 INFO - mozprocess == 0.22 17:26:43 INFO - mozprofile == 0.28 17:26:43 INFO - mozrunner == 6.11 17:26:43 INFO - mozscreenshot == 0.1 17:26:43 INFO - mozsystemmonitor == 0.0 17:26:43 INFO - moztest == 0.7 17:26:43 INFO - mozversion == 1.4 17:26:43 INFO - psutil == 3.1.1 17:26:43 INFO - requests == 1.2.3 17:26:43 INFO - wsgiref == 0.1.2 17:26:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:43 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')]} 17:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:43 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')]} 17:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:43 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 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:43 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 17:26:43 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 17:26:43 INFO - Using env: {'DISPLAY': ':0', 17:26:43 INFO - 'HOME': '/home/cltbld', 17:26:43 INFO - 'LANG': 'en_US.UTF-8', 17:26:43 INFO - 'LANGUAGE': 'en_US:en', 17:26:43 INFO - 'LOGNAME': 'cltbld', 17:26:43 INFO - 'MAIL': '/var/mail/cltbld', 17:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:43 INFO - 'MOZ_NO_REMOTE': '1', 17:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:43 INFO - 'NO_EM_RESTART': '1', 17:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:43 INFO - 'PWD': '/builds/slave/test', 17:26:43 INFO - 'SHELL': '/bin/bash', 17:26:43 INFO - 'SHLVL': '1', 17:26:43 INFO - 'TERM': 'linux', 17:26:43 INFO - 'TMOUT': '86400', 17:26:43 INFO - 'USER': 'cltbld', 17:26:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:43 INFO - '_': '/tools/buildbot/bin/python'} 17:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 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)) 17:26:44 INFO - Cleaning up... 17:26:44 INFO - Return code: 0 17:26:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26: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', 'jsonschema'] in /builds/slave/test/build 17:26: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 jsonschema 17:26:44 INFO - Using env: {'DISPLAY': ':0', 17:26:44 INFO - 'HOME': '/home/cltbld', 17:26:44 INFO - 'LANG': 'en_US.UTF-8', 17:26:44 INFO - 'LANGUAGE': 'en_US:en', 17:26:44 INFO - 'LOGNAME': 'cltbld', 17:26:44 INFO - 'MAIL': '/var/mail/cltbld', 17:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:44 INFO - 'MOZ_NO_REMOTE': '1', 17:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:44 INFO - 'NO_EM_RESTART': '1', 17:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:44 INFO - 'PWD': '/builds/slave/test', 17:26:44 INFO - 'SHELL': '/bin/bash', 17:26:44 INFO - 'SHLVL': '1', 17:26:44 INFO - 'TERM': 'linux', 17:26:44 INFO - 'TMOUT': '86400', 17:26:44 INFO - 'USER': 'cltbld', 17:26:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:44 INFO - '_': '/tools/buildbot/bin/python'} 17:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:44 INFO - Downloading/unpacking jsonschema 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:46 INFO - Downloading/unpacking functools32 (from jsonschema) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:46 INFO - warning: no files found matching '*.txt' 17:26:46 INFO - no previously-included directories found matching 'build' 17:26:46 INFO - no previously-included directories found matching 'dist' 17:26:46 INFO - no previously-included directories found matching '.git*' 17:26:46 INFO - Installing collected packages: jsonschema, functools32 17:26:46 INFO - Running setup.py install for functools32 17:26:46 INFO - warning: no files found matching '*.txt' 17:26:46 INFO - no previously-included directories found matching 'build' 17:26:46 INFO - no previously-included directories found matching 'dist' 17:26:46 INFO - no previously-included directories found matching '.git*' 17:26:46 INFO - Successfully installed jsonschema functools32 17:26:46 INFO - Cleaning up... 17:26:46 INFO - Return code: 0 17:26:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:26:46 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')]} 17:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:46 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')]} 17:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:46 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 0x7fd55935df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', '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 17:26:46 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 17:26:46 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 17:26:46 INFO - Using env: {'DISPLAY': ':0', 17:26:46 INFO - 'HOME': '/home/cltbld', 17:26:46 INFO - 'LANG': 'en_US.UTF-8', 17:26:46 INFO - 'LANGUAGE': 'en_US:en', 17:26:46 INFO - 'LOGNAME': 'cltbld', 17:26:46 INFO - 'MAIL': '/var/mail/cltbld', 17:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:46 INFO - 'MOZ_NO_REMOTE': '1', 17:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:46 INFO - 'NO_EM_RESTART': '1', 17:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:46 INFO - 'PWD': '/builds/slave/test', 17:26:46 INFO - 'SHELL': '/bin/bash', 17:26:46 INFO - 'SHLVL': '1', 17:26:46 INFO - 'TERM': 'linux', 17:26:46 INFO - 'TMOUT': '86400', 17:26:46 INFO - 'USER': 'cltbld', 17:26:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:46 INFO - '_': '/tools/buildbot/bin/python'} 17:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:46 INFO - Downloading/unpacking flake8 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:26:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:26:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 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 17:26:48 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 17:26:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:26:49 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 17:26:49 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 17:26:49 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 17:26:49 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 17:26:49 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 17:26:49 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 17:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:49 INFO - no previously-included directories found matching 'docs/_build' 17:26:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:26:49 INFO - Running setup.py install for pep8 17:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:26:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:26:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:26:49 INFO - no previously-included directories found matching 'docs/_build' 17:26:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:26:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:26:49 INFO - Cleaning up... 17:26:49 INFO - Return code: 0 17:26:49 INFO - Running post-action listener: _resource_record_post_action 17:26:49 INFO - Running post-action listener: _start_resource_monitoring 17:26:49 INFO - Starting resource monitoring. 17:26:49 INFO - ##### 17:26:49 INFO - ##### Running install step. 17:26:49 INFO - ##### 17:26:49 INFO - Running pre-action listener: _resource_record_pre_action 17:26:49 INFO - Running main action method: install 17:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:49 INFO - Reading from file tmpfile_stdout 17:26:49 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:26:50 INFO - Reading from file tmpfile_stdout 17:26:50 INFO - Output received: 17:26:50 INFO - Usage: mozinstall [options] installer 17:26:50 INFO - Options: 17:26:50 INFO - -h, --help show this help message and exit 17:26:50 INFO - -d DEST, --destination=DEST 17:26:50 INFO - Directory to install application into. [default: 17:26:50 INFO - "/builds/slave/test"] 17:26:50 INFO - --app=APP Application being installed. [default: firefox] 17:26:50 INFO - mkdir: /builds/slave/test/build/application 17:26:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:27:05 INFO - Reading from file tmpfile_stdout 17:27:05 INFO - Output received: 17:27:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:27:05 INFO - Running post-action listener: _resource_record_post_action 17:27:05 INFO - ##### 17:27:05 INFO - ##### Running run-tests step. 17:27:05 INFO - ##### 17:27:05 INFO - Running pre-action listener: _resource_record_pre_action 17:27:05 INFO - Running main action method: run_tests 17:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:05 INFO - Python 2.7.3 17:27:05 INFO - Return code: 0 17:27:05 INFO - grabbing minidump binary from tooltool 17:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:05 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706410>, '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 0x1707310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17077a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:05 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 17:27:05 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 17:27:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:05 INFO - Return code: 0 17:27:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:27:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:27:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:27:06 INFO - Return code: 0 17:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 17:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 17:27:06 INFO - Using env: {'DISPLAY': ':0', 17:27:06 INFO - 'HOME': '/home/cltbld', 17:27:06 INFO - 'LANG': 'en_US.UTF-8', 17:27:06 INFO - 'LANGUAGE': 'en_US:en', 17:27:06 INFO - 'LOGNAME': 'cltbld', 17:27:06 INFO - 'MAIL': '/var/mail/cltbld', 17:27:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:06 INFO - 'MOZ_NO_REMOTE': '1', 17:27:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:06 INFO - 'NO_EM_RESTART': '1', 17:27:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:06 INFO - 'PWD': '/builds/slave/test', 17:27:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:06 INFO - 'SHELL': '/bin/bash', 17:27:06 INFO - 'SHLVL': '1', 17:27:06 INFO - 'TERM': 'linux', 17:27:06 INFO - 'TMOUT': '86400', 17:27:06 INFO - 'USER': 'cltbld', 17:27:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460', 17:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:06 INFO - '_': '/tools/buildbot/bin/python'} 17:27:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 17:27:06 INFO - mozversion application_buildid: 20160419163752 17:27:06 INFO - mozversion application_changeset: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 17:27:06 INFO - mozversion application_display_name: Nightly 17:27:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:06 INFO - mozversion application_name: Firefox 17:27:06 INFO - mozversion application_remotingname: firefox 17:27:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:27:06 INFO - mozversion application_vendor: Mozilla 17:27:06 INFO - mozversion application_version: 48.0a1 17:27:06 INFO - mozversion platform_buildid: 20160419163752 17:27:06 INFO - mozversion platform_changeset: f60bd9567a058bf0d4d5b35f0d53a46eba0aa500 17:27:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:27:06 INFO - mozversion platform_version: 48.0a1 17:27:06 INFO - using testdate: 1461112026 17:27:06 INFO - actual date: 1461112026 17:27:06 INFO - starting webserver on 'localhost:60580' 17:27:06 INFO - SUITE-START | Running 2 tests 17:27:06 INFO - TEST-START | dromaeo_css 17:27:06 INFO - operating with platform_type : linux_ 17:27:06 INFO - Initialising browser for dromaeo_css test... 17:27:06 INFO - TEST-INFO | started process 5056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAbnMV8/profile http://localhost:60580/getInfo.html) 17:27:11 INFO - PROCESS | 5056 | 17:27:11 INFO - PROCESS | 5056 | (process:5127): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:27:12 INFO - PROCESS | 5056 | __metrics Screen width/height:1600/1200 17:27:12 INFO - PROCESS | 5056 | colorDepth:24 17:27:12 INFO - PROCESS | 5056 | Browser inner width/height: 1024/697 17:27:12 INFO - PROCESS | 5056 | __metrics 17:27:12 ERROR - PROCESS | 5056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:27:13 INFO - TEST-INFO | 5056: exit 0 17:27:13 INFO - Browser initialized. 17:27:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:13 INFO - TEST-INFO | started process 5178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAbnMV8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:15 INFO - PROCESS | 5178 | 17:27:15 INFO - PROCESS | 5178 | (process:5237): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:27:25 INFO - PROCESS | 5178 | RSS: Main: 164786176 17:27:25 INFO - PROCESS | 5178 | 17:28:15 INFO - PROCESS | 5178 | 1461112095345 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] 17:30:27 INFO - PROCESS | 5178 | Cycle 1(1): loaded http://localhost:60580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60580/tests/dromaeo/cssquery-ext.html) 17:30:28 INFO - PROCESS | 5178 | RSS: Main: 168374272 17:30:28 INFO - PROCESS | 5178 | 17:33:30 INFO - PROCESS | 5178 | Cycle 1(1): loaded http://localhost:60580/tests/dromaeo/cssquery-ext.html (next: http://localhost:60580/tests/dromaeo/cssquery-jquery.html) 17:33:31 INFO - PROCESS | 5178 | RSS: Main: 166035456 17:33:31 INFO - PROCESS | 5178 | 17:36:33 INFO - PROCESS | 5178 | Cycle 1(1): loaded http://localhost:60580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60580/tests/dromaeo/cssquery-mootools.html) 17:36:33 INFO - PROCESS | 5178 | RSS: Main: 166453248 17:36:33 INFO - PROCESS | 5178 | 17:39:35 INFO - PROCESS | 5178 | Cycle 1(1): loaded http://localhost:60580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60580/tests/dromaeo/cssquery-prototype.html) 17:39:36 INFO - PROCESS | 5178 | RSS: Main: 163926016 17:39:36 INFO - PROCESS | 5178 | 17:42:38 INFO - PROCESS | 5178 | Cycle 1(1): loaded http://localhost:60580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60580/tests/dromaeo/cssquery-yui.html) 17:42:39 INFO - PROCESS | 5178 | RSS: Main: 164884480 17:42:39 INFO - PROCESS | 5178 | 17:45:41 INFO - PROCESS | 5178 | Cycle 1(1): loaded http://localhost:60580/tests/dromaeo/cssquery-yui.html (next: http://localhost:60580/tests/dromaeo/cssquery-dojo.html) 17:45:42 INFO - PROCESS | 5178 | RSS: Main: 167264256 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | __start_tp_report 17:45:42 INFO - PROCESS | 5178 | _x_x_mozilla_page_load 17:45:42 INFO - PROCESS | 5178 | _x_x_mozilla_page_load_details 17:45:42 INFO - PROCESS | 5178 | |i|pagename|runs| 17:45:42 INFO - PROCESS | 5178 | |0;dojo.html;2581.47079848631;2680.1155618645835;2680.9329766755827;2684.355754618891;2700.2169370882443;4659.836905708301;4690.1792186367375;4699.4595621503495;4701.2478003519445;4744.833930812422;4522.864314070575;4670.042641258542;4702.271147972061;4777.498362671921;4782.856514304568;4304.870853874381;4329.783510824462;4367.956320436787;4374.825006999732;4419.491758447787;4333.544977777336;4436.889077773049;4453.176162409948;4464.620507256887;4473.686841921067;4236.85171019016;4240.23675738367;4311.676624253162;4378.584034516716;4430.180416622935;4235.851745188904;4326;4335.978320108411;4350.499692535335;4376.321670141133;4351.782410879443;4359.128174365108;4373.628241599468;4378.540253273424;4416.227160246944;4551.385562949025;4600.838970636011;4609.308603709437;4633.930491042637;4645.976770116162;4960.2559616057515;4984.352034235562;5007.37407824022;5016.3227964224725;5065.696058236481;4781.258904869751;4978.6514943953935;5023.32185155003;5052.216906379517;5076;4718.363020992157;4742.288656701522;4751.952480475151;4769.141554520185;4811.663183577116;5103.464136265713;5113.15632920564;5122.282880396748;5128.230765385148;5147.948520514822;4653.139169253699;4896.902061958741;4919.7540122993705;4943.678660887031;4960;5009.874753131128;5030.89938201234;5038.874028149326;5040.974795126001;5077;4765.070811191854;4825.855224343275;4829.396325459317;4837.467878533358;4841.661083724176;4842.467328593852;4947.084789313988;4958.652894297436;4969.503049695074;5020.221865610836;4131.483564554431;4207.768572728468;4215.325547912381;4220.620144187038;4257.106007738348;3703.6296370362747;3733.5893051764283;3742.045778326509;3773.3019391412677;3774.3960966245268;4354.673399495051;4369.519352871182;4385.298352263686;4388.802503887333;4405.427294451701;4860.149473842063;5019.07147177766;5058.64589478733;5086.64393492452;5117.257997590403;4352.673549483801;4355.3684715716045;4355.760433176206;4384.276594361958;4394.8242070317465;4484.910301793946;4522.4346956630425;4541.3869127668;4550.47669518003;4598.494165641777;4700.600448961808;4706.694064885772;4765.070811191785;4800.4479484859685;4805.014971930816;5029.346184996073;5041.747912604428;5054.241863720325;5057.772400242072;5119.820806271762;4603.378543896665;4783.4738178801;4805.567498925114;4814.013127308824;4860.465348811698;4892.0705066037335;4949.851504454872;4962.751862406793;4963.181075122564;4965.776540055778;4997.925031124463;5044.571211446922;5046.621503387334;5061.797528098835;5087.898242035212;4696.436427628706;4858.368412106545;4860.854174374775;4891.192953162688;4959.528844759742;4650.255959046536;4789.353437285922;4833.73414462208;4877.365942427462;4904.117258893433;4817.940053188293;4835.95164048355;4836.226203807374;4868.513148685103;4886.975565122151;4753.595944344769;4929.802807887644;4947.431045429822;4950.133726597759;4951.876203094951;4723.173444647242;4773.284007398918;4780.928286075781;4797.040591881568;4817.494163112963 17:45:42 INFO - PROCESS | 5178 | |1;ext.html;580.1616663920634;594.991075133873;614.0482252508612;634.5399585300655;655.4199533412929;33694.83152584237;34561.82719086401;34660.653393466055;34693.47959780605;34718.47922281165;34185;34525.48211776819;34759;34767.304653906904;34873.12817179565;7467.925320746777;7608.391328693719;7617.2001939796355;7625.161232264447;7636.083669959613;7507.624618769067;7735.72924947627;7754.612269386508;7760.029996250469;7770.4560680752365;7713.5757533335645;7791.3766898648255;7840.725574604861;7842.254985776342;7863.606819659023;7732.381409487228;7759.961200193991;7766.805829854271;7773.028371453568;7778.261065198853;7648.541087534766;7764.689412423496;7768.417368697314;7774.611269436562;7791.766247012599;29230.269243268875;34361.48457773135;34478.310433791434;34667.13332166691;34687;2932.6040984467036;3043.223977885647;3051.649060358065;3336.582927134108;3511.701505372021;26954.5956810648;27016.324591885164;27562;27564.173074807786;27755.306117347027;2939.556486227667;2961.5557666350005;2988.5218365061705;2994.925126871824;3061.663217046123;238917;245394;245712;246072;246779;52855.73572132115;53209.46790532045;53241.73379133157;53289;53321.46678533243;60829.69585152134;62048;63963.36036639667;64081.67959160174;64150;13654.658633534042;13841.30793460323;13848.16910985324;13926.30368481592;13939.233342166075;9632.75918102039;9651.71044868655;9654.75863103414;9714.22286217101;9714.61141554344;19326.424611446928;19361.225550978084;19407.902960485106;19423.611527769648;19520.219191232474;7548.641244576029;7600.771976840703;7658.310752032344;7838.921610783933;7853.214678532101;907.9921287371013;920.6501529418778;923.4643906534194;928.4522131942051;997.152420442618;26830.731692683214;27647.861760691067;27891.442171156465;27941.580876286873;28137.57793633097;987.3434166279344;1016.4968340671415;1028.1466382902174;1100.7028102412303;1104.536094840153;14666.706665866623;14968.775468367983;15139.470118546018;15402.15288159162;15430;340313;344872;348269;350105;350377;47963.280550791766;48943.75528122336;48952;48978.51021489811;49329.75335123373;1195.7548702515962;1231.1928802330879;1236;1251.2117366059324;1338.0098726941992;26429.60355594629;27629.309267267676;27739.861300693367;27871;28203;41273;41592.792036039624;42127;42138.36792448177;42194.156116876875;312242;314249;314924;315729.1630211458;316291;25604.74395256098;25922.35194120162;26078.34804129836;26190.476190476464;40492;40648.187036259704;40903.59096408998;41244.79377603213;41274.38088428616;41445.378319325835;34005.82997084999;34071.48892766561;34244.143896401794;34251.14372140716;34404;34004.82997584996;34615;34650.48024279688;34674.826625866706;34854.82572587121;31736;34994.475082873265;35101.824490877385;36790.26419471542;37397.81301093477;29332.706672932996;31919;33949.66050339465;36245.63754362422;36585;24351.391215219763;24760;24854.130105446224;24976.125835595667;25134.24597262085 17:45:42 INFO - PROCESS | 5178 | |2;jquery.html;378.6459660217696;386.8645973909132;389.1574740686414;395.778364116095;402.17353338888574;13114.606561803137;15564.688706225868;15955.680886382266;17126.486205413843;17732.758706890505;15095.547133585982;15317.463888763896;15513.689726205497;16361.918190409031;16366.427175048875;4590.701604395712;5085.720285384321;5200.791968321262;5250.343707036621;5319.680819150844;5165.22521621756;5183.844484665447;5189.714565698885;5217.713025783581;5234.241035049916;5148.459411761767;5148.948510514903;5156.613254005964;5181.896362072756;5188.429272779991;5067.0879241736475;5204.375474943031;5228.294180285669;5238.292830467895;5239.5546378557865;4486.192485352635;4622.306654001926;4648.976755116237;4653.092646933849;4672.322513235596;20301.695474567747;20506.58986820255;20513.692294615594;20542.281020164224;20788.688169677465;1909;1953.5702145527962;2057.4753437873396;2123.4797474618817;2401.6637670726113;12844;12954;13259.138156019828;13304.800427993589;13479.528216512375;1761.9647607047916;1766.0721979823409;1767.3460819496868;1828.6068495273446;1883.5950270691867;65810.34189658138;66135;67149.66425167891;68598;69650;9221.585028673726;9235.353525253302;9400.717978460658;9462.053794620482;9686.564104615169;11529.423528823525;12154.817677734842;13140.868591314156;13164.934175329254;13200.339983000811;6433.742650293936;6747.122874026345;6752.628605426748;6876.553024053421;7182.569045857161;6480.935190648033;6517.837054073686;6579.605223686594;6591.868162636721;6652.301508341651;5987.401259873977;6001.3098493672915;6041.72812223451;6169.352218017133;6192.783252586138;1769.7523246111462;1777.8399944004843;1781.8040015598274;1813.6826055440245;1821.6629923464202;854.4104567848165;857.0401150711119;888.9911100889037;891.5497673674753;929.5259417696888;16016.519504414886;16677.833221667872;16731.581710457336;16787.748183777254;17140.228689708994;793.349453448167;881.6517475597103;910.7222297199286;918.0223062438482;921.801812610292;8581.871271930926;8844.73465796027;8845.513496757612;8895.911040889638;9029.232515236146;142478;142871.28564357111;144159;145094;145534.2723286398;73479.63260183665;74558;78618;79456;79624.20375796167;944.6599224279254;1009.4700282351678;1012.8176928153003;1030.1038096855784;1040.2822052783556;14722;15115.697686045998;15336.923315383352;15432.92283538575;15532.689346212786;23341.533169336857;23934.521309573363;34538.82730586432;34641.82679086588;34704.30591388208;41491.58508414998;48843;49567.50432495629;50240.748796255786;50420.24369634385;6555.704993275219;7117.074780278531;7691.769246922601;7800.84398312042;7936.84126317482;10285.02292282232;11033.448327583428;11041.723956901142;11362.602308919148;11816.586419475278;6538.640374779433;8907.821843563223;9236.26109911192;9490.28822838276;9560.713178604376;9535.952320238355;9807.852882206915;9896.158826499828;9951.402915825074;10041.899581004389;9414.576344064397;9682.851249962872;9729.22166226686;9784.85322720174;9913.504324783877;7240.203577606354;7543.47195696296;7600.50596711212;7712.768616941501;7788.299053085023;8875.245604123722;9002.729918102468;9158.496282704515;9166.954165229132;9293.395929264576 17:45:42 INFO - PROCESS | 5178 | |3;mootools.html;1426.8715815576595;1478.5638236720167;1592.7053495103407;1727.8531324837388;1790.4449620617609;7005.894911576331;7610.315071643551;7664.96167519163;7872.5670088145125;7893.13175550689;7652.693892244318;7700.537967721926;7704.6918123275;7746.264104910025;7764.728234511793;2207.4260692219977;2213.5351576169023;2227.986266248853;2229.4649284171765;2232.174095584636;2127.606392817326;2170.218721260345;2203.2178576605234;2223.1218668625884;2235.3964429604;2135.5301833596664;2166.2851259084464;2168.945776355588;2173.652215645497;2200.1309482754305;2114.5136618577735;2122.9893850530725;2123.3099242746093;2128.042380928573;2129.7231359923267;2195.637719776235;2232.464208589943;2241.0363543676376;2253.7295524537;2254.368776742515;7840.176781437924;7943.801404964922;7967.800804979864;7994.480358776719;7995.040595128622;4670.7664616769025;4797.112534181188;4804.903901921942;4820.614350851958;4830.396200474941;2830.716928307153;2901.4777340078776;2918.7810914181523;2947.970520294791;2953.867075981586;922.7185708358948;932.7481579973369;944.4380593546829;946.4936259101348;949.6154057606681;10574.10120139789;10625.574977000912;10661.147108231324;10662.733431664194;10682.572697092108;4191.685623578243;4274.914501709948;4333.783310834446;4402.3711226845635;4442.155990361821;9141.451512909247;9179.58691858868;9198.310126740522;9207.447553146832;9211.677591284273;4695.060987802453;4736.289556566474;4742.430908291027;4755.476897541268;4780.665353425296;3647.8176091195332;4161.9583804161575;4284.207421627009;4336.501302350207;4340.956590434118;3648.689861361814;3752.849886004584;3767.3595488766973;3798.4682144499793;3888.650021498079;1243.1422318600319;1295.6501744529112;1299.636101891472;1301.6745813546613;1303.641498587896;758.4766511107318;841.7390608911257;869.7608157756541;887.0331338840695;893.6872094766779;5498;5615.354234263031;5774.220480235199;5821.825345239649;5916.852078697981;947.2327414794039;961.927855410833;986.4820968991337;998.8102260570469;1016.1210552871861;3690.206605579813;3826.1582451860545;3830.9616903830606;3862.4592557042038;3896.1428485733095;9541.713748587554;9724.854127188099;9825.361351512129;9855.852162217572;9859.950700246596;9708.805823883482;9760.365576237522;9763.658271960589;9769.609215631437;9775.804483910424;7126.857462850818;7268.491205615556;7510.1363343215135;7522;7597;5523.696196709219;5625.803096891589;5715.914261286167;5738.340090889435;5782.421757824184;9046.095390460901;9096.636134554543;9141.3601047926;9153.496557689392;9202.585883635118;8386.203310685476;8864.911350886667;8879.866801997847;8902.243309318781;8940.642374304955;6108.08378743192;6710.396064354231;6722.865542689216;6885.793426197021;6908.2400935896;7445.181030086795;7507.624618769149;7544.132424771222;7554.093508778982;7558.848823023619;6662.933370666231;6761.560498567577;6849.212340580897;6916.619585922823;6921.307869213038;6409.262934762562;6485.189351331083;6692.665366731741;6824.4199243064895;6844.247132815287;6383.744650213939;6430.421262086435;6460.967695161494;6466.224053113657;6483.837904052436;4800.183968725255;4810.903781924412;4916.3362946001835;4929.704217746947;4994.600431965507;4590.678652494294;4597.333386658849;4623.606993405599;4714.41704304724;4742.78657460422 17:45:42 INFO - PROCESS | 5178 | |4;prototype.html;316.98573564189616;324.1571913026132;326.42549113560136;328.22866264278935;328.2712378519685;5204.583633309336;5249.422563518015;5285;5292.153255479124;5329.946700532993;5163.483651634835;5181.145111056671;5196.8700782480455;5220.190870415092;5234.110201265785;3822.57951625321;3955.307821131305;4102.938455923164;4103.815328310233;4109.856155034575;4117.8764637060785;4124.628783409493;4138.772367519785;4150.937735933963;4154.252234597771;4105.692073094515;4117.444145040411;4119.773412462313;4123.340265557511;4130.256553820311;4026.5570787213383;4055.580546808623;4094.549599544048;4109.157622687342;4121.258173528764;3592.76647017943;3593.443016332473;3598.8200589970397;3604.945925811115;3625.7461977661574;4889.779959901813;4938.580220681247;4940.752962351904;4943.332650092228;4974.129527332739;4572.1312950539295;4622.14490319292;4653.418322709661;4665;4686.953130468686;5425.864353391157;5426.023315803154;5431.429699881534;5449.182622606601;5476.17857321401;3935.724499285051;3943.112799620091;3948.9070792480034;3961.187956468917;3961.187956468917;5554.638948468337;5664.376918538957;5735.971320143414;5739.770409183628;5742.770289188427;4009.799510024487;4013.0368711509027;4016.5180178378196;4020.276350256982;4031.536373317106;4104.4048612950955;4113.753174809521;4131.793410329532;4132.648724858361;4137.648299894482;4652.976735116303;4668.105774419813;4669.731188168295;4669.832541864534;4683.648726345537;5274.393444753902;5476.561875049986;5478.506934375925;5487.5884308677005;5502.449755024546;1409.7673883809057;1442.3653592419303;1442.740306744796;1443.3288520837862;1443.7545617245094;903.75146834621;960.693113559231;969.0987381734914;970.8737864077766;988.0239520958083;4744.264638980963;4773.164696178155;4773.832915847928;4781.378420805273;4794.161021821167;5586.497215250566;5603.5237004854225;5606.579506537026;5627.352854421794;5631.042722737145;4613.123506533748;4745.762711864462;4767.165745994437;4772.141014617402;4783.062859541891;2990.7308342249303;2993.1918382037165;3003.5044217703835;3007.8646460909313;3018.24543864034;5308.203769434538;5310.654807437504;5318;5321.73391330432;5327.547158491571;5630.577706672016;5736.856578585485;5744.310682718101;5763.8559036024435;5809.099589563624;5292.259083728281;5305.230741542455;5310.468953104813;5310.548603368679;5325.281087053276;5405.054115529688;5568.192612071146;5587.245721827501;5588.552915766811;5595.916061259003;5506.1190209566275;5526.640768350045;5529.778808847762;5539.169124631338;5548.334199896039;5247.107991641354;5271.810554614403;5304.628675992798;5310.601704872072;5358.544523715528;3726.925461490701;4051.2707712612014;4051.736637118578;4053.7365071270274;4073.490813648294;5600.635958662674;5617.494425501724;5650.124230744241;5650.68921209321;5652.7173641318595;5458.590605704668;5479.315085614298;5490.203920431435;5492.340919089735;5506.752196151263;5345.599080069088;5467.20725494809;5490.6980116094;5499.102809530706;5504.422035686195;5366.812161574326;5395.541378982831;5395.595330350318;5400.135978243462;5401.594880384066;5214.43566929912;5340.2256672783005;5531.1426728857095;5550.555955523468;5555.22226888244;5396.9190462142315;5398.946010540001;5434.619576629756;5444.646098003617;5459 17:45:42 INFO - PROCESS | 5178 | |5;yui.html;719.5934297122129;734.5886303669942;743.7173873927907;745.5750222373249;764.728521374912;10963.232573719843;11020.50407731652;11100.111991040718;11112.055475284591;11221.887781122186;11259.943700281508;11362.318260904352;11367.658970230907;11437.714057148576;11499.770004599925;641.1024565608162;796.992030079699;810.3355248696072;810.5096416667919;813.4305985809957;791.635847510146;808.7412028150994;819.647551552832;820.7578764264526;826.1738261738262;862.2067697718084;863.2446609216935;867.3581549653275;867.7700409391516;868.9217970382664;847.5253857839599;851.6040041380757;853.3343991686463;857.1214505132227;859.5530324231427;628.610261637783;628.987420251597;629.4492319220682;631.6462780842697;632.5287660692767;11680.415979201007;11688.181827272094;11688.941555292255;11737.354445505494;11751.647450576496;12406.19359741623;12510.937445312715;12548.560800371943;12603.306818125;13061.477540898353;9397.859032114524;9398.90601093987;9433.669821556281;9438.811223775487;9550.188234000118;2898.6666533348725;2919.8102123361914;2926.195296293515;2938.3976284861765;2961.7926745127847;44512;44527.77736111299;44560;44808.775956120335;46569.767151164364;9141.268698504236;9218.907810921804;9588.520573971273;9724.659636912675;9764.707058788248;17085;17120.486385408458;17197.1401429928;17198;17248.137593120293;6400.7119679614525;6468.997305417668;6506.251781045145;6599.967000164968;6619.8084344817435;3177.809331440075;3190.617125944855;3216.967830321667;3233.4988076848126;3236;2595.7793587544893;2659.0959073914573;2660.441307325483;2679.4641071785722;2696.042904768818;457.5698843087487;462.264998652138;469.0525139218759;481.1771870102095;483.8524250103752;518.1502336168686;523.756453249241;545.0869793096548;565.801969310738;570.6290910907943;7699.422543309274;7721;7857.685692572233;7935.6032198391;7955.124936257007;476.98330558430985;479.42947892008397;561.6854561445604;568.877691296365;575.246427180395;3614.204874927512;3643.1620727232353;3645.9635403646153;3676.7426280160666;3747.681447077029;50381.49618503768;52245.7387713059;52498.73750631299;52512.73743631257;52865.47134528682;43928;45115.32327015098;45124.77437612857;45455;45619.54380456153;42335.36496952548;42413.15173696509;42519.57480425218;42826.78586607109;43320;7056.400205982549;7119.2168861426235;7141.214466408795;7310.451716121206;7435.553866768011;28186.43627127405;28527.001554945477;28790.280242994093;28862.567061494516;28905.710942891143;35292;36663.45004824983;38250.234995300496;38559.61440385672;38663;9734.561944712646;9814.803703926023;9914.900850991398;9924.15644670211;10554.683359499228;11495.597654082067;11529.308241505536;11536.134789890959;11567.537298507965;11979.580714674945;10215.693529194135;10500.947495262475;10657.413842238751;11344.886551134383;11570.88429115698;9220.262379009797;9498.66754663611;9921.603135874484;10012.64955726546;10504.527296271839;10719.571217151226;10794;11030.44847757625;11344.149188810707;11560.42197890119;9385.906140938503;9393;9639.277054220822;9790.787894482835;9791.706248812547;8331.666733330841;8507.723841423836;8702.173293537104;8873.778155546162;8902.866457003021 17:45:42 INFO - PROCESS | 5178 | __end_tp_report 17:45:42 INFO - PROCESS | 5178 | __start_cc_report 17:45:42 INFO - PROCESS | 5178 | _x_x_mozilla_cycle_collect,385 17:45:42 INFO - PROCESS | 5178 | __end_cc_report 17:45:42 INFO - PROCESS | 5178 | __startTimestamp1461113142040__endTimestamp 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | ------- Summary: start ------- 17:45:42 INFO - PROCESS | 5178 | Number of tests: 6 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | [#0] dojo.html Cycles:165 Average:4638.78 Median:4773.28 stddev:468.90 (9.8%) stddev-sans-first:441.69 17:45:42 INFO - PROCESS | 5178 | Values: 2581.5 2680.1 2680.9 2684.4 2700.2 4659.8 4690.2 4699.5 4701.2 4744.8 4522.9 4670.0 4702.3 4777.5 4782.9 4304.9 4329.8 4368.0 4374.8 4419.5 4333.5 4436.9 4453.2 4464.6 4473.7 4236.9 4240.2 4311.7 4378.6 4430.2 4235.9 4326.0 4336.0 4350.5 4376.3 4351.8 4359.1 4373.6 4378.5 4416.2 4551.4 4600.8 4609.3 4633.9 4646.0 4960.3 4984.4 5007.4 5016.3 5065.7 4781.3 4978.7 5023.3 5052.2 5076.0 4718.4 4742.3 4752.0 4769.1 4811.7 5103.5 5113.2 5122.3 5128.2 5147.9 4653.1 4896.9 4919.8 4943.7 4960.0 5009.9 5030.9 5038.9 5041.0 5077.0 4765.1 4825.9 4829.4 4837.5 4841.7 4842.5 4947.1 4958.7 4969.5 5020.2 4131.5 4207.8 4215.3 4220.6 4257.1 3703.6 3733.6 3742.0 3773.3 3774.4 4354.7 4369.5 4385.3 4388.8 4405.4 4860.1 5019.1 5058.6 5086.6 5117.3 4352.7 4355.4 4355.8 4384.3 4394.8 4484.9 4522.4 4541.4 4550.5 4598.5 4700.6 4706.7 4765.1 4800.4 4805.0 5029.3 5041.7 5054.2 5057.8 5119.8 4603.4 4783.5 4805.6 4814.0 4860.5 4892.1 4949.9 4962.8 4963.2 4965.8 4997.9 5044.6 5046.6 5061.8 5087.9 4696.4 4858.4 4860.9 4891.2 4959.5 4650.3 4789.4 4833.7 4877.4 4904.1 4817.9 4836.0 4836.2 4868.5 4887.0 4753.6 4929.8 4947.4 4950.1 4951.9 4723.2 4773.3 4780.9 4797.0 4817.5 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | [#1] ext.html Cycles:180 Average:45690.89 Median:34680.91 stddev:80134.39 (231.1%) stddev-sans-first:80287.61 17:45:42 INFO - PROCESS | 5178 | Values: 580.2 595.0 614.0 634.5 655.4 33694.8 34561.8 34660.7 34693.5 34718.5 34185.0 34525.5 34759.0 34767.3 34873.1 7467.9 7608.4 7617.2 7625.2 7636.1 7507.6 7735.7 7754.6 7760.0 7770.5 7713.6 7791.4 7840.7 7842.3 7863.6 7732.4 7760.0 7766.8 7773.0 7778.3 7648.5 7764.7 7768.4 7774.6 7791.8 29230.3 34361.5 34478.3 34667.1 34687.0 2932.6 3043.2 3051.6 3336.6 3511.7 26954.6 27016.3 27562.0 27564.2 27755.3 2939.6 2961.6 2988.5 2994.9 3061.7 238917.0 245394.0 245712.0 246072.0 246779.0 52855.7 53209.5 53241.7 53289.0 53321.5 60829.7 62048.0 63963.4 64081.7 64150.0 13654.7 13841.3 13848.2 13926.3 13939.2 9632.8 9651.7 9654.8 9714.2 9714.6 19326.4 19361.2 19407.9 19423.6 19520.2 7548.6 7600.8 7658.3 7838.9 7853.2 908.0 920.7 923.5 928.5 997.2 26830.7 27647.9 27891.4 27941.6 28137.6 987.3 1016.5 1028.1 1100.7 1104.5 14666.7 14968.8 15139.5 15402.2 15430.0 340313.0 344872.0 348269.0 350105.0 350377.0 47963.3 48943.8 48952.0 48978.5 49329.8 1195.8 1231.2 1236.0 1251.2 1338.0 26429.6 27629.3 27739.9 27871.0 28203.0 41273.0 41592.8 42127.0 42138.4 42194.2 312242.0 314249.0 314924.0 315729.2 316291.0 25604.7 25922.4 26078.3 26190.5 40492.0 40648.2 40903.6 41244.8 41274.4 41445.4 34005.8 34071.5 34244.1 34251.1 34404.0 34004.8 34615.0 34650.5 34674.8 34854.8 31736.0 34994.5 35101.8 36790.3 37397.8 29332.7 31919.0 33949.7 36245.6 36585.0 24351.4 24760.0 24854.1 24976.1 25134.2 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | [#2] jquery.html Cycles:180 Average:17004.29 Median:5160.92 stddev:27416.04 (531.2%) stddev-sans-first:27464.53 17:45:42 INFO - PROCESS | 5178 | Values: 378.6 386.9 389.2 395.8 402.2 13114.6 15564.7 15955.7 17126.5 17732.8 15095.5 15317.5 15513.7 16361.9 16366.4 4590.7 5085.7 5200.8 5250.3 5319.7 5165.2 5183.8 5189.7 5217.7 5234.2 5148.5 5148.9 5156.6 5181.9 5188.4 5067.1 5204.4 5228.3 5238.3 5239.6 4486.2 4622.3 4649.0 4653.1 4672.3 20301.7 20506.6 20513.7 20542.3 20788.7 1909.0 1953.6 2057.5 2123.5 2401.7 12844.0 12954.0 13259.1 13304.8 13479.5 1762.0 1766.1 1767.3 1828.6 1883.6 65810.3 66135.0 67149.7 68598.0 69650.0 9221.6 9235.4 9400.7 9462.1 9686.6 11529.4 12154.8 13140.9 13164.9 13200.3 6433.7 6747.1 6752.6 6876.6 7182.6 6480.9 6517.8 6579.6 6591.9 6652.3 5987.4 6001.3 6041.7 6169.4 6192.8 1769.8 1777.8 1781.8 1813.7 1821.7 854.4 857.0 889.0 891.5 929.5 16016.5 16677.8 16731.6 16787.7 17140.2 793.3 881.7 910.7 918.0 921.8 8581.9 8844.7 8845.5 8895.9 9029.2 142478.0 142871.3 144159.0 145094.0 145534.3 73479.6 74558.0 78618.0 79456.0 79624.2 944.7 1009.5 1012.8 1030.1 1040.3 14722.0 15115.7 15336.9 15432.9 15532.7 23341.5 23934.5 34538.8 34641.8 34704.3 41491.6 48843.0 49567.5 50240.7 50420.2 6555.7 7117.1 7691.8 7800.8 7936.8 10285.0 11033.4 11041.7 11362.6 11816.6 6538.6 8907.8 9236.3 9490.3 9560.7 9536.0 9807.9 9896.2 9951.4 10041.9 9414.6 9682.9 9729.2 9784.9 9913.5 7240.2 7543.5 7600.5 7712.8 7788.3 8875.2 9002.7 9158.5 9167.0 9293.4 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | [#3] mootools.html Cycles:180 Average:5225.50 Median:5727.13 stddev:2870.73 (50.1%) stddev-sans-first:2864.59 17:45:42 INFO - PROCESS | 5178 | Values: 1426.9 1478.6 1592.7 1727.9 1790.4 7005.9 7610.3 7665.0 7872.6 7893.1 7652.7 7700.5 7704.7 7746.3 7764.7 2207.4 2213.5 2228.0 2229.5 2232.2 2127.6 2170.2 2203.2 2223.1 2235.4 2135.5 2166.3 2168.9 2173.7 2200.1 2114.5 2123.0 2123.3 2128.0 2129.7 2195.6 2232.5 2241.0 2253.7 2254.4 7840.2 7943.8 7967.8 7994.5 7995.0 4670.8 4797.1 4804.9 4820.6 4830.4 2830.7 2901.5 2918.8 2948.0 2953.9 922.7 932.7 944.4 946.5 949.6 10574.1 10625.6 10661.1 10662.7 10682.6 4191.7 4274.9 4333.8 4402.4 4442.2 9141.5 9179.6 9198.3 9207.4 9211.7 4695.1 4736.3 4742.4 4755.5 4780.7 3647.8 4162.0 4284.2 4336.5 4341.0 3648.7 3752.8 3767.4 3798.5 3888.7 1243.1 1295.7 1299.6 1301.7 1303.6 758.5 841.7 869.8 887.0 893.7 5498.0 5615.4 5774.2 5821.8 5916.9 947.2 961.9 986.5 998.8 1016.1 3690.2 3826.2 3831.0 3862.5 3896.1 9541.7 9724.9 9825.4 9855.9 9860.0 9708.8 9760.4 9763.7 9769.6 9775.8 7126.9 7268.5 7510.1 7522.0 7597.0 5523.7 5625.8 5715.9 5738.3 5782.4 9046.1 9096.6 9141.4 9153.5 9202.6 8386.2 8864.9 8879.9 8902.2 8940.6 6108.1 6710.4 6722.9 6885.8 6908.2 7445.2 7507.6 7544.1 7554.1 7558.8 6662.9 6761.6 6849.2 6916.6 6921.3 6409.3 6485.2 6692.7 6824.4 6844.2 6383.7 6430.4 6461.0 6466.2 6483.8 4800.2 4810.9 4916.3 4929.7 4994.6 4590.7 4597.3 4623.6 4714.4 4742.8 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | [#4] prototype.html Cycles:180 Average:4548.78 Median:5227.15 stddev:1308.27 (25.0%) stddev-sans-first:1272.80 17:45:42 INFO - PROCESS | 5178 | Values: 317.0 324.2 326.4 328.2 328.3 5204.6 5249.4 5285.0 5292.2 5329.9 5163.5 5181.1 5196.9 5220.2 5234.1 3822.6 3955.3 4102.9 4103.8 4109.9 4117.9 4124.6 4138.8 4150.9 4154.3 4105.7 4117.4 4119.8 4123.3 4130.3 4026.6 4055.6 4094.5 4109.2 4121.3 3592.8 3593.4 3598.8 3604.9 3625.7 4889.8 4938.6 4940.8 4943.3 4974.1 4572.1 4622.1 4653.4 4665.0 4687.0 5425.9 5426.0 5431.4 5449.2 5476.2 3935.7 3943.1 3948.9 3961.2 3961.2 5554.6 5664.4 5736.0 5739.8 5742.8 4009.8 4013.0 4016.5 4020.3 4031.5 4104.4 4113.8 4131.8 4132.6 4137.6 4653.0 4668.1 4669.7 4669.8 4683.6 5274.4 5476.6 5478.5 5487.6 5502.4 1409.8 1442.4 1442.7 1443.3 1443.8 903.8 960.7 969.1 970.9 988.0 4744.3 4773.2 4773.8 4781.4 4794.2 5586.5 5603.5 5606.6 5627.4 5631.0 4613.1 4745.8 4767.2 4772.1 4783.1 2990.7 2993.2 3003.5 3007.9 3018.2 5308.2 5310.7 5318.0 5321.7 5327.5 5630.6 5736.9 5744.3 5763.9 5809.1 5292.3 5305.2 5310.5 5310.5 5325.3 5405.1 5568.2 5587.2 5588.6 5595.9 5506.1 5526.6 5529.8 5539.2 5548.3 5247.1 5271.8 5304.6 5310.6 5358.5 3726.9 4051.3 4051.7 4053.7 4073.5 5600.6 5617.5 5650.1 5650.7 5652.7 5458.6 5479.3 5490.2 5492.3 5506.8 5345.6 5467.2 5490.7 5499.1 5504.4 5366.8 5395.5 5395.6 5400.1 5401.6 5214.4 5340.2 5531.1 5550.6 5555.2 5396.9 5398.9 5434.6 5444.6 5459.0 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - PROCESS | 5178 | [#5] yui.html Cycles:180 Average:12382.88 Median:473.02 stddev:14243.96 (3011.3%) stddev-sans-first:14256.99 17:45:42 INFO - PROCESS | 5178 | Values: 719.6 734.6 743.7 745.6 764.7 10963.2 11020.5 11100.1 11112.1 11221.9 11259.9 11362.3 11367.7 11437.7 11499.8 641.1 797.0 810.3 810.5 813.4 791.6 808.7 819.6 820.8 826.2 862.2 863.2 867.4 867.8 868.9 847.5 851.6 853.3 857.1 859.6 628.6 629.0 629.4 631.6 632.5 11680.4 11688.2 11688.9 11737.4 11751.6 12406.2 12510.9 12548.6 12603.3 13061.5 9397.9 9398.9 9433.7 9438.8 9550.2 2898.7 2919.8 2926.2 2938.4 2961.8 44512.0 44527.8 44560.0 44808.8 46569.8 9141.3 9218.9 9588.5 9724.7 9764.7 17085.0 17120.5 17197.1 17198.0 17248.1 6400.7 6469.0 6506.3 6600.0 6619.8 3177.8 3190.6 3217.0 3233.5 3236.0 2595.8 2659.1 2660.4 2679.5 2696.0 457.6 462.3 469.1 481.2 483.9 518.2 523.8 545.1 565.8 570.6 7699.4 7721.0 7857.7 7935.6 7955.1 477.0 479.4 561.7 568.9 575.2 3614.2 3643.2 3646.0 3676.7 3747.7 50381.5 52245.7 52498.7 52512.7 52865.5 43928.0 45115.3 45124.8 45455.0 45619.5 42335.4 42413.2 42519.6 42826.8 43320.0 7056.4 7119.2 7141.2 7310.5 7435.6 28186.4 28527.0 28790.3 28862.6 28905.7 35292.0 36663.5 38250.2 38559.6 38663.0 9734.6 9814.8 9914.9 9924.2 10554.7 11495.6 11529.3 11536.1 11567.5 11979.6 10215.7 10500.9 10657.4 11344.9 11570.9 9220.3 9498.7 9921.6 10012.6 10504.5 10719.6 10794.0 11030.4 11344.1 11560.4 9385.9 9393.0 9639.3 9790.8 9791.7 8331.7 8507.7 8702.2 8873.8 8902.9 17:45:42 INFO - PROCESS | 5178 | -------- Summary: end -------- 17:45:42 INFO - PROCESS | 5178 | 17:45:42 INFO - TEST-INFO | 5178: exit 0 17:45:42 INFO - TEST-OK | dromaeo_css | took 1115751ms 17:45:42 INFO - TEST-START | kraken 17:45:42 INFO - operating with platform_type : linux_ 17:45:42 INFO - Initialising browser for kraken test... 17:45:42 INFO - TEST-INFO | started process 5406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx_a67D/profile http://localhost:60580/getInfo.html) 17:45:46 INFO - PROCESS | 5406 | 17:45:46 INFO - PROCESS | 5406 | (process:5476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:45:47 INFO - PROCESS | 5406 | __metrics Screen width/height:1600/1200 17:45:47 INFO - PROCESS | 5406 | colorDepth:24 17:45:47 INFO - PROCESS | 5406 | Browser inner width/height: 1024/697 17:45:47 INFO - PROCESS | 5406 | __metrics 17:45:48 ERROR - PROCESS | 5406 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:45:49 INFO - TEST-INFO | 5406: exit 0 17:45:49 INFO - Browser initialized. 17:45:49 INFO - Running cycle 1/1 for kraken test... 17:45:49 INFO - TEST-INFO | started process 5527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx_a67D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:51 INFO - PROCESS | 5527 | 17:45:51 INFO - PROCESS | 5527 | (process:5587): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:46:01 INFO - PROCESS | 5527 | RSS: Main: 164782080 17:46:01 INFO - PROCESS | 5527 | 17:46:04 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60580/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:05 INFO - PROCESS | 5527 | RSS: Main: 169160704 17:46:05 INFO - PROCESS | 5527 | 17:46:07 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60580/tests/kraken/driver.html?testName=audio-dft) 17:46:08 INFO - PROCESS | 5527 | RSS: Main: 172474368 17:46:08 INFO - PROCESS | 5527 | 17:46:11 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60580/tests/kraken/driver.html?testName=audio-fft) 17:46:12 INFO - PROCESS | 5527 | RSS: Main: 162885632 17:46:12 INFO - PROCESS | 5527 | 17:46:14 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60580/tests/kraken/driver.html?testName=audio-oscillator) 17:46:14 INFO - PROCESS | 5527 | RSS: Main: 164114432 17:46:14 INFO - PROCESS | 5527 | 17:46:17 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:17 INFO - PROCESS | 5527 | RSS: Main: 164761600 17:46:17 INFO - PROCESS | 5527 | 17:46:20 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60580/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:21 INFO - PROCESS | 5527 | RSS: Main: 165007360 17:46:21 INFO - PROCESS | 5527 | 17:46:24 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60580/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:25 INFO - PROCESS | 5527 | RSS: Main: 164483072 17:46:25 INFO - PROCESS | 5527 | 17:46:28 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60580/tests/kraken/driver.html?testName=json-parse-financial) 17:46:29 INFO - PROCESS | 5527 | RSS: Main: 165052416 17:46:29 INFO - PROCESS | 5527 | 17:46:30 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:31 INFO - PROCESS | 5527 | RSS: Main: 165801984 17:46:31 INFO - PROCESS | 5527 | 17:46:33 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:34 INFO - PROCESS | 5527 | RSS: Main: 165650432 17:46:34 INFO - PROCESS | 5527 | 17:46:36 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:36 INFO - PROCESS | 5527 | RSS: Main: 166031360 17:46:36 INFO - PROCESS | 5527 | 17:46:39 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:40 INFO - PROCESS | 5527 | RSS: Main: 166178816 17:46:40 INFO - PROCESS | 5527 | 17:46:43 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:43 INFO - PROCESS | 5527 | RSS: Main: 165982208 17:46:43 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | Cycle 1(1): loaded http://localhost:60580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60580/tests/kraken/driver.html?testName=ai-astar) 17:46:45 INFO - PROCESS | 5527 | RSS: Main: 167481344 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | __start_tp_report 17:46:45 INFO - PROCESS | 5527 | _x_x_mozilla_page_load 17:46:45 INFO - PROCESS | 5527 | _x_x_mozilla_page_load_details 17:46:45 INFO - PROCESS | 5527 | |i|pagename|runs| 17:46:45 INFO - PROCESS | 5527 | |0;ai-astar;113;107;114;116;114;125;123;112;114;112 17:46:45 INFO - PROCESS | 5527 | |1;audio-beat-detection;172;133;162;191;135;166;159;140;194;133 17:46:45 INFO - PROCESS | 5527 | |2;audio-dft;162;162;163;174;161;165;162;163;165;163 17:46:45 INFO - PROCESS | 5527 | |3;audio-fft;72;73;74;173;76;77;77;77;153;74 17:46:45 INFO - PROCESS | 5527 | |4;audio-oscillator;95;96;138;95;95;95;144;93;94;142 17:46:45 INFO - PROCESS | 5527 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;117;117;118 17:46:45 INFO - PROCESS | 5527 | |6;imaging-darkroom;147;147;147;148;147;147;146;147;147;147 17:46:45 INFO - PROCESS | 5527 | |7;imaging-desaturate;96;95;96;95;95;95;95;96;95;96 17:46:45 INFO - PROCESS | 5527 | |8;json-parse-financial;65;65;65;64;65;65;63;92;63;61 17:46:45 INFO - PROCESS | 5527 | |9;json-stringify-tinderbox;64;65;66;64;65;65;65;65;65;66 17:46:45 INFO - PROCESS | 5527 | |10;stanford-crypto-aes;80;79;87;79;82;79;83;82;80;81 17:46:45 INFO - PROCESS | 5527 | |11;stanford-crypto-ccm;138;136;143;136;134;133;134;139;169;138 17:46:45 INFO - PROCESS | 5527 | |12;stanford-crypto-pbkdf2;175;182;174;173;175;173;172;171;181;173 17:46:45 INFO - PROCESS | 5527 | |13;stanford-crypto-sha256-iterative;72;73;72;73;72;71;71;73;74;74 17:46:45 INFO - PROCESS | 5527 | __end_tp_report 17:46:45 INFO - PROCESS | 5527 | __start_cc_report 17:46:45 INFO - PROCESS | 5527 | _x_x_mozilla_cycle_collect,911 17:46:45 INFO - PROCESS | 5527 | __end_cc_report 17:46:45 INFO - PROCESS | 5527 | __startTimestamp1461113205968__endTimestamp 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | ------- Summary: start ------- 17:46:45 INFO - PROCESS | 5527 | Number of tests: 14 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:5.31 (4.7%) stddev-sans-first:5.59 17:46:45 INFO - PROCESS | 5527 | Values: 113.0 107.0 114.0 116.0 114.0 125.0 123.0 112.0 114.0 112.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#1] audio-beat-detection Cycles:10 Average:158.50 Median:164.00 stddev:23.00 (14.0%) stddev-sans-first:23.87 17:46:45 INFO - PROCESS | 5527 | Values: 172.0 133.0 162.0 191.0 135.0 166.0 159.0 140.0 194.0 133.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.74 (2.3%) stddev-sans-first:3.90 17:46:45 INFO - PROCESS | 5527 | Values: 162.0 162.0 163.0 174.0 161.0 165.0 162.0 163.0 165.0 163.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:37.44 (49.9%) stddev-sans-first:38.97 17:46:45 INFO - PROCESS | 5527 | Values: 72.0 73.0 74.0 173.0 76.0 77.0 77.0 77.0 153.0 74.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:22.58 (23.8%) stddev-sans-first:23.40 17:46:45 INFO - PROCESS | 5527 | Values: 95.0 96.0 138.0 95.0 95.0 95.0 144.0 93.0 94.0 142.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:46:45 INFO - PROCESS | 5527 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 17:46:45 INFO - PROCESS | 5527 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:46:45 INFO - PROCESS | 5527 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:65.00 stddev:8.95 (13.8%) stddev-sans-first:9.47 17:46:45 INFO - PROCESS | 5527 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 63.0 92.0 63.0 61.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 17:46:45 INFO - PROCESS | 5527 | Values: 64.0 65.0 66.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:2.49 (3.0%) stddev-sans-first:2.60 17:46:45 INFO - PROCESS | 5527 | Values: 80.0 79.0 87.0 79.0 82.0 79.0 83.0 82.0 80.0 81.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:138.00 stddev:10.60 (7.7%) stddev-sans-first:11.22 17:46:45 INFO - PROCESS | 5527 | Values: 138.0 136.0 143.0 136.0 134.0 133.0 134.0 139.0 169.0 138.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.50 stddev:3.70 (2.1%) stddev-sans-first:3.92 17:46:45 INFO - PROCESS | 5527 | Values: 175.0 182.0 174.0 173.0 175.0 173.0 172.0 171.0 181.0 173.0 17:46:45 INFO - PROCESS | 5527 | 17:46:45 INFO - PROCESS | 5527 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 17:46:45 INFO - PROCESS | 5527 | Values: 72.0 73.0 72.0 73.0 72.0 71.0 71.0 73.0 74.0 74.0 17:46:45 INFO - PROCESS | 5527 | -------- Summary: end -------- 17:46:45 INFO - PROCESS | 5527 | 17:46:46 INFO - TEST-INFO | 5527: exit 0 17:46:46 INFO - TEST-OK | kraken | took 64261ms 17:46:46 INFO - SUITE-END | took 1180s 17:46:47 INFO - Completed test suite (00:19:40) 17:46:47 INFO - javascript benchmark 17:46:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.47079848631, 2680.1155618645835, 2680.9329766755827, 2684.355754618891, 2700.2169370882443, 4659.836905708301, 4690.1792186367375, 4699.4595621503495, 4701.2478003519445, 4744.833930812422, 4522.864314070575, 4670.042641258542, 4702.271147972061, 4777.498362671921, 4782.856514304568, 4304.870853874381, 4329.783510824462, 4367.956320436787, 4374.825006999732, 4419.491758447787, 4333.544977777336, 4436.889077773049, 4453.176162409948, 4464.620507256887, 4473.686841921067, 4236.85171019016, 4240.23675738367, 4311.676624253162, 4378.584034516716, 4430.180416622935, 4235.851745188904, 4326.0, 4335.978320108411, 4350.499692535335, 4376.321670141133, 4351.782410879443, 4359.128174365108, 4373.628241599468, 4378.540253273424, 4416.227160246944, 4551.385562949025, 4600.838970636011, 4609.308603709437, 4633.930491042637, 4645.976770116162, 4960.2559616057515, 4984.352034235562, 5007.37407824022, 5016.3227964224725, 5065.696058236481, 4781.258904869751, 4978.6514943953935, 5023.32185155003, 5052.216906379517, 5076.0, 4718.363020992157, 4742.288656701522, 4751.952480475151, 4769.141554520185, 4811.663183577116, 5103.464136265713, 5113.15632920564, 5122.282880396748, 5128.230765385148, 5147.948520514822, 4653.139169253699, 4896.902061958741, 4919.7540122993705, 4943.678660887031, 4960.0, 5009.874753131128, 5030.89938201234, 5038.874028149326, 5040.974795126001, 5077.0, 4765.070811191854, 4825.855224343275, 4829.396325459317, 4837.467878533358, 4841.661083724176, 4842.467328593852, 4947.084789313988, 4958.652894297436, 4969.503049695074, 5020.221865610836, 4131.483564554431, 4207.768572728468, 4215.325547912381, 4220.620144187038, 4257.106007738348, 3703.6296370362747, 3733.5893051764283, 3742.045778326509, 3773.3019391412677, 3774.3960966245268, 4354.673399495051, 4369.519352871182, 4385.298352263686, 4388.802503887333, 4405.427294451701, 4860.149473842063, 5019.07147177766, 5058.64589478733, 5086.64393492452, 5117.257997590403, 4352.673549483801, 4355.3684715716045, 4355.760433176206, 4384.276594361958, 4394.8242070317465, 4484.910301793946, 4522.4346956630425, 4541.3869127668, 4550.47669518003, 4598.494165641777, 4700.600448961808, 4706.694064885772, 4765.070811191785, 4800.4479484859685, 4805.014971930816, 5029.346184996073, 5041.747912604428, 5054.241863720325, 5057.772400242072, 5119.820806271762, 4603.378543896665, 4783.4738178801, 4805.567498925114, 4814.013127308824, 4860.465348811698, 4892.0705066037335, 4949.851504454872, 4962.751862406793, 4963.181075122564, 4965.776540055778, 4997.925031124463, 5044.571211446922, 5046.621503387334, 5061.797528098835, 5087.898242035212, 4696.436427628706, 4858.368412106545, 4860.854174374775, 4891.192953162688, 4959.528844759742, 4650.255959046536, 4789.353437285922, 4833.73414462208, 4877.365942427462, 4904.117258893433, 4817.940053188293, 4835.95164048355, 4836.226203807374, 4868.513148685103, 4886.975565122151, 4753.595944344769, 4929.802807887644, 4947.431045429822, 4950.133726597759, 4951.876203094951, 4723.173444647242, 4773.284007398918, 4780.928286075781, 4797.040591881568, 4817.494163112963], "value": 4610.055921832076, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1616663920634, 594.991075133873, 614.0482252508612, 634.5399585300655, 655.4199533412929, 33694.83152584237, 34561.82719086401, 34660.653393466055, 34693.47959780605, 34718.47922281165, 34185.0, 34525.48211776819, 34759.0, 34767.304653906904, 34873.12817179565, 7467.925320746777, 7608.391328693719, 7617.2001939796355, 7625.161232264447, 7636.083669959613, 7507.624618769067, 7735.72924947627, 7754.612269386508, 7760.029996250469, 7770.4560680752365, 7713.5757533335645, 7791.3766898648255, 7840.725574604861, 7842.254985776342, 7863.606819659023, 7732.381409487228, 7759.961200193991, 7766.805829854271, 7773.028371453568, 7778.261065198853, 7648.541087534766, 7764.689412423496, 7768.417368697314, 7774.611269436562, 7791.766247012599, 29230.269243268875, 34361.48457773135, 34478.310433791434, 34667.13332166691, 34687.0, 2932.6040984467036, 3043.223977885647, 3051.649060358065, 3336.582927134108, 3511.701505372021, 26954.5956810648, 27016.324591885164, 27562.0, 27564.173074807786, 27755.306117347027, 2939.556486227667, 2961.5557666350005, 2988.5218365061705, 2994.925126871824, 3061.663217046123, 238917.0, 245394.0, 245712.0, 246072.0, 246779.0, 52855.73572132115, 53209.46790532045, 53241.73379133157, 53289.0, 53321.46678533243, 60829.69585152134, 62048.0, 63963.36036639667, 64081.67959160174, 64150.0, 13654.658633534042, 13841.30793460323, 13848.16910985324, 13926.30368481592, 13939.233342166075, 9632.75918102039, 9651.71044868655, 9654.75863103414, 9714.22286217101, 9714.61141554344, 19326.424611446928, 19361.225550978084, 19407.902960485106, 19423.611527769648, 19520.219191232474, 7548.641244576029, 7600.771976840703, 7658.310752032344, 7838.921610783933, 7853.214678532101, 907.9921287371013, 920.6501529418778, 923.4643906534194, 928.4522131942051, 997.152420442618, 26830.731692683214, 27647.861760691067, 27891.442171156465, 27941.580876286873, 28137.57793633097, 987.3434166279344, 1016.4968340671415, 1028.1466382902174, 1100.7028102412303, 1104.536094840153, 14666.706665866623, 14968.775468367983, 15139.470118546018, 15402.15288159162, 15430.0, 340313.0, 344872.0, 348269.0, 350105.0, 350377.0, 47963.280550791766, 48943.75528122336, 48952.0, 48978.51021489811, 49329.75335123373, 1195.7548702515962, 1231.1928802330879, 1236.0, 1251.2117366059324, 1338.0098726941992, 26429.60355594629, 27629.309267267676, 27739.861300693367, 27871.0, 28203.0, 41273.0, 41592.792036039624, 42127.0, 42138.36792448177, 42194.156116876875, 312242.0, 314249.0, 314924.0, 315729.1630211458, 316291.0, 25604.74395256098, 25922.35194120162, 26078.34804129836, 26190.476190476464, 40492.0, 40648.187036259704, 40903.59096408998, 41244.79377603213, 41274.38088428616, 41445.378319325835, 34005.82997084999, 34071.48892766561, 34244.143896401794, 34251.14372140716, 34404.0, 34004.82997584996, 34615.0, 34650.48024279688, 34674.826625866706, 34854.82572587121, 31736.0, 34994.475082873265, 35101.824490877385, 36790.26419471542, 37397.81301093477, 29332.706672932996, 31919.0, 33949.66050339465, 36245.63754362422, 36585.0, 24351.391215219763, 24760.0, 24854.130105446224, 24976.125835595667, 25134.24597262085], "value": 17306.09243249621, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6459660217696, 386.8645973909132, 389.1574740686414, 395.778364116095, 402.17353338888574, 13114.606561803137, 15564.688706225868, 15955.680886382266, 17126.486205413843, 17732.758706890505, 15095.547133585982, 15317.463888763896, 15513.689726205497, 16361.918190409031, 16366.427175048875, 4590.701604395712, 5085.720285384321, 5200.791968321262, 5250.343707036621, 5319.680819150844, 5165.22521621756, 5183.844484665447, 5189.714565698885, 5217.713025783581, 5234.241035049916, 5148.459411761767, 5148.948510514903, 5156.613254005964, 5181.896362072756, 5188.429272779991, 5067.0879241736475, 5204.375474943031, 5228.294180285669, 5238.292830467895, 5239.5546378557865, 4486.192485352635, 4622.306654001926, 4648.976755116237, 4653.092646933849, 4672.322513235596, 20301.695474567747, 20506.58986820255, 20513.692294615594, 20542.281020164224, 20788.688169677465, 1909.0, 1953.5702145527962, 2057.4753437873396, 2123.4797474618817, 2401.6637670726113, 12844.0, 12954.0, 13259.138156019828, 13304.800427993589, 13479.528216512375, 1761.9647607047916, 1766.0721979823409, 1767.3460819496868, 1828.6068495273446, 1883.5950270691867, 65810.34189658138, 66135.0, 67149.66425167891, 68598.0, 69650.0, 9221.585028673726, 9235.353525253302, 9400.717978460658, 9462.053794620482, 9686.564104615169, 11529.423528823525, 12154.817677734842, 13140.868591314156, 13164.934175329254, 13200.339983000811, 6433.742650293936, 6747.122874026345, 6752.628605426748, 6876.553024053421, 7182.569045857161, 6480.935190648033, 6517.837054073686, 6579.605223686594, 6591.868162636721, 6652.301508341651, 5987.401259873977, 6001.3098493672915, 6041.72812223451, 6169.352218017133, 6192.783252586138, 1769.7523246111462, 1777.8399944004843, 1781.8040015598274, 1813.6826055440245, 1821.6629923464202, 854.4104567848165, 857.0401150711119, 888.9911100889037, 891.5497673674753, 929.5259417696888, 16016.519504414886, 16677.833221667872, 16731.581710457336, 16787.748183777254, 17140.228689708994, 793.349453448167, 881.6517475597103, 910.7222297199286, 918.0223062438482, 921.801812610292, 8581.871271930926, 8844.73465796027, 8845.513496757612, 8895.911040889638, 9029.232515236146, 142478.0, 142871.28564357111, 144159.0, 145094.0, 145534.2723286398, 73479.63260183665, 74558.0, 78618.0, 79456.0, 79624.20375796167, 944.6599224279254, 1009.4700282351678, 1012.8176928153003, 1030.1038096855784, 1040.2822052783556, 14722.0, 15115.697686045998, 15336.923315383352, 15432.92283538575, 15532.689346212786, 23341.533169336857, 23934.521309573363, 34538.82730586432, 34641.82679086588, 34704.30591388208, 41491.58508414998, 48843.0, 49567.50432495629, 50240.748796255786, 50420.24369634385, 6555.704993275219, 7117.074780278531, 7691.769246922601, 7800.84398312042, 7936.84126317482, 10285.02292282232, 11033.448327583428, 11041.723956901142, 11362.602308919148, 11816.586419475278, 6538.640374779433, 8907.821843563223, 9236.26109911192, 9490.28822838276, 9560.713178604376, 9535.952320238355, 9807.852882206915, 9896.158826499828, 9951.402915825074, 10041.899581004389, 9414.576344064397, 9682.851249962872, 9729.22166226686, 9784.85322720174, 9913.504324783877, 7240.203577606354, 7543.47195696296, 7600.50596711212, 7712.768616941501, 7788.299053085023, 8875.245604123722, 9002.729918102468, 9158.496282704515, 9166.954165229132, 9293.395929264576], "value": 7862.078483952147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.8715815576595, 1478.5638236720167, 1592.7053495103407, 1727.8531324837388, 1790.4449620617609, 7005.894911576331, 7610.315071643551, 7664.96167519163, 7872.5670088145125, 7893.13175550689, 7652.693892244318, 7700.537967721926, 7704.6918123275, 7746.264104910025, 7764.728234511793, 2207.4260692219977, 2213.5351576169023, 2227.986266248853, 2229.4649284171765, 2232.174095584636, 2127.606392817326, 2170.218721260345, 2203.2178576605234, 2223.1218668625884, 2235.3964429604, 2135.5301833596664, 2166.2851259084464, 2168.945776355588, 2173.652215645497, 2200.1309482754305, 2114.5136618577735, 2122.9893850530725, 2123.3099242746093, 2128.042380928573, 2129.7231359923267, 2195.637719776235, 2232.464208589943, 2241.0363543676376, 2253.7295524537, 2254.368776742515, 7840.176781437924, 7943.801404964922, 7967.800804979864, 7994.480358776719, 7995.040595128622, 4670.7664616769025, 4797.112534181188, 4804.903901921942, 4820.614350851958, 4830.396200474941, 2830.716928307153, 2901.4777340078776, 2918.7810914181523, 2947.970520294791, 2953.867075981586, 922.7185708358948, 932.7481579973369, 944.4380593546829, 946.4936259101348, 949.6154057606681, 10574.10120139789, 10625.574977000912, 10661.147108231324, 10662.733431664194, 10682.572697092108, 4191.685623578243, 4274.914501709948, 4333.783310834446, 4402.3711226845635, 4442.155990361821, 9141.451512909247, 9179.58691858868, 9198.310126740522, 9207.447553146832, 9211.677591284273, 4695.060987802453, 4736.289556566474, 4742.430908291027, 4755.476897541268, 4780.665353425296, 3647.8176091195332, 4161.9583804161575, 4284.207421627009, 4336.501302350207, 4340.956590434118, 3648.689861361814, 3752.849886004584, 3767.3595488766973, 3798.4682144499793, 3888.650021498079, 1243.1422318600319, 1295.6501744529112, 1299.636101891472, 1301.6745813546613, 1303.641498587896, 758.4766511107318, 841.7390608911257, 869.7608157756541, 887.0331338840695, 893.6872094766779, 5498.0, 5615.354234263031, 5774.220480235199, 5821.825345239649, 5916.852078697981, 947.2327414794039, 961.927855410833, 986.4820968991337, 998.8102260570469, 1016.1210552871861, 3690.206605579813, 3826.1582451860545, 3830.9616903830606, 3862.4592557042038, 3896.1428485733095, 9541.713748587554, 9724.854127188099, 9825.361351512129, 9855.852162217572, 9859.950700246596, 9708.805823883482, 9760.365576237522, 9763.658271960589, 9769.609215631437, 9775.804483910424, 7126.857462850818, 7268.491205615556, 7510.1363343215135, 7522.0, 7597.0, 5523.696196709219, 5625.803096891589, 5715.914261286167, 5738.340090889435, 5782.421757824184, 9046.095390460901, 9096.636134554543, 9141.3601047926, 9153.496557689392, 9202.585883635118, 8386.203310685476, 8864.911350886667, 8879.866801997847, 8902.243309318781, 8940.642374304955, 6108.08378743192, 6710.396064354231, 6722.865542689216, 6885.793426197021, 6908.2400935896, 7445.181030086795, 7507.624618769149, 7544.132424771222, 7554.093508778982, 7558.848823023619, 6662.933370666231, 6761.560498567577, 6849.212340580897, 6916.619585922823, 6921.307869213038, 6409.262934762562, 6485.189351331083, 6692.665366731741, 6824.4199243064895, 6844.247132815287, 6383.744650213939, 6430.421262086435, 6460.967695161494, 6466.224053113657, 6483.837904052436, 4800.183968725255, 4810.903781924412, 4916.3362946001835, 4929.704217746947, 4994.600431965507, 4590.678652494294, 4597.333386658849, 4623.606993405599, 4714.41704304724, 4742.78657460422], "value": 4241.817319492366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.98573564189616, 324.1571913026132, 326.42549113560136, 328.22866264278935, 328.2712378519685, 5204.583633309336, 5249.422563518015, 5285.0, 5292.153255479124, 5329.946700532993, 5163.483651634835, 5181.145111056671, 5196.8700782480455, 5220.190870415092, 5234.110201265785, 3822.57951625321, 3955.307821131305, 4102.938455923164, 4103.815328310233, 4109.856155034575, 4117.8764637060785, 4124.628783409493, 4138.772367519785, 4150.937735933963, 4154.252234597771, 4105.692073094515, 4117.444145040411, 4119.773412462313, 4123.340265557511, 4130.256553820311, 4026.5570787213383, 4055.580546808623, 4094.549599544048, 4109.157622687342, 4121.258173528764, 3592.76647017943, 3593.443016332473, 3598.8200589970397, 3604.945925811115, 3625.7461977661574, 4889.779959901813, 4938.580220681247, 4940.752962351904, 4943.332650092228, 4974.129527332739, 4572.1312950539295, 4622.14490319292, 4653.418322709661, 4665.0, 4686.953130468686, 5425.864353391157, 5426.023315803154, 5431.429699881534, 5449.182622606601, 5476.17857321401, 3935.724499285051, 3943.112799620091, 3948.9070792480034, 3961.187956468917, 3961.187956468917, 5554.638948468337, 5664.376918538957, 5735.971320143414, 5739.770409183628, 5742.770289188427, 4009.799510024487, 4013.0368711509027, 4016.5180178378196, 4020.276350256982, 4031.536373317106, 4104.4048612950955, 4113.753174809521, 4131.793410329532, 4132.648724858361, 4137.648299894482, 4652.976735116303, 4668.105774419813, 4669.731188168295, 4669.832541864534, 4683.648726345537, 5274.393444753902, 5476.561875049986, 5478.506934375925, 5487.5884308677005, 5502.449755024546, 1409.7673883809057, 1442.3653592419303, 1442.740306744796, 1443.3288520837862, 1443.7545617245094, 903.75146834621, 960.693113559231, 969.0987381734914, 970.8737864077766, 988.0239520958083, 4744.264638980963, 4773.164696178155, 4773.832915847928, 4781.378420805273, 4794.161021821167, 5586.497215250566, 5603.5237004854225, 5606.579506537026, 5627.352854421794, 5631.042722737145, 4613.123506533748, 4745.762711864462, 4767.165745994437, 4772.141014617402, 4783.062859541891, 2990.7308342249303, 2993.1918382037165, 3003.5044217703835, 3007.8646460909313, 3018.24543864034, 5308.203769434538, 5310.654807437504, 5318.0, 5321.73391330432, 5327.547158491571, 5630.577706672016, 5736.856578585485, 5744.310682718101, 5763.8559036024435, 5809.099589563624, 5292.259083728281, 5305.230741542455, 5310.468953104813, 5310.548603368679, 5325.281087053276, 5405.054115529688, 5568.192612071146, 5587.245721827501, 5588.552915766811, 5595.916061259003, 5506.1190209566275, 5526.640768350045, 5529.778808847762, 5539.169124631338, 5548.334199896039, 5247.107991641354, 5271.810554614403, 5304.628675992798, 5310.601704872072, 5358.544523715528, 3726.925461490701, 4051.2707712612014, 4051.736637118578, 4053.7365071270274, 4073.490813648294, 5600.635958662674, 5617.494425501724, 5650.124230744241, 5650.68921209321, 5652.7173641318595, 5458.590605704668, 5479.315085614298, 5490.203920431435, 5492.340919089735, 5506.752196151263, 5345.599080069088, 5467.20725494809, 5490.6980116094, 5499.102809530706, 5504.422035686195, 5366.812161574326, 5395.541378982831, 5395.595330350318, 5400.135978243462, 5401.594880384066, 5214.43566929912, 5340.2256672783005, 5531.1426728857095, 5550.555955523468, 5555.22226888244, 5396.9190462142315, 5398.946010540001, 5434.619576629756, 5444.646098003617, 5459.0], "value": 4135.797506489195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.5934297122129, 734.5886303669942, 743.7173873927907, 745.5750222373249, 764.728521374912, 10963.232573719843, 11020.50407731652, 11100.111991040718, 11112.055475284591, 11221.887781122186, 11259.943700281508, 11362.318260904352, 11367.658970230907, 11437.714057148576, 11499.770004599925, 641.1024565608162, 796.992030079699, 810.3355248696072, 810.5096416667919, 813.4305985809957, 791.635847510146, 808.7412028150994, 819.647551552832, 820.7578764264526, 826.1738261738262, 862.2067697718084, 863.2446609216935, 867.3581549653275, 867.7700409391516, 868.9217970382664, 847.5253857839599, 851.6040041380757, 853.3343991686463, 857.1214505132227, 859.5530324231427, 628.610261637783, 628.987420251597, 629.4492319220682, 631.6462780842697, 632.5287660692767, 11680.415979201007, 11688.181827272094, 11688.941555292255, 11737.354445505494, 11751.647450576496, 12406.19359741623, 12510.937445312715, 12548.560800371943, 12603.306818125, 13061.477540898353, 9397.859032114524, 9398.90601093987, 9433.669821556281, 9438.811223775487, 9550.188234000118, 2898.6666533348725, 2919.8102123361914, 2926.195296293515, 2938.3976284861765, 2961.7926745127847, 44512.0, 44527.77736111299, 44560.0, 44808.775956120335, 46569.767151164364, 9141.268698504236, 9218.907810921804, 9588.520573971273, 9724.659636912675, 9764.707058788248, 17085.0, 17120.486385408458, 17197.1401429928, 17198.0, 17248.137593120293, 6400.7119679614525, 6468.997305417668, 6506.251781045145, 6599.967000164968, 6619.8084344817435, 3177.809331440075, 3190.617125944855, 3216.967830321667, 3233.4988076848126, 3236.0, 2595.7793587544893, 2659.0959073914573, 2660.441307325483, 2679.4641071785722, 2696.042904768818, 457.5698843087487, 462.264998652138, 469.0525139218759, 481.1771870102095, 483.8524250103752, 518.1502336168686, 523.756453249241, 545.0869793096548, 565.801969310738, 570.6290910907943, 7699.422543309274, 7721.0, 7857.685692572233, 7935.6032198391, 7955.124936257007, 476.98330558430985, 479.42947892008397, 561.6854561445604, 568.877691296365, 575.246427180395, 3614.204874927512, 3643.1620727232353, 3645.9635403646153, 3676.7426280160666, 3747.681447077029, 50381.49618503768, 52245.7387713059, 52498.73750631299, 52512.73743631257, 52865.47134528682, 43928.0, 45115.32327015098, 45124.77437612857, 45455.0, 45619.54380456153, 42335.36496952548, 42413.15173696509, 42519.57480425218, 42826.78586607109, 43320.0, 7056.400205982549, 7119.2168861426235, 7141.214466408795, 7310.451716121206, 7435.553866768011, 28186.43627127405, 28527.001554945477, 28790.280242994093, 28862.567061494516, 28905.710942891143, 35292.0, 36663.45004824983, 38250.234995300496, 38559.61440385672, 38663.0, 9734.561944712646, 9814.803703926023, 9914.900850991398, 9924.15644670211, 10554.683359499228, 11495.597654082067, 11529.308241505536, 11536.134789890959, 11567.537298507965, 11979.580714674945, 10215.693529194135, 10500.947495262475, 10657.413842238751, 11344.886551134383, 11570.88429115698, 9220.262379009797, 9498.66754663611, 9921.603135874484, 10012.64955726546, 10504.527296271839, 10719.571217151226, 10794.0, 11030.44847757625, 11344.149188810707, 11560.42197890119, 9385.906140938503, 9393.0, 9639.277054220822, 9790.787894482835, 9791.706248812547, 8331.666733330841, 8507.723841423836, 8702.173293537104, 8873.778155546162, 8902.866457003021], "value": 5698.328094651845, "unit": "score"}], "name": "dromaeo_css", "value": 6303.150336050762, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 116.0, 114.0, 125.0, 123.0, 112.0, 114.0, 112.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 133.0, 162.0, 191.0, 135.0, 166.0, 159.0, 140.0, 194.0, 133.0], "value": 158.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 174.0, 161.0, 165.0, 162.0, 163.0, 165.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 173.0, 76.0, 77.0, 77.0, 77.0, 153.0, 74.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 138.0, 95.0, 95.0, 95.0, 144.0, 93.0, 94.0, 142.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 63.0, 92.0, 63.0, 61.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 87.0, 79.0, 82.0, 79.0, 83.0, 82.0, 80.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 143.0, 136.0, 134.0, 133.0, 134.0, 139.0, 169.0, 138.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 182.0, 174.0, 173.0, 175.0, 173.0, 172.0, 171.0, 181.0, 173.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 72.0, 71.0, 71.0, 73.0, 74.0, 74.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1599.3000000000002, "alertThreshold": 2.0}]} 17:46:47 INFO - Return code: 0 17:46:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:46:47 ERROR - # TBPL SUCCESS # 17:46:47 INFO - Running post-action listener: _resource_record_post_action 17:46:47 INFO - Running post-run listener: _resource_record_post_run 17:46:48 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 526376960; Read time: 288; Write time: 654180 17:46:48 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243593216; Read time: 0; Write time: 362724 17:46:48 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282783744; Read time: 288; Write time: 291456 17:46:48 INFO - Running post-run listener: _upload_blobber_files 17:46:48 INFO - Blob upload gear active. 17:46:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:46:48 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 17:46:48 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:46:48 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:46:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:50 INFO - (blobuploader) - INFO - Done attempting. 17:46:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:46:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:51 INFO - (blobuploader) - INFO - Done attempting. 17:46:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:46:51 INFO - Return code: 0 17:46:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:46:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:46:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c2434f57867d49f97da37cb49773e64bb1f6e258788caeeecf7faa32e01bab6f9cf9df90712150fedb008de0f76a421f88e078b9387c707a9fc8c1240118523d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad0449e653b42c81af902a8f0211044478997dd8fdf0ccc1123815d7ef7cf1a0e77b93cf6bef99b992b4f18cf395d04b4ab5889bc699c2c8a81d0ed0278ff44b"} 17:46:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:46:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:46:51 INFO - Contents: 17:46:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c2434f57867d49f97da37cb49773e64bb1f6e258788caeeecf7faa32e01bab6f9cf9df90712150fedb008de0f76a421f88e078b9387c707a9fc8c1240118523d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad0449e653b42c81af902a8f0211044478997dd8fdf0ccc1123815d7ef7cf1a0e77b93cf6bef99b992b4f18cf395d04b4ab5889bc699c2c8a81d0ed0278ff44b"} 17:46:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:46:51 INFO - Copying logs to upload dir... 17:46:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:46:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.017010 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-19 17:46:51.407783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 17:46:51.411539) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460 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-Non-PGO/sha512/c2434f57867d49f97da37cb49773e64bb1f6e258788caeeecf7faa32e01bab6f9cf9df90712150fedb008de0f76a421f88e078b9387c707a9fc8c1240118523d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad0449e653b42c81af902a8f0211044478997dd8fdf0ccc1123815d7ef7cf1a0e77b93cf6bef99b992b4f18cf395d04b4ab5889bc699c2c8a81d0ed0278ff44b"} build_url:https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008693 build_url: 'https://queue.taskcluster.net/v1/task/L5AgqF7qSqugR-5ZXRuQag/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c2434f57867d49f97da37cb49773e64bb1f6e258788caeeecf7faa32e01bab6f9cf9df90712150fedb008de0f76a421f88e078b9387c707a9fc8c1240118523d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad0449e653b42c81af902a8f0211044478997dd8fdf0ccc1123815d7ef7cf1a0e77b93cf6bef99b992b4f18cf395d04b4ab5889bc699c2c8a81d0ed0278ff44b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 17:46:51.433963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:46:51.434514) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461111749.348650-1542863460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 17:46:51.516165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 17:46:51.516482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 17:46:51.516890) ========= ========= Total master_lag: 0.18 =========