builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1460678533.71 results: success (0) buildid: 20160414143005 builduid: f2a95d52ccea4ea4ad253917daaefb4f revision: 3e85a84c7d68632e1098cc9374787dc8f54ce24f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.706401) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.706945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.707260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.737128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.737419) ========= 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=33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 17:02: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% 220M=0s 2016-04-14 17:02:14 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082742 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.833994) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.834335) ========= 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=33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018076 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:13.884315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 17:02:13.884693) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e85a84c7d68632e1098cc9374787dc8f54ce24f --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 3e85a84c7d68632e1098cc9374787dc8f54ce24f --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=33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 17:02:14,164 truncating revision to first 12 chars 2016-04-14 17:02:14,164 Setting DEBUG logging. 2016-04-14 17:02:14,164 attempt 1/10 2016-04-14 17:02:14,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e85a84c7d68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 17:02:15,130 unpacking tar archive at: fx-team-3e85a84c7d68/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 17:02:15.155150) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:15.155895) ========= script_repo_revision: 3e85a84c7d68632e1098cc9374787dc8f54ce24f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:15.156530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:15.156873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:15.167703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-14 17:02:15.168036) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:02:15 INFO - MultiFileLogger online at 20160414 17:02:15 in /builds/slave/test 17:02:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:02:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:02:15 INFO - {'append_to_log': False, 17:02:15 INFO - 'base_work_dir': '/builds/slave/test', 17:02:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:02:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:02:15 INFO - 'branch': 'Fx-Team', 17:02:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:02:15 INFO - 'config_files': ('talos/linux_config.py',), 17:02:15 INFO - 'default_actions': ('clobber', 17:02:15 INFO - 'read-buildbot-config', 17:02:15 INFO - 'download-and-extract', 17:02:15 INFO - 'populate-webroot', 17:02:15 INFO - 'create-virtualenv', 17:02:15 INFO - 'install', 17:02:15 INFO - 'run-tests'), 17:02:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:02:15 INFO - 'download_minidump_stackwalk': True, 17:02:15 INFO - 'download_symbols': 'ondemand', 17:02:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:02:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:02:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:02:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:02:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:02:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:02:15 INFO - 'installer_path': 'installer.exe', 17:02:15 INFO - 'log_level': 'info', 17:02:15 INFO - 'log_name': 'talos', 17:02:15 INFO - 'log_to_console': True, 17:02:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:02:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:02:15 INFO - 'opt_config_files': (), 17:02:15 INFO - 'pip_index': False, 17:02:15 INFO - 'sps_profile': False, 17:02:15 INFO - 'sps_profile_interval': 0, 17:02:15 INFO - 'suite': 'dromaeojs', 17:02:15 INFO - 'system_bits': '32', 17:02:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:02:15 INFO - 'title': 'talos-linux64-ix-063', 17:02:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:02:15 INFO - 'use_talos_json': True, 17:02:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:02:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:02:15 INFO - 'work_dir': 'build'} 17:02:15 INFO - ##### 17:02:15 INFO - ##### Running clobber step. 17:02:15 INFO - ##### 17:02:15 INFO - Running pre-action listener: _resource_record_pre_action 17:02:15 INFO - Running main action method: clobber 17:02:15 INFO - rmtree: /builds/slave/test/build 17:02:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:16 INFO - Running post-action listener: _resource_record_post_action 17:02:16 INFO - ##### 17:02:16 INFO - ##### Running read-buildbot-config step. 17:02:16 INFO - ##### 17:02:16 INFO - Running pre-action listener: _resource_record_pre_action 17:02:16 INFO - Running main action method: read_buildbot_config 17:02:16 INFO - Using buildbot properties: 17:02:16 INFO - { 17:02:16 INFO - "project": "", 17:02:16 INFO - "product": "firefox", 17:02:16 INFO - "script_repo_revision": "production", 17:02:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:02:16 INFO - "repository": "", 17:02:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:02:16 INFO - "buildid": "20160414143005", 17:02:16 INFO - "pgo_build": "True", 17:02:16 INFO - "basedir": "/builds/slave/test", 17:02:16 INFO - "buildnumber": 26, 17:02:16 INFO - "slavename": "talos-linux64-ix-063", 17:02:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:02:16 INFO - "platform": "ubuntu64_hw", 17:02:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:02:16 INFO - "branch": "fx-team", 17:02:16 INFO - "repo_path": "integration/fx-team", 17:02:16 INFO - "revision": "3e85a84c7d68632e1098cc9374787dc8f54ce24f", 17:02:16 INFO - "stage_platform": "linux64-pgo", 17:02:16 INFO - "builduid": "f2a95d52ccea4ea4ad253917daaefb4f", 17:02:16 INFO - "slavebuilddir": "test" 17:02:16 INFO - } 17:02:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:02:16 INFO - Running post-action listener: _resource_record_post_action 17:02:16 INFO - ##### 17:02:16 INFO - ##### Running download-and-extract step. 17:02:16 INFO - ##### 17:02:16 INFO - Running pre-action listener: _resource_record_pre_action 17:02:16 INFO - Running main action method: download_and_extract 17:02:16 INFO - mkdir: /builds/slave/test/build/tests 17:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:16 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:02:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:23 INFO - Downloaded 1361 bytes. 17:02:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:02:23 INFO - Using the following test package requirements: 17:02:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:02:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:02:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'jsshell-linux-x86_64.zip'], 17:02:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:02:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:02:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:02:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:02:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:02:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:23 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:27 INFO - Downloaded 23774857 bytes. 17:02:27 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:02:27 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:02:29 INFO - Return code: 0 17:02:29 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:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:29 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:02:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:02:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:33 INFO - Downloaded 23774857 bytes. 17:02:33 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:02:33 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:02:35 INFO - Return code: 0 17:02:35 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:02:35 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:38 INFO - Downloaded 10841076 bytes. 17:02:38 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:02:38 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:02:38 INFO - Return code: 0 17:02:38 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:02:38 INFO - https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:02:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eCpx8i7OQMKPg-qIooRKiw/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:02:39 INFO - Downloaded 58159403 bytes. 17:02:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:39 INFO - mkdir: /builds/slave/test/properties 17:02:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:39 INFO - Contents: 17:02:39 INFO - build_url:https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:02:40 INFO - Running post-action listener: _resource_record_post_action 17:02:40 INFO - Running post-action listener: set_extra_try_arguments 17:02:40 INFO - ##### 17:02:40 INFO - ##### Running populate-webroot step. 17:02:40 INFO - ##### 17:02:40 INFO - Running pre-action listener: _resource_record_pre_action 17:02:40 INFO - Running main action method: populate_webroot 17:02:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:40 INFO - '--tppagecycles', 17:02:40 INFO - '7'], 17:02:40 INFO - 'tests': ['tsvgm']}}, 17:02:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['damp', 'tps']}, 17:02:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'tests': ['damp', 'tps']}, 17:02:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['dromaeo_dom']}, 17:02:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['a11yr', 17:02:40 INFO - 'ts_paint', 17:02:40 INFO - 'tpaint', 17:02:40 INFO - 'sessionrestore', 17:02:40 INFO - 'sessionrestore_no_auto_restore', 17:02:40 INFO - 'tabpaint']}, 17:02:40 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:40 INFO - 'ts_paint', 17:02:40 INFO - 'tpaint', 17:02:40 INFO - 'sessionrestore', 17:02:40 INFO - 'sessionrestore_no_auto_restore', 17:02:40 INFO - 'tabpaint']}, 17:02:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:40 INFO - 'ts_paint', 17:02:40 INFO - 'tpaint', 17:02:40 INFO - 'sessionrestore', 17:02:40 INFO - 'sessionrestore_no_auto_restore', 17:02:40 INFO - 'tabpaint']}, 17:02:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:40 INFO - 'ts_paint', 17:02:40 INFO - 'tpaint', 17:02:40 INFO - 'sessionrestore', 17:02:40 INFO - 'sessionrestore_no_auto_restore', 17:02:40 INFO - 'tabpaint']}, 17:02:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['a11yr', 17:02:40 INFO - 'ts_paint', 17:02:40 INFO - 'tpaint', 17:02:40 INFO - 'sessionrestore', 17:02:40 INFO - 'sessionrestore_no_auto_restore', 17:02:40 INFO - 'tabpaint']}, 17:02:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['a11yr', 17:02:40 INFO - 'ts_paint', 17:02:40 INFO - 'tpaint', 17:02:40 INFO - 'sessionrestore', 17:02:40 INFO - 'sessionrestore_no_auto_restore', 17:02:40 INFO - 'tabpaint']}, 17:02:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['tsvgx', 17:02:40 INFO - 'tsvgr_opacity', 17:02:40 INFO - 'tart', 17:02:40 INFO - 'tscrollx', 17:02:40 INFO - 'cart']}, 17:02:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:40 INFO - 'tsvgr_opacity', 17:02:40 INFO - 'tart', 17:02:40 INFO - 'tscrollx', 17:02:40 INFO - 'cart']}, 17:02:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'talos_options': ['--disable-e10s'], 17:02:40 INFO - 'tests': ['tp5o']}, 17:02:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'tests': ['tp5o']}, 17:02:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'talos_options': ['--disable-e10s', 17:02:40 INFO - '--xperf_path', 17:02:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:40 INFO - 'tests': ['tp5n']}, 17:02:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:40 INFO - 'talos_options': ['--xperf_path', 17:02:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:40 INFO - 'tests': ['tp5n']}}, 17:02:40 INFO - 'talos.zip': {'path': '', 17:02:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:40 INFO - Running post-action listener: _resource_record_post_action 17:02:40 INFO - ##### 17:02:40 INFO - ##### Running create-virtualenv step. 17:02:40 INFO - ##### 17:02:40 INFO - Running pre-action listener: _resource_record_pre_action 17:02:40 INFO - Running main action method: create_virtualenv 17:02:40 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:40 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:02:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:40 INFO - Using real prefix '/usr' 17:02:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:43 INFO - Installing pip.................done. 17:02:43 INFO - Return code: 0 17:02:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02: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:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:43 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:43 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:02:43 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:02:43 INFO - Using env: {'DISPLAY': ':0', 17:02:43 INFO - 'HOME': '/home/cltbld', 17:02:43 INFO - 'LANG': 'en_US.UTF-8', 17:02:43 INFO - 'LANGUAGE': 'en_US:en', 17:02:43 INFO - 'LOGNAME': 'cltbld', 17:02:43 INFO - 'MAIL': '/var/mail/cltbld', 17:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:43 INFO - 'MOZ_NO_REMOTE': '1', 17:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:43 INFO - 'NO_EM_RESTART': '1', 17:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:43 INFO - 'PWD': '/builds/slave/test', 17:02:43 INFO - 'SHELL': '/bin/bash', 17:02:43 INFO - 'SHLVL': '1', 17:02:43 INFO - 'TERM': 'linux', 17:02:43 INFO - 'TMOUT': '86400', 17:02:43 INFO - 'USER': 'cltbld', 17:02:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:43 INFO - '_': '/tools/buildbot/bin/python'} 17:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:43 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:02:43 INFO - Cleaning up... 17:02:43 INFO - Return code: 0 17:02:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:02: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:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:43 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:43 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:02:43 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:02:43 INFO - Using env: {'DISPLAY': ':0', 17:02:43 INFO - 'HOME': '/home/cltbld', 17:02:43 INFO - 'LANG': 'en_US.UTF-8', 17:02:43 INFO - 'LANGUAGE': 'en_US:en', 17:02:43 INFO - 'LOGNAME': 'cltbld', 17:02:43 INFO - 'MAIL': '/var/mail/cltbld', 17:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:43 INFO - 'MOZ_NO_REMOTE': '1', 17:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:43 INFO - 'NO_EM_RESTART': '1', 17:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:43 INFO - 'PWD': '/builds/slave/test', 17:02:43 INFO - 'SHELL': '/bin/bash', 17:02:43 INFO - 'SHLVL': '1', 17:02:43 INFO - 'TERM': 'linux', 17:02:43 INFO - 'TMOUT': '86400', 17:02:43 INFO - 'USER': 'cltbld', 17:02:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:43 INFO - '_': '/tools/buildbot/bin/python'} 17:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:43 INFO - Downloading/unpacking psutil>=0.7.1 17:02:43 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:02:43 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:02:43 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:02:43 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:02:43 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:02:43 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:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:45 INFO - Installing collected packages: psutil 17:02:45 INFO - Running setup.py install for psutil 17:02:45 INFO - building 'psutil._psutil_linux' extension 17:02:45 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:02:45 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:02:45 INFO - building 'psutil._psutil_posix' extension 17:02:45 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:02:46 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:02:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:46 INFO - Successfully installed psutil 17:02:46 INFO - Cleaning up... 17:02:46 INFO - Return code: 0 17:02:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:02: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:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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', '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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:02: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 mozsystemmonitor==0.0.0 17:02:46 INFO - Using env: {'DISPLAY': ':0', 17:02:46 INFO - 'HOME': '/home/cltbld', 17:02:46 INFO - 'LANG': 'en_US.UTF-8', 17:02:46 INFO - 'LANGUAGE': 'en_US:en', 17:02:46 INFO - 'LOGNAME': 'cltbld', 17:02:46 INFO - 'MAIL': '/var/mail/cltbld', 17:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:46 INFO - 'MOZ_NO_REMOTE': '1', 17:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:46 INFO - 'NO_EM_RESTART': '1', 17:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:46 INFO - 'PWD': '/builds/slave/test', 17:02:46 INFO - 'SHELL': '/bin/bash', 17:02:46 INFO - 'SHLVL': '1', 17:02:46 INFO - 'TERM': 'linux', 17:02:46 INFO - 'TMOUT': '86400', 17:02:46 INFO - 'USER': 'cltbld', 17:02:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:46 INFO - '_': '/tools/buildbot/bin/python'} 17:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:02: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:02: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:02: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:02: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:02: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:02: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:02:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:48 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:02:48 INFO - Installing collected packages: mozsystemmonitor 17:02:48 INFO - Running setup.py install for mozsystemmonitor 17:02:48 INFO - Successfully installed mozsystemmonitor 17:02:48 INFO - Cleaning up... 17:02:48 INFO - Return code: 0 17:02:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:48 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:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:48 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:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:48 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:48 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:02:48 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:02:48 INFO - Using env: {'DISPLAY': ':0', 17:02:48 INFO - 'HOME': '/home/cltbld', 17:02:48 INFO - 'LANG': 'en_US.UTF-8', 17:02:48 INFO - 'LANGUAGE': 'en_US:en', 17:02:48 INFO - 'LOGNAME': 'cltbld', 17:02:48 INFO - 'MAIL': '/var/mail/cltbld', 17:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:48 INFO - 'MOZ_NO_REMOTE': '1', 17:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:48 INFO - 'NO_EM_RESTART': '1', 17:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:48 INFO - 'PWD': '/builds/slave/test', 17:02:48 INFO - 'SHELL': '/bin/bash', 17:02:48 INFO - 'SHLVL': '1', 17:02:48 INFO - 'TERM': 'linux', 17:02:48 INFO - 'TMOUT': '86400', 17:02:48 INFO - 'USER': 'cltbld', 17:02:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:48 INFO - '_': '/tools/buildbot/bin/python'} 17:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:02: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:02: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:02: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:02: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:02: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:02: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:02:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:02:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:02:50 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:02:50 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:02:50 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:02:50 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:02:50 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:02:50 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:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:51 INFO - Downloading docopt-0.6.1.tar.gz 17:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:51 INFO - Running setup.py install for blobuploader 17:02:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:51 INFO - Running setup.py install for requests 17:02:51 INFO - Running setup.py install for docopt 17:02:51 INFO - Successfully installed blobuploader requests docopt 17:02:51 INFO - Cleaning up... 17:02:51 INFO - Return code: 0 17:02:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:51 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:51 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:02:51 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:02:51 INFO - Using env: {'DISPLAY': ':0', 17:02:51 INFO - 'HOME': '/home/cltbld', 17:02:51 INFO - 'LANG': 'en_US.UTF-8', 17:02:51 INFO - 'LANGUAGE': 'en_US:en', 17:02:51 INFO - 'LOGNAME': 'cltbld', 17:02:51 INFO - 'MAIL': '/var/mail/cltbld', 17:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:51 INFO - 'MOZ_NO_REMOTE': '1', 17:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:51 INFO - 'NO_EM_RESTART': '1', 17:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:51 INFO - 'PWD': '/builds/slave/test', 17:02:51 INFO - 'SHELL': '/bin/bash', 17:02:51 INFO - 'SHLVL': '1', 17:02:51 INFO - 'TERM': 'linux', 17:02:51 INFO - 'TMOUT': '86400', 17:02:51 INFO - 'USER': 'cltbld', 17:02:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:51 INFO - '_': '/tools/buildbot/bin/python'} 17:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:52 INFO - Running setup.py (path:/tmp/pip-xhWQMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:52 INFO - Running setup.py (path:/tmp/pip-jNTBXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:52 INFO - Running setup.py (path:/tmp/pip-3nyn7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:52 INFO - Running setup.py (path:/tmp/pip-OfKceH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:52 INFO - Running setup.py (path:/tmp/pip-AdgD7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:52 INFO - Running setup.py (path:/tmp/pip-WB3zce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:52 INFO - Running setup.py (path:/tmp/pip-8MQVaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:52 INFO - Running setup.py (path:/tmp/pip-o55wiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:52 INFO - Running setup.py (path:/tmp/pip-BlDfcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:52 INFO - Running setup.py (path:/tmp/pip-VdUlXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:52 INFO - Running setup.py (path:/tmp/pip-kYxN_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:52 INFO - Running setup.py (path:/tmp/pip-IeSPzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:52 INFO - Running setup.py (path:/tmp/pip-ETlPXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:53 INFO - Running setup.py (path:/tmp/pip-iOIA7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:53 INFO - Running setup.py (path:/tmp/pip-K9xJrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:53 INFO - Running setup.py (path:/tmp/pip-x6oZvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:53 INFO - Running setup.py (path:/tmp/pip-1Z5LjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:53 INFO - Running setup.py install for manifestparser 17:02:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:53 INFO - Running setup.py install for mozcrash 17:02:53 INFO - Running setup.py install for mozdebug 17:02:53 INFO - Running setup.py install for mozdevice 17:02:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:02:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:53 INFO - Running setup.py install for mozfile 17:02:53 INFO - Running setup.py install for mozhttpd 17:02:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:53 INFO - Running setup.py install for mozinfo 17:02:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Running setup.py install for mozInstall 17:02:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Running setup.py install for mozleak 17:02:54 INFO - Running setup.py install for mozlog 17:02:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Running setup.py install for moznetwork 17:02:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Running setup.py install for mozprocess 17:02:54 INFO - Running setup.py install for mozprofile 17:02:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Running setup.py install for mozrunner 17:02:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:54 INFO - Running setup.py install for mozscreenshot 17:02:54 INFO - Running setup.py install for moztest 17:02:55 INFO - Running setup.py install for mozversion 17:02:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:55 INFO - Cleaning up... 17:02:55 INFO - Return code: 0 17:02:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:55 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:55 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:02:55 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:02:55 INFO - Using env: {'DISPLAY': ':0', 17:02:55 INFO - 'HOME': '/home/cltbld', 17:02:55 INFO - 'LANG': 'en_US.UTF-8', 17:02:55 INFO - 'LANGUAGE': 'en_US:en', 17:02:55 INFO - 'LOGNAME': 'cltbld', 17:02:55 INFO - 'MAIL': '/var/mail/cltbld', 17:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:55 INFO - 'MOZ_NO_REMOTE': '1', 17:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:55 INFO - 'NO_EM_RESTART': '1', 17:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:55 INFO - 'PWD': '/builds/slave/test', 17:02:55 INFO - 'SHELL': '/bin/bash', 17:02:55 INFO - 'SHLVL': '1', 17:02:55 INFO - 'TERM': 'linux', 17:02:55 INFO - 'TMOUT': '86400', 17:02:55 INFO - 'USER': 'cltbld', 17:02:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:55 INFO - '_': '/tools/buildbot/bin/python'} 17:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:55 INFO - Running setup.py (path:/tmp/pip-cjEb_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:55 INFO - Running setup.py (path:/tmp/pip-kSvU9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:55 INFO - Running setup.py (path:/tmp/pip-W2yFgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:55 INFO - Running setup.py (path:/tmp/pip-lqElbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:55 INFO - Running setup.py (path:/tmp/pip-P9hcPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:55 INFO - Running setup.py (path:/tmp/pip-UIGTtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:55 INFO - Running setup.py (path:/tmp/pip-7BLklI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:55 INFO - Running setup.py (path:/tmp/pip-VjrQqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:55 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:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:55 INFO - Running setup.py (path:/tmp/pip-YI8msy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:56 INFO - Running setup.py (path:/tmp/pip-sNwPEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:56 INFO - Running setup.py (path:/tmp/pip-0W4Fc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:56 INFO - Running setup.py (path:/tmp/pip-wNFcYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:56 INFO - Running setup.py (path:/tmp/pip-cFSBX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:56 INFO - Running setup.py (path:/tmp/pip-gRQdzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:56 INFO - Running setup.py (path:/tmp/pip-t6cNV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:56 INFO - Running setup.py (path:/tmp/pip-EFNXBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:56 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:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:56 INFO - Running setup.py (path:/tmp/pip-fmLO9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:56 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:02:56 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:02:56 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:02:56 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:02:56 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:02:56 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:02:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:56 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:02:56 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:02:56 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:02:56 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:02:56 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:02:56 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:02:58 INFO - Downloading blessings-1.6.tar.gz 17:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:58 INFO - Installing collected packages: blessings 17:02:58 INFO - Running setup.py install for blessings 17:02:58 INFO - Successfully installed blessings 17:02:58 INFO - Cleaning up... 17:02:58 INFO - Return code: 0 17:02:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:58 INFO - Reading from file tmpfile_stdout 17:02:58 INFO - Current package versions: 17:02:58 INFO - argparse == 1.2.1 17:02:58 INFO - blessings == 1.6 17:02:58 INFO - blobuploader == 1.2.4 17:02:58 INFO - docopt == 0.6.1 17:02:58 INFO - manifestparser == 1.1 17:02:58 INFO - mozInstall == 1.12 17:02:58 INFO - mozcrash == 0.17 17:02:58 INFO - mozdebug == 0.1 17:02:58 INFO - mozdevice == 0.48 17:02:58 INFO - mozfile == 1.2 17:02:58 INFO - mozhttpd == 0.7 17:02:58 INFO - mozinfo == 0.9 17:02:58 INFO - mozleak == 0.1 17:02:58 INFO - mozlog == 3.1 17:02:58 INFO - moznetwork == 0.27 17:02:58 INFO - mozprocess == 0.22 17:02:58 INFO - mozprofile == 0.28 17:02:58 INFO - mozrunner == 6.11 17:02:58 INFO - mozscreenshot == 0.1 17:02:58 INFO - mozsystemmonitor == 0.0 17:02:58 INFO - moztest == 0.7 17:02:58 INFO - mozversion == 1.4 17:02:58 INFO - psutil == 3.1.1 17:02:58 INFO - requests == 1.2.3 17:02:58 INFO - wsgiref == 0.1.2 17:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:58 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:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:58 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:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:58 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:58 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:02:58 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:02:58 INFO - Using env: {'DISPLAY': ':0', 17:02:58 INFO - 'HOME': '/home/cltbld', 17:02:58 INFO - 'LANG': 'en_US.UTF-8', 17:02:58 INFO - 'LANGUAGE': 'en_US:en', 17:02:58 INFO - 'LOGNAME': 'cltbld', 17:02:58 INFO - 'MAIL': '/var/mail/cltbld', 17:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:58 INFO - 'MOZ_NO_REMOTE': '1', 17:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:58 INFO - 'NO_EM_RESTART': '1', 17:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:58 INFO - 'PWD': '/builds/slave/test', 17:02:58 INFO - 'SHELL': '/bin/bash', 17:02:58 INFO - 'SHLVL': '1', 17:02:58 INFO - 'TERM': 'linux', 17:02:58 INFO - 'TMOUT': '86400', 17:02:58 INFO - 'USER': 'cltbld', 17:02:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:58 INFO - '_': '/tools/buildbot/bin/python'} 17:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 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:02:59 INFO - Cleaning up... 17:02:59 INFO - Return code: 0 17:02:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:59 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:02:59 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:02:59 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:02:59 INFO - Using env: {'DISPLAY': ':0', 17:02:59 INFO - 'HOME': '/home/cltbld', 17:02:59 INFO - 'LANG': 'en_US.UTF-8', 17:02:59 INFO - 'LANGUAGE': 'en_US:en', 17:02:59 INFO - 'LOGNAME': 'cltbld', 17:02:59 INFO - 'MAIL': '/var/mail/cltbld', 17:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:59 INFO - 'MOZ_NO_REMOTE': '1', 17:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:59 INFO - 'NO_EM_RESTART': '1', 17:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:59 INFO - 'PWD': '/builds/slave/test', 17:02:59 INFO - 'SHELL': '/bin/bash', 17:02:59 INFO - 'SHLVL': '1', 17:02:59 INFO - 'TERM': 'linux', 17:02:59 INFO - 'TMOUT': '86400', 17:02:59 INFO - 'USER': 'cltbld', 17:02:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:59 INFO - '_': '/tools/buildbot/bin/python'} 17:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:59 INFO - Downloading/unpacking jsonschema 17:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:01 INFO - Downloading/unpacking functools32 (from jsonschema) 17:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:01 INFO - warning: no files found matching '*.txt' 17:03:01 INFO - no previously-included directories found matching 'build' 17:03:01 INFO - no previously-included directories found matching 'dist' 17:03:01 INFO - no previously-included directories found matching '.git*' 17:03:01 INFO - Installing collected packages: jsonschema, functools32 17:03:01 INFO - Running setup.py install for functools32 17:03:01 INFO - warning: no files found matching '*.txt' 17:03:01 INFO - no previously-included directories found matching 'build' 17:03:01 INFO - no previously-included directories found matching 'dist' 17:03:01 INFO - no previously-included directories found matching '.git*' 17:03:01 INFO - Successfully installed jsonschema functools32 17:03:01 INFO - Cleaning up... 17:03:01 INFO - Return code: 0 17:03:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 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 0x7f182b3e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, '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': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', '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:03:01 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:03:01 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:03:01 INFO - Using env: {'DISPLAY': ':0', 17:03:01 INFO - 'HOME': '/home/cltbld', 17:03:01 INFO - 'LANG': 'en_US.UTF-8', 17:03:01 INFO - 'LANGUAGE': 'en_US:en', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MAIL': '/var/mail/cltbld', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SHLVL': '1', 17:03:01 INFO - 'TERM': 'linux', 17:03:01 INFO - 'TMOUT': '86400', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - '_': '/tools/buildbot/bin/python'} 17:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:01 INFO - Downloading/unpacking flake8 17:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:03:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:03:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:03:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:03:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:03:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:03:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:03:04 INFO - no previously-included directories found matching 'docs/_build' 17:03:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:03:04 INFO - Running setup.py install for pep8 17:03:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:03:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:03:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:03:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:03:04 INFO - no previously-included directories found matching 'docs/_build' 17:03:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:03:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:03:04 INFO - Cleaning up... 17:03:04 INFO - Return code: 0 17:03:04 INFO - Running post-action listener: _resource_record_post_action 17:03:04 INFO - Running post-action listener: _start_resource_monitoring 17:03:04 INFO - Starting resource monitoring. 17:03:04 INFO - ##### 17:03:04 INFO - ##### Running install step. 17:03:04 INFO - ##### 17:03:04 INFO - Running pre-action listener: _resource_record_pre_action 17:03:04 INFO - Running main action method: install 17:03:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:05 INFO - Reading from file tmpfile_stdout 17:03:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:03:05 INFO - Reading from file tmpfile_stdout 17:03:05 INFO - Output received: 17:03:05 INFO - Usage: mozinstall [options] installer 17:03:05 INFO - Options: 17:03:05 INFO - -h, --help show this help message and exit 17:03:05 INFO - -d DEST, --destination=DEST 17:03:05 INFO - Directory to install application into. [default: 17:03:05 INFO - "/builds/slave/test"] 17:03:05 INFO - --app=APP Application being installed. [default: firefox] 17:03:05 INFO - mkdir: /builds/slave/test/build/application 17:03:05 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:03:05 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:03:21 INFO - Reading from file tmpfile_stdout 17:03:21 INFO - Output received: 17:03:21 INFO - /builds/slave/test/build/application/firefox/firefox 17:03:21 INFO - Running post-action listener: _resource_record_post_action 17:03:21 INFO - ##### 17:03:21 INFO - ##### Running run-tests step. 17:03:21 INFO - ##### 17:03:21 INFO - Running pre-action listener: _resource_record_pre_action 17:03:21 INFO - Running main action method: run_tests 17:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:21 INFO - Python 2.7.3 17:03:21 INFO - Return code: 0 17:03:21 INFO - grabbing minidump binary from tooltool 17:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:21 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 0x2b32810>, '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 0x2b33710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b33ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:21 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:03:21 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:03:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:03:21 INFO - Return code: 0 17:03:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:03:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:03:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:03:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:03:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:03:22 INFO - Return code: 0 17:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:03:22 INFO - Using env: {'DISPLAY': ':0', 17:03:22 INFO - 'HOME': '/home/cltbld', 17:03:22 INFO - 'LANG': 'en_US.UTF-8', 17:03:22 INFO - 'LANGUAGE': 'en_US:en', 17:03:22 INFO - 'LOGNAME': 'cltbld', 17:03:22 INFO - 'MAIL': '/var/mail/cltbld', 17:03:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:22 INFO - 'MOZ_NO_REMOTE': '1', 17:03:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:22 INFO - 'NO_EM_RESTART': '1', 17:03:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:22 INFO - 'PWD': '/builds/slave/test', 17:03:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:22 INFO - 'SHELL': '/bin/bash', 17:03:22 INFO - 'SHLVL': '1', 17:03:22 INFO - 'TERM': 'linux', 17:03:22 INFO - 'TMOUT': '86400', 17:03:22 INFO - 'USER': 'cltbld', 17:03:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829', 17:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:22 INFO - '_': '/tools/buildbot/bin/python'} 17:03:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:03:22 INFO - mozversion application_buildid: 20160414143005 17:03:22 INFO - mozversion application_changeset: 3e85a84c7d68632e1098cc9374787dc8f54ce24f 17:03:22 INFO - mozversion application_display_name: Nightly 17:03:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:22 INFO - mozversion application_name: Firefox 17:03:22 INFO - mozversion application_remotingname: firefox 17:03:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:03:22 INFO - mozversion application_vendor: Mozilla 17:03:22 INFO - mozversion application_version: 48.0a1 17:03:22 INFO - mozversion platform_buildid: 20160414143005 17:03:22 INFO - mozversion platform_changeset: 3e85a84c7d68632e1098cc9374787dc8f54ce24f 17:03:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:03:22 INFO - mozversion platform_version: 48.0a1 17:03:22 INFO - using testdate: 1460678602 17:03:22 INFO - actual date: 1460678602 17:03:22 INFO - starting webserver on 'localhost:59188' 17:03:22 INFO - SUITE-START | Running 2 tests 17:03:22 INFO - TEST-START | dromaeo_css 17:03:22 INFO - operating with platform_type : linux_ 17:03:22 INFO - Initialising browser for dromaeo_css test... 17:03:22 INFO - TEST-INFO | started process 6337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsOrtr/profile http://localhost:59188/getInfo.html) 17:03:27 INFO - PROCESS | 6337 | __metrics Screen width/height:1600/1200 17:03:27 INFO - PROCESS | 6337 | colorDepth:24 17:03:27 INFO - PROCESS | 6337 | Browser inner width/height: 1024/697 17:03:27 INFO - PROCESS | 6337 | __metrics 17:03:28 ERROR - PROCESS | 6337 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:03:29 INFO - TEST-INFO | 6337: exit 0 17:03:29 INFO - Browser initialized. 17:03:29 INFO - Running cycle 1/1 for dromaeo_css test... 17:03:29 INFO - TEST-INFO | started process 6421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsOrtr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:41 INFO - PROCESS | 6421 | RSS: Main: 153264128 17:03:41 INFO - PROCESS | 6421 | 17:04:32 INFO - PROCESS | 6421 | 1460678672248 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:06:39 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:59188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59188/tests/dromaeo/cssquery-ext.html) 17:06:40 INFO - PROCESS | 6421 | RSS: Main: 251551744 17:06:40 INFO - PROCESS | 6421 | 17:09:42 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:59188/tests/dromaeo/cssquery-ext.html (next: http://localhost:59188/tests/dromaeo/cssquery-jquery.html) 17:09:43 INFO - PROCESS | 6421 | RSS: Main: 231321600 17:09:43 INFO - PROCESS | 6421 | 17:12:45 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:59188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59188/tests/dromaeo/cssquery-mootools.html) 17:12:45 INFO - PROCESS | 6421 | RSS: Main: 233771008 17:12:45 INFO - PROCESS | 6421 | 17:15:47 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:59188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59188/tests/dromaeo/cssquery-prototype.html) 17:15:48 INFO - PROCESS | 6421 | RSS: Main: 231501824 17:15:48 INFO - PROCESS | 6421 | 17:18:50 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:59188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59188/tests/dromaeo/cssquery-yui.html) 17:18:51 INFO - PROCESS | 6421 | RSS: Main: 220999680 17:18:51 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | Cycle 1(1): loaded http://localhost:59188/tests/dromaeo/cssquery-yui.html (next: http://localhost:59188/tests/dromaeo/cssquery-dojo.html) 17:21:54 INFO - PROCESS | 6421 | RSS: Main: 262266880 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | __start_tp_report 17:21:54 INFO - PROCESS | 6421 | _x_x_mozilla_page_load 17:21:54 INFO - PROCESS | 6421 | _x_x_mozilla_page_load_details 17:21:54 INFO - PROCESS | 6421 | |i|pagename|runs| 17:21:54 INFO - PROCESS | 6421 | |0;dojo.html;3094.102710214038;3108.0520441265435;3149.795263307885;3155.021943197609;3174.6984036516524;5192.039472697549;5220.190870415082;5227.477252274771;5239.633225674204;5342.1452567589195;5257.447967963366;5267.841964741064;5269.209618557218;5296.602754793386;5303.628745987782;4752.405949256343;4785.760711964396;4836.443808961962;4840.588549973257;4884.19410797218;4801.8079276828885;4818.397700287464;4824.445188803297;4851;4911.7544122793715;4722.480527142012;4817.349657796222;4829.179039563265;4856.2958371036;4906.1414252505665;4839.41926968766;4850.078485087822;4863.294822250789;4863.562279394836;4893.608511319121;4709.646776491777;4822.083804077214;4835.492273311287;4850.636202284807;4856.05306965142;5165.380154381461;5201.9479805201845;5230.529252367305;5271.182966640138;5273.024490469275;5546.223528705985;5565.666060036411;5568.610197286192;5575.414581468928;5583.6928968906695;5585.134304182818;5605.915911261293;5609.102543593006;5627.521660658849;5676.403977582336;5283.86790330241;5298.735063246861;5308.416074231832;5351.705656188869;5354.946450535484;5746.569007324384;5764.106563482667;5765.625234359837;5771.567132465082;5773.538116950634;5410.945890541123;5510.724463776795;5541.418151094158;5553.583481238923;5560.638558493685;5608.495235428831;5641.548676105902;5646.124850648156;5649.661020338711;5673.574481913873;5600.971995140079;5613.915791263134;5614.2701448811395;5616.269884914935;5618.353889302783;5519.668819870821;5616.97191514048;5656.208130861683;5732.455416735404;5744.080947048452;4194.2450358935685;4201.2017716634355;4204.432401625802;4215.768132752728;4238.639715624145;3781.2248489059675;3789.1853251551047;3801.961980380216;3810.942835857464;3821.121142137268;5096.286519887219;5221.451747566527;5250.97374513125;5296.576273898079;5387.191921211771;5627.127795191752;5647.209390685307;5650.7174641267775;5664.688442135722;5666.943330566724;5352.143657014859;5370.758315875795;5374.1938709193155;5395.163749618815;5451.1005684062475;4717;4831.202851529459;4885.316055752198;4909.729964851967;4928;5790.160426738184;5791.9710401448565;5804.390538993345;5804.970975145097;5809.3609702932645;5495.395506494362;5631.577631677641;5646.802361917477;5654.095344744821;5687.687177205294;5733.39799321082;5754.482096611325;5762.30852297727;5780.710964451845;5785.82642520725;5406.810761623325;5462.863428414322;5464.617476776746;5468.152436372368;5478.260434841405;5537.2524709163745;5556.055470569932;5564.304461942257;5583.106702927512;5602.915956260741;5512.6968016759465;5519.31008623922;5519.31008623922;5520.558355331484;5563.972180139073;5489.505944465017;5495.835124946258;5502;5503.587230957614;5504.22940788298;5282.97358513205;5367.5169234769055;5449.564034877121;5462.399136095106;5513.751881165277;5572.219889215432;5573.944260557342;5583.302087239095;5583.832485025456;5593.860153496195;5434.3207099112615;5463.945360546344;5467.343918729778;5475.835724928259;5496.6701997880255 17:21:54 INFO - PROCESS | 6421 | |1;ext.html;591.61249381655;630.7603110817888;651.1047309948818;652.0773106054933;662.519673236903;26977.325566860814;37006.25987480252;38095.04762380938;38201.23597528048;38302.425463618;39462.8026859866;39708;40024.399634005444;40026;40088.59911400885;7573.924260757377;8297.543635100066;8602.139786021411;8613.870791938127;9842.803143937153;9916.256280778935;10051.597936082548;10080.798384032314;10082.294239403245;10095.242856785733;9998.500074996258;10128.442935638537;10137.645182418617;10138.59445622178;10149.594016239378;7691.000169977895;10035.197184225244;10133.594656213743;10451.320664156805;10458.79082418355;9904.55429505674;9975.65085222021;10008.849867251996;10028.24788140885;10042.548085336177;37445.438318425244;37899.81050094759;38046.23907521862;38070.42894356587;38162.80918595417;3215.742740580748;3351.463765797485;3352.128446603876;3485.372632926072;3776.433534969749;28209.43581128366;28501.144965651063;28519.429611407864;28538.286542836388;28716;4176.749395036308;4223.704340696153;4287.635550978171;4300.440942677463;4485.573870482299;197629.01185494123;198144;199603;200852;200930;56740.148897766565;57083.14375284374;57470.712646437336;57483.425165748646;57525.712371437876;62277.37722622806;63928.360716393174;63998.68000659967;64120.35879641144;64193.35806641874;14520.782188267185;14663.046901951338;14677.633059173393;14686;14687.55937321882;12312.81530777039;12368.75262494763;12390.070744694183;12390.690232744253;12403.131780775258;19161.32935347256;19352.838829670265;19413.4175974721;19415.708764368545;19457.610847782966;5863.355030946593;7019.6490175492045;7203.819904502429;7316;7333.230010848891;1078.1428764132534;1078.6278733836814;1084.4035780320792;1141.7830612183825;1147.3861484105964;31568.684313157035;32914.50628240578;33151.502727459105;33339.83330083334;33833.492497612555;1136.6249137784512;1149.747055647756;1158.4034222375483;1185.2236784905901;1194.6057800925673;15040;15304.770428443582;15325.31036103378;15385.307661155051;15590.142542160063;440089;445726;446348;446807;449136;53723.19415208775;55898;55933.720331398894;55934;56062;1282.2050328796206;1352.3441131051432;1418.4113592859055;1431.4131206205407;1445.3351458329287;28621;31544.36911261808;31871.52192717065;31960.84019579887;32534.34931301408;44776.55223447724;45537.77231113823;45804.77097614624;45881.54118458906;45907.770461147484;322105;322770;323835;323987;324788;22400.439989000406;26655.33361665974;27636.309092272855;27774;27796.30509237285;39561.20877582375;46729.53270467252;48249;48268;49007.26489102595;35115.473267901514;35571.466428003085;36033.45949810807;36063.819680902474;36477.27045459023;35961;36161;36227.63772362243;36388;36646.450303246005;36271.818640906626;37471.62528374681;37685;38129.428058579695;40304.677485069304;33402.164945876546;34635.30729385449;35226.82386588153;35303.117422063624;35527;27829;28197.061848977904;28206.43587128287;28251;28314.150575482767 17:21:54 INFO - PROCESS | 6421 | |2;jquery.html;381.5631102387768;383.8925100971729;391.8804764546814;394.45171212015293;400.8196311659754;17554;18961.715574266396;19191.32830350938;19196.136173872175;19196.61606767864;17227.82772172281;17975.19111639976;18149.818501814978;19013.809861901376;19021.33425330114;4958.429780575235;5091.109055915219;5123.820666276681;5130.5126013028885;5324.520793128618;5482.314710661168;5661.377248502661;5665.093585026397;5668.603197776158;5682.630629009122;5250.212468129792;5639.436056394348;5640.379558248589;5642.887142257153;5646.717664116798;5409.675419474825;5432.70120143392;5451.536619387357;5461.208124821918;5464.644798088111;4791.233402655594;5178.715170665612;5284.286621306152;5288.8413347599635;5290.127129023706;12178.269303841798;12251.326177060258;12342.382880855921;12347.691307717289;14700.632484187874;2150.2259186692777;2184.1263494602126;2233.4081468410886;2323.4772176260376;2326.5114325991563;9138.862917056249;9166.495842728647;9169.22061624756;9289.396189247676;9664.806703865883;1835.403493864486;1840.9874568987138;1869.429823903709;1882.407041781848;2021.353166986565;77992.61003695002;80166.59916700379;80180;81019.18980810176;81100.59449702773;10589.205809564313;10770.138388928866;10913.126949843994;10949.890501095046;11058.834117488244;15242.618934526725;15303.540893772983;15324.310406031755;15329.846701532842;15336.846631533765;7822.591933452033;8039.181388840371;8107.594620268963;8196.13940536247;8209.712660056988;7786.883196752054;7814.570198639016;7817.335526480199;7906.525608463396;7923.920760792434;4411.625011873963;4432.335149727567;4673;4691.1555919934735;4705.082508910798;1847.5473508990383;1853.3235369090455;1870.822271884169;1914.4065339744723;1950.6196291722977;943.5848226780195;989.5893204320126;1062.6227689170387;1077.256692881909;1113.7494063835734;18683.15925783343;19159.712604310946;19211;19382.70925936112;19521.804781952;1015.6800607808665;1021.7701017271203;1043.2384359417667;1043.5617040842865;1067.2635881241918;10270.589176432859;10730.83903741429;10802;10882.347059176474;10915.508802103766;492638;493488;495102;523461;525806;90735;91812;91986;92482;94477;1036.8548403223556;1042.213129087534;1069.550788668761;1090.7055095124272;1104.5636973395465;16465.176741162653;16871.240794164536;16947.32210711558;17280.395186168425;17392.913035434744;37138.62861371352;37564;37746.62253377431;39080.609193907694;39210.60789392069;54771.45228547663;55205;56485;56801.431985681265;56817.43182568121;8019.558924259221;8053.476524025919;8188.344932405274;8240.587970601566;8287.088420273645;9063.728088157366;11672.474738636613;12299.87700123023;12810.743785124432;13542.729145417234;11464.656060318204;11715.414229288332;12066.577669781516;12088.461423101247;12211.87788122143;11241.269317494336;11604;11715.648530544097;11784.882151178379;11792.52829886795;11976.401179941142;12089.697757556132;12177.878221217674;12223.816642750187;12561.434735436744;8088.272055515032;8365.330773538224;8383.287420569077;8562.357823163413;8710.346723995599;11226.719332016764;12274.693132671755;12277.447514862031;12294.385280735749;12555.183913045623 17:21:54 INFO - PROCESS | 6421 | |3;mootools.html;1327.502186679995;1503.1281856523215;1506.9547913562594;1656.6521030583576;1789.4273832373638;6847.452203823695;7678.347340476059;7807.375409967189;7849.529028258301;7854.450188486809;7534.133574638919;7693.499922505047;7698.499597526157;7713.961430192841;7720.112187098485;1984.0674882805058;2054.1680619349186;2056.5475595368994;2219.5782801267746;2247.1011595361906;2221.4779526811267;2266.6939963104933;2275.601769690306;2277.430642339415;2278.168468508999;2202.50443650179;2227.8551894126913;2234.765349638289;2236.7539570647214;2238.250186187629;1965.263026365113;2185.1259496201487;2211.215018668374;2218.0794970087395;2219.611567975606;2232.05137816429;2252.1441852096264;2258.3563684350047;2259.243153543565;2260.2993072147688;7438.628068596603;7476.102867655916;7485.363744081759;7488.700451981914;7549.660265288076;4627.1439783640135;4738.4550776660435;4773.188557945157;4791.161546729343;4796.808127674889;3110.5956225690516;3143.827089510076;3269.1336795749144;3291.0291464017932;3294.159989202762;1081.0702795595782;1126.0822429719751;1129.0322580645227;1129.6836885672026;1147.8679951805566;9775.706728798148;9889.307748457612;9906.504674766305;9934.00659934008;9952.203823694088;4041.413994970713;4143.56492568282;4221.071364299849;4224.746515209097;4243.554426785143;8605.569721513899;8665.610047547876;8730.083341249205;8748.8687669685;8858.73423797287;4781.569658730731;4783.473817880031;4806.351142595775;4809.158397280462;4816.494268101869;3907.1794923065904;4356.978215108968;4447.555244475527;4463.754493502888;4513.819447222074;3654;3701.7964011979598;3753.868614598476;3780.9243815124096;3782.0355809268463;1150.3902931446346;1203.5366383942246;1203.554684766642;1213.9453724582415;1230.9630711078682;804.2199066905092;804.4851295171095;842.3682238321259;874.7157173918501;887.2281115429618;5282.1548552232225;5291.153415453509;5366.838994830161;5410.810621628224;5531.861703457365;401.23564609419105;402.7643828360442;408.65264525153384;413.64426593129883;416.5230810721767;3821.5414150301585;3847.9807600961817;3909.198614284065;3964.583718709494;3977.3835055566433;9280.164785169232;9518.333716639769;9594.520273986273;9610.183134433511;9619.422834629944;9354.625814967325;9388.95305523468;9453.43279403238;9470;9481.09929556691;7065.752698655522;7159.391451726661;7323.3408993189805;7378.483506154517;7388.0764904388025;5224.346956630421;5285.735713214401;5287.7620507078045;5318.0959236930585;5376.73116344189;8642.178992995656;8772.78068048304;8798.47209167452;8804.427712198687;8810.118988101138;8613.526256055977;8808.691695790616;8905.243054340453;8944.86582701247;9034.864477032981;6254.374562543891;6348.746050157942;6877.862442751017;7034.507584469038;7143.892841607484;7288.234735352712;7352.338289553966;7399.852002960019;7408.851822963618;7422.96288518554;6648.767293144717;6759.729610815512;6769.966150169218;6943.201531823703;7019.508634395544;6614;6631.900521492085;6721.563098398588;6774;6812.557183783038;6282.183316168869;6590.406863382319;6614.272430032789;6644.501662375244;6670.633115178712;4605.861824145281;4671.416072990876;4725.952740472551;4735.668503204743;4755.762211889461;4657.184992626345;4759.095771803346;4809.374781278411;4831.613470922248;4838.153323168502 17:21:54 INFO - PROCESS | 6421 | |4;prototype.html;288.7545586251686;296.22980251346496;299.878549187579;301.9305559721263;302.23534457821705;5448.972755136218;5525.861853453665;5576.386597474275;5616.129499927512;5650.124230744241;5628.465295796893;5653.349864765553;5656.745446454909;5671.602987790856;5678.659280443177;4303.956960430395;4310.331898555729;4318.244307246235;4321.351797230409;4326.005018845667;4166.999920019189;4281.079567892903;4287.957120428787;4319.157764235975;4327.610515053644;4216.388623649585;4225.704200705952;4228.534861165269;4249.788810189097;4261.659067274611;4155.646770024551;4206.64243539298;4222.619964203206;4229.133027729308;4233.767142807144;3694.7967861767593;3702.407614781649;3709.0356507308293;3740;3763.41667041609;5418.485243901823;5432.348118225838;5455.236266922634;5456.972715136399;5469.644473109235;4846.297286893416;4918.9754051229875;4941.45643979162;4942.555170034678;4956.826511072095;5901.2918449785875;5933.495652869511;5937.406259374071;5942.762289508414;5951.256092988377;4069.8575549855614;4099.795010249476;4104.035551645361;4111.1366613011305;4112.814923328458;5898.380670029628;6067.393260673942;6160.383961603804;6161.7535298588;6168.722407491674;4129.256733787947;4145.419641250227;4161.3549899765585;4162.084341444938;4173.5409104998425;4201.243776120327;4213.136307057046;4224.725392849455;4229.090745489734;4235.4917409910395;4787.473377928425;4897.2654101885;4901.701049221959;4915.21356582945;4916.262560615936;5636.267285252891;5808.30300363959;5934.821955341346;5988.9101663475085;5993.310769261503;1442.8701416872323;1470.2942587558032;1474.9631259218606;1476.8966172368046;1477.926103694811;951.9286053546011;971.2521358553875;979.4319294808994;993.7068564773409;995.2585323933715;5678.659280443187;5712.314522257356;5722.113072473773;5732.398098199712;5746.224259724967;6081.604695694766;6093.634381937098;6097.207363042776;6104.534911621179;6104.603200791934;5569.498745112959;5720.425808386243;5746.281714785652;5758.165066065397;5763.596548241583;3217.3404452087266;3242.302904875463;3265.6081270247723;3268.2188207426534;3288.67113288674;6074.696265186812;6235.282942461584;6293.622382657055;6299.244090709052;6349.492040636738;6190.1952746142715;6191.535634827406;6194.562018079919;6232.473044104133;6235.376462353819;6311.842203944846;6315.621062736251;6320.652364119926;6331.936680633226;6369.936300637027;5848.970755146197;6095.207623009158;6153.507719382528;6188.907166392598;6213.9067913982235;6067.423594758491;6069.180660610761;6094.512439004958;6097.286707415157;6114.174586430775;6284.8428789278805;6394.90407643895;6406.167198264196;6416.422521972858;6441.903371449525;4048.2390160280374;4063.5733248008532;4067.186562687415;4072.938905916473;4080.9387859181543;5899.764009439575;6019.337872834072;6174.104754810437;6186.412290832363;6186.505079593531;6013.338532761481;6017.879642407215;6029.397060294111;6040.577159598786;6063.211782468251;5982.820515384546;6017.532811547245;6019.6990150493175;6026.728797204224;6055.576109672281;5577.52591029767;5930.52555795544;5954.672493012753;5968.791092311748;5980.970095149496;6030.698465076816;6061.605995610271;6062.36345183767;6064.363241859718;6089.451949324582;5637;5903.734331955158;5917.319508256605;5931.3178984417345;5948.10778383246 17:21:54 INFO - PROCESS | 6421 | |5;yui.html;791.1060501633154;796.2833449895096;797.557355667605;810.5136917849292;827.6565225431442;14320.140791552514;14696.044757090782;14698.779518307234;14739.484118055843;14782.704345913075;14469.20419376934;15290.541283761506;15298.541043768677;15311;15326.15706136162;691.5159388428095;807.5840941914919;836.1513064239801;838.8112674648186;840.9915900840974;836.4939211776879;841.1168273313027;841.146236569879;841.4530555139178;842.0442797424936;864.788126908905;870.9520976346298;872.6901949807822;872.9563521823915;873.8776571280026;716.9498135130569;844.3118858130604;866.0386970462781;870.7126648206108;877.1579283887476;614.370270472769;619.2074145094286;624.7157543317779;625.121704005868;625.4308579192913;14501.347439365254;14519.346629401702;14584.854151458561;14592.197429141394;14594.416223351052;13651.658708532266;14286.428542858273;14504.27478626075;14523.491677791333;14590.27048647574;11106.61126860564;11270.54917803295;11290.830637540443;11325.207235493519;11417.200795944287;3779.848806047755;3802.6957843372466;3877.5346958365176;3893.279743247508;4006.559278479365;57442.7127864358;57610.42389576093;58313;58975.41024589785;59090.99999999957;11198;11207.383593902414;11336.886631133748;11526.769464610828;11543.538258469567;18234.726479102825;18476.722849157275;18514.629707405777;18545.44363669092;18559;8264.958675206586;8468.280196183394;8480.491170529787;8574.699885503978;8815.338849586307;4434.955650443519;4503.54964503547;4521.367008618796;4692.859214223578;4792.329073929653;3118.438681037435;3217.501287300472;3227.0480208338126;3228.1929517620597;3230.0148454721534;600.3576173494406;635.0791352538837;635.1267007864187;639.3191251317425;639.8016614849412;568.1194149069009;606.4451027309962;644.4908522267357;705.1960764728213;706.3007622453733;8532.658693652309;8732.8690069649;8868.822623547621;8946.68686595966;8977.32670049749;582.6387639663436;657.2540166910495;711.6015031582331;734.5078797205884;745.1765798792364;4008.7594744315434;4031.113155105872;4054;4071.6742660587083;4297.290946993711;61629;62331.37668623256;63295;63360;63682.6815865927;53068.46931530713;53235.201471977954;54273.72863135738;54491.72754136283;55333;48569.27146092812;49302;49359.50640493549;49391;50719.49280507295;7988.241117093867;8104.716334928485;8216.589170541569;8363.83272334562;8416.621252043551;31232.594533246513;31965.20086997844;32279.35441291208;32810.1797455056;32895;42389.78805105955;43213.567864320954;43439.56560434482;43619.345709813744;43661;10667.89332106669;10944.45277736094;11011.119110471303;11044.282121662067;11159.10727141843;12289.385530723606;12385.752284954071;12822.615321540368;12925.224486530838;13143.934280328536;11915;12161.817572736592;12284.692882678004;12661.620151395473;12981.610551683465;12027.639170824888;12167.45246463929;12246.632601021984;12368.938155309166;12479;11818.527258909548;11907.166498345032;12328.81506777417;12474.812877807022;12812.359382031047;9999.500024998575;10117.949410252902;10261.127804136731;10344.534495947852;10395.532201051123;10440.37357758537;10675.626353077605;10705.357678539001;10734.892651073702;10857.891421085687 17:21:54 INFO - PROCESS | 6421 | __end_tp_report 17:21:54 INFO - PROCESS | 6421 | __start_cc_report 17:21:54 INFO - PROCESS | 6421 | _x_x_mozilla_cycle_collect,819 17:21:54 INFO - PROCESS | 6421 | __end_cc_report 17:21:54 INFO - PROCESS | 6421 | __startTimestamp1460679714294__endTimestamp 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | ------- Summary: start ------- 17:21:54 INFO - PROCESS | 6421 | Number of tests: 6 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | [#0] dojo.html Cycles:165 Average:5230.59 Median:5462.86 stddev:581.84 (10.7%) stddev-sans-first:558.96 17:21:54 INFO - PROCESS | 6421 | Values: 3094.1 3108.1 3149.8 3155.0 3174.7 5192.0 5220.2 5227.5 5239.6 5342.1 5257.4 5267.8 5269.2 5296.6 5303.6 4752.4 4785.8 4836.4 4840.6 4884.2 4801.8 4818.4 4824.4 4851.0 4911.8 4722.5 4817.3 4829.2 4856.3 4906.1 4839.4 4850.1 4863.3 4863.6 4893.6 4709.6 4822.1 4835.5 4850.6 4856.1 5165.4 5201.9 5230.5 5271.2 5273.0 5546.2 5565.7 5568.6 5575.4 5583.7 5585.1 5605.9 5609.1 5627.5 5676.4 5283.9 5298.7 5308.4 5351.7 5354.9 5746.6 5764.1 5765.6 5771.6 5773.5 5410.9 5510.7 5541.4 5553.6 5560.6 5608.5 5641.5 5646.1 5649.7 5673.6 5601.0 5613.9 5614.3 5616.3 5618.4 5519.7 5617.0 5656.2 5732.5 5744.1 4194.2 4201.2 4204.4 4215.8 4238.6 3781.2 3789.2 3802.0 3810.9 3821.1 5096.3 5221.5 5251.0 5296.6 5387.2 5627.1 5647.2 5650.7 5664.7 5666.9 5352.1 5370.8 5374.2 5395.2 5451.1 4717.0 4831.2 4885.3 4909.7 4928.0 5790.2 5792.0 5804.4 5805.0 5809.4 5495.4 5631.6 5646.8 5654.1 5687.7 5733.4 5754.5 5762.3 5780.7 5785.8 5406.8 5462.9 5464.6 5468.2 5478.3 5537.3 5556.1 5564.3 5583.1 5602.9 5512.7 5519.3 5519.3 5520.6 5564.0 5489.5 5495.8 5502.0 5503.6 5504.2 5283.0 5367.5 5449.6 5462.4 5513.8 5572.2 5573.9 5583.3 5583.8 5593.9 5434.3 5463.9 5467.3 5475.8 5496.7 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | [#1] ext.html Cycles:180 Average:49220.55 Median:19060.34 stddev:89372.45 (468.9%) stddev-sans-first:89548.58 17:21:54 INFO - PROCESS | 6421 | Values: 591.6 630.8 651.1 652.1 662.5 26977.3 37006.3 38095.0 38201.2 38302.4 39462.8 39708.0 40024.4 40026.0 40088.6 7573.9 8297.5 8602.1 8613.9 9842.8 9916.3 10051.6 10080.8 10082.3 10095.2 9998.5 10128.4 10137.6 10138.6 10149.6 7691.0 10035.2 10133.6 10451.3 10458.8 9904.6 9975.7 10008.8 10028.2 10042.5 37445.4 37899.8 38046.2 38070.4 38162.8 3215.7 3351.5 3352.1 3485.4 3776.4 28209.4 28501.1 28519.4 28538.3 28716.0 4176.7 4223.7 4287.6 4300.4 4485.6 197629.0 198144.0 199603.0 200852.0 200930.0 56740.1 57083.1 57470.7 57483.4 57525.7 62277.4 63928.4 63998.7 64120.4 64193.4 14520.8 14663.0 14677.6 14686.0 14687.6 12312.8 12368.8 12390.1 12390.7 12403.1 19161.3 19352.8 19413.4 19415.7 19457.6 5863.4 7019.6 7203.8 7316.0 7333.2 1078.1 1078.6 1084.4 1141.8 1147.4 31568.7 32914.5 33151.5 33339.8 33833.5 1136.6 1149.7 1158.4 1185.2 1194.6 15040.0 15304.8 15325.3 15385.3 15590.1 440089.0 445726.0 446348.0 446807.0 449136.0 53723.2 55898.0 55933.7 55934.0 56062.0 1282.2 1352.3 1418.4 1431.4 1445.3 28621.0 31544.4 31871.5 31960.8 32534.3 44776.6 45537.8 45804.8 45881.5 45907.8 322105.0 322770.0 323835.0 323987.0 324788.0 22400.4 26655.3 27636.3 27774.0 27796.3 39561.2 46729.5 48249.0 48268.0 49007.3 35115.5 35571.5 36033.5 36063.8 36477.3 35961.0 36161.0 36227.6 36388.0 36646.5 36271.8 37471.6 37685.0 38129.4 40304.7 33402.2 34635.3 35226.8 35303.1 35527.0 27829.0 28197.1 28206.4 28251.0 28314.2 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | [#2] jquery.html Cycles:180 Average:28838.60 Median:2324.99 stddev:83429.35 (3588.4%) stddev-sans-first:83636.03 17:21:54 INFO - PROCESS | 6421 | Values: 381.6 383.9 391.9 394.5 400.8 17554.0 18961.7 19191.3 19196.1 19196.6 17227.8 17975.2 18149.8 19013.8 19021.3 4958.4 5091.1 5123.8 5130.5 5324.5 5482.3 5661.4 5665.1 5668.6 5682.6 5250.2 5639.4 5640.4 5642.9 5646.7 5409.7 5432.7 5451.5 5461.2 5464.6 4791.2 5178.7 5284.3 5288.8 5290.1 12178.3 12251.3 12342.4 12347.7 14700.6 2150.2 2184.1 2233.4 2323.5 2326.5 9138.9 9166.5 9169.2 9289.4 9664.8 1835.4 1841.0 1869.4 1882.4 2021.4 77992.6 80166.6 80180.0 81019.2 81100.6 10589.2 10770.1 10913.1 10949.9 11058.8 15242.6 15303.5 15324.3 15329.8 15336.8 7822.6 8039.2 8107.6 8196.1 8209.7 7786.9 7814.6 7817.3 7906.5 7923.9 4411.6 4432.3 4673.0 4691.2 4705.1 1847.5 1853.3 1870.8 1914.4 1950.6 943.6 989.6 1062.6 1077.3 1113.7 18683.2 19159.7 19211.0 19382.7 19521.8 1015.7 1021.8 1043.2 1043.6 1067.3 10270.6 10730.8 10802.0 10882.3 10915.5 492638.0 493488.0 495102.0 523461.0 525806.0 90735.0 91812.0 91986.0 92482.0 94477.0 1036.9 1042.2 1069.6 1090.7 1104.6 16465.2 16871.2 16947.3 17280.4 17392.9 37138.6 37564.0 37746.6 39080.6 39210.6 54771.5 55205.0 56485.0 56801.4 56817.4 8019.6 8053.5 8188.3 8240.6 8287.1 9063.7 11672.5 12299.9 12810.7 13542.7 11464.7 11715.4 12066.6 12088.5 12211.9 11241.3 11604.0 11715.6 11784.9 11792.5 11976.4 12089.7 12177.9 12223.8 12561.4 8088.3 8365.3 8383.3 8562.4 8710.3 11226.7 12274.7 12277.4 12294.4 12555.2 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | [#3] mootools.html Cycles:180 Average:5129.14 Median:5253.25 stddev:2775.93 (52.8%) stddev-sans-first:2769.01 17:21:54 INFO - PROCESS | 6421 | Values: 1327.5 1503.1 1507.0 1656.7 1789.4 6847.5 7678.3 7807.4 7849.5 7854.5 7534.1 7693.5 7698.5 7714.0 7720.1 1984.1 2054.2 2056.5 2219.6 2247.1 2221.5 2266.7 2275.6 2277.4 2278.2 2202.5 2227.9 2234.8 2236.8 2238.3 1965.3 2185.1 2211.2 2218.1 2219.6 2232.1 2252.1 2258.4 2259.2 2260.3 7438.6 7476.1 7485.4 7488.7 7549.7 4627.1 4738.5 4773.2 4791.2 4796.8 3110.6 3143.8 3269.1 3291.0 3294.2 1081.1 1126.1 1129.0 1129.7 1147.9 9775.7 9889.3 9906.5 9934.0 9952.2 4041.4 4143.6 4221.1 4224.7 4243.6 8605.6 8665.6 8730.1 8748.9 8858.7 4781.6 4783.5 4806.4 4809.2 4816.5 3907.2 4357.0 4447.6 4463.8 4513.8 3654.0 3701.8 3753.9 3780.9 3782.0 1150.4 1203.5 1203.6 1213.9 1231.0 804.2 804.5 842.4 874.7 887.2 5282.2 5291.2 5366.8 5410.8 5531.9 401.2 402.8 408.7 413.6 416.5 3821.5 3848.0 3909.2 3964.6 3977.4 9280.2 9518.3 9594.5 9610.2 9619.4 9354.6 9389.0 9453.4 9470.0 9481.1 7065.8 7159.4 7323.3 7378.5 7388.1 5224.3 5285.7 5287.8 5318.1 5376.7 8642.2 8772.8 8798.5 8804.4 8810.1 8613.5 8808.7 8905.2 8944.9 9034.9 6254.4 6348.7 6877.9 7034.5 7143.9 7288.2 7352.3 7399.9 7408.9 7423.0 6648.8 6759.7 6770.0 6943.2 7019.5 6614.0 6631.9 6721.6 6774.0 6812.6 6282.2 6590.4 6614.3 6644.5 6670.6 4605.9 4671.4 4726.0 4735.7 4755.8 4657.2 4759.1 4809.4 4831.6 4838.2 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | [#4] prototype.html Cycles:180 Average:4958.99 Median:5716.37 stddev:1511.61 (26.4%) stddev-sans-first:1474.65 17:21:54 INFO - PROCESS | 6421 | Values: 288.8 296.2 299.9 301.9 302.2 5449.0 5525.9 5576.4 5616.1 5650.1 5628.5 5653.3 5656.7 5671.6 5678.7 4304.0 4310.3 4318.2 4321.4 4326.0 4167.0 4281.1 4288.0 4319.2 4327.6 4216.4 4225.7 4228.5 4249.8 4261.7 4155.6 4206.6 4222.6 4229.1 4233.8 3694.8 3702.4 3709.0 3740.0 3763.4 5418.5 5432.3 5455.2 5457.0 5469.6 4846.3 4919.0 4941.5 4942.6 4956.8 5901.3 5933.5 5937.4 5942.8 5951.3 4069.9 4099.8 4104.0 4111.1 4112.8 5898.4 6067.4 6160.4 6161.8 6168.7 4129.3 4145.4 4161.4 4162.1 4173.5 4201.2 4213.1 4224.7 4229.1 4235.5 4787.5 4897.3 4901.7 4915.2 4916.3 5636.3 5808.3 5934.8 5988.9 5993.3 1442.9 1470.3 1475.0 1476.9 1477.9 951.9 971.3 979.4 993.7 995.3 5678.7 5712.3 5722.1 5732.4 5746.2 6081.6 6093.6 6097.2 6104.5 6104.6 5569.5 5720.4 5746.3 5758.2 5763.6 3217.3 3242.3 3265.6 3268.2 3288.7 6074.7 6235.3 6293.6 6299.2 6349.5 6190.2 6191.5 6194.6 6232.5 6235.4 6311.8 6315.6 6320.7 6331.9 6369.9 5849.0 6095.2 6153.5 6188.9 6213.9 6067.4 6069.2 6094.5 6097.3 6114.2 6284.8 6394.9 6406.2 6416.4 6441.9 4048.2 4063.6 4067.2 4072.9 4080.9 5899.8 6019.3 6174.1 6186.4 6186.5 6013.3 6017.9 6029.4 6040.6 6063.2 5982.8 6017.5 6019.7 6026.7 6055.6 5577.5 5930.5 5954.7 5968.8 5981.0 6030.7 6061.6 6062.4 6064.4 6089.5 5637.0 5903.7 5917.3 5931.3 5948.1 17:21:54 INFO - PROCESS | 6421 | 17:21:54 INFO - PROCESS | 6421 | [#5] yui.html Cycles:180 Average:14708.94 Median:43326.57 stddev:17162.90 (39.6%) stddev-sans-first:17179.22 17:21:54 INFO - PROCESS | 6421 | Values: 791.1 796.3 797.6 810.5 827.7 14320.1 14696.0 14698.8 14739.5 14782.7 14469.2 15290.5 15298.5 15311.0 15326.2 691.5 807.6 836.2 838.8 841.0 836.5 841.1 841.1 841.5 842.0 864.8 871.0 872.7 873.0 873.9 716.9 844.3 866.0 870.7 877.2 614.4 619.2 624.7 625.1 625.4 14501.3 14519.3 14584.9 14592.2 14594.4 13651.7 14286.4 14504.3 14523.5 14590.3 11106.6 11270.5 11290.8 11325.2 11417.2 3779.8 3802.7 3877.5 3893.3 4006.6 57442.7 57610.4 58313.0 58975.4 59091.0 11198.0 11207.4 11336.9 11526.8 11543.5 18234.7 18476.7 18514.6 18545.4 18559.0 8265.0 8468.3 8480.5 8574.7 8815.3 4435.0 4503.5 4521.4 4692.9 4792.3 3118.4 3217.5 3227.0 3228.2 3230.0 600.4 635.1 635.1 639.3 639.8 568.1 606.4 644.5 705.2 706.3 8532.7 8732.9 8868.8 8946.7 8977.3 582.6 657.3 711.6 734.5 745.2 4008.8 4031.1 4054.0 4071.7 4297.3 61629.0 62331.4 63295.0 63360.0 63682.7 53068.5 53235.2 54273.7 54491.7 55333.0 48569.3 49302.0 49359.5 49391.0 50719.5 7988.2 8104.7 8216.6 8363.8 8416.6 31232.6 31965.2 32279.4 32810.2 32895.0 42389.8 43213.6 43439.6 43619.3 43661.0 10667.9 10944.5 11011.1 11044.3 11159.1 12289.4 12385.8 12822.6 12925.2 13143.9 11915.0 12161.8 12284.7 12661.6 12981.6 12027.6 12167.5 12246.6 12368.9 12479.0 11818.5 11907.2 12328.8 12474.8 12812.4 9999.5 10117.9 10261.1 10344.5 10395.5 10440.4 10675.6 10705.4 10734.9 10857.9 17:21:54 INFO - PROCESS | 6421 | -------- Summary: end -------- 17:21:54 INFO - PROCESS | 6421 | 17:21:55 INFO - TEST-INFO | 6421: exit 0 17:21:55 INFO - TEST-OK | dromaeo_css | took 1112166ms 17:21:55 INFO - TEST-START | kraken 17:21:55 INFO - operating with platform_type : linux_ 17:21:55 INFO - Initialising browser for kraken test... 17:21:55 INFO - TEST-INFO | started process 6609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTpoISV/profile http://localhost:59188/getInfo.html) 17:21:58 INFO - PROCESS | 6609 | __metrics Screen width/height:1600/1200 17:21:58 INFO - PROCESS | 6609 | colorDepth:24 17:21:58 INFO - PROCESS | 6609 | Browser inner width/height: 1024/697 17:21:58 INFO - PROCESS | 6609 | __metrics 17:22:00 ERROR - PROCESS | 6609 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:22:01 INFO - TEST-INFO | 6609: exit 0 17:22:01 INFO - Browser initialized. 17:22:01 INFO - Running cycle 1/1 for kraken test... 17:22:01 INFO - TEST-INFO | started process 6691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTpoISV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:12 INFO - PROCESS | 6691 | RSS: Main: 153575424 17:22:12 INFO - PROCESS | 6691 | 17:22:15 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59188/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:16 INFO - PROCESS | 6691 | RSS: Main: 208392192 17:22:16 INFO - PROCESS | 6691 | 17:22:18 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59188/tests/kraken/driver.html?testName=audio-dft) 17:22:19 INFO - PROCESS | 6691 | RSS: Main: 194150400 17:22:19 INFO - PROCESS | 6691 | 17:22:22 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59188/tests/kraken/driver.html?testName=audio-fft) 17:22:23 INFO - PROCESS | 6691 | RSS: Main: 265973760 17:22:23 INFO - PROCESS | 6691 | 17:22:25 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59188/tests/kraken/driver.html?testName=audio-oscillator) 17:22:25 INFO - PROCESS | 6691 | RSS: Main: 172896256 17:22:25 INFO - PROCESS | 6691 | 17:22:28 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:28 INFO - PROCESS | 6691 | RSS: Main: 176136192 17:22:28 INFO - PROCESS | 6691 | 17:22:31 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59188/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:32 INFO - PROCESS | 6691 | RSS: Main: 213463040 17:22:32 INFO - PROCESS | 6691 | 17:22:35 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59188/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:36 INFO - PROCESS | 6691 | RSS: Main: 215044096 17:22:36 INFO - PROCESS | 6691 | 17:22:38 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59188/tests/kraken/driver.html?testName=json-parse-financial) 17:22:39 INFO - PROCESS | 6691 | RSS: Main: 214499328 17:22:39 INFO - PROCESS | 6691 | 17:22:41 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:41 INFO - PROCESS | 6691 | RSS: Main: 201318400 17:22:41 INFO - PROCESS | 6691 | 17:22:43 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:44 INFO - PROCESS | 6691 | RSS: Main: 203882496 17:22:44 INFO - PROCESS | 6691 | 17:22:46 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:46 INFO - PROCESS | 6691 | RSS: Main: 219258880 17:22:46 INFO - PROCESS | 6691 | 17:22:49 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:49 INFO - PROCESS | 6691 | RSS: Main: 224473088 17:22:49 INFO - PROCESS | 6691 | 17:22:52 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:53 INFO - PROCESS | 6691 | RSS: Main: 219193344 17:22:53 INFO - PROCESS | 6691 | 17:22:54 INFO - PROCESS | 6691 | Cycle 1(1): loaded http://localhost:59188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59188/tests/kraken/driver.html?testName=ai-astar) 17:22:55 INFO - PROCESS | 6691 | RSS: Main: 282071040 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | __start_tp_report 17:22:55 INFO - PROCESS | 6691 | _x_x_mozilla_page_load 17:22:55 INFO - PROCESS | 6691 | _x_x_mozilla_page_load_details 17:22:55 INFO - PROCESS | 6691 | |i|pagename|runs| 17:22:55 INFO - PROCESS | 6691 | |0;ai-astar;110;112;106;110;112;115;100;111;112;111 17:22:55 INFO - PROCESS | 6691 | |1;audio-beat-detection;157;128;152;179;132;163;161;128;180;132 17:22:55 INFO - PROCESS | 6691 | |2;audio-dft;162;162;161;160;162;162;162;161;162;162 17:22:55 INFO - PROCESS | 6691 | |3;audio-fft;76;76;115;113;76;76;73;111;106;76 17:22:55 INFO - PROCESS | 6691 | |4;audio-oscillator;92;93;151;93;93;94;147;92;93;145 17:22:55 INFO - PROCESS | 6691 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;117;116;116 17:22:55 INFO - PROCESS | 6691 | |6;imaging-darkroom;145;145;146;146;146;145;146;145;146;145 17:22:55 INFO - PROCESS | 6691 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;95;96 17:22:55 INFO - PROCESS | 6691 | |8;json-parse-financial;54;57;56;57;56;57;60;81;54;55 17:22:55 INFO - PROCESS | 6691 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;61;61;61 17:22:55 INFO - PROCESS | 6691 | |10;stanford-crypto-aes;81;80;81;88;80;80;83;87;83;81 17:22:55 INFO - PROCESS | 6691 | |11;stanford-crypto-ccm;134;129;127;134;124;127;125;126;159;134 17:22:55 INFO - PROCESS | 6691 | |12;stanford-crypto-pbkdf2;175;169;167;172;164;171;167;168;167;167 17:22:55 INFO - PROCESS | 6691 | |13;stanford-crypto-sha256-iterative;68;66;68;69;67;66;68;69;70;68 17:22:55 INFO - PROCESS | 6691 | __end_tp_report 17:22:55 INFO - PROCESS | 6691 | __start_cc_report 17:22:55 INFO - PROCESS | 6691 | _x_x_mozilla_cycle_collect,1586 17:22:55 INFO - PROCESS | 6691 | __end_cc_report 17:22:55 INFO - PROCESS | 6691 | __startTimestamp1460679775225__endTimestamp 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | ------- Summary: start ------- 17:22:55 INFO - PROCESS | 6691 | Number of tests: 14 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:4.15 (3.7%) stddev-sans-first:4.40 17:22:55 INFO - PROCESS | 6691 | Values: 110.0 112.0 106.0 110.0 112.0 115.0 100.0 111.0 112.0 111.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:159.00 stddev:20.24 (12.7%) stddev-sans-first:21.35 17:22:55 INFO - PROCESS | 6691 | Values: 157.0 128.0 152.0 179.0 132.0 163.0 161.0 128.0 180.0 132.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 17:22:55 INFO - PROCESS | 6691 | Values: 162.0 162.0 161.0 160.0 162.0 162.0 162.0 161.0 162.0 162.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.00 stddev:18.62 (24.5%) stddev-sans-first:19.07 17:22:55 INFO - PROCESS | 6691 | Values: 76.0 76.0 115.0 113.0 76.0 76.0 73.0 111.0 106.0 76.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:93.00 stddev:26.52 (28.5%) stddev-sans-first:27.38 17:22:55 INFO - PROCESS | 6691 | Values: 92.0 93.0 151.0 93.0 93.0 94.0 147.0 92.0 93.0 145.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:22:55 INFO - PROCESS | 6691 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 116.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:22:55 INFO - PROCESS | 6691 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:22:55 INFO - PROCESS | 6691 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:8.03 (14.1%) stddev-sans-first:8.33 17:22:55 INFO - PROCESS | 6691 | Values: 54.0 57.0 56.0 57.0 56.0 57.0 60.0 81.0 54.0 55.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 17:22:55 INFO - PROCESS | 6691 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.91 (3.6%) stddev-sans-first:3.05 17:22:55 INFO - PROCESS | 6691 | Values: 81.0 80.0 81.0 88.0 80.0 80.0 83.0 87.0 83.0 81.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.50 stddev:10.27 (7.8%) stddev-sans-first:10.86 17:22:55 INFO - PROCESS | 6691 | Values: 134.0 129.0 127.0 134.0 124.0 127.0 125.0 126.0 159.0 134.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:168.50 stddev:3.16 (1.9%) stddev-sans-first:2.40 17:22:55 INFO - PROCESS | 6691 | Values: 175.0 169.0 167.0 172.0 164.0 171.0 167.0 168.0 167.0 167.0 17:22:55 INFO - PROCESS | 6691 | 17:22:55 INFO - PROCESS | 6691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.36 17:22:55 INFO - PROCESS | 6691 | Values: 68.0 66.0 68.0 69.0 67.0 66.0 68.0 69.0 70.0 68.0 17:22:55 INFO - PROCESS | 6691 | -------- Summary: end -------- 17:22:55 INFO - PROCESS | 6691 | 17:22:56 INFO - TEST-INFO | 6691: exit 0 17:22:56 INFO - TEST-OK | kraken | took 61150ms 17:22:56 INFO - SUITE-END | took 1173s 17:22:56 INFO - Completed test suite (00:19:33) 17:22:56 INFO - javascript benchmark 17:22:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.102710214038, 3108.0520441265435, 3149.795263307885, 3155.021943197609, 3174.6984036516524, 5192.039472697549, 5220.190870415082, 5227.477252274771, 5239.633225674204, 5342.1452567589195, 5257.447967963366, 5267.841964741064, 5269.209618557218, 5296.602754793386, 5303.628745987782, 4752.405949256343, 4785.760711964396, 4836.443808961962, 4840.588549973257, 4884.19410797218, 4801.8079276828885, 4818.397700287464, 4824.445188803297, 4851.0, 4911.7544122793715, 4722.480527142012, 4817.349657796222, 4829.179039563265, 4856.2958371036, 4906.1414252505665, 4839.41926968766, 4850.078485087822, 4863.294822250789, 4863.562279394836, 4893.608511319121, 4709.646776491777, 4822.083804077214, 4835.492273311287, 4850.636202284807, 4856.05306965142, 5165.380154381461, 5201.9479805201845, 5230.529252367305, 5271.182966640138, 5273.024490469275, 5546.223528705985, 5565.666060036411, 5568.610197286192, 5575.414581468928, 5583.6928968906695, 5585.134304182818, 5605.915911261293, 5609.102543593006, 5627.521660658849, 5676.403977582336, 5283.86790330241, 5298.735063246861, 5308.416074231832, 5351.705656188869, 5354.946450535484, 5746.569007324384, 5764.106563482667, 5765.625234359837, 5771.567132465082, 5773.538116950634, 5410.945890541123, 5510.724463776795, 5541.418151094158, 5553.583481238923, 5560.638558493685, 5608.495235428831, 5641.548676105902, 5646.124850648156, 5649.661020338711, 5673.574481913873, 5600.971995140079, 5613.915791263134, 5614.2701448811395, 5616.269884914935, 5618.353889302783, 5519.668819870821, 5616.97191514048, 5656.208130861683, 5732.455416735404, 5744.080947048452, 4194.2450358935685, 4201.2017716634355, 4204.432401625802, 4215.768132752728, 4238.639715624145, 3781.2248489059675, 3789.1853251551047, 3801.961980380216, 3810.942835857464, 3821.121142137268, 5096.286519887219, 5221.451747566527, 5250.97374513125, 5296.576273898079, 5387.191921211771, 5627.127795191752, 5647.209390685307, 5650.7174641267775, 5664.688442135722, 5666.943330566724, 5352.143657014859, 5370.758315875795, 5374.1938709193155, 5395.163749618815, 5451.1005684062475, 4717.0, 4831.202851529459, 4885.316055752198, 4909.729964851967, 4928.0, 5790.160426738184, 5791.9710401448565, 5804.390538993345, 5804.970975145097, 5809.3609702932645, 5495.395506494362, 5631.577631677641, 5646.802361917477, 5654.095344744821, 5687.687177205294, 5733.39799321082, 5754.482096611325, 5762.30852297727, 5780.710964451845, 5785.82642520725, 5406.810761623325, 5462.863428414322, 5464.617476776746, 5468.152436372368, 5478.260434841405, 5537.2524709163745, 5556.055470569932, 5564.304461942257, 5583.106702927512, 5602.915956260741, 5512.6968016759465, 5519.31008623922, 5519.31008623922, 5520.558355331484, 5563.972180139073, 5489.505944465017, 5495.835124946258, 5502.0, 5503.587230957614, 5504.22940788298, 5282.97358513205, 5367.5169234769055, 5449.564034877121, 5462.399136095106, 5513.751881165277, 5572.219889215432, 5573.944260557342, 5583.302087239095, 5583.832485025456, 5593.860153496195, 5434.3207099112615, 5463.945360546344, 5467.343918729778, 5475.835724928259, 5496.6701997880255], "value": 5192.258959990781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.61249381655, 630.7603110817888, 651.1047309948818, 652.0773106054933, 662.519673236903, 26977.325566860814, 37006.25987480252, 38095.04762380938, 38201.23597528048, 38302.425463618, 39462.8026859866, 39708.0, 40024.399634005444, 40026.0, 40088.59911400885, 7573.924260757377, 8297.543635100066, 8602.139786021411, 8613.870791938127, 9842.803143937153, 9916.256280778935, 10051.597936082548, 10080.798384032314, 10082.294239403245, 10095.242856785733, 9998.500074996258, 10128.442935638537, 10137.645182418617, 10138.59445622178, 10149.594016239378, 7691.000169977895, 10035.197184225244, 10133.594656213743, 10451.320664156805, 10458.79082418355, 9904.55429505674, 9975.65085222021, 10008.849867251996, 10028.24788140885, 10042.548085336177, 37445.438318425244, 37899.81050094759, 38046.23907521862, 38070.42894356587, 38162.80918595417, 3215.742740580748, 3351.463765797485, 3352.128446603876, 3485.372632926072, 3776.433534969749, 28209.43581128366, 28501.144965651063, 28519.429611407864, 28538.286542836388, 28716.0, 4176.749395036308, 4223.704340696153, 4287.635550978171, 4300.440942677463, 4485.573870482299, 197629.01185494123, 198144.0, 199603.0, 200852.0, 200930.0, 56740.148897766565, 57083.14375284374, 57470.712646437336, 57483.425165748646, 57525.712371437876, 62277.37722622806, 63928.360716393174, 63998.68000659967, 64120.35879641144, 64193.35806641874, 14520.782188267185, 14663.046901951338, 14677.633059173393, 14686.0, 14687.55937321882, 12312.81530777039, 12368.75262494763, 12390.070744694183, 12390.690232744253, 12403.131780775258, 19161.32935347256, 19352.838829670265, 19413.4175974721, 19415.708764368545, 19457.610847782966, 5863.355030946593, 7019.6490175492045, 7203.819904502429, 7316.0, 7333.230010848891, 1078.1428764132534, 1078.6278733836814, 1084.4035780320792, 1141.7830612183825, 1147.3861484105964, 31568.684313157035, 32914.50628240578, 33151.502727459105, 33339.83330083334, 33833.492497612555, 1136.6249137784512, 1149.747055647756, 1158.4034222375483, 1185.2236784905901, 1194.6057800925673, 15040.0, 15304.770428443582, 15325.31036103378, 15385.307661155051, 15590.142542160063, 440089.0, 445726.0, 446348.0, 446807.0, 449136.0, 53723.19415208775, 55898.0, 55933.720331398894, 55934.0, 56062.0, 1282.2050328796206, 1352.3441131051432, 1418.4113592859055, 1431.4131206205407, 1445.3351458329287, 28621.0, 31544.36911261808, 31871.52192717065, 31960.84019579887, 32534.34931301408, 44776.55223447724, 45537.77231113823, 45804.77097614624, 45881.54118458906, 45907.770461147484, 322105.0, 322770.0, 323835.0, 323987.0, 324788.0, 22400.439989000406, 26655.33361665974, 27636.309092272855, 27774.0, 27796.30509237285, 39561.20877582375, 46729.53270467252, 48249.0, 48268.0, 49007.26489102595, 35115.473267901514, 35571.466428003085, 36033.45949810807, 36063.819680902474, 36477.27045459023, 35961.0, 36161.0, 36227.63772362243, 36388.0, 36646.450303246005, 36271.818640906626, 37471.62528374681, 37685.0, 38129.428058579695, 40304.677485069304, 33402.164945876546, 34635.30729385449, 35226.82386588153, 35303.117422063624, 35527.0, 27829.0, 28197.061848977904, 28206.43587128287, 28251.0, 28314.150575482767], "value": 19112.348376241254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.5631102387768, 383.8925100971729, 391.8804764546814, 394.45171212015293, 400.8196311659754, 17554.0, 18961.715574266396, 19191.32830350938, 19196.136173872175, 19196.61606767864, 17227.82772172281, 17975.19111639976, 18149.818501814978, 19013.809861901376, 19021.33425330114, 4958.429780575235, 5091.109055915219, 5123.820666276681, 5130.5126013028885, 5324.520793128618, 5482.314710661168, 5661.377248502661, 5665.093585026397, 5668.603197776158, 5682.630629009122, 5250.212468129792, 5639.436056394348, 5640.379558248589, 5642.887142257153, 5646.717664116798, 5409.675419474825, 5432.70120143392, 5451.536619387357, 5461.208124821918, 5464.644798088111, 4791.233402655594, 5178.715170665612, 5284.286621306152, 5288.8413347599635, 5290.127129023706, 12178.269303841798, 12251.326177060258, 12342.382880855921, 12347.691307717289, 14700.632484187874, 2150.2259186692777, 2184.1263494602126, 2233.4081468410886, 2323.4772176260376, 2326.5114325991563, 9138.862917056249, 9166.495842728647, 9169.22061624756, 9289.396189247676, 9664.806703865883, 1835.403493864486, 1840.9874568987138, 1869.429823903709, 1882.407041781848, 2021.353166986565, 77992.61003695002, 80166.59916700379, 80180.0, 81019.18980810176, 81100.59449702773, 10589.205809564313, 10770.138388928866, 10913.126949843994, 10949.890501095046, 11058.834117488244, 15242.618934526725, 15303.540893772983, 15324.310406031755, 15329.846701532842, 15336.846631533765, 7822.591933452033, 8039.181388840371, 8107.594620268963, 8196.13940536247, 8209.712660056988, 7786.883196752054, 7814.570198639016, 7817.335526480199, 7906.525608463396, 7923.920760792434, 4411.625011873963, 4432.335149727567, 4673.0, 4691.1555919934735, 4705.082508910798, 1847.5473508990383, 1853.3235369090455, 1870.822271884169, 1914.4065339744723, 1950.6196291722977, 943.5848226780195, 989.5893204320126, 1062.6227689170387, 1077.256692881909, 1113.7494063835734, 18683.15925783343, 19159.712604310946, 19211.0, 19382.70925936112, 19521.804781952, 1015.6800607808665, 1021.7701017271203, 1043.2384359417667, 1043.5617040842865, 1067.2635881241918, 10270.589176432859, 10730.83903741429, 10802.0, 10882.347059176474, 10915.508802103766, 492638.0, 493488.0, 495102.0, 523461.0, 525806.0, 90735.0, 91812.0, 91986.0, 92482.0, 94477.0, 1036.8548403223556, 1042.213129087534, 1069.550788668761, 1090.7055095124272, 1104.5636973395465, 16465.176741162653, 16871.240794164536, 16947.32210711558, 17280.395186168425, 17392.913035434744, 37138.62861371352, 37564.0, 37746.62253377431, 39080.609193907694, 39210.60789392069, 54771.45228547663, 55205.0, 56485.0, 56801.431985681265, 56817.43182568121, 8019.558924259221, 8053.476524025919, 8188.344932405274, 8240.587970601566, 8287.088420273645, 9063.728088157366, 11672.474738636613, 12299.87700123023, 12810.743785124432, 13542.729145417234, 11464.656060318204, 11715.414229288332, 12066.577669781516, 12088.461423101247, 12211.87788122143, 11241.269317494336, 11604.0, 11715.648530544097, 11784.882151178379, 11792.52829886795, 11976.401179941142, 12089.697757556132, 12177.878221217674, 12223.816642750187, 12561.434735436744, 8088.272055515032, 8365.330773538224, 8383.287420569077, 8562.357823163413, 8710.346723995599, 11226.719332016764, 12274.693132671755, 12277.447514862031, 12294.385280735749, 12555.183913045623], "value": 8899.505761845285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.502186679995, 1503.1281856523215, 1506.9547913562594, 1656.6521030583576, 1789.4273832373638, 6847.452203823695, 7678.347340476059, 7807.375409967189, 7849.529028258301, 7854.450188486809, 7534.133574638919, 7693.499922505047, 7698.499597526157, 7713.961430192841, 7720.112187098485, 1984.0674882805058, 2054.1680619349186, 2056.5475595368994, 2219.5782801267746, 2247.1011595361906, 2221.4779526811267, 2266.6939963104933, 2275.601769690306, 2277.430642339415, 2278.168468508999, 2202.50443650179, 2227.8551894126913, 2234.765349638289, 2236.7539570647214, 2238.250186187629, 1965.263026365113, 2185.1259496201487, 2211.215018668374, 2218.0794970087395, 2219.611567975606, 2232.05137816429, 2252.1441852096264, 2258.3563684350047, 2259.243153543565, 2260.2993072147688, 7438.628068596603, 7476.102867655916, 7485.363744081759, 7488.700451981914, 7549.660265288076, 4627.1439783640135, 4738.4550776660435, 4773.188557945157, 4791.161546729343, 4796.808127674889, 3110.5956225690516, 3143.827089510076, 3269.1336795749144, 3291.0291464017932, 3294.159989202762, 1081.0702795595782, 1126.0822429719751, 1129.0322580645227, 1129.6836885672026, 1147.8679951805566, 9775.706728798148, 9889.307748457612, 9906.504674766305, 9934.00659934008, 9952.203823694088, 4041.413994970713, 4143.56492568282, 4221.071364299849, 4224.746515209097, 4243.554426785143, 8605.569721513899, 8665.610047547876, 8730.083341249205, 8748.8687669685, 8858.73423797287, 4781.569658730731, 4783.473817880031, 4806.351142595775, 4809.158397280462, 4816.494268101869, 3907.1794923065904, 4356.978215108968, 4447.555244475527, 4463.754493502888, 4513.819447222074, 3654.0, 3701.7964011979598, 3753.868614598476, 3780.9243815124096, 3782.0355809268463, 1150.3902931446346, 1203.5366383942246, 1203.554684766642, 1213.9453724582415, 1230.9630711078682, 804.2199066905092, 804.4851295171095, 842.3682238321259, 874.7157173918501, 887.2281115429618, 5282.1548552232225, 5291.153415453509, 5366.838994830161, 5410.810621628224, 5531.861703457365, 401.23564609419105, 402.7643828360442, 408.65264525153384, 413.64426593129883, 416.5230810721767, 3821.5414150301585, 3847.9807600961817, 3909.198614284065, 3964.583718709494, 3977.3835055566433, 9280.164785169232, 9518.333716639769, 9594.520273986273, 9610.183134433511, 9619.422834629944, 9354.625814967325, 9388.95305523468, 9453.43279403238, 9470.0, 9481.09929556691, 7065.752698655522, 7159.391451726661, 7323.3408993189805, 7378.483506154517, 7388.0764904388025, 5224.346956630421, 5285.735713214401, 5287.7620507078045, 5318.0959236930585, 5376.73116344189, 8642.178992995656, 8772.78068048304, 8798.47209167452, 8804.427712198687, 8810.118988101138, 8613.526256055977, 8808.691695790616, 8905.243054340453, 8944.86582701247, 9034.864477032981, 6254.374562543891, 6348.746050157942, 6877.862442751017, 7034.507584469038, 7143.892841607484, 7288.234735352712, 7352.338289553966, 7399.852002960019, 7408.851822963618, 7422.96288518554, 6648.767293144717, 6759.729610815512, 6769.966150169218, 6943.201531823703, 7019.508634395544, 6614.0, 6631.900521492085, 6721.563098398588, 6774.0, 6812.557183783038, 6282.183316168869, 6590.406863382319, 6614.272430032789, 6644.501662375244, 6670.633115178712, 4605.861824145281, 4671.416072990876, 4725.952740472551, 4735.668503204743, 4755.762211889461, 4657.184992626345, 4759.095771803346, 4809.374781278411, 4831.613470922248, 4838.153323168502], "value": 4116.568036618367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.7545586251686, 296.22980251346496, 299.878549187579, 301.9305559721263, 302.23534457821705, 5448.972755136218, 5525.861853453665, 5576.386597474275, 5616.129499927512, 5650.124230744241, 5628.465295796893, 5653.349864765553, 5656.745446454909, 5671.602987790856, 5678.659280443177, 4303.956960430395, 4310.331898555729, 4318.244307246235, 4321.351797230409, 4326.005018845667, 4166.999920019189, 4281.079567892903, 4287.957120428787, 4319.157764235975, 4327.610515053644, 4216.388623649585, 4225.704200705952, 4228.534861165269, 4249.788810189097, 4261.659067274611, 4155.646770024551, 4206.64243539298, 4222.619964203206, 4229.133027729308, 4233.767142807144, 3694.7967861767593, 3702.407614781649, 3709.0356507308293, 3740.0, 3763.41667041609, 5418.485243901823, 5432.348118225838, 5455.236266922634, 5456.972715136399, 5469.644473109235, 4846.297286893416, 4918.9754051229875, 4941.45643979162, 4942.555170034678, 4956.826511072095, 5901.2918449785875, 5933.495652869511, 5937.406259374071, 5942.762289508414, 5951.256092988377, 4069.8575549855614, 4099.795010249476, 4104.035551645361, 4111.1366613011305, 4112.814923328458, 5898.380670029628, 6067.393260673942, 6160.383961603804, 6161.7535298588, 6168.722407491674, 4129.256733787947, 4145.419641250227, 4161.3549899765585, 4162.084341444938, 4173.5409104998425, 4201.243776120327, 4213.136307057046, 4224.725392849455, 4229.090745489734, 4235.4917409910395, 4787.473377928425, 4897.2654101885, 4901.701049221959, 4915.21356582945, 4916.262560615936, 5636.267285252891, 5808.30300363959, 5934.821955341346, 5988.9101663475085, 5993.310769261503, 1442.8701416872323, 1470.2942587558032, 1474.9631259218606, 1476.8966172368046, 1477.926103694811, 951.9286053546011, 971.2521358553875, 979.4319294808994, 993.7068564773409, 995.2585323933715, 5678.659280443187, 5712.314522257356, 5722.113072473773, 5732.398098199712, 5746.224259724967, 6081.604695694766, 6093.634381937098, 6097.207363042776, 6104.534911621179, 6104.603200791934, 5569.498745112959, 5720.425808386243, 5746.281714785652, 5758.165066065397, 5763.596548241583, 3217.3404452087266, 3242.302904875463, 3265.6081270247723, 3268.2188207426534, 3288.67113288674, 6074.696265186812, 6235.282942461584, 6293.622382657055, 6299.244090709052, 6349.492040636738, 6190.1952746142715, 6191.535634827406, 6194.562018079919, 6232.473044104133, 6235.376462353819, 6311.842203944846, 6315.621062736251, 6320.652364119926, 6331.936680633226, 6369.936300637027, 5848.970755146197, 6095.207623009158, 6153.507719382528, 6188.907166392598, 6213.9067913982235, 6067.423594758491, 6069.180660610761, 6094.512439004958, 6097.286707415157, 6114.174586430775, 6284.8428789278805, 6394.90407643895, 6406.167198264196, 6416.422521972858, 6441.903371449525, 4048.2390160280374, 4063.5733248008532, 4067.186562687415, 4072.938905916473, 4080.9387859181543, 5899.764009439575, 6019.337872834072, 6174.104754810437, 6186.412290832363, 6186.505079593531, 6013.338532761481, 6017.879642407215, 6029.397060294111, 6040.577159598786, 6063.211782468251, 5982.820515384546, 6017.532811547245, 6019.6990150493175, 6026.728797204224, 6055.576109672281, 5577.52591029767, 5930.52555795544, 5954.672493012753, 5968.791092311748, 5980.970095149496, 6030.698465076816, 6061.605995610271, 6062.36345183767, 6064.363241859718, 6089.451949324582, 5637.0, 5903.734331955158, 5917.319508256605, 5931.3178984417345, 5948.10778383246], "value": 4458.729059529183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.1060501633154, 796.2833449895096, 797.557355667605, 810.5136917849292, 827.6565225431442, 14320.140791552514, 14696.044757090782, 14698.779518307234, 14739.484118055843, 14782.704345913075, 14469.20419376934, 15290.541283761506, 15298.541043768677, 15311.0, 15326.15706136162, 691.5159388428095, 807.5840941914919, 836.1513064239801, 838.8112674648186, 840.9915900840974, 836.4939211776879, 841.1168273313027, 841.146236569879, 841.4530555139178, 842.0442797424936, 864.788126908905, 870.9520976346298, 872.6901949807822, 872.9563521823915, 873.8776571280026, 716.9498135130569, 844.3118858130604, 866.0386970462781, 870.7126648206108, 877.1579283887476, 614.370270472769, 619.2074145094286, 624.7157543317779, 625.121704005868, 625.4308579192913, 14501.347439365254, 14519.346629401702, 14584.854151458561, 14592.197429141394, 14594.416223351052, 13651.658708532266, 14286.428542858273, 14504.27478626075, 14523.491677791333, 14590.27048647574, 11106.61126860564, 11270.54917803295, 11290.830637540443, 11325.207235493519, 11417.200795944287, 3779.848806047755, 3802.6957843372466, 3877.5346958365176, 3893.279743247508, 4006.559278479365, 57442.7127864358, 57610.42389576093, 58313.0, 58975.41024589785, 59090.99999999957, 11198.0, 11207.383593902414, 11336.886631133748, 11526.769464610828, 11543.538258469567, 18234.726479102825, 18476.722849157275, 18514.629707405777, 18545.44363669092, 18559.0, 8264.958675206586, 8468.280196183394, 8480.491170529787, 8574.699885503978, 8815.338849586307, 4434.955650443519, 4503.54964503547, 4521.367008618796, 4692.859214223578, 4792.329073929653, 3118.438681037435, 3217.501287300472, 3227.0480208338126, 3228.1929517620597, 3230.0148454721534, 600.3576173494406, 635.0791352538837, 635.1267007864187, 639.3191251317425, 639.8016614849412, 568.1194149069009, 606.4451027309962, 644.4908522267357, 705.1960764728213, 706.3007622453733, 8532.658693652309, 8732.8690069649, 8868.822623547621, 8946.68686595966, 8977.32670049749, 582.6387639663436, 657.2540166910495, 711.6015031582331, 734.5078797205884, 745.1765798792364, 4008.7594744315434, 4031.113155105872, 4054.0, 4071.6742660587083, 4297.290946993711, 61629.0, 62331.37668623256, 63295.0, 63360.0, 63682.6815865927, 53068.46931530713, 53235.201471977954, 54273.72863135738, 54491.72754136283, 55333.0, 48569.27146092812, 49302.0, 49359.50640493549, 49391.0, 50719.49280507295, 7988.241117093867, 8104.716334928485, 8216.589170541569, 8363.83272334562, 8416.621252043551, 31232.594533246513, 31965.20086997844, 32279.35441291208, 32810.1797455056, 32895.0, 42389.78805105955, 43213.567864320954, 43439.56560434482, 43619.345709813744, 43661.0, 10667.89332106669, 10944.45277736094, 11011.119110471303, 11044.282121662067, 11159.10727141843, 12289.385530723606, 12385.752284954071, 12822.615321540368, 12925.224486530838, 13143.934280328536, 11915.0, 12161.817572736592, 12284.692882678004, 12661.620151395473, 12981.610551683465, 12027.639170824888, 12167.45246463929, 12246.632601021984, 12368.938155309166, 12479.0, 11818.527258909548, 11907.166498345032, 12328.81506777417, 12474.812877807022, 12812.359382031047, 9999.500024998575, 10117.949410252902, 10261.127804136731, 10344.534495947852, 10395.532201051123, 10440.37357758537, 10675.626353077605, 10705.357678539001, 10734.892651073702, 10857.891421085687], "value": 6651.866392909891, "unit": "score"}], "name": "dromaeo_css", "value": 6899.145525384472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 110.0, 112.0, 115.0, 100.0, 111.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 152.0, 179.0, 132.0, 163.0, 161.0, 128.0, 180.0, 132.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 115.0, 113.0, 76.0, 76.0, 73.0, 111.0, 106.0, 76.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 93.0, 93.0, 94.0, 147.0, 92.0, 93.0, 145.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 57.0, 56.0, 57.0, 60.0, 81.0, 54.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 88.0, 80.0, 80.0, 83.0, 87.0, 83.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 127.0, 134.0, 124.0, 127.0, 125.0, 126.0, 159.0, 134.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 167.0, 172.0, 164.0, 171.0, 167.0, 168.0, 167.0, 167.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 69.0, 67.0, 66.0, 68.0, 69.0, 70.0, 68.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1550.0000000000002, "alertThreshold": 2.0}]} 17:22:56 INFO - Return code: 0 17:22:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:22:56 ERROR - # TBPL SUCCESS # 17:22:56 INFO - Running post-action listener: _resource_record_post_action 17:22:56 INFO - Running post-run listener: _resource_record_post_run 17:22:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 508731392; Read time: 0; Write time: 1004360 17:22:57 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 219635712; Read time: 0; Write time: 615840 17:22:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289095680; Read time: 0; Write time: 388520 17:22:57 INFO - Running post-run listener: _upload_blobber_files 17:22:57 INFO - Blob upload gear active. 17:22:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:57 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:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:22:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:58 INFO - (blobuploader) - INFO - Done attempting. 17:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:22:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:59 INFO - (blobuploader) - INFO - Done attempting. 17:22:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:59 INFO - Return code: 0 17:22:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8f0d0195e5406e44cf8dada3be3d9a0407eaf99fc69fed1194f0814e897de1ffe96098067dde6f48cd7a58d83a23b8bbb357e10f4b912953832e7d130ea086", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/308d4b654f0b097b1ddf36d10bbb9ce4b0cee7411389a009b9685857544665ff729e6073b546ccd605ec3c64f1caaf577af003ac6af2cc83d619fd10a43f96e6"} 17:22:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:59 INFO - Contents: 17:22:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8f0d0195e5406e44cf8dada3be3d9a0407eaf99fc69fed1194f0814e897de1ffe96098067dde6f48cd7a58d83a23b8bbb357e10f4b912953832e7d130ea086", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/308d4b654f0b097b1ddf36d10bbb9ce4b0cee7411389a009b9685857544665ff729e6073b546ccd605ec3c64f1caaf577af003ac6af2cc83d619fd10a43f96e6"} 17:22:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:59 INFO - Copying logs to upload dir... 17:22:59 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.377508 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-14 17:22:59.554732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:22:59.558010) ========= 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=33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8f0d0195e5406e44cf8dada3be3d9a0407eaf99fc69fed1194f0814e897de1ffe96098067dde6f48cd7a58d83a23b8bbb357e10f4b912953832e7d130ea086", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/308d4b654f0b097b1ddf36d10bbb9ce4b0cee7411389a009b9685857544665ff729e6073b546ccd605ec3c64f1caaf577af003ac6af2cc83d619fd10a43f96e6"} build_url:https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/eCpx8i7OQMKPg-qIooRKiw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8f0d0195e5406e44cf8dada3be3d9a0407eaf99fc69fed1194f0814e897de1ffe96098067dde6f48cd7a58d83a23b8bbb357e10f4b912953832e7d130ea086", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/308d4b654f0b097b1ddf36d10bbb9ce4b0cee7411389a009b9685857544665ff729e6073b546ccd605ec3c64f1caaf577af003ac6af2cc83d619fd10a43f96e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:22:59.583139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:22:59.583580) ========= 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=33d5923976266a1c518c4bf7000001ab-1460678444.259127-1600986829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:22:59.666874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:22:59.667226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:22:59.667578) ========= ========= Total master_lag: 0.16 =========