builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1461339346.21 results: success (0) buildid: 20160422070002 builduid: 1f34c23a995f40fc96395e4bd8f08ce1 revision: 0da9dcd298a62e744a069c336797b24135f277a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.212980) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.213415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.213692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.347963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.348273) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 08:35:46-- 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% 88.2M=0s 2016-04-22 08:35:46 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094832 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.456678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.457007) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013598 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.506405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:46.506722) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0da9dcd298a62e744a069c336797b24135f277a0 --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 0da9dcd298a62e744a069c336797b24135f277a0 --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=82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 08:35:46,976 truncating revision to first 12 chars 2016-04-22 08:35:46,977 Setting DEBUG logging. 2016-04-22 08:35:46,977 attempt 1/10 2016-04-22 08:35:46,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0da9dcd298a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 08:35:47,309 unpacking tar archive at: fx-team-0da9dcd298a6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:47.191669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:47.192008) ========= script_repo_revision: 0da9dcd298a62e744a069c336797b24135f277a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:47.192402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:47.192674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 08:35:47.201581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 08:35:47.201855) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:35:47 INFO - MultiFileLogger online at 20160422 08:35:47 in /builds/slave/test 08:35:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:35:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:47 INFO - {'append_to_log': False, 08:35:47 INFO - 'base_work_dir': '/builds/slave/test', 08:35:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:35:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:47 INFO - 'branch': 'Fx-Team-Non-PGO', 08:35:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:47 INFO - 'config_files': ('talos/linux_config.py',), 08:35:47 INFO - 'default_actions': ('clobber', 08:35:47 INFO - 'read-buildbot-config', 08:35:47 INFO - 'download-and-extract', 08:35:47 INFO - 'populate-webroot', 08:35:47 INFO - 'create-virtualenv', 08:35:47 INFO - 'install', 08:35:47 INFO - 'run-tests'), 08:35:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:47 INFO - 'download_minidump_stackwalk': True, 08:35:47 INFO - 'download_symbols': 'ondemand', 08:35:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:47 INFO - 'installer_path': 'installer.exe', 08:35:47 INFO - 'log_level': 'info', 08:35:47 INFO - 'log_name': 'talos', 08:35:47 INFO - 'log_to_console': True, 08:35:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:35:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:35:47 INFO - 'opt_config_files': (), 08:35:47 INFO - 'pip_index': False, 08:35:47 INFO - 'sps_profile': False, 08:35:47 INFO - 'sps_profile_interval': 0, 08:35:47 INFO - 'suite': 'dromaeojs', 08:35:47 INFO - 'system_bits': '32', 08:35:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:47 INFO - 'title': 'talos-linux64-ix-066', 08:35:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:47 INFO - 'use_talos_json': True, 08:35:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:47 INFO - 'work_dir': 'build'} 08:35:47 INFO - ##### 08:35:47 INFO - ##### Running clobber step. 08:35:47 INFO - ##### 08:35:47 INFO - Running pre-action listener: _resource_record_pre_action 08:35:47 INFO - Running main action method: clobber 08:35:47 INFO - rmtree: /builds/slave/test/build 08:35:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:48 INFO - Running post-action listener: _resource_record_post_action 08:35:48 INFO - ##### 08:35:48 INFO - ##### Running read-buildbot-config step. 08:35:48 INFO - ##### 08:35:48 INFO - Running pre-action listener: _resource_record_pre_action 08:35:48 INFO - Running main action method: read_buildbot_config 08:35:48 INFO - Using buildbot properties: 08:35:48 INFO - { 08:35:48 INFO - "project": "", 08:35:48 INFO - "product": "firefox", 08:35:48 INFO - "script_repo_revision": "production", 08:35:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:35:48 INFO - "repository": "", 08:35:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:35:48 INFO - "buildid": "20160422070002", 08:35:48 INFO - "pgo_build": "False", 08:35:48 INFO - "basedir": "/builds/slave/test", 08:35:48 INFO - "buildnumber": 2866, 08:35:48 INFO - "slavename": "talos-linux64-ix-066", 08:35:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:35:48 INFO - "platform": "ubuntu64_hw", 08:35:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:35:48 INFO - "branch": "fx-team", 08:35:48 INFO - "repo_path": "integration/fx-team", 08:35:48 INFO - "revision": "0da9dcd298a62e744a069c336797b24135f277a0", 08:35:48 INFO - "stage_platform": "linux64", 08:35:48 INFO - "builduid": "1f34c23a995f40fc96395e4bd8f08ce1", 08:35:48 INFO - "slavebuilddir": "test" 08:35:48 INFO - } 08:35:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:35:48 INFO - Running post-action listener: _resource_record_post_action 08:35:48 INFO - ##### 08:35:48 INFO - ##### Running download-and-extract step. 08:35:48 INFO - ##### 08:35:48 INFO - Running pre-action listener: _resource_record_pre_action 08:35:48 INFO - Running main action method: download_and_extract 08:35:48 INFO - mkdir: /builds/slave/test/build/tests 08:35: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')]} 08:35:48 INFO - https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:49 INFO - Downloaded 1361 bytes. 08:35:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:35:49 INFO - Using the following test package requirements: 08:35:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:35:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:35:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'jsshell-linux-x86_64.zip'], 08:35:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:35:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:35:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:35:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:35:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:35:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:49 INFO - https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:35:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:35:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:50 INFO - Downloaded 22285608 bytes. 08:35:50 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'] 08:35:50 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 08:35:51 INFO - Return code: 0 08:35:51 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 08:35: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')]} 08:35:51 INFO - https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:53 INFO - Downloaded 22285608 bytes. 08:35:53 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'] 08:35:53 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 08:35:54 INFO - Return code: 0 08:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:54 INFO - https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:55 INFO - Downloaded 10840145 bytes. 08:35:55 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'] 08:35:55 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 08:35:55 INFO - Return code: 0 08:35: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')]} 08:35:55 INFO - https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjHr00PCSUWjStYT0J6OKg/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 08:35:56 INFO - Downloaded 54742674 bytes. 08:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:35:56 INFO - mkdir: /builds/slave/test/properties 08:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:56 INFO - Contents: 08:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:35:57 INFO - Running post-action listener: _resource_record_post_action 08:35:57 INFO - Running post-action listener: set_extra_try_arguments 08:35:57 INFO - ##### 08:35:57 INFO - ##### Running populate-webroot step. 08:35:57 INFO - ##### 08:35:57 INFO - Running pre-action listener: _resource_record_pre_action 08:35:57 INFO - Running main action method: populate_webroot 08:35:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:57 INFO - '--tppagecycles', 08:35:57 INFO - '7'], 08:35:57 INFO - 'tests': ['tsvgm']}}, 08:35:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['damp', 'tps']}, 08:35:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'tests': ['damp', 'tps']}, 08:35:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['dromaeo_dom']}, 08:35:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['a11yr', 08:35:57 INFO - 'ts_paint', 08:35:57 INFO - 'tpaint', 08:35:57 INFO - 'sessionrestore', 08:35:57 INFO - 'sessionrestore_no_auto_restore', 08:35:57 INFO - 'tabpaint']}, 08:35:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:57 INFO - 'ts_paint', 08:35:57 INFO - 'tpaint', 08:35:57 INFO - 'sessionrestore', 08:35:57 INFO - 'sessionrestore_no_auto_restore', 08:35:57 INFO - 'tabpaint']}, 08:35:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:57 INFO - 'ts_paint', 08:35:57 INFO - 'tpaint', 08:35:57 INFO - 'sessionrestore', 08:35:57 INFO - 'sessionrestore_no_auto_restore', 08:35:57 INFO - 'tabpaint']}, 08:35:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:57 INFO - 'ts_paint', 08:35:57 INFO - 'tpaint', 08:35:57 INFO - 'sessionrestore', 08:35:57 INFO - 'sessionrestore_no_auto_restore', 08:35:57 INFO - 'tabpaint']}, 08:35:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['a11yr', 08:35:57 INFO - 'ts_paint', 08:35:57 INFO - 'tpaint', 08:35:57 INFO - 'sessionrestore', 08:35:57 INFO - 'sessionrestore_no_auto_restore', 08:35:57 INFO - 'tabpaint']}, 08:35:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['a11yr', 08:35:57 INFO - 'ts_paint', 08:35:57 INFO - 'tpaint', 08:35:57 INFO - 'sessionrestore', 08:35:57 INFO - 'sessionrestore_no_auto_restore', 08:35:57 INFO - 'tabpaint']}, 08:35:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['tsvgx', 08:35:57 INFO - 'tsvgr_opacity', 08:35:57 INFO - 'tart', 08:35:57 INFO - 'tscrollx', 08:35:57 INFO - 'cart']}, 08:35:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:57 INFO - 'tsvgr_opacity', 08:35:57 INFO - 'tart', 08:35:57 INFO - 'tscrollx', 08:35:57 INFO - 'cart']}, 08:35:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'talos_options': ['--disable-e10s'], 08:35:57 INFO - 'tests': ['tp5o']}, 08:35:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'tests': ['tp5o']}, 08:35:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'talos_options': ['--disable-e10s', 08:35:57 INFO - '--xperf_path', 08:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:57 INFO - 'tests': ['tp5n']}, 08:35:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:57 INFO - 'talos_options': ['--xperf_path', 08:35:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:57 INFO - 'tests': ['tp5n']}}, 08:35:57 INFO - 'talos.zip': {'path': '', 08:35:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:57 INFO - Running post-action listener: _resource_record_post_action 08:35:57 INFO - ##### 08:35:57 INFO - ##### Running create-virtualenv step. 08:35:57 INFO - ##### 08:35:57 INFO - Running pre-action listener: _resource_record_pre_action 08:35:57 INFO - Running main action method: create_virtualenv 08:35:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:35:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:57 INFO - Using real prefix '/usr' 08:35:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:00 INFO - Installing pip.................done. 08:36:00 INFO - Return code: 0 08:36:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:36:00 INFO - Using env: {'DISPLAY': ':0', 08:36:00 INFO - 'HOME': '/home/cltbld', 08:36:00 INFO - 'LANG': 'en_US.UTF-8', 08:36:00 INFO - 'LANGUAGE': 'en_US:en', 08:36:00 INFO - 'LOGNAME': 'cltbld', 08:36:00 INFO - 'MAIL': '/var/mail/cltbld', 08:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:00 INFO - 'MOZ_NO_REMOTE': '1', 08:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:00 INFO - 'NO_EM_RESTART': '1', 08:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:00 INFO - 'PWD': '/builds/slave/test', 08:36:00 INFO - 'SHELL': '/bin/bash', 08:36:00 INFO - 'SHLVL': '1', 08:36:00 INFO - 'TERM': 'linux', 08:36:00 INFO - 'TMOUT': '86400', 08:36:00 INFO - 'USER': 'cltbld', 08:36:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:00 INFO - '_': '/tools/buildbot/bin/python'} 08:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:36:00 INFO - Cleaning up... 08:36:00 INFO - Return code: 0 08:36:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:00 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:00 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 08:36:00 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 08:36:00 INFO - Using env: {'DISPLAY': ':0', 08:36:00 INFO - 'HOME': '/home/cltbld', 08:36:00 INFO - 'LANG': 'en_US.UTF-8', 08:36:00 INFO - 'LANGUAGE': 'en_US:en', 08:36:00 INFO - 'LOGNAME': 'cltbld', 08:36:00 INFO - 'MAIL': '/var/mail/cltbld', 08:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:00 INFO - 'MOZ_NO_REMOTE': '1', 08:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:00 INFO - 'NO_EM_RESTART': '1', 08:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:00 INFO - 'PWD': '/builds/slave/test', 08:36:00 INFO - 'SHELL': '/bin/bash', 08:36:00 INFO - 'SHLVL': '1', 08:36:00 INFO - 'TERM': 'linux', 08:36:00 INFO - 'TMOUT': '86400', 08:36:00 INFO - 'USER': 'cltbld', 08:36:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:00 INFO - '_': '/tools/buildbot/bin/python'} 08:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:00 INFO - Downloading/unpacking psutil>=0.7.1 08:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:02 INFO - Installing collected packages: psutil 08:36:02 INFO - Running setup.py install for psutil 08:36:02 INFO - building 'psutil._psutil_linux' extension 08:36:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:36:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:36:02 INFO - building 'psutil._psutil_posix' extension 08:36:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:36:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:03 INFO - Successfully installed psutil 08:36:03 INFO - Cleaning up... 08:36:03 INFO - Return code: 0 08:36:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:03 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:03 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 08:36:03 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 08:36:03 INFO - Using env: {'DISPLAY': ':0', 08:36:03 INFO - 'HOME': '/home/cltbld', 08:36:03 INFO - 'LANG': 'en_US.UTF-8', 08:36:03 INFO - 'LANGUAGE': 'en_US:en', 08:36:03 INFO - 'LOGNAME': 'cltbld', 08:36:03 INFO - 'MAIL': '/var/mail/cltbld', 08:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:03 INFO - 'MOZ_NO_REMOTE': '1', 08:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:03 INFO - 'NO_EM_RESTART': '1', 08:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:03 INFO - 'PWD': '/builds/slave/test', 08:36:03 INFO - 'SHELL': '/bin/bash', 08:36:03 INFO - 'SHLVL': '1', 08:36:03 INFO - 'TERM': 'linux', 08:36:03 INFO - 'TMOUT': '86400', 08:36:03 INFO - 'USER': 'cltbld', 08:36:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:03 INFO - '_': '/tools/buildbot/bin/python'} 08:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:36:05 INFO - Installing collected packages: mozsystemmonitor 08:36:05 INFO - Running setup.py install for mozsystemmonitor 08:36:05 INFO - Successfully installed mozsystemmonitor 08:36:05 INFO - Cleaning up... 08:36:05 INFO - Return code: 0 08:36:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:05 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:05 INFO - Using env: {'DISPLAY': ':0', 08:36:05 INFO - 'HOME': '/home/cltbld', 08:36:05 INFO - 'LANG': 'en_US.UTF-8', 08:36:05 INFO - 'LANGUAGE': 'en_US:en', 08:36:05 INFO - 'LOGNAME': 'cltbld', 08:36:05 INFO - 'MAIL': '/var/mail/cltbld', 08:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:05 INFO - 'MOZ_NO_REMOTE': '1', 08:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:05 INFO - 'NO_EM_RESTART': '1', 08:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:05 INFO - 'PWD': '/builds/slave/test', 08:36:05 INFO - 'SHELL': '/bin/bash', 08:36:05 INFO - 'SHLVL': '1', 08:36:05 INFO - 'TERM': 'linux', 08:36:05 INFO - 'TMOUT': '86400', 08:36:05 INFO - 'USER': 'cltbld', 08:36:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:05 INFO - '_': '/tools/buildbot/bin/python'} 08:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:08 INFO - Downloading docopt-0.6.1.tar.gz 08:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:08 INFO - Running setup.py install for blobuploader 08:36:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:08 INFO - Running setup.py install for requests 08:36:08 INFO - Running setup.py install for docopt 08:36:08 INFO - Successfully installed blobuploader requests docopt 08:36:08 INFO - Cleaning up... 08:36:09 INFO - Return code: 0 08:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:09 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:36:09 INFO - Using env: {'DISPLAY': ':0', 08:36:09 INFO - 'HOME': '/home/cltbld', 08:36:09 INFO - 'LANG': 'en_US.UTF-8', 08:36:09 INFO - 'LANGUAGE': 'en_US:en', 08:36:09 INFO - 'LOGNAME': 'cltbld', 08:36:09 INFO - 'MAIL': '/var/mail/cltbld', 08:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:09 INFO - 'MOZ_NO_REMOTE': '1', 08:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:09 INFO - 'NO_EM_RESTART': '1', 08:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:09 INFO - 'PWD': '/builds/slave/test', 08:36:09 INFO - 'SHELL': '/bin/bash', 08:36:09 INFO - 'SHLVL': '1', 08:36:09 INFO - 'TERM': 'linux', 08:36:09 INFO - 'TMOUT': '86400', 08:36:09 INFO - 'USER': 'cltbld', 08:36:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:09 INFO - '_': '/tools/buildbot/bin/python'} 08:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:09 INFO - Running setup.py (path:/tmp/pip-I6vISD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:09 INFO - Running setup.py (path:/tmp/pip-2KYVZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:09 INFO - Running setup.py (path:/tmp/pip-0COXkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:09 INFO - Running setup.py (path:/tmp/pip-TeskuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:09 INFO - Running setup.py (path:/tmp/pip-FOysxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:09 INFO - Running setup.py (path:/tmp/pip-4rN5lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:09 INFO - Running setup.py (path:/tmp/pip-oWn8AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:09 INFO - Running setup.py (path:/tmp/pip-7NRDEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:09 INFO - Running setup.py (path:/tmp/pip-9UZUXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:09 INFO - Running setup.py (path:/tmp/pip-d_pgWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:09 INFO - Running setup.py (path:/tmp/pip-CHro9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:10 INFO - Running setup.py (path:/tmp/pip-TRPQda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:10 INFO - Running setup.py (path:/tmp/pip-u60CrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:10 INFO - Running setup.py (path:/tmp/pip-NsCW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:10 INFO - Running setup.py (path:/tmp/pip-Ct_uHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:10 INFO - Running setup.py (path:/tmp/pip-LfHNZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:10 INFO - Running setup.py (path:/tmp/pip-h3QfrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:10 INFO - Running setup.py install for manifestparser 08:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Running setup.py install for mozcrash 08:36:10 INFO - Running setup.py install for mozdebug 08:36:10 INFO - Running setup.py install for mozdevice 08:36:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Running setup.py install for mozfile 08:36:10 INFO - Running setup.py install for mozhttpd 08:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozinfo 08:36:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozInstall 08:36:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozleak 08:36:11 INFO - Running setup.py install for mozlog 08:36:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for moznetwork 08:36:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozprocess 08:36:11 INFO - Running setup.py install for mozprofile 08:36:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozrunner 08:36:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:11 INFO - Running setup.py install for mozscreenshot 08:36:12 INFO - Running setup.py install for moztest 08:36:12 INFO - Running setup.py install for mozversion 08:36:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:12 INFO - Cleaning up... 08:36:12 INFO - Return code: 0 08:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:12 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:36:12 INFO - Using env: {'DISPLAY': ':0', 08:36:12 INFO - 'HOME': '/home/cltbld', 08:36:12 INFO - 'LANG': 'en_US.UTF-8', 08:36:12 INFO - 'LANGUAGE': 'en_US:en', 08:36:12 INFO - 'LOGNAME': 'cltbld', 08:36:12 INFO - 'MAIL': '/var/mail/cltbld', 08:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:12 INFO - 'MOZ_NO_REMOTE': '1', 08:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:12 INFO - 'NO_EM_RESTART': '1', 08:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:12 INFO - 'PWD': '/builds/slave/test', 08:36:12 INFO - 'SHELL': '/bin/bash', 08:36:12 INFO - 'SHLVL': '1', 08:36:12 INFO - 'TERM': 'linux', 08:36:12 INFO - 'TMOUT': '86400', 08:36:12 INFO - 'USER': 'cltbld', 08:36:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:12 INFO - '_': '/tools/buildbot/bin/python'} 08:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:12 INFO - Running setup.py (path:/tmp/pip-aFpfHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:12 INFO - Running setup.py (path:/tmp/pip-mH0s9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:12 INFO - Running setup.py (path:/tmp/pip-ym1P8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:12 INFO - Running setup.py (path:/tmp/pip-pgV9t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:12 INFO - Running setup.py (path:/tmp/pip-ijAJKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:12 INFO - Running setup.py (path:/tmp/pip-LXciOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:12 INFO - Running setup.py (path:/tmp/pip-Jzq1yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:12 INFO - Running setup.py (path:/tmp/pip-gxnfDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:13 INFO - Running setup.py (path:/tmp/pip-h_BbXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:13 INFO - Running setup.py (path:/tmp/pip-2AaLw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:13 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)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:13 INFO - Running setup.py (path:/tmp/pip-ICsCwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:13 INFO - Running setup.py (path:/tmp/pip-1YBz9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:13 INFO - Running setup.py (path:/tmp/pip-fMmRbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:13 INFO - Running setup.py (path:/tmp/pip-5pAZlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:13 INFO - Running setup.py (path:/tmp/pip-lW9Dyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:13 INFO - Running setup.py (path:/tmp/pip-15LBVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:13 INFO - Running setup.py (path:/tmp/pip-K0VTun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:36:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:15 INFO - Downloading blessings-1.6.tar.gz 08:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:15 INFO - Installing collected packages: blessings 08:36:15 INFO - Running setup.py install for blessings 08:36:15 INFO - Successfully installed blessings 08:36:15 INFO - Cleaning up... 08:36:15 INFO - Return code: 0 08:36:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:16 INFO - Reading from file tmpfile_stdout 08:36:16 INFO - Current package versions: 08:36:16 INFO - argparse == 1.2.1 08:36:16 INFO - blessings == 1.6 08:36:16 INFO - blobuploader == 1.2.4 08:36:16 INFO - docopt == 0.6.1 08:36:16 INFO - manifestparser == 1.1 08:36:16 INFO - mozInstall == 1.12 08:36:16 INFO - mozcrash == 0.17 08:36:16 INFO - mozdebug == 0.1 08:36:16 INFO - mozdevice == 0.48 08:36:16 INFO - mozfile == 1.2 08:36:16 INFO - mozhttpd == 0.7 08:36:16 INFO - mozinfo == 0.9 08:36:16 INFO - mozleak == 0.1 08:36:16 INFO - mozlog == 3.1 08:36:16 INFO - moznetwork == 0.27 08:36:16 INFO - mozprocess == 0.22 08:36:16 INFO - mozprofile == 0.28 08:36:16 INFO - mozrunner == 6.11 08:36:16 INFO - mozscreenshot == 0.1 08:36:16 INFO - mozsystemmonitor == 0.0 08:36:16 INFO - moztest == 0.7 08:36:16 INFO - mozversion == 1.4 08:36:16 INFO - psutil == 3.1.1 08:36:16 INFO - requests == 1.2.3 08:36:16 INFO - wsgiref == 0.1.2 08:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:16 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:36:16 INFO - Using env: {'DISPLAY': ':0', 08:36:16 INFO - 'HOME': '/home/cltbld', 08:36:16 INFO - 'LANG': 'en_US.UTF-8', 08:36:16 INFO - 'LANGUAGE': 'en_US:en', 08:36:16 INFO - 'LOGNAME': 'cltbld', 08:36:16 INFO - 'MAIL': '/var/mail/cltbld', 08:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:16 INFO - 'MOZ_NO_REMOTE': '1', 08:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:16 INFO - 'NO_EM_RESTART': '1', 08:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:16 INFO - 'PWD': '/builds/slave/test', 08:36:16 INFO - 'SHELL': '/bin/bash', 08:36:16 INFO - 'SHLVL': '1', 08:36:16 INFO - 'TERM': 'linux', 08:36:16 INFO - 'TMOUT': '86400', 08:36:16 INFO - 'USER': 'cltbld', 08:36:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:16 INFO - '_': '/tools/buildbot/bin/python'} 08:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:36:16 INFO - Cleaning up... 08:36:16 INFO - Return code: 0 08:36:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:16 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:36:16 INFO - Using env: {'DISPLAY': ':0', 08:36:16 INFO - 'HOME': '/home/cltbld', 08:36:16 INFO - 'LANG': 'en_US.UTF-8', 08:36:16 INFO - 'LANGUAGE': 'en_US:en', 08:36:16 INFO - 'LOGNAME': 'cltbld', 08:36:16 INFO - 'MAIL': '/var/mail/cltbld', 08:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:16 INFO - 'MOZ_NO_REMOTE': '1', 08:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:16 INFO - 'NO_EM_RESTART': '1', 08:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:16 INFO - 'PWD': '/builds/slave/test', 08:36:16 INFO - 'SHELL': '/bin/bash', 08:36:16 INFO - 'SHLVL': '1', 08:36:16 INFO - 'TERM': 'linux', 08:36:16 INFO - 'TMOUT': '86400', 08:36:16 INFO - 'USER': 'cltbld', 08:36:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:16 INFO - '_': '/tools/buildbot/bin/python'} 08:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:16 INFO - Downloading/unpacking jsonschema 08:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:18 INFO - Downloading/unpacking functools32 (from jsonschema) 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:18 INFO - warning: no files found matching '*.txt' 08:36:18 INFO - no previously-included directories found matching 'build' 08:36:18 INFO - no previously-included directories found matching 'dist' 08:36:18 INFO - no previously-included directories found matching '.git*' 08:36:18 INFO - Installing collected packages: jsonschema, functools32 08:36:18 INFO - Running setup.py install for functools32 08:36:18 INFO - warning: no files found matching '*.txt' 08:36:18 INFO - no previously-included directories found matching 'build' 08:36:18 INFO - no previously-included directories found matching 'dist' 08:36:18 INFO - no previously-included directories found matching '.git*' 08:36:18 INFO - Successfully installed jsonschema functools32 08:36:18 INFO - Cleaning up... 08:36:18 INFO - Return code: 0 08:36:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 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 0x7f2f95221f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:36:18 INFO - Using env: {'DISPLAY': ':0', 08:36:18 INFO - 'HOME': '/home/cltbld', 08:36:18 INFO - 'LANG': 'en_US.UTF-8', 08:36:18 INFO - 'LANGUAGE': 'en_US:en', 08:36:18 INFO - 'LOGNAME': 'cltbld', 08:36:18 INFO - 'MAIL': '/var/mail/cltbld', 08:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:18 INFO - 'MOZ_NO_REMOTE': '1', 08:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:18 INFO - 'NO_EM_RESTART': '1', 08:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:18 INFO - 'PWD': '/builds/slave/test', 08:36:18 INFO - 'SHELL': '/bin/bash', 08:36:18 INFO - 'SHLVL': '1', 08:36:18 INFO - 'TERM': 'linux', 08:36:18 INFO - 'TMOUT': '86400', 08:36:18 INFO - 'USER': 'cltbld', 08:36:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:18 INFO - '_': '/tools/buildbot/bin/python'} 08:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:19 INFO - Downloading/unpacking flake8 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:36:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:21 INFO - no previously-included directories found matching 'docs/_build' 08:36:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:36:21 INFO - Running setup.py install for pep8 08:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:21 INFO - no previously-included directories found matching 'docs/_build' 08:36:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:36:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:36:21 INFO - Cleaning up... 08:36:21 INFO - Return code: 0 08:36:21 INFO - Running post-action listener: _resource_record_post_action 08:36:21 INFO - Running post-action listener: _start_resource_monitoring 08:36:21 INFO - Starting resource monitoring. 08:36:21 INFO - ##### 08:36:21 INFO - ##### Running install step. 08:36:21 INFO - ##### 08:36:21 INFO - Running pre-action listener: _resource_record_pre_action 08:36:21 INFO - Running main action method: install 08:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:22 INFO - Reading from file tmpfile_stdout 08:36:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:22 INFO - Reading from file tmpfile_stdout 08:36:22 INFO - Output received: 08:36:22 INFO - Usage: mozinstall [options] installer 08:36:22 INFO - Options: 08:36:22 INFO - -h, --help show this help message and exit 08:36:22 INFO - -d DEST, --destination=DEST 08:36:22 INFO - Directory to install application into. [default: 08:36:22 INFO - "/builds/slave/test"] 08:36:22 INFO - --app=APP Application being installed. [default: firefox] 08:36:22 INFO - mkdir: /builds/slave/test/build/application 08:36:22 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'] 08:36:22 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 08:36:38 INFO - Reading from file tmpfile_stdout 08:36:38 INFO - Output received: 08:36:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:36:38 INFO - Running post-action listener: _resource_record_post_action 08:36:38 INFO - ##### 08:36:38 INFO - ##### Running run-tests step. 08:36:38 INFO - ##### 08:36:38 INFO - Running pre-action listener: _resource_record_pre_action 08:36:38 INFO - Running main action method: run_tests 08:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:38 INFO - Python 2.7.3 08:36:38 INFO - Return code: 0 08:36:38 INFO - grabbing minidump binary from tooltool 08:36: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')]} 08:36:38 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 0x1a9d410>, '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 0x1a9e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:36:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:36:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:38 INFO - Return code: 0 08:36:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:36:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:36:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:36:38 INFO - Return code: 0 08:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 08:36:38 INFO - Using env: {'DISPLAY': ':0', 08:36:38 INFO - 'HOME': '/home/cltbld', 08:36:38 INFO - 'LANG': 'en_US.UTF-8', 08:36:38 INFO - 'LANGUAGE': 'en_US:en', 08:36:38 INFO - 'LOGNAME': 'cltbld', 08:36:38 INFO - 'MAIL': '/var/mail/cltbld', 08:36:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:38 INFO - 'MOZ_NO_REMOTE': '1', 08:36:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:38 INFO - 'NO_EM_RESTART': '1', 08:36:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:38 INFO - 'PWD': '/builds/slave/test', 08:36:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:38 INFO - 'SHELL': '/bin/bash', 08:36:38 INFO - 'SHLVL': '1', 08:36:38 INFO - 'TERM': 'linux', 08:36:38 INFO - 'TMOUT': '86400', 08:36:38 INFO - 'USER': 'cltbld', 08:36:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145', 08:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:38 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 08:36:39 INFO - mozversion application_buildid: 20160422070002 08:36:39 INFO - mozversion application_changeset: 0da9dcd298a62e744a069c336797b24135f277a0 08:36:39 INFO - mozversion application_display_name: Nightly 08:36:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:39 INFO - mozversion application_name: Firefox 08:36:39 INFO - mozversion application_remotingname: firefox 08:36:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:36:39 INFO - mozversion application_vendor: Mozilla 08:36:39 INFO - mozversion application_version: 48.0a1 08:36:39 INFO - mozversion platform_buildid: 20160422070002 08:36:39 INFO - mozversion platform_changeset: 0da9dcd298a62e744a069c336797b24135f277a0 08:36:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:36:39 INFO - mozversion platform_version: 48.0a1 08:36:39 INFO - using testdate: 1461339399 08:36:39 INFO - actual date: 1461339399 08:36:39 INFO - starting webserver on 'localhost:57261' 08:36:39 INFO - SUITE-START | Running 2 tests 08:36:39 INFO - TEST-START | dromaeo_css 08:36:39 INFO - operating with platform_type : linux_ 08:36:39 INFO - Initialising browser for dromaeo_css test... 08:36:39 INFO - TEST-INFO | started process 22234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_TCOHa/profile http://localhost:57261/getInfo.html) 08:36:43 INFO - PROCESS | 22234 | __metrics Screen width/height:1600/1200 08:36:43 INFO - PROCESS | 22234 | colorDepth:24 08:36:43 INFO - PROCESS | 22234 | Browser inner width/height: 1024/697 08:36:43 INFO - PROCESS | 22234 | __metrics 08:36:44 ERROR - PROCESS | 22234 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:36:45 INFO - TEST-INFO | 22234: exit 0 08:36:45 INFO - Browser initialized. 08:36:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:45 INFO - TEST-INFO | started process 22316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_TCOHa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:57 INFO - PROCESS | 22316 | RSS: Main: 155963392 08:36:57 INFO - PROCESS | 22316 | 08:37:49 INFO - PROCESS | 22316 | 1461339469090 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:40:00 INFO - PROCESS | 22316 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57261/tests/dromaeo/cssquery-ext.html) 08:40:01 INFO - PROCESS | 22316 | RSS: Main: 263958528 08:40:01 INFO - PROCESS | 22316 | 08:43:03 INFO - PROCESS | 22316 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-ext.html (next: http://localhost:57261/tests/dromaeo/cssquery-jquery.html) 08:43:04 INFO - PROCESS | 22316 | RSS: Main: 232943616 08:43:04 INFO - PROCESS | 22316 | 08:46:06 INFO - PROCESS | 22316 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57261/tests/dromaeo/cssquery-mootools.html) 08:46:07 INFO - PROCESS | 22316 | RSS: Main: 232947712 08:46:07 INFO - PROCESS | 22316 | 08:49:09 INFO - PROCESS | 22316 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57261/tests/dromaeo/cssquery-prototype.html) 08:49:10 INFO - PROCESS | 22316 | RSS: Main: 236482560 08:49:10 INFO - PROCESS | 22316 | 08:52:13 INFO - PROCESS | 22316 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57261/tests/dromaeo/cssquery-yui.html) 08:52:13 INFO - PROCESS | 22316 | RSS: Main: 221544448 08:52:13 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-yui.html (next: http://localhost:57261/tests/dromaeo/cssquery-dojo.html) 08:55:16 INFO - PROCESS | 22316 | RSS: Main: 274997248 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | __start_tp_report 08:55:16 INFO - PROCESS | 22316 | _x_x_mozilla_page_load 08:55:16 INFO - PROCESS | 22316 | _x_x_mozilla_page_load_details 08:55:16 INFO - PROCESS | 22316 | |i|pagename|runs| 08:55:16 INFO - PROCESS | 22316 | |0;dojo.html;2609.073778808523;2695.5013322535347;2700.5814098814676;2710.498557766812;2734.3847634282283;4527.909441811162;4639.559241872025;4692.178868697982;4707;4711.387519622453;4675.064987002596;4683.414573178353;4768.690035147713;4814.927776083362;4825.059113472866;4316.20150272199;4358.1283743251315;4364.563543645634;4379.364992076147;4432.312991486325;4306.590873866993;4353.891152721191;4422.6240769534625;4443.46678398591;4473.172463094322;4250.872473825791;4382.868513944587;4388.122375524892;4408.360787685768;4430.6012458878695;4217.34631132175;4285.164392943378;4285.271503844354;4313.805878735433;4352.630026447756;4245.80893859774;4254.74471531706;4259.936100958488;4293.055527783914;4302.978485107586;4519.954800451987;4575.702579332366;4578.336141259499;4592.380028696117;4594.310853371988;4840.975795121037;5043.067032598944;5044.747762611854;5087.669301495391;5097.362829646294;5072.771725272371;5080.74596270185;5083.161278389061;5083.313752643419;5153.2270159476375;4642.628589712815;4670.322803193586;4740.620750339999;4743.691660042121;4748.216544270226;5125.103106956268;5151.07280689472;5151.5363617274625;5187.714675692798;5197;4930.630202734809;4932.901341973212;4935.580475659537;4938.9012219755405;4980.526849949249;4903.705777653352;4997.450280469146;5009.774560144802;5037.042961837239;5122.9743851281255;5004.124278251365;5029.5221953914315;5033.119204139261;5048.964962182744;5051.166557517969;5023.974880125576;5026.949730502722;5029.195328747456;5033.723145226974;5063.569596584258;4255.808488617958;4298.634616057608;4345.652347812231;4376.212281789309;4399.824007039747;3766.1902690921584;3771.962280377216;3773.1887644156636;3786.8295926683363;3806.847726090981;4319.136172765459;4321.13577284538;4338.566143385636;4373.956260437355;4377.102693947733;5003.24951257307;5061.417936937226;5092.821751238689;5177.559907407837;5181.041507321158;4310.331898555729;4316.115196384733;4319.136172765459;4344.3483477478;4350.521442641307;4552.998340365114;4554.612857907049;4557.817687292471;4559.475660299108;4600.401947746838;4605.102005108972;4747.83382581608;4768;4844.152273352079;4848.200046992207;4994.725290109079;5006.4743201963265;5016.774245159049;5017.698938063728;5063.063333283354;4703.3650457189215;4711.976440117777;4713.3401323814005;4724.4094488188975;4756.97724989129;4842.564169224786;4976.800927962841;5026.447090819934;5074.289599456153;5081.72050537224;4995.700257984533;5002.699838009731;5009.849704508871;5017.2724954880605;5032;4797.472278049481;4874.658773885794;4875.390576177978;4882.292067650242;4924.606031517542;4891.608671306358;4925.655204135676;4950.331705219894;4984.900301994012;5004.87487812793;4739.976300118616;4751.311059896227;4759.785809638505;4768.094062128184;4814.927776083291;4841;4846.418429788448;4855.174620314484;4861.440934292602;4910.410750709795;4808.9519104808505;4823.831165909176;4828.106800241966;4859.392575928009;4873.1959226727195 08:55:16 INFO - PROCESS | 22316 | |1;ext.html;566.6543408520802;606.6238931862244;617.4689766800551;619.2785405003171;622.9345918678539;34610.826945865265;35616.46575301369;35641.82179089101;35681.46477802835;35728.82135589322;37938;38635.227295454075;38685.41971870417;38767.22465550687;38780.41829372562;7483.476156669021;7700.4224683148705;7701.1528731839735;7706.152323244439;7710.460267781257;7753.922460775405;7899.420115976799;7906.090799558067;7910.802229944268;7916.366690664762;7880.448368614199;7921.326687231593;7953.801154971143;7958.801029974268;7958.920410795876;7807.297343239107;7914.604269786488;7922.881156782624;7926;7931.603419829044;7792.10390805059;7877.054753429625;7895.842083158362;7897.881531777028;7898.131205567383;37168.44247336292;37639.24721505555;37709.43435848464;37726.24547509034;37737.43393849095;3181.1410919051727;3203.215212272985;3246.5454836322697;3352.664733526628;3434.4161492546327;28543.714562854315;28749.281267968257;28770.856145719346;29297.121086367442;29521.409571808443;3081.50695888659;3082.969170308313;3123.453395655774;3129.358481511285;3191.0745883693703;239091;240759;240917.99999999825;241391;242546;46545.76727116343;46805;46845.76577117161;46937;46963.76518117456;57554.410051547784;59128.11307830386;59459.70270148622;59475;59502.70248648729;14062.085964412281;14400.279986000867;14435.783463248059;14436;14444.711105778037;10602.363858168535;10713;10725.78548429027;10727.570897164025;10732.78534429307;18238.90880545589;18421.171047302905;18491.907540462213;18503.259869605336;18528.722069168703;7013;7149.428045756327;7226.566406015656;7261.237570055174;7347.88978165328;788.9526628402314;882.280941033056;889.208604342136;936.2445414847161;1044.4568824211367;27927.441451170864;28036.71963280341;28162.241375028105;28531.57202641962;28591.428171436455;864.7924498120406;907.3013779389833;970.2383628851318;977.4379731654327;1001.9929970379721;13046.869531304756;14085;14227.35976881043;14335.211563364115;14547.127172369692;394140;396063;402031;402364;403726;48282.27576586354;49212.75393623009;49226;49227.75386123046;49433.50566494361;1068.3536460441321;1234.8641649418557;1252.311228824143;1278.8657190994998;1378.3866179550205;26578.335541611614;27644.585331219645;27767.44465110646;28031.719682803727;28260;38836.805815970736;39091;39357;39409;39479.65723770326;253756;254600;254618;254644.17490775467;256404;22779.772202277763;25049.624255635816;25744.970201191743;25780.484390311714;25802.870985644953;35946.28107437785;38416.39003319619;40136.799316003235;40243.195136096525;40854.387184192856;33111.83444082764;33517;33983.49024764581;34112.48831267583;34549.82725086459;33607.495887562196;33985.15037124092;34004;34854.30291394208;34905;33828.15429614279;34352;34362.65637343695;34471.96584102481;34792.652073478945;29869.551956720232;30792.692073079877;30896;31088.84455577798;31179.844100780258;23406.64890026685;23421.531569368177;23458.88870001708;23702.170424035077;24100.15649452261 08:55:16 INFO - PROCESS | 22316 | |2;jquery.html;381.54820906450954;386.4801841523152;391.26637554585153;393.08019234990115;404.85829959514194;14751;16471.588210294718;16754.66490670186;16768.496945091665;16983.320667173313;15105.320260588273;15317.463888763896;15832.366705331802;15834.841651583482;15849.20753962303;4984.651074424792;5119.488051194888;5144.0740666679985;5153.536181743642;5154.664946778466;3739.2708421857747;3965.2466031453932;5730.283714535683;6038.96980515099;6067.302260240062;5741.454561816641;6003.309619393782;6028.276606807167;6028.63828170309;6030.517558595302;5872.442117998783;5896.469317761379;5904.55715821313;5939.406059394048;5941.435563621428;3391.220019395528;4983.825566105169;5240.7379631018675;5254.8160814371695;5268.0517506848755;19077.80922190774;19216.231350745955;19314;20865.37403877886;20885;1975.802419758027;2026.7365242518379;2069.4205622425743;2173.478365192358;2247.4606094537357;13020.934895325558;13318.267495287755;13449;13471.66320841977;13692.246926419042;1782.8841125326942;1832.2854086906118;1865.4403678896276;1866.4214093631017;1895.7156426535992;71226;71602.64198679026;71686.64156679236;71792;72093;8985.371024028254;9168.81662366749;9203.125703058198;9291.953540232256;9527.142557169887;13266.005049621317;13287.73424531504;13326;13341;13489.527866524624;7084.964575177091;7145.428365730729;7226.674799633924;7272.672729727175;7303.45224108194;6555.475561955128;6619.635920024445;6630.270670226271;6671.531533332698;6678.398944094957;6008.939910600838;6118.816435506942;6178.5366097542865;6266.342034086447;6274.592151510137;1625.244261418446;1640.8277130901083;1646.440210328494;1676.2875777794388;1695.4913525942168;865.407196070681;882.0958517519465;895.230102112183;978.4618459847055;1035.3477309295097;15332.386704531917;15779.763303550455;16237.025778453331;16511.917440412722;17459.38892138769;883.5140672630027;904.5477261369315;906.0902206976874;918.5774543709834;919.3656377099779;9707.514624268759;9871.80256394868;9903.356281841801;9912.603495860229;9928.354656947275;406874;407091;407115;414162;421964;67099;67641.66179169073;68168.97746533806;69471.65264173748;69731;977.4086677559974;978.5645387802359;993.1955116355775;996.7508122969258;997.4264797741328;15102.697946041237;15183;15221;15478.380864765284;15667.764983525483;32559;32997.50503742398;33756.3248735019;33919.66080339264;34641.48037779385;41996.580034199265;42992.355114673934;44067.77966110149;44474.55525444704;44636.55363446324;7572.091349038151;7598.924010759822;7723.729669461542;7757;8098.959505202436;11113.333200008025;11244.156688248579;11578.884211157781;11617.244879083171;11790.882091178979;9624.230061595195;9798.167155791552;10093.19254459656;10099.343542669703;10608.946955265174;9876.753081173028;10247.231457640557;10312;10619.203559732896;10678.199135064746;9945.900540994788;10508.42203678805;10858.67423977282;11008.174386921173;11046.723831904266;6954.9652251740445;7153.606551639502;7886.093099293655;7898.605069746604;7940.007499062617;9109.18017378439;9440.716778496657;9659.130678238993;9681.951590242004;9787.951060244653 08:55:16 INFO - PROCESS | 22316 | |3;mootools.html;1282.653683505453;1461.700351427957;1501.6996600679863;1664.2843577261772;1814.863885208609;6781.254062053176;7675.270849269317;7863.252990965863;7879.1726868678825;7906.841863162734;7627.7330293439745;7752.341051010657;7755.650995705193;7758.14660387357;7761.534307941528;1900.8194221548931;2066.1838573763353;2135.7757435469284;2168.56628674265;2195.110980053081;2172.2071443923014;2192.210804110519;2193.429708275844;2193.835462340323;2197.9010944507454;2109.2933867154443;2149.419656692692;2159;2160.8487405881597;2164.5238047629496;1851.583393736412;2104.158336665331;2147.7852214778554;2230.944226394337;2237.284069097889;2122.936311910645;2165.545235500547;2168.761436242012;2170.7720689327552;2171.294329342954;7658.8085297868;7713.4214933880185;7717.845643087163;7717.922820771777;7727.459077864552;4551.908961820778;4737.431508219036;4770.475247722748;4778.522147785228;4793.808247670089;2935.691752365992;2967.1691926260683;3135.7648176386633;3136.2786559091537;3136.560881476595;955.8661787349707;983.1201075037801;985.1183191043975;985.3152059318776;998.975025624358;10500;10764.677059688143;10815.783684326349;10838.783224335548;10858.619948301772;4260.382244574519;4392.890177745582;4493.348464472633;4528.592426681615;4530.524294949048;9204.677836275698;9277;9309.44143351401;9312.34813563044;9321.487318197564;4826.251930950708;4832.347633069561;4841.757912104381;4843.564079232816;4862.343583616166;3793.4878791363367;4206;4243.830246790094;4256.765877876746;4257.723247988933;3751.399776035821;3768.717346199046;3857.7106716996336;3894.2990261753157;3934.6852251819787;1233.9506419743288;1247.7442124364484;1248.1762037055682;1263.2673049631192;1281.1352337172557;847.3983471735014;854.747849384433;859.4671303791689;902.8149229407956;904.4663648447447;5519.39286678465;5558.694271815089;5602.831915042555;5706.229658995982;5917.112433135064;917.2478567574658;918.5499105438287;938.648006997376;951.7382719752123;955.5365647660878;3583.749137560346;3666.4683620874825;3718.605522928902;3723.888283351504;3800.7149463790324;9187;9516.666916657883;9624.37441566296;9677.951610242044;9701.17540009093;9607.90392096084;9710.17463515609;9862.260330475243;9862.605495780232;9941.254405919584;7358.742444014434;7466.589337586376;7509.436792240604;7523.699052037967;7538.09542854861;5089.338386009795;5309.893802123858;5348.572114230775;5456;5472.589555783412;8959.283257339528;8971.058038906081;9006.099390060941;9065.456072635663;9090.863637045582;8525.317974562144;8868.379213454997;8870.42342247752;8953.238974686965;8965.058668839938;6203.751849925952;6425.5502114851515;6531.412172904462;6767.289434609295;6901.137357830271;7202.099737532809;7225.1329840419485;7317.341439270491;7326.853462930605;7347.70609175627;6569.24453687832;6788.456923446014;6824.897626535507;6944.992976018348;6949;6744.258131605618;6749.696263668048;6778;6882.242953275236;6904.13698287714;6242.5942313749465;6356.809295721136;6435.549511534147;6448.097266382616;6658.533902626963;4597.747123908217;4623.56076172763;4750.9287360690305;4768.809247630056;4811.855644330676;4450.354698568754;4598.080383923296;4636.721796692209;4652.55800698933;4731.763411829464 08:55:16 INFO - PROCESS | 22316 | |4;prototype.html;309.80946717768563;312.68731268731267;316.1937060495736;319.2844854512372;324.3254031614241;5081.974590127049;5091.363579552556;5113.769880355384;5119.6177032201285;5143.665661731994;4749.121412538683;4848.854534363974;4920.753962301888;4999.1255028358655;5078.1874900016;3943.4479172915817;3967.8016099194924;3978.4231286463446;3990.8204130814183;3993.5806740292287;3972.36442169253;3978.9801050994706;3984.661303789167;3994.2810294147043;3996.8001599920035;3729.9440508392395;3817.1983883384523;3939.409088636699;3953.2884080865433;3976.145128797308;3928.4696565963513;3940.7044471664453;3954.2882281189372;3961.1285517186175;3965.8810235692977;3530.6292839251764;3537.540119784437;3538.6992105671047;3540.6459354064646;3553.6091029986683;4761.40482439695;4843.564079232886;4853.902921941577;4866.124097662419;4884.438289596706;4599.632029437637;4618.699784513996;4632.328312394718;4639.327297541871;4648.395708557866;5349.652272602269;5367.409584945653;5380.354357477088;5388.78444862205;5389.676619402849;3600.963990360089;3806.4290356446477;3922.9803850980848;3929.0766669832565;3930.430087637305;5600;5610.102383618601;5630.943690563083;5637.323521177444;5642.097264437712;3886.4170374443493;3889.163829776555;3892.844286228519;3894.532656081288;3900.64894159527;3842.481265029241;3925.5878132796215;3939.1530820873077;3943.5464921533817;3946.782926939046;4453.621442177451;4488.753118578445;4497.505274419811;4498.122866041091;4524.049949510574;5296.311479507639;5322.8935421292135;5329.8934021319355;5333.973330133402;5348.144296912553;1304.6477451088153;1326.409747662281;1351.094766506443;1379.3310244531394;1385.1965859801292;906.8639704044446;916.6241840845222;926.3885835348638;929.9674511392204;932.6383480119102;4637.8840528986375;4653.162430762495;4658.324542941323;4670.229412146958;4678.017616300547;5475.123980163235;5480.177973304037;5481.835544933659;5489.752961116759;5490.945090549123;4495.707778994355;4611.76941152941;4622.583967442946;4646.442426908725;4651.813927442932;2918.0662188099604;2939.8971036013636;2940.588317635533;2941.382309714941;2950.7639388848843;5135;5138.100832354323;5148.382194136728;5161.612879034087;5166.081164142248;5467.1799230115;5579.525740312038;5602;5613.7193140342815;5639.125935480007;5149.176131818891;5152.742362881766;5155.922661160085;5163.896722065538;5169.896602067937;5456.317960254968;5468.507834294774;5471.671699698031;5476.945230547643;5482.342118945592;5132.538071573576;5321.095413779744;5326;5328.60035497347;5330.2804121443105;5093.312402825572;5118.360204974379;5142.665726727901;5152.381714194321;5162.934826069602;3855.151866589346;3872.5352957645264;3874.7868867212574;3887.8056097195595;3896.1038961038553;5186.507281808223;5262.368515778131;5392.460753924576;5410.621256512007;5445.319335083114;5230.921536177037;5404.567634589302;5406.1079921814035;5413.756380962787;5432.360318586478;5383.031054410244;5392.730363481889;5398.325209348832;5404.865278062207;5416.079266524779;5131.692098474104;5290.338707661543;5309.920351194658;5314.335708036496;5329.413764485826;5413.593980451561;5435.83692489226;5449;5455.645383050089;5460.945390546202;5319.521243088141;5325.4940780625775;5327.413984461628;5327.936436549077;5334.06653835585 08:55:16 INFO - PROCESS | 22316 | |5;yui.html;689.6586189836032;711.8647456983176;712.4478529139916;716.8387112899595;775.3487070860477;12306.200096993689;12661.746765064694;13154.408051637687;13786.65533361664;13809.171449713025;14007.159570425782;14062.578122656336;14104.15375077496;14104.788428173586;14114.223717695522;653.5131327161248;795.0657976877175;796.3549524884833;804.2801692485223;819.565630215985;778.6924164954839;778.8130848596325;779.2168870285356;789.4631650477672;793.1552896165565;821.1542111625035;821.3839620284787;821.6836517940606;823.979400514986;864.6022829498438;683.45323741007;700.4396482813729;822.5517093184169;830.8047608811954;871.0288028847853;512.5387151563585;614.7049416280211;626.357983067355;627.269231345482;628.4281304013372;12713.809292860615;12723.936380318131;12730.745385092247;12738.936305318413;12768.936155319258;12105.15263931525;12219.15569858612;12548;12585.559505417357;12745.490180392773;9861.211103111806;9931.65239216624;9992.750181245527;10163.339382940085;10179.032991865835;3293.4730443129224;3346.531485592019;3406.4549672052353;3406.4549672052353;3448.413769659139;45674;45983.540164598264;46022.53977460216;46099.53900460986;46186;9955.601775929026;10072.841623213279;10266.743331416625;10675.199360048027;10692.358458492516;17533.298668053136;17768.37810676646;17768.733468997976;17780.733289000676;17792.110394480223;6615;6654.600723956578;6708.899366509506;6918.411934985583;7091;3551.893443196708;3617.059564513193;3623.61951995042;3652.7808331500196;3719.2933342664805;2839;2901.17316564778;2948.7051294870344;2956.6452025756616;2958.2012856528618;525.1754745050234;531.7595100286696;535.0476152448648;537.159345624097;539.5090467674397;629.3423372575669;632.7595513704763;637.9585326953733;643.2120652201016;649.65932498811;7649.502782319243;7887.605619719106;8228.50628962264;8568.22885940256;8615.052344242129;617.197643064015;619.5910698938679;628.3057221769969;633.9017452294902;643.231338550437;3825.4304978736277;3904.9219015620097;3966.464527288779;4021.6581590564547;4126.91746165075;50849.49150508447;51246;51697;51774;53089.46910530845;44322.778386107864;44744;45279;45382;45692.77153614211;40021.39967900484;40404.191916161515;40409.59590404058;41101.79449102735;42087.36868946968;7675.846483070419;7704.6918123274445;7817.882731759142;7945.682172713026;8041.075276343296;27542.724572754018;27819.721802781714;27872.303192420353;28301.858490707415;28484.287892802844;36078.63921360753;38004.80997595105;38098.80950595229;38213;38946.61053389543;9554.766945993588;9625.71122866315;9679.177269932135;9684.225261979165;9883.061109194616;10122.8481572775;10448;10544.630937917136;10592.258541901992;11206.439678015904;9746.512674366111;9853.605855765689;9904.207663386767;10104.635874156895;10216.335938164293;9641.517924103626;9692.41845489273;9710.514474276399;9761.707148785548;10214.927432619765;10125.746856328651;11246.437678115897;11329.546818127183;11536.59621913229;11558.653240402802;9303.488308143116;9448.669296574863;9550.283728720235;9685.9031409685;9796.755081123029;9290.489023103793;9371.906280937103;9481.762955926157;9706.417614943126;9992.60029598837 08:55:16 INFO - PROCESS | 22316 | __end_tp_report 08:55:16 INFO - PROCESS | 22316 | __start_cc_report 08:55:16 INFO - PROCESS | 22316 | _x_x_mozilla_cycle_collect,1074 08:55:16 INFO - PROCESS | 22316 | __end_cc_report 08:55:16 INFO - PROCESS | 22316 | __startTimestamp1461340516708__endTimestamp 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | ------- Summary: start ------- 08:55:16 INFO - PROCESS | 22316 | Number of tests: 6 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | [#0] dojo.html Cycles:165 Average:4656.27 Median:4768.00 stddev:476.31 (10.0%) stddev-sans-first:449.88 08:55:16 INFO - PROCESS | 22316 | Values: 2609.1 2695.5 2700.6 2710.5 2734.4 4527.9 4639.6 4692.2 4707.0 4711.4 4675.1 4683.4 4768.7 4814.9 4825.1 4316.2 4358.1 4364.6 4379.4 4432.3 4306.6 4353.9 4422.6 4443.5 4473.2 4250.9 4382.9 4388.1 4408.4 4430.6 4217.3 4285.2 4285.3 4313.8 4352.6 4245.8 4254.7 4259.9 4293.1 4303.0 4520.0 4575.7 4578.3 4592.4 4594.3 4841.0 5043.1 5044.7 5087.7 5097.4 5072.8 5080.7 5083.2 5083.3 5153.2 4642.6 4670.3 4740.6 4743.7 4748.2 5125.1 5151.1 5151.5 5187.7 5197.0 4930.6 4932.9 4935.6 4938.9 4980.5 4903.7 4997.5 5009.8 5037.0 5123.0 5004.1 5029.5 5033.1 5049.0 5051.2 5024.0 5026.9 5029.2 5033.7 5063.6 4255.8 4298.6 4345.7 4376.2 4399.8 3766.2 3772.0 3773.2 3786.8 3806.8 4319.1 4321.1 4338.6 4374.0 4377.1 5003.2 5061.4 5092.8 5177.6 5181.0 4310.3 4316.1 4319.1 4344.3 4350.5 4553.0 4554.6 4557.8 4559.5 4600.4 4605.1 4747.8 4768.0 4844.2 4848.2 4994.7 5006.5 5016.8 5017.7 5063.1 4703.4 4712.0 4713.3 4724.4 4757.0 4842.6 4976.8 5026.4 5074.3 5081.7 4995.7 5002.7 5009.8 5017.3 5032.0 4797.5 4874.7 4875.4 4882.3 4924.6 4891.6 4925.7 4950.3 4984.9 5004.9 4740.0 4751.3 4759.8 4768.1 4814.9 4841.0 4846.4 4855.2 4861.4 4910.4 4809.0 4823.8 4828.1 4859.4 4873.2 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | [#1] ext.html Cycles:180 Average:45032.65 Median:34823.48 stddev:80902.11 (232.3%) stddev-sans-first:81060.18 08:55:16 INFO - PROCESS | 22316 | Values: 566.7 606.6 617.5 619.3 622.9 34610.8 35616.5 35641.8 35681.5 35728.8 37938.0 38635.2 38685.4 38767.2 38780.4 7483.5 7700.4 7701.2 7706.2 7710.5 7753.9 7899.4 7906.1 7910.8 7916.4 7880.4 7921.3 7953.8 7958.8 7958.9 7807.3 7914.6 7922.9 7926.0 7931.6 7792.1 7877.1 7895.8 7897.9 7898.1 37168.4 37639.2 37709.4 37726.2 37737.4 3181.1 3203.2 3246.5 3352.7 3434.4 28543.7 28749.3 28770.9 29297.1 29521.4 3081.5 3083.0 3123.5 3129.4 3191.1 239091.0 240759.0 240918.0 241391.0 242546.0 46545.8 46805.0 46845.8 46937.0 46963.8 57554.4 59128.1 59459.7 59475.0 59502.7 14062.1 14400.3 14435.8 14436.0 14444.7 10602.4 10713.0 10725.8 10727.6 10732.8 18238.9 18421.2 18491.9 18503.3 18528.7 7013.0 7149.4 7226.6 7261.2 7347.9 789.0 882.3 889.2 936.2 1044.5 27927.4 28036.7 28162.2 28531.6 28591.4 864.8 907.3 970.2 977.4 1002.0 13046.9 14085.0 14227.4 14335.2 14547.1 394140.0 396063.0 402031.0 402364.0 403726.0 48282.3 49212.8 49226.0 49227.8 49433.5 1068.4 1234.9 1252.3 1278.9 1378.4 26578.3 27644.6 27767.4 28031.7 28260.0 38836.8 39091.0 39357.0 39409.0 39479.7 253756.0 254600.0 254618.0 254644.2 256404.0 22779.8 25049.6 25745.0 25780.5 25802.9 35946.3 38416.4 40136.8 40243.2 40854.4 33111.8 33517.0 33983.5 34112.5 34549.8 33607.5 33985.2 34004.0 34854.3 34905.0 33828.2 34352.0 34362.7 34472.0 34792.7 29869.6 30792.7 30896.0 31088.8 31179.8 23406.6 23421.5 23458.9 23702.2 24100.2 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | [#2] jquery.html Cycles:180 Average:24475.68 Median:4984.24 stddev:67582.06 (1355.9%) stddev-sans-first:67747.43 08:55:16 INFO - PROCESS | 22316 | Values: 381.5 386.5 391.3 393.1 404.9 14751.0 16471.6 16754.7 16768.5 16983.3 15105.3 15317.5 15832.4 15834.8 15849.2 4984.7 5119.5 5144.1 5153.5 5154.7 3739.3 3965.2 5730.3 6039.0 6067.3 5741.5 6003.3 6028.3 6028.6 6030.5 5872.4 5896.5 5904.6 5939.4 5941.4 3391.2 4983.8 5240.7 5254.8 5268.1 19077.8 19216.2 19314.0 20865.4 20885.0 1975.8 2026.7 2069.4 2173.5 2247.5 13020.9 13318.3 13449.0 13471.7 13692.2 1782.9 1832.3 1865.4 1866.4 1895.7 71226.0 71602.6 71686.6 71792.0 72093.0 8985.4 9168.8 9203.1 9292.0 9527.1 13266.0 13287.7 13326.0 13341.0 13489.5 7085.0 7145.4 7226.7 7272.7 7303.5 6555.5 6619.6 6630.3 6671.5 6678.4 6008.9 6118.8 6178.5 6266.3 6274.6 1625.2 1640.8 1646.4 1676.3 1695.5 865.4 882.1 895.2 978.5 1035.3 15332.4 15779.8 16237.0 16511.9 17459.4 883.5 904.5 906.1 918.6 919.4 9707.5 9871.8 9903.4 9912.6 9928.4 406874.0 407091.0 407115.0 414162.0 421964.0 67099.0 67641.7 68169.0 69471.7 69731.0 977.4 978.6 993.2 996.8 997.4 15102.7 15183.0 15221.0 15478.4 15667.8 32559.0 32997.5 33756.3 33919.7 34641.5 41996.6 42992.4 44067.8 44474.6 44636.6 7572.1 7598.9 7723.7 7757.0 8099.0 11113.3 11244.2 11578.9 11617.2 11790.9 9624.2 9798.2 10093.2 10099.3 10608.9 9876.8 10247.2 10312.0 10619.2 10678.2 9945.9 10508.4 10858.7 11008.2 11046.7 6955.0 7153.6 7886.1 7898.6 7940.0 9109.2 9440.7 9659.1 9682.0 9788.0 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | [#3] mootools.html Cycles:180 Average:5196.07 Median:5539.04 stddev:2868.16 (51.8%) stddev-sans-first:2861.13 08:55:16 INFO - PROCESS | 22316 | Values: 1282.7 1461.7 1501.7 1664.3 1814.9 6781.3 7675.3 7863.3 7879.2 7906.8 7627.7 7752.3 7755.7 7758.1 7761.5 1900.8 2066.2 2135.8 2168.6 2195.1 2172.2 2192.2 2193.4 2193.8 2197.9 2109.3 2149.4 2159.0 2160.8 2164.5 1851.6 2104.2 2147.8 2230.9 2237.3 2122.9 2165.5 2168.8 2170.8 2171.3 7658.8 7713.4 7717.8 7717.9 7727.5 4551.9 4737.4 4770.5 4778.5 4793.8 2935.7 2967.2 3135.8 3136.3 3136.6 955.9 983.1 985.1 985.3 999.0 10500.0 10764.7 10815.8 10838.8 10858.6 4260.4 4392.9 4493.3 4528.6 4530.5 9204.7 9277.0 9309.4 9312.3 9321.5 4826.3 4832.3 4841.8 4843.6 4862.3 3793.5 4206.0 4243.8 4256.8 4257.7 3751.4 3768.7 3857.7 3894.3 3934.7 1234.0 1247.7 1248.2 1263.3 1281.1 847.4 854.7 859.5 902.8 904.5 5519.4 5558.7 5602.8 5706.2 5917.1 917.2 918.5 938.6 951.7 955.5 3583.7 3666.5 3718.6 3723.9 3800.7 9187.0 9516.7 9624.4 9678.0 9701.2 9607.9 9710.2 9862.3 9862.6 9941.3 7358.7 7466.6 7509.4 7523.7 7538.1 5089.3 5309.9 5348.6 5456.0 5472.6 8959.3 8971.1 9006.1 9065.5 9090.9 8525.3 8868.4 8870.4 8953.2 8965.1 6203.8 6425.6 6531.4 6767.3 6901.1 7202.1 7225.1 7317.3 7326.9 7347.7 6569.2 6788.5 6824.9 6945.0 6949.0 6744.3 6749.7 6778.0 6882.2 6904.1 6242.6 6356.8 6435.5 6448.1 6658.5 4597.7 4623.6 4750.9 4768.8 4811.9 4450.4 4598.1 4636.7 4652.6 4731.8 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | [#4] prototype.html Cycles:180 Average:4427.65 Median:5086.67 stddev:1284.61 (25.3%) stddev-sans-first:1250.48 08:55:16 INFO - PROCESS | 22316 | Values: 309.8 312.7 316.2 319.3 324.3 5082.0 5091.4 5113.8 5119.6 5143.7 4749.1 4848.9 4920.8 4999.1 5078.2 3943.4 3967.8 3978.4 3990.8 3993.6 3972.4 3979.0 3984.7 3994.3 3996.8 3729.9 3817.2 3939.4 3953.3 3976.1 3928.5 3940.7 3954.3 3961.1 3965.9 3530.6 3537.5 3538.7 3540.6 3553.6 4761.4 4843.6 4853.9 4866.1 4884.4 4599.6 4618.7 4632.3 4639.3 4648.4 5349.7 5367.4 5380.4 5388.8 5389.7 3601.0 3806.4 3923.0 3929.1 3930.4 5600.0 5610.1 5630.9 5637.3 5642.1 3886.4 3889.2 3892.8 3894.5 3900.6 3842.5 3925.6 3939.2 3943.5 3946.8 4453.6 4488.8 4497.5 4498.1 4524.0 5296.3 5322.9 5329.9 5334.0 5348.1 1304.6 1326.4 1351.1 1379.3 1385.2 906.9 916.6 926.4 930.0 932.6 4637.9 4653.2 4658.3 4670.2 4678.0 5475.1 5480.2 5481.8 5489.8 5490.9 4495.7 4611.8 4622.6 4646.4 4651.8 2918.1 2939.9 2940.6 2941.4 2950.8 5135.0 5138.1 5148.4 5161.6 5166.1 5467.2 5579.5 5602.0 5613.7 5639.1 5149.2 5152.7 5155.9 5163.9 5169.9 5456.3 5468.5 5471.7 5476.9 5482.3 5132.5 5321.1 5326.0 5328.6 5330.3 5093.3 5118.4 5142.7 5152.4 5162.9 3855.2 3872.5 3874.8 3887.8 3896.1 5186.5 5262.4 5392.5 5410.6 5445.3 5230.9 5404.6 5406.1 5413.8 5432.4 5383.0 5392.7 5398.3 5404.9 5416.1 5131.7 5290.3 5309.9 5314.3 5329.4 5413.6 5435.8 5449.0 5455.6 5460.9 5319.5 5325.5 5327.4 5327.9 5334.1 08:55:16 INFO - PROCESS | 22316 | 08:55:16 INFO - PROCESS | 22316 | [#5] yui.html Cycles:180 Average:12592.07 Median:25879.27 stddev:14131.44 (54.6%) stddev-sans-first:14142.81 08:55:16 INFO - PROCESS | 22316 | Values: 689.7 711.9 712.4 716.8 775.3 12306.2 12661.7 13154.4 13786.7 13809.2 14007.2 14062.6 14104.2 14104.8 14114.2 653.5 795.1 796.4 804.3 819.6 778.7 778.8 779.2 789.5 793.2 821.2 821.4 821.7 824.0 864.6 683.5 700.4 822.6 830.8 871.0 512.5 614.7 626.4 627.3 628.4 12713.8 12723.9 12730.7 12738.9 12768.9 12105.2 12219.2 12548.0 12585.6 12745.5 9861.2 9931.7 9992.8 10163.3 10179.0 3293.5 3346.5 3406.5 3406.5 3448.4 45674.0 45983.5 46022.5 46099.5 46186.0 9955.6 10072.8 10266.7 10675.2 10692.4 17533.3 17768.4 17768.7 17780.7 17792.1 6615.0 6654.6 6708.9 6918.4 7091.0 3551.9 3617.1 3623.6 3652.8 3719.3 2839.0 2901.2 2948.7 2956.6 2958.2 525.2 531.8 535.0 537.2 539.5 629.3 632.8 638.0 643.2 649.7 7649.5 7887.6 8228.5 8568.2 8615.1 617.2 619.6 628.3 633.9 643.2 3825.4 3904.9 3966.5 4021.7 4126.9 50849.5 51246.0 51697.0 51774.0 53089.5 44322.8 44744.0 45279.0 45382.0 45692.8 40021.4 40404.2 40409.6 41101.8 42087.4 7675.8 7704.7 7817.9 7945.7 8041.1 27542.7 27819.7 27872.3 28301.9 28484.3 36078.6 38004.8 38098.8 38213.0 38946.6 9554.8 9625.7 9679.2 9684.2 9883.1 10122.8 10448.0 10544.6 10592.3 11206.4 9746.5 9853.6 9904.2 10104.6 10216.3 9641.5 9692.4 9710.5 9761.7 10214.9 10125.7 11246.4 11329.5 11536.6 11558.7 9303.5 9448.7 9550.3 9685.9 9796.8 9290.5 9371.9 9481.8 9706.4 9992.6 08:55:16 INFO - PROCESS | 22316 | -------- Summary: end -------- 08:55:16 INFO - PROCESS | 22316 | 08:55:17 INFO - TEST-INFO | 22316: exit 0 08:55:17 INFO - TEST-OK | dromaeo_css | took 1118188ms 08:55:17 INFO - TEST-START | kraken 08:55:17 INFO - operating with platform_type : linux_ 08:55:17 INFO - Initialising browser for kraken test... 08:55:17 INFO - TEST-INFO | started process 22496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuhpLfg/profile http://localhost:57261/getInfo.html) 08:55:21 INFO - PROCESS | 22496 | __metrics Screen width/height:1600/1200 08:55:21 INFO - PROCESS | 22496 | colorDepth:24 08:55:21 INFO - PROCESS | 22496 | Browser inner width/height: 1024/697 08:55:21 INFO - PROCESS | 22496 | __metrics 08:55:22 ERROR - PROCESS | 22496 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:55:23 INFO - TEST-INFO | 22496: exit 0 08:55:23 INFO - Browser initialized. 08:55:23 INFO - Running cycle 1/1 for kraken test... 08:55:23 INFO - TEST-INFO | started process 22575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuhpLfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:35 INFO - PROCESS | 22575 | RSS: Main: 156143616 08:55:35 INFO - PROCESS | 22575 | 08:55:38 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:39 INFO - PROCESS | 22575 | RSS: Main: 210874368 08:55:39 INFO - PROCESS | 22575 | 08:55:42 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-dft) 08:55:42 INFO - PROCESS | 22575 | RSS: Main: 196042752 08:55:42 INFO - PROCESS | 22575 | 08:55:46 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-fft) 08:55:46 INFO - PROCESS | 22575 | RSS: Main: 267182080 08:55:46 INFO - PROCESS | 22575 | 08:55:48 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-oscillator) 08:55:49 INFO - PROCESS | 22575 | RSS: Main: 174989312 08:55:49 INFO - PROCESS | 22575 | 08:55:51 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:52 INFO - PROCESS | 22575 | RSS: Main: 179601408 08:55:52 INFO - PROCESS | 22575 | 08:55:55 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57261/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:55 INFO - PROCESS | 22575 | RSS: Main: 215572480 08:55:55 INFO - PROCESS | 22575 | 08:55:59 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57261/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:00 INFO - PROCESS | 22575 | RSS: Main: 215388160 08:56:00 INFO - PROCESS | 22575 | 08:56:02 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57261/tests/kraken/driver.html?testName=json-parse-financial) 08:56:03 INFO - PROCESS | 22575 | RSS: Main: 216289280 08:56:03 INFO - PROCESS | 22575 | 08:56:05 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:05 INFO - PROCESS | 22575 | RSS: Main: 201850880 08:56:05 INFO - PROCESS | 22575 | 08:56:07 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:08 INFO - PROCESS | 22575 | RSS: Main: 205766656 08:56:08 INFO - PROCESS | 22575 | 08:56:10 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:11 INFO - PROCESS | 22575 | RSS: Main: 216494080 08:56:11 INFO - PROCESS | 22575 | 08:56:13 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:14 INFO - PROCESS | 22575 | RSS: Main: 224272384 08:56:14 INFO - PROCESS | 22575 | 08:56:17 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:18 INFO - PROCESS | 22575 | RSS: Main: 221691904 08:56:18 INFO - PROCESS | 22575 | 08:56:19 INFO - PROCESS | 22575 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57261/tests/kraken/driver.html?testName=ai-astar) 08:56:20 INFO - PROCESS | 22575 | RSS: Main: 285204480 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | __start_tp_report 08:56:20 INFO - PROCESS | 22575 | _x_x_mozilla_page_load 08:56:20 INFO - PROCESS | 22575 | _x_x_mozilla_page_load_details 08:56:20 INFO - PROCESS | 22575 | |i|pagename|runs| 08:56:20 INFO - PROCESS | 22575 | |0;ai-astar;111;114;109;113;116;115;102;113;112;116 08:56:20 INFO - PROCESS | 22575 | |1;audio-beat-detection;161;141;162;186;141;162;160;131;194;134 08:56:20 INFO - PROCESS | 22575 | |2;audio-dft;162;162;162;162;162;161;161;161;162;163 08:56:20 INFO - PROCESS | 22575 | |3;audio-fft;74;75;120;123;77;73;74;116;101;74 08:56:20 INFO - PROCESS | 22575 | |4;audio-oscillator;94;95;147;94;95;94;149;93;94;143 08:56:20 INFO - PROCESS | 22575 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;117 08:56:20 INFO - PROCESS | 22575 | |6;imaging-darkroom;147;145;147;146;146;147;146;146;146;146 08:56:20 INFO - PROCESS | 22575 | |7;imaging-desaturate;96;95;95;95;95;95;95;97;96;95 08:56:20 INFO - PROCESS | 22575 | |8;json-parse-financial;66;65;66;66;65;66;66;86;64;64 08:56:20 INFO - PROCESS | 22575 | |9;json-stringify-tinderbox;65;66;66;65;66;65;65;65;65;65 08:56:20 INFO - PROCESS | 22575 | |10;stanford-crypto-aes;79;78;78;79;79;80;81;79;79;79 08:56:20 INFO - PROCESS | 22575 | |11;stanford-crypto-ccm;138;133;145;134;134;140;131;135;168;141 08:56:20 INFO - PROCESS | 22575 | |12;stanford-crypto-pbkdf2;172;174;174;173;170;176;177;172;173;172 08:56:20 INFO - PROCESS | 22575 | |13;stanford-crypto-sha256-iterative;73;74;73;72;76;72;71;70;72;70 08:56:20 INFO - PROCESS | 22575 | __end_tp_report 08:56:20 INFO - PROCESS | 22575 | __start_cc_report 08:56:20 INFO - PROCESS | 22575 | _x_x_mozilla_cycle_collect,1935 08:56:20 INFO - PROCESS | 22575 | __end_cc_report 08:56:20 INFO - PROCESS | 22575 | __startTimestamp1461340580096__endTimestamp 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | ------- Summary: start ------- 08:56:20 INFO - PROCESS | 22575 | Number of tests: 14 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:4.18 (3.7%) stddev-sans-first:4.41 08:56:20 INFO - PROCESS | 22575 | Values: 111.0 114.0 109.0 113.0 116.0 115.0 102.0 113.0 112.0 116.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:161.50 stddev:21.09 (13.1%) stddev-sans-first:22.32 08:56:20 INFO - PROCESS | 22575 | Values: 161.0 141.0 162.0 186.0 141.0 162.0 160.0 131.0 194.0 134.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:56:20 INFO - PROCESS | 22575 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 161.0 161.0 162.0 163.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.00 stddev:21.68 (29.3%) stddev-sans-first:22.14 08:56:20 INFO - PROCESS | 22575 | Values: 74.0 75.0 120.0 123.0 77.0 73.0 74.0 116.0 101.0 74.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.00 stddev:25.26 (26.9%) stddev-sans-first:26.13 08:56:20 INFO - PROCESS | 22575 | Values: 94.0 95.0 147.0 94.0 95.0 94.0 149.0 93.0 94.0 143.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:56:20 INFO - PROCESS | 22575 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:56:20 INFO - PROCESS | 22575 | Values: 147.0 145.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 08:56:20 INFO - PROCESS | 22575 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 96.0 95.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:6.59 (10.0%) stddev-sans-first:6.97 08:56:20 INFO - PROCESS | 22575 | Values: 66.0 65.0 66.0 66.0 65.0 66.0 66.0 86.0 64.0 64.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 08:56:20 INFO - PROCESS | 22575 | Values: 65.0 66.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 08:56:20 INFO - PROCESS | 22575 | Values: 79.0 78.0 78.0 79.0 79.0 80.0 81.0 79.0 79.0 79.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:139.00 stddev:10.75 (7.7%) stddev-sans-first:11.38 08:56:20 INFO - PROCESS | 22575 | Values: 138.0 133.0 145.0 134.0 134.0 140.0 131.0 135.0 168.0 141.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.50 stddev:2.06 (1.2%) stddev-sans-first:2.13 08:56:20 INFO - PROCESS | 22575 | Values: 172.0 174.0 174.0 173.0 170.0 176.0 177.0 172.0 173.0 172.0 08:56:20 INFO - PROCESS | 22575 | 08:56:20 INFO - PROCESS | 22575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.83 (2.5%) stddev-sans-first:1.92 08:56:20 INFO - PROCESS | 22575 | Values: 73.0 74.0 73.0 72.0 76.0 72.0 71.0 70.0 72.0 70.0 08:56:20 INFO - PROCESS | 22575 | -------- Summary: end -------- 08:56:20 INFO - PROCESS | 22575 | 08:56:21 INFO - TEST-INFO | 22575: exit 0 08:56:21 INFO - TEST-OK | kraken | took 63768ms 08:56:21 INFO - SUITE-END | took 1181s 08:56:21 INFO - Completed test suite (00:19:42) 08:56:21 INFO - javascript benchmark 08:56:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.073778808523, 2695.5013322535347, 2700.5814098814676, 2710.498557766812, 2734.3847634282283, 4527.909441811162, 4639.559241872025, 4692.178868697982, 4707.0, 4711.387519622453, 4675.064987002596, 4683.414573178353, 4768.690035147713, 4814.927776083362, 4825.059113472866, 4316.20150272199, 4358.1283743251315, 4364.563543645634, 4379.364992076147, 4432.312991486325, 4306.590873866993, 4353.891152721191, 4422.6240769534625, 4443.46678398591, 4473.172463094322, 4250.872473825791, 4382.868513944587, 4388.122375524892, 4408.360787685768, 4430.6012458878695, 4217.34631132175, 4285.164392943378, 4285.271503844354, 4313.805878735433, 4352.630026447756, 4245.80893859774, 4254.74471531706, 4259.936100958488, 4293.055527783914, 4302.978485107586, 4519.954800451987, 4575.702579332366, 4578.336141259499, 4592.380028696117, 4594.310853371988, 4840.975795121037, 5043.067032598944, 5044.747762611854, 5087.669301495391, 5097.362829646294, 5072.771725272371, 5080.74596270185, 5083.161278389061, 5083.313752643419, 5153.2270159476375, 4642.628589712815, 4670.322803193586, 4740.620750339999, 4743.691660042121, 4748.216544270226, 5125.103106956268, 5151.07280689472, 5151.5363617274625, 5187.714675692798, 5197.0, 4930.630202734809, 4932.901341973212, 4935.580475659537, 4938.9012219755405, 4980.526849949249, 4903.705777653352, 4997.450280469146, 5009.774560144802, 5037.042961837239, 5122.9743851281255, 5004.124278251365, 5029.5221953914315, 5033.119204139261, 5048.964962182744, 5051.166557517969, 5023.974880125576, 5026.949730502722, 5029.195328747456, 5033.723145226974, 5063.569596584258, 4255.808488617958, 4298.634616057608, 4345.652347812231, 4376.212281789309, 4399.824007039747, 3766.1902690921584, 3771.962280377216, 3773.1887644156636, 3786.8295926683363, 3806.847726090981, 4319.136172765459, 4321.13577284538, 4338.566143385636, 4373.956260437355, 4377.102693947733, 5003.24951257307, 5061.417936937226, 5092.821751238689, 5177.559907407837, 5181.041507321158, 4310.331898555729, 4316.115196384733, 4319.136172765459, 4344.3483477478, 4350.521442641307, 4552.998340365114, 4554.612857907049, 4557.817687292471, 4559.475660299108, 4600.401947746838, 4605.102005108972, 4747.83382581608, 4768.0, 4844.152273352079, 4848.200046992207, 4994.725290109079, 5006.4743201963265, 5016.774245159049, 5017.698938063728, 5063.063333283354, 4703.3650457189215, 4711.976440117777, 4713.3401323814005, 4724.4094488188975, 4756.97724989129, 4842.564169224786, 4976.800927962841, 5026.447090819934, 5074.289599456153, 5081.72050537224, 4995.700257984533, 5002.699838009731, 5009.849704508871, 5017.2724954880605, 5032.0, 4797.472278049481, 4874.658773885794, 4875.390576177978, 4882.292067650242, 4924.606031517542, 4891.608671306358, 4925.655204135676, 4950.331705219894, 4984.900301994012, 5004.87487812793, 4739.976300118616, 4751.311059896227, 4759.785809638505, 4768.094062128184, 4814.927776083291, 4841.0, 4846.418429788448, 4855.174620314484, 4861.440934292602, 4910.410750709795, 4808.9519104808505, 4823.831165909176, 4828.106800241966, 4859.392575928009, 4873.1959226727195], "value": 4626.955030992404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6543408520802, 606.6238931862244, 617.4689766800551, 619.2785405003171, 622.9345918678539, 34610.826945865265, 35616.46575301369, 35641.82179089101, 35681.46477802835, 35728.82135589322, 37938.0, 38635.227295454075, 38685.41971870417, 38767.22465550687, 38780.41829372562, 7483.476156669021, 7700.4224683148705, 7701.1528731839735, 7706.152323244439, 7710.460267781257, 7753.922460775405, 7899.420115976799, 7906.090799558067, 7910.802229944268, 7916.366690664762, 7880.448368614199, 7921.326687231593, 7953.801154971143, 7958.801029974268, 7958.920410795876, 7807.297343239107, 7914.604269786488, 7922.881156782624, 7926.0, 7931.603419829044, 7792.10390805059, 7877.054753429625, 7895.842083158362, 7897.881531777028, 7898.131205567383, 37168.44247336292, 37639.24721505555, 37709.43435848464, 37726.24547509034, 37737.43393849095, 3181.1410919051727, 3203.215212272985, 3246.5454836322697, 3352.664733526628, 3434.4161492546327, 28543.714562854315, 28749.281267968257, 28770.856145719346, 29297.121086367442, 29521.409571808443, 3081.50695888659, 3082.969170308313, 3123.453395655774, 3129.358481511285, 3191.0745883693703, 239091.0, 240759.0, 240917.99999999825, 241391.0, 242546.0, 46545.76727116343, 46805.0, 46845.76577117161, 46937.0, 46963.76518117456, 57554.410051547784, 59128.11307830386, 59459.70270148622, 59475.0, 59502.70248648729, 14062.085964412281, 14400.279986000867, 14435.783463248059, 14436.0, 14444.711105778037, 10602.363858168535, 10713.0, 10725.78548429027, 10727.570897164025, 10732.78534429307, 18238.90880545589, 18421.171047302905, 18491.907540462213, 18503.259869605336, 18528.722069168703, 7013.0, 7149.428045756327, 7226.566406015656, 7261.237570055174, 7347.88978165328, 788.9526628402314, 882.280941033056, 889.208604342136, 936.2445414847161, 1044.4568824211367, 27927.441451170864, 28036.71963280341, 28162.241375028105, 28531.57202641962, 28591.428171436455, 864.7924498120406, 907.3013779389833, 970.2383628851318, 977.4379731654327, 1001.9929970379721, 13046.869531304756, 14085.0, 14227.35976881043, 14335.211563364115, 14547.127172369692, 394140.0, 396063.0, 402031.0, 402364.0, 403726.0, 48282.27576586354, 49212.75393623009, 49226.0, 49227.75386123046, 49433.50566494361, 1068.3536460441321, 1234.8641649418557, 1252.311228824143, 1278.8657190994998, 1378.3866179550205, 26578.335541611614, 27644.585331219645, 27767.44465110646, 28031.719682803727, 28260.0, 38836.805815970736, 39091.0, 39357.0, 39409.0, 39479.65723770326, 253756.0, 254600.0, 254618.0, 254644.17490775467, 256404.0, 22779.772202277763, 25049.624255635816, 25744.970201191743, 25780.484390311714, 25802.870985644953, 35946.28107437785, 38416.39003319619, 40136.799316003235, 40243.195136096525, 40854.387184192856, 33111.83444082764, 33517.0, 33983.49024764581, 34112.48831267583, 34549.82725086459, 33607.495887562196, 33985.15037124092, 34004.0, 34854.30291394208, 34905.0, 33828.15429614279, 34352.0, 34362.65637343695, 34471.96584102481, 34792.652073478945, 29869.551956720232, 30792.692073079877, 30896.0, 31088.84455577798, 31179.844100780258, 23406.64890026685, 23421.531569368177, 23458.88870001708, 23702.170424035077, 24100.15649452261], "value": 17100.949140341116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.54820906450954, 386.4801841523152, 391.26637554585153, 393.08019234990115, 404.85829959514194, 14751.0, 16471.588210294718, 16754.66490670186, 16768.496945091665, 16983.320667173313, 15105.320260588273, 15317.463888763896, 15832.366705331802, 15834.841651583482, 15849.20753962303, 4984.651074424792, 5119.488051194888, 5144.0740666679985, 5153.536181743642, 5154.664946778466, 3739.2708421857747, 3965.2466031453932, 5730.283714535683, 6038.96980515099, 6067.302260240062, 5741.454561816641, 6003.309619393782, 6028.276606807167, 6028.63828170309, 6030.517558595302, 5872.442117998783, 5896.469317761379, 5904.55715821313, 5939.406059394048, 5941.435563621428, 3391.220019395528, 4983.825566105169, 5240.7379631018675, 5254.8160814371695, 5268.0517506848755, 19077.80922190774, 19216.231350745955, 19314.0, 20865.37403877886, 20885.0, 1975.802419758027, 2026.7365242518379, 2069.4205622425743, 2173.478365192358, 2247.4606094537357, 13020.934895325558, 13318.267495287755, 13449.0, 13471.66320841977, 13692.246926419042, 1782.8841125326942, 1832.2854086906118, 1865.4403678896276, 1866.4214093631017, 1895.7156426535992, 71226.0, 71602.64198679026, 71686.64156679236, 71792.0, 72093.0, 8985.371024028254, 9168.81662366749, 9203.125703058198, 9291.953540232256, 9527.142557169887, 13266.005049621317, 13287.73424531504, 13326.0, 13341.0, 13489.527866524624, 7084.964575177091, 7145.428365730729, 7226.674799633924, 7272.672729727175, 7303.45224108194, 6555.475561955128, 6619.635920024445, 6630.270670226271, 6671.531533332698, 6678.398944094957, 6008.939910600838, 6118.816435506942, 6178.5366097542865, 6266.342034086447, 6274.592151510137, 1625.244261418446, 1640.8277130901083, 1646.440210328494, 1676.2875777794388, 1695.4913525942168, 865.407196070681, 882.0958517519465, 895.230102112183, 978.4618459847055, 1035.3477309295097, 15332.386704531917, 15779.763303550455, 16237.025778453331, 16511.917440412722, 17459.38892138769, 883.5140672630027, 904.5477261369315, 906.0902206976874, 918.5774543709834, 919.3656377099779, 9707.514624268759, 9871.80256394868, 9903.356281841801, 9912.603495860229, 9928.354656947275, 406874.0, 407091.0, 407115.0, 414162.0, 421964.0, 67099.0, 67641.66179169073, 68168.97746533806, 69471.65264173748, 69731.0, 977.4086677559974, 978.5645387802359, 993.1955116355775, 996.7508122969258, 997.4264797741328, 15102.697946041237, 15183.0, 15221.0, 15478.380864765284, 15667.764983525483, 32559.0, 32997.50503742398, 33756.3248735019, 33919.66080339264, 34641.48037779385, 41996.580034199265, 42992.355114673934, 44067.77966110149, 44474.55525444704, 44636.55363446324, 7572.091349038151, 7598.924010759822, 7723.729669461542, 7757.0, 8098.959505202436, 11113.333200008025, 11244.156688248579, 11578.884211157781, 11617.244879083171, 11790.882091178979, 9624.230061595195, 9798.167155791552, 10093.19254459656, 10099.343542669703, 10608.946955265174, 9876.753081173028, 10247.231457640557, 10312.0, 10619.203559732896, 10678.199135064746, 9945.900540994788, 10508.42203678805, 10858.67423977282, 11008.174386921173, 11046.723831904266, 6954.9652251740445, 7153.606551639502, 7886.093099293655, 7898.605069746604, 7940.007499062617, 9109.18017378439, 9440.716778496657, 9659.130678238993, 9681.951590242004, 9787.951060244653], "value": 8295.253315232514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.653683505453, 1461.700351427957, 1501.6996600679863, 1664.2843577261772, 1814.863885208609, 6781.254062053176, 7675.270849269317, 7863.252990965863, 7879.1726868678825, 7906.841863162734, 7627.7330293439745, 7752.341051010657, 7755.650995705193, 7758.14660387357, 7761.534307941528, 1900.8194221548931, 2066.1838573763353, 2135.7757435469284, 2168.56628674265, 2195.110980053081, 2172.2071443923014, 2192.210804110519, 2193.429708275844, 2193.835462340323, 2197.9010944507454, 2109.2933867154443, 2149.419656692692, 2159.0, 2160.8487405881597, 2164.5238047629496, 1851.583393736412, 2104.158336665331, 2147.7852214778554, 2230.944226394337, 2237.284069097889, 2122.936311910645, 2165.545235500547, 2168.761436242012, 2170.7720689327552, 2171.294329342954, 7658.8085297868, 7713.4214933880185, 7717.845643087163, 7717.922820771777, 7727.459077864552, 4551.908961820778, 4737.431508219036, 4770.475247722748, 4778.522147785228, 4793.808247670089, 2935.691752365992, 2967.1691926260683, 3135.7648176386633, 3136.2786559091537, 3136.560881476595, 955.8661787349707, 983.1201075037801, 985.1183191043975, 985.3152059318776, 998.975025624358, 10500.0, 10764.677059688143, 10815.783684326349, 10838.783224335548, 10858.619948301772, 4260.382244574519, 4392.890177745582, 4493.348464472633, 4528.592426681615, 4530.524294949048, 9204.677836275698, 9277.0, 9309.44143351401, 9312.34813563044, 9321.487318197564, 4826.251930950708, 4832.347633069561, 4841.757912104381, 4843.564079232816, 4862.343583616166, 3793.4878791363367, 4206.0, 4243.830246790094, 4256.765877876746, 4257.723247988933, 3751.399776035821, 3768.717346199046, 3857.7106716996336, 3894.2990261753157, 3934.6852251819787, 1233.9506419743288, 1247.7442124364484, 1248.1762037055682, 1263.2673049631192, 1281.1352337172557, 847.3983471735014, 854.747849384433, 859.4671303791689, 902.8149229407956, 904.4663648447447, 5519.39286678465, 5558.694271815089, 5602.831915042555, 5706.229658995982, 5917.112433135064, 917.2478567574658, 918.5499105438287, 938.648006997376, 951.7382719752123, 955.5365647660878, 3583.749137560346, 3666.4683620874825, 3718.605522928902, 3723.888283351504, 3800.7149463790324, 9187.0, 9516.666916657883, 9624.37441566296, 9677.951610242044, 9701.17540009093, 9607.90392096084, 9710.17463515609, 9862.260330475243, 9862.605495780232, 9941.254405919584, 7358.742444014434, 7466.589337586376, 7509.436792240604, 7523.699052037967, 7538.09542854861, 5089.338386009795, 5309.893802123858, 5348.572114230775, 5456.0, 5472.589555783412, 8959.283257339528, 8971.058038906081, 9006.099390060941, 9065.456072635663, 9090.863637045582, 8525.317974562144, 8868.379213454997, 8870.42342247752, 8953.238974686965, 8965.058668839938, 6203.751849925952, 6425.5502114851515, 6531.412172904462, 6767.289434609295, 6901.137357830271, 7202.099737532809, 7225.1329840419485, 7317.341439270491, 7326.853462930605, 7347.70609175627, 6569.24453687832, 6788.456923446014, 6824.897626535507, 6944.992976018348, 6949.0, 6744.258131605618, 6749.696263668048, 6778.0, 6882.242953275236, 6904.13698287714, 6242.5942313749465, 6356.809295721136, 6435.549511534147, 6448.097266382616, 6658.533902626963, 4597.747123908217, 4623.56076172763, 4750.9287360690305, 4768.809247630056, 4811.855644330676, 4450.354698568754, 4598.080383923296, 4636.721796692209, 4652.55800698933, 4731.763411829464], "value": 4212.814404393588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.80946717768563, 312.68731268731267, 316.1937060495736, 319.2844854512372, 324.3254031614241, 5081.974590127049, 5091.363579552556, 5113.769880355384, 5119.6177032201285, 5143.665661731994, 4749.121412538683, 4848.854534363974, 4920.753962301888, 4999.1255028358655, 5078.1874900016, 3943.4479172915817, 3967.8016099194924, 3978.4231286463446, 3990.8204130814183, 3993.5806740292287, 3972.36442169253, 3978.9801050994706, 3984.661303789167, 3994.2810294147043, 3996.8001599920035, 3729.9440508392395, 3817.1983883384523, 3939.409088636699, 3953.2884080865433, 3976.145128797308, 3928.4696565963513, 3940.7044471664453, 3954.2882281189372, 3961.1285517186175, 3965.8810235692977, 3530.6292839251764, 3537.540119784437, 3538.6992105671047, 3540.6459354064646, 3553.6091029986683, 4761.40482439695, 4843.564079232886, 4853.902921941577, 4866.124097662419, 4884.438289596706, 4599.632029437637, 4618.699784513996, 4632.328312394718, 4639.327297541871, 4648.395708557866, 5349.652272602269, 5367.409584945653, 5380.354357477088, 5388.78444862205, 5389.676619402849, 3600.963990360089, 3806.4290356446477, 3922.9803850980848, 3929.0766669832565, 3930.430087637305, 5600.0, 5610.102383618601, 5630.943690563083, 5637.323521177444, 5642.097264437712, 3886.4170374443493, 3889.163829776555, 3892.844286228519, 3894.532656081288, 3900.64894159527, 3842.481265029241, 3925.5878132796215, 3939.1530820873077, 3943.5464921533817, 3946.782926939046, 4453.621442177451, 4488.753118578445, 4497.505274419811, 4498.122866041091, 4524.049949510574, 5296.311479507639, 5322.8935421292135, 5329.8934021319355, 5333.973330133402, 5348.144296912553, 1304.6477451088153, 1326.409747662281, 1351.094766506443, 1379.3310244531394, 1385.1965859801292, 906.8639704044446, 916.6241840845222, 926.3885835348638, 929.9674511392204, 932.6383480119102, 4637.8840528986375, 4653.162430762495, 4658.324542941323, 4670.229412146958, 4678.017616300547, 5475.123980163235, 5480.177973304037, 5481.835544933659, 5489.752961116759, 5490.945090549123, 4495.707778994355, 4611.76941152941, 4622.583967442946, 4646.442426908725, 4651.813927442932, 2918.0662188099604, 2939.8971036013636, 2940.588317635533, 2941.382309714941, 2950.7639388848843, 5135.0, 5138.100832354323, 5148.382194136728, 5161.612879034087, 5166.081164142248, 5467.1799230115, 5579.525740312038, 5602.0, 5613.7193140342815, 5639.125935480007, 5149.176131818891, 5152.742362881766, 5155.922661160085, 5163.896722065538, 5169.896602067937, 5456.317960254968, 5468.507834294774, 5471.671699698031, 5476.945230547643, 5482.342118945592, 5132.538071573576, 5321.095413779744, 5326.0, 5328.60035497347, 5330.2804121443105, 5093.312402825572, 5118.360204974379, 5142.665726727901, 5152.381714194321, 5162.934826069602, 3855.151866589346, 3872.5352957645264, 3874.7868867212574, 3887.8056097195595, 3896.1038961038553, 5186.507281808223, 5262.368515778131, 5392.460753924576, 5410.621256512007, 5445.319335083114, 5230.921536177037, 5404.567634589302, 5406.1079921814035, 5413.756380962787, 5432.360318586478, 5383.031054410244, 5392.730363481889, 5398.325209348832, 5404.865278062207, 5416.079266524779, 5131.692098474104, 5290.338707661543, 5309.920351194658, 5314.335708036496, 5329.413764485826, 5413.593980451561, 5435.83692489226, 5449.0, 5455.645383050089, 5460.945390546202, 5319.521243088141, 5325.4940780625775, 5327.413984461628, 5327.936436549077, 5334.06653835585], "value": 4020.4838453291677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6586189836032, 711.8647456983176, 712.4478529139916, 716.8387112899595, 775.3487070860477, 12306.200096993689, 12661.746765064694, 13154.408051637687, 13786.65533361664, 13809.171449713025, 14007.159570425782, 14062.578122656336, 14104.15375077496, 14104.788428173586, 14114.223717695522, 653.5131327161248, 795.0657976877175, 796.3549524884833, 804.2801692485223, 819.565630215985, 778.6924164954839, 778.8130848596325, 779.2168870285356, 789.4631650477672, 793.1552896165565, 821.1542111625035, 821.3839620284787, 821.6836517940606, 823.979400514986, 864.6022829498438, 683.45323741007, 700.4396482813729, 822.5517093184169, 830.8047608811954, 871.0288028847853, 512.5387151563585, 614.7049416280211, 626.357983067355, 627.269231345482, 628.4281304013372, 12713.809292860615, 12723.936380318131, 12730.745385092247, 12738.936305318413, 12768.936155319258, 12105.15263931525, 12219.15569858612, 12548.0, 12585.559505417357, 12745.490180392773, 9861.211103111806, 9931.65239216624, 9992.750181245527, 10163.339382940085, 10179.032991865835, 3293.4730443129224, 3346.531485592019, 3406.4549672052353, 3406.4549672052353, 3448.413769659139, 45674.0, 45983.540164598264, 46022.53977460216, 46099.53900460986, 46186.0, 9955.601775929026, 10072.841623213279, 10266.743331416625, 10675.199360048027, 10692.358458492516, 17533.298668053136, 17768.37810676646, 17768.733468997976, 17780.733289000676, 17792.110394480223, 6615.0, 6654.600723956578, 6708.899366509506, 6918.411934985583, 7091.0, 3551.893443196708, 3617.059564513193, 3623.61951995042, 3652.7808331500196, 3719.2933342664805, 2839.0, 2901.17316564778, 2948.7051294870344, 2956.6452025756616, 2958.2012856528618, 525.1754745050234, 531.7595100286696, 535.0476152448648, 537.159345624097, 539.5090467674397, 629.3423372575669, 632.7595513704763, 637.9585326953733, 643.2120652201016, 649.65932498811, 7649.502782319243, 7887.605619719106, 8228.50628962264, 8568.22885940256, 8615.052344242129, 617.197643064015, 619.5910698938679, 628.3057221769969, 633.9017452294902, 643.231338550437, 3825.4304978736277, 3904.9219015620097, 3966.464527288779, 4021.6581590564547, 4126.91746165075, 50849.49150508447, 51246.0, 51697.0, 51774.0, 53089.46910530845, 44322.778386107864, 44744.0, 45279.0, 45382.0, 45692.77153614211, 40021.39967900484, 40404.191916161515, 40409.59590404058, 41101.79449102735, 42087.36868946968, 7675.846483070419, 7704.6918123274445, 7817.882731759142, 7945.682172713026, 8041.075276343296, 27542.724572754018, 27819.721802781714, 27872.303192420353, 28301.858490707415, 28484.287892802844, 36078.63921360753, 38004.80997595105, 38098.80950595229, 38213.0, 38946.61053389543, 9554.766945993588, 9625.71122866315, 9679.177269932135, 9684.225261979165, 9883.061109194616, 10122.8481572775, 10448.0, 10544.630937917136, 10592.258541901992, 11206.439678015904, 9746.512674366111, 9853.605855765689, 9904.207663386767, 10104.635874156895, 10216.335938164293, 9641.517924103626, 9692.41845489273, 9710.514474276399, 9761.707148785548, 10214.927432619765, 10125.746856328651, 11246.437678115897, 11329.546818127183, 11536.59621913229, 11558.653240402802, 9303.488308143116, 9448.669296574863, 9550.283728720235, 9685.9031409685, 9796.755081123029, 9290.489023103793, 9371.906280937103, 9481.762955926157, 9706.417614943126, 9992.60029598837], "value": 5906.674426193066, "unit": "score"}], "name": "dromaeo_css", "value": 6351.809586188917, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 109.0, 113.0, 116.0, 115.0, 102.0, 113.0, 112.0, 116.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 141.0, 162.0, 186.0, 141.0, 162.0, 160.0, 131.0, 194.0, 134.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 120.0, 123.0, 77.0, 73.0, 74.0, 116.0, 101.0, 74.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 147.0, 94.0, 95.0, 94.0, 149.0, 93.0, 94.0, 143.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 86.0, 64.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 79.0, 80.0, 81.0, 79.0, 79.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 145.0, 134.0, 134.0, 140.0, 131.0, 135.0, 168.0, 141.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 174.0, 173.0, 170.0, 176.0, 177.0, 172.0, 173.0, 172.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 72.0, 76.0, 72.0, 71.0, 70.0, 72.0, 70.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1587.6999999999998, "alertThreshold": 2.0}]} 08:56:21 INFO - Return code: 0 08:56:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:56:21 ERROR - # TBPL SUCCESS # 08:56:21 INFO - Running post-action listener: _resource_record_post_action 08:56:21 INFO - Running post-run listener: _resource_record_post_run 08:56:22 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518127616; Read time: 12; Write time: 550844 08:56:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234668032; Read time: 0; Write time: 335944 08:56:22 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283308032; Read time: 12; Write time: 214884 08:56:22 INFO - Running post-run listener: _upload_blobber_files 08:56:22 INFO - Blob upload gear active. 08:56:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:23 INFO - (blobuploader) - INFO - Done attempting. 08:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:24 INFO - (blobuploader) - INFO - Done attempting. 08:56:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:24 INFO - Return code: 0 08:56:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dff5b7a66e02146e69bed9da2caca7fa771a795df4b6fb8592e52b66f3e47f2fa86389d274d0b43492f48fe16ecee0a541207afbde20978cd8006d4e16f4f115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1393aa7325503654143da35f33b577e4106236f1509ee496801747df49f78c51e6590c6773785854ce3ad610fc6da6b33d9ef44359a47d1649ff2b39ed9ce0b8"} 08:56:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:24 INFO - Contents: 08:56:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dff5b7a66e02146e69bed9da2caca7fa771a795df4b6fb8592e52b66f3e47f2fa86389d274d0b43492f48fe16ecee0a541207afbde20978cd8006d4e16f4f115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1393aa7325503654143da35f33b577e4106236f1509ee496801747df49f78c51e6590c6773785854ce3ad610fc6da6b33d9ef44359a47d1649ff2b39ed9ce0b8"} 08:56:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:24 INFO - Copying logs to upload dir... 08:56:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.824578 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-22 08:56:24.253311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:56:24.257124) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145 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-Non-PGO/sha512/dff5b7a66e02146e69bed9da2caca7fa771a795df4b6fb8592e52b66f3e47f2fa86389d274d0b43492f48fe16ecee0a541207afbde20978cd8006d4e16f4f115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1393aa7325503654143da35f33b577e4106236f1509ee496801747df49f78c51e6590c6773785854ce3ad610fc6da6b33d9ef44359a47d1649ff2b39ed9ce0b8"} build_url:https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/JjHr00PCSUWjStYT0J6OKg/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-Non-PGO/sha512/dff5b7a66e02146e69bed9da2caca7fa771a795df4b6fb8592e52b66f3e47f2fa86389d274d0b43492f48fe16ecee0a541207afbde20978cd8006d4e16f4f115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1393aa7325503654143da35f33b577e4106236f1509ee496801747df49f78c51e6590c6773785854ce3ad610fc6da6b33d9ef44359a47d1649ff2b39ed9ce0b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 08:56:24.282114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:56:24.282459) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1461339345.903409-1411998145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 08:56:24.367469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:56:24.367823) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 08:56:24.368134) ========= ========= Total master_lag: 0.38 =========