builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1461574832.77 results: success (0) buildid: 20160424232645 builduid: c6af1b73fa52477b802806879cd541dd revision: 0225961ad7adbef25e670abf314ec67f5e6c224d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.772878) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.774461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.774752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.794187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.794477) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 02:00:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-04-25 02:00:33 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113662 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.921400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.921710) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.971628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:32.971984) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0225961ad7adbef25e670abf314ec67f5e6c224d --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 0225961ad7adbef25e670abf314ec67f5e6c224d --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=5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 02:00:34,077 truncating revision to first 12 chars 2016-04-25 02:00:34,077 Setting DEBUG logging. 2016-04-25 02:00:34,077 attempt 1/10 2016-04-25 02:00:34,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0225961ad7ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 02:00:34,523 unpacking tar archive at: fx-team-0225961ad7ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:33.710511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:33.710816) ========= script_repo_revision: 0225961ad7adbef25e670abf314ec67f5e6c224d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:33.711245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:33.711507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 02:00:33.720469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-25 02:00:33.720854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:00:34 INFO - MultiFileLogger online at 20160425 02:00:34 in /builds/slave/test 02:00:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:00:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:00:34 INFO - {'append_to_log': False, 02:00:34 INFO - 'base_work_dir': '/builds/slave/test', 02:00:34 INFO - 'blob_upload_branch': 'Fx-Team', 02:00:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:00:34 INFO - 'branch': 'Fx-Team', 02:00:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:00:34 INFO - 'config_files': ('talos/linux_config.py',), 02:00:34 INFO - 'default_actions': ('clobber', 02:00:34 INFO - 'read-buildbot-config', 02:00:34 INFO - 'download-and-extract', 02:00:34 INFO - 'populate-webroot', 02:00:34 INFO - 'create-virtualenv', 02:00:34 INFO - 'install', 02:00:34 INFO - 'run-tests'), 02:00:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:00:34 INFO - 'download_minidump_stackwalk': True, 02:00:34 INFO - 'download_symbols': 'ondemand', 02:00:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:00:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:00:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:00:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:00:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:00:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:00:34 INFO - 'installer_path': 'installer.exe', 02:00:34 INFO - 'log_level': 'info', 02:00:34 INFO - 'log_name': 'talos', 02:00:34 INFO - 'log_to_console': True, 02:00:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:00:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:00:34 INFO - 'opt_config_files': (), 02:00:34 INFO - 'pip_index': False, 02:00:34 INFO - 'sps_profile': False, 02:00:34 INFO - 'sps_profile_interval': 0, 02:00:34 INFO - 'suite': 'dromaeojs-e10s', 02:00:34 INFO - 'system_bits': '32', 02:00:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:00:34 INFO - 'title': 'talos-linux64-ix-051', 02:00:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:00:34 INFO - 'use_talos_json': True, 02:00:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:00:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:00:34 INFO - 'work_dir': 'build'} 02:00:34 INFO - ##### 02:00:34 INFO - ##### Running clobber step. 02:00:34 INFO - ##### 02:00:34 INFO - Running pre-action listener: _resource_record_pre_action 02:00:34 INFO - Running main action method: clobber 02:00:34 INFO - rmtree: /builds/slave/test/build 02:00:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:00:35 INFO - Running post-action listener: _resource_record_post_action 02:00:35 INFO - ##### 02:00:35 INFO - ##### Running read-buildbot-config step. 02:00:35 INFO - ##### 02:00:35 INFO - Running pre-action listener: _resource_record_pre_action 02:00:35 INFO - Running main action method: read_buildbot_config 02:00:35 INFO - Using buildbot properties: 02:00:35 INFO - { 02:00:35 INFO - "project": "", 02:00:35 INFO - "product": "firefox", 02:00:35 INFO - "script_repo_revision": "production", 02:00:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:00:35 INFO - "repository": "", 02:00:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:00:35 INFO - "buildid": "20160424232645", 02:00:35 INFO - "pgo_build": "True", 02:00:35 INFO - "basedir": "/builds/slave/test", 02:00:35 INFO - "buildnumber": 412, 02:00:35 INFO - "slavename": "talos-linux64-ix-051", 02:00:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:00:35 INFO - "platform": "ubuntu64_hw", 02:00:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:00:35 INFO - "branch": "fx-team", 02:00:35 INFO - "repo_path": "integration/fx-team", 02:00:35 INFO - "revision": "0225961ad7adbef25e670abf314ec67f5e6c224d", 02:00:35 INFO - "stage_platform": "linux64-pgo", 02:00:35 INFO - "builduid": "c6af1b73fa52477b802806879cd541dd", 02:00:35 INFO - "slavebuilddir": "test" 02:00:35 INFO - } 02:00:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:00:35 INFO - Running post-action listener: _resource_record_post_action 02:00:35 INFO - ##### 02:00:35 INFO - ##### Running download-and-extract step. 02:00:35 INFO - ##### 02:00:35 INFO - Running pre-action listener: _resource_record_pre_action 02:00:35 INFO - Running main action method: download_and_extract 02:00:35 INFO - mkdir: /builds/slave/test/build/tests 02:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:35 INFO - https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:36 INFO - Downloaded 1361 bytes. 02:00:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:00:36 INFO - Using the following test package requirements: 02:00:36 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:00:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:00:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:00:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'jsshell-linux-x86_64.zip'], 02:00:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:00:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:00:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:00:36 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:00:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:00:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:00:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:00:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:36 INFO - https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:37 INFO - Downloaded 23857717 bytes. 02:00:37 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'] 02:00:37 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 02:00:39 INFO - Return code: 0 02:00:39 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 02:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:39 INFO - https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:45 INFO - Downloaded 23857717 bytes. 02:00:45 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'] 02:00:45 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 02:00:46 INFO - Return code: 0 02:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:46 INFO - https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:48 INFO - Downloaded 10840145 bytes. 02:00:48 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'] 02:00:48 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 02:00:48 INFO - Return code: 0 02:00: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')]} 02:00:48 INFO - https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/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 02:00:49 INFO - Downloaded 58293711 bytes. 02:00:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:49 INFO - mkdir: /builds/slave/test/properties 02:00:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:00:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:00:49 INFO - Contents: 02:00:49 INFO - build_url:https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:00:51 INFO - Running post-action listener: _resource_record_post_action 02:00:51 INFO - Running post-action listener: set_extra_try_arguments 02:00:51 INFO - ##### 02:00:51 INFO - ##### Running populate-webroot step. 02:00:51 INFO - ##### 02:00:51 INFO - Running pre-action listener: _resource_record_pre_action 02:00:51 INFO - Running main action method: populate_webroot 02:00:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:51 INFO - '--tppagecycles', 02:00:51 INFO - '7'], 02:00:51 INFO - 'tests': ['tsvgm']}}, 02:00:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['damp', 'tps']}, 02:00:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'tests': ['damp', 'tps']}, 02:00:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['dromaeo_dom']}, 02:00:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['a11yr', 02:00:51 INFO - 'ts_paint', 02:00:51 INFO - 'tpaint', 02:00:51 INFO - 'sessionrestore', 02:00:51 INFO - 'sessionrestore_no_auto_restore', 02:00:51 INFO - 'tabpaint']}, 02:00:51 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:51 INFO - 'ts_paint', 02:00:51 INFO - 'tpaint', 02:00:51 INFO - 'sessionrestore', 02:00:51 INFO - 'sessionrestore_no_auto_restore', 02:00:51 INFO - 'tabpaint']}, 02:00:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:51 INFO - 'ts_paint', 02:00:51 INFO - 'tpaint', 02:00:51 INFO - 'sessionrestore', 02:00:51 INFO - 'sessionrestore_no_auto_restore', 02:00:51 INFO - 'tabpaint']}, 02:00:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:51 INFO - 'ts_paint', 02:00:51 INFO - 'tpaint', 02:00:51 INFO - 'sessionrestore', 02:00:51 INFO - 'sessionrestore_no_auto_restore', 02:00:51 INFO - 'tabpaint']}, 02:00:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['a11yr', 02:00:51 INFO - 'ts_paint', 02:00:51 INFO - 'tpaint', 02:00:51 INFO - 'sessionrestore', 02:00:51 INFO - 'sessionrestore_no_auto_restore', 02:00:51 INFO - 'tabpaint']}, 02:00:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['a11yr', 02:00:51 INFO - 'ts_paint', 02:00:51 INFO - 'tpaint', 02:00:51 INFO - 'sessionrestore', 02:00:51 INFO - 'sessionrestore_no_auto_restore', 02:00:51 INFO - 'tabpaint']}, 02:00:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['tsvgx', 02:00:51 INFO - 'tsvgr_opacity', 02:00:51 INFO - 'tart', 02:00:51 INFO - 'tscrollx', 02:00:51 INFO - 'cart']}, 02:00:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:51 INFO - 'tsvgr_opacity', 02:00:51 INFO - 'tart', 02:00:51 INFO - 'tscrollx', 02:00:51 INFO - 'cart']}, 02:00:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'talos_options': ['--disable-e10s'], 02:00:51 INFO - 'tests': ['tp5o']}, 02:00:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'tests': ['tp5o']}, 02:00:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'talos_options': ['--disable-e10s', 02:00:51 INFO - '--xperf_path', 02:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:51 INFO - 'tests': ['tp5n']}, 02:00:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:51 INFO - 'talos_options': ['--xperf_path', 02:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:51 INFO - 'tests': ['tp5n']}}, 02:00:51 INFO - 'talos.zip': {'path': '', 02:00:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:51 INFO - Running post-action listener: _resource_record_post_action 02:00:51 INFO - ##### 02:00:51 INFO - ##### Running create-virtualenv step. 02:00:51 INFO - ##### 02:00:51 INFO - Running pre-action listener: _resource_record_pre_action 02:00:51 INFO - Running main action method: create_virtualenv 02:00:51 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:51 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 02:00:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:51 INFO - Using real prefix '/usr' 02:00:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:52 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:54 INFO - Installing pip.................done. 02:00:54 INFO - Return code: 0 02:00:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00: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')]} 02:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:00:54 INFO - Using env: {'DISPLAY': ':0', 02:00:54 INFO - 'HOME': '/home/cltbld', 02:00:54 INFO - 'LANG': 'en_US.UTF-8', 02:00:54 INFO - 'LANGUAGE': 'en_US:en', 02:00:54 INFO - 'LOGNAME': 'cltbld', 02:00:54 INFO - 'MAIL': '/var/mail/cltbld', 02:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:54 INFO - 'MOZ_NO_REMOTE': '1', 02:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:54 INFO - 'NO_EM_RESTART': '1', 02:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:54 INFO - 'PWD': '/builds/slave/test', 02:00:54 INFO - 'SHELL': '/bin/bash', 02:00:54 INFO - 'SHLVL': '1', 02:00:54 INFO - 'TERM': 'linux', 02:00:54 INFO - 'TMOUT': '86400', 02:00:54 INFO - 'USER': 'cltbld', 02:00:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:54 INFO - '_': '/tools/buildbot/bin/python'} 02:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:54 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 02:00:54 INFO - Cleaning up... 02:00:54 INFO - Return code: 0 02:00:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00: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')]} 02:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:00:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:00:54 INFO - Using env: {'DISPLAY': ':0', 02:00:54 INFO - 'HOME': '/home/cltbld', 02:00:54 INFO - 'LANG': 'en_US.UTF-8', 02:00:54 INFO - 'LANGUAGE': 'en_US:en', 02:00:54 INFO - 'LOGNAME': 'cltbld', 02:00:54 INFO - 'MAIL': '/var/mail/cltbld', 02:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:54 INFO - 'MOZ_NO_REMOTE': '1', 02:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:54 INFO - 'NO_EM_RESTART': '1', 02:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:54 INFO - 'PWD': '/builds/slave/test', 02:00:54 INFO - 'SHELL': '/bin/bash', 02:00:54 INFO - 'SHLVL': '1', 02:00:54 INFO - 'TERM': 'linux', 02:00:54 INFO - 'TMOUT': '86400', 02:00:54 INFO - 'USER': 'cltbld', 02:00:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:54 INFO - '_': '/tools/buildbot/bin/python'} 02:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:54 INFO - Downloading/unpacking psutil>=0.7.1 02:00:54 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 02:00:54 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 02:00:54 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 02:00:54 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 02:00:54 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 02:00:54 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 02:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:56 INFO - Installing collected packages: psutil 02:00:56 INFO - Running setup.py install for psutil 02:00:56 INFO - building 'psutil._psutil_linux' extension 02:00:56 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 02:00:56 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 02:00:56 INFO - building 'psutil._psutil_posix' extension 02:00:56 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 02:00:56 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 02:00:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:57 INFO - Successfully installed psutil 02:00:57 INFO - Cleaning up... 02:00:57 INFO - Return code: 0 02:00:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:00:57 INFO - Using env: {'DISPLAY': ':0', 02:00:57 INFO - 'HOME': '/home/cltbld', 02:00:57 INFO - 'LANG': 'en_US.UTF-8', 02:00:57 INFO - 'LANGUAGE': 'en_US:en', 02:00:57 INFO - 'LOGNAME': 'cltbld', 02:00:57 INFO - 'MAIL': '/var/mail/cltbld', 02:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:57 INFO - 'MOZ_NO_REMOTE': '1', 02:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:57 INFO - 'NO_EM_RESTART': '1', 02:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:57 INFO - 'PWD': '/builds/slave/test', 02:00:57 INFO - 'SHELL': '/bin/bash', 02:00:57 INFO - 'SHLVL': '1', 02:00:57 INFO - 'TERM': 'linux', 02:00:57 INFO - 'TMOUT': '86400', 02:00:57 INFO - 'USER': 'cltbld', 02:00:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:57 INFO - '_': '/tools/buildbot/bin/python'} 02:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:00:59 INFO - Installing collected packages: mozsystemmonitor 02:00:59 INFO - Running setup.py install for mozsystemmonitor 02:00:59 INFO - Successfully installed mozsystemmonitor 02:00:59 INFO - Cleaning up... 02:00:59 INFO - Return code: 0 02:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:00:59 INFO - Using env: {'DISPLAY': ':0', 02:00:59 INFO - 'HOME': '/home/cltbld', 02:00:59 INFO - 'LANG': 'en_US.UTF-8', 02:00:59 INFO - 'LANGUAGE': 'en_US:en', 02:00:59 INFO - 'LOGNAME': 'cltbld', 02:00:59 INFO - 'MAIL': '/var/mail/cltbld', 02:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:59 INFO - 'MOZ_NO_REMOTE': '1', 02:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:59 INFO - 'NO_EM_RESTART': '1', 02:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:59 INFO - 'PWD': '/builds/slave/test', 02:00:59 INFO - 'SHELL': '/bin/bash', 02:00:59 INFO - 'SHLVL': '1', 02:00:59 INFO - 'TERM': 'linux', 02:00:59 INFO - 'TMOUT': '86400', 02:00:59 INFO - 'USER': 'cltbld', 02:00:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:59 INFO - '_': '/tools/buildbot/bin/python'} 02:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01:02 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 02:01:02 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 02:01:02 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 02:01:02 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 02:01:02 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 02:01:02 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 02:01:02 INFO - Downloading docopt-0.6.1.tar.gz 02:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:02 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:02 INFO - Running setup.py install for blobuploader 02:01:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:02 INFO - Running setup.py install for requests 02:01:02 INFO - Running setup.py install for docopt 02:01:02 INFO - Successfully installed blobuploader requests docopt 02:01:02 INFO - Cleaning up... 02:01:02 INFO - Return code: 0 02:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:02 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')]} 02:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:02 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')]} 02:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:02 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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:01:02 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 02:01:02 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 02:01:02 INFO - Using env: {'DISPLAY': ':0', 02:01:02 INFO - 'HOME': '/home/cltbld', 02:01:02 INFO - 'LANG': 'en_US.UTF-8', 02:01:02 INFO - 'LANGUAGE': 'en_US:en', 02:01:02 INFO - 'LOGNAME': 'cltbld', 02:01:02 INFO - 'MAIL': '/var/mail/cltbld', 02:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:02 INFO - 'MOZ_NO_REMOTE': '1', 02:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:02 INFO - 'NO_EM_RESTART': '1', 02:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:02 INFO - 'PWD': '/builds/slave/test', 02:01:02 INFO - 'SHELL': '/bin/bash', 02:01:02 INFO - 'SHLVL': '1', 02:01:02 INFO - 'TERM': 'linux', 02:01:02 INFO - 'TMOUT': '86400', 02:01:02 INFO - 'USER': 'cltbld', 02:01:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:02 INFO - '_': '/tools/buildbot/bin/python'} 02:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:03 INFO - Running setup.py (path:/tmp/pip-livzOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:03 INFO - Running setup.py (path:/tmp/pip-Y3BjzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:03 INFO - Running setup.py (path:/tmp/pip-1MYcJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:03 INFO - Running setup.py (path:/tmp/pip-Rfqpaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:03 INFO - Running setup.py (path:/tmp/pip-_13c12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:03 INFO - Running setup.py (path:/tmp/pip-TLe7nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:03 INFO - Running setup.py (path:/tmp/pip-uW2aVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:03 INFO - Running setup.py (path:/tmp/pip-Prqqap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:03 INFO - Running setup.py (path:/tmp/pip-qRkV8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:03 INFO - Running setup.py (path:/tmp/pip-9xZ4Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:03 INFO - Running setup.py (path:/tmp/pip-mOawHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:03 INFO - Running setup.py (path:/tmp/pip-ceAqIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:04 INFO - Running setup.py (path:/tmp/pip-dPKt2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:04 INFO - Running setup.py (path:/tmp/pip-yVEA9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:04 INFO - Running setup.py (path:/tmp/pip-Ehqdtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:04 INFO - Running setup.py (path:/tmp/pip-Ey7f1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:04 INFO - Running setup.py (path:/tmp/pip-NhadDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:04 INFO - Running setup.py install for manifestparser 02:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:04 INFO - Running setup.py install for mozcrash 02:01:04 INFO - Running setup.py install for mozdebug 02:01:04 INFO - Running setup.py install for mozdevice 02:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:04 INFO - Running setup.py install for mozfile 02:01:04 INFO - Running setup.py install for mozhttpd 02:01:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for mozinfo 02:01:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for mozInstall 02:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for mozleak 02:01:05 INFO - Running setup.py install for mozlog 02:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for moznetwork 02:01:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for mozprocess 02:01:05 INFO - Running setup.py install for mozprofile 02:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for mozrunner 02:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:05 INFO - Running setup.py install for mozscreenshot 02:01:05 INFO - Running setup.py install for moztest 02:01:06 INFO - Running setup.py install for mozversion 02:01:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:01:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:01:06 INFO - Cleaning up... 02:01:06 INFO - Return code: 0 02:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:06 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')]} 02:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:06 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')]} 02:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:06 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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:01:06 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 02:01:06 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 02:01:06 INFO - Using env: {'DISPLAY': ':0', 02:01:06 INFO - 'HOME': '/home/cltbld', 02:01:06 INFO - 'LANG': 'en_US.UTF-8', 02:01:06 INFO - 'LANGUAGE': 'en_US:en', 02:01:06 INFO - 'LOGNAME': 'cltbld', 02:01:06 INFO - 'MAIL': '/var/mail/cltbld', 02:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:06 INFO - 'MOZ_NO_REMOTE': '1', 02:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:06 INFO - 'NO_EM_RESTART': '1', 02:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:06 INFO - 'PWD': '/builds/slave/test', 02:01:06 INFO - 'SHELL': '/bin/bash', 02:01:06 INFO - 'SHLVL': '1', 02:01:06 INFO - 'TERM': 'linux', 02:01:06 INFO - 'TMOUT': '86400', 02:01:06 INFO - 'USER': 'cltbld', 02:01:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:06 INFO - '_': '/tools/buildbot/bin/python'} 02:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:06 INFO - Running setup.py (path:/tmp/pip-jxIDJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:06 INFO - Running setup.py (path:/tmp/pip-MwkGl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:06 INFO - Running setup.py (path:/tmp/pip-THdykO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:06 INFO - Running setup.py (path:/tmp/pip-K0WvLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:06 INFO - Running setup.py (path:/tmp/pip-8WTmlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:06 INFO - Running setup.py (path:/tmp/pip-aMc6XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:06 INFO - Running setup.py (path:/tmp/pip-Xn5tyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:06 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)) 02:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:06 INFO - Running setup.py (path:/tmp/pip-arVJXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:07 INFO - Running setup.py (path:/tmp/pip-XbqybK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:07 INFO - Running setup.py (path:/tmp/pip-EZO9Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:07 INFO - Running setup.py (path:/tmp/pip-GqsPPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:07 INFO - Running setup.py (path:/tmp/pip-d5yNRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:07 INFO - Running setup.py (path:/tmp/pip-3C8qXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:07 INFO - Running setup.py (path:/tmp/pip-4R3qfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:07 INFO - Running setup.py (path:/tmp/pip-PJaCOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:07 INFO - Running setup.py (path:/tmp/pip-bB92b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:07 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)) 02:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:07 INFO - Running setup.py (path:/tmp/pip-_PF_d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:07 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)) 02:01:07 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)) 02:01:07 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)) 02:01:07 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)) 02:01:07 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)) 02:01:07 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)) 02:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:09 INFO - Downloading blessings-1.6.tar.gz 02:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:01:09 INFO - Installing collected packages: blessings 02:01:09 INFO - Running setup.py install for blessings 02:01:09 INFO - Successfully installed blessings 02:01:09 INFO - Cleaning up... 02:01:09 INFO - Return code: 0 02:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:10 INFO - Reading from file tmpfile_stdout 02:01:10 INFO - Current package versions: 02:01:10 INFO - argparse == 1.2.1 02:01:10 INFO - blessings == 1.6 02:01:10 INFO - blobuploader == 1.2.4 02:01:10 INFO - docopt == 0.6.1 02:01:10 INFO - manifestparser == 1.1 02:01:10 INFO - mozInstall == 1.12 02:01:10 INFO - mozcrash == 0.17 02:01:10 INFO - mozdebug == 0.1 02:01:10 INFO - mozdevice == 0.48 02:01:10 INFO - mozfile == 1.2 02:01:10 INFO - mozhttpd == 0.7 02:01:10 INFO - mozinfo == 0.9 02:01:10 INFO - mozleak == 0.1 02:01:10 INFO - mozlog == 3.1 02:01:10 INFO - moznetwork == 0.27 02:01:10 INFO - mozprocess == 0.22 02:01:10 INFO - mozprofile == 0.28 02:01:10 INFO - mozrunner == 6.11 02:01:10 INFO - mozscreenshot == 0.1 02:01:10 INFO - mozsystemmonitor == 0.0 02:01:10 INFO - moztest == 0.7 02:01:10 INFO - mozversion == 1.4 02:01:10 INFO - psutil == 3.1.1 02:01:10 INFO - requests == 1.2.3 02:01:10 INFO - wsgiref == 0.1.2 02:01:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:10 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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:01:10 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 02:01:10 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 02:01:10 INFO - Using env: {'DISPLAY': ':0', 02:01:10 INFO - 'HOME': '/home/cltbld', 02:01:10 INFO - 'LANG': 'en_US.UTF-8', 02:01:10 INFO - 'LANGUAGE': 'en_US:en', 02:01:10 INFO - 'LOGNAME': 'cltbld', 02:01:10 INFO - 'MAIL': '/var/mail/cltbld', 02:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:10 INFO - 'MOZ_NO_REMOTE': '1', 02:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:10 INFO - 'NO_EM_RESTART': '1', 02:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:10 INFO - 'PWD': '/builds/slave/test', 02:01:10 INFO - 'SHELL': '/bin/bash', 02:01:10 INFO - 'SHLVL': '1', 02:01:10 INFO - 'TERM': 'linux', 02:01:10 INFO - 'TMOUT': '86400', 02:01:10 INFO - 'USER': 'cltbld', 02:01:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:10 INFO - '_': '/tools/buildbot/bin/python'} 02:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 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)) 02:01:10 INFO - Cleaning up... 02:01:10 INFO - Return code: 0 02:01:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:10 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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:01:10 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 02:01:10 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 02:01:10 INFO - Using env: {'DISPLAY': ':0', 02:01:10 INFO - 'HOME': '/home/cltbld', 02:01:10 INFO - 'LANG': 'en_US.UTF-8', 02:01:10 INFO - 'LANGUAGE': 'en_US:en', 02:01:10 INFO - 'LOGNAME': 'cltbld', 02:01:10 INFO - 'MAIL': '/var/mail/cltbld', 02:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:10 INFO - 'MOZ_NO_REMOTE': '1', 02:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:10 INFO - 'NO_EM_RESTART': '1', 02:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:10 INFO - 'PWD': '/builds/slave/test', 02:01:10 INFO - 'SHELL': '/bin/bash', 02:01:10 INFO - 'SHLVL': '1', 02:01:10 INFO - 'TERM': 'linux', 02:01:10 INFO - 'TMOUT': '86400', 02:01:10 INFO - 'USER': 'cltbld', 02:01:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:10 INFO - '_': '/tools/buildbot/bin/python'} 02:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:10 INFO - Downloading/unpacking jsonschema 02:01:10 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 02:01:10 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 02:01:10 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 02:01:10 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 02:01:10 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 02:01:10 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 02:01:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:01:13 INFO - Downloading/unpacking functools32 (from jsonschema) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:13 INFO - Downloading functools32-3.2.3-2.tar.gz 02:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:01:13 INFO - warning: no files found matching '*.txt' 02:01:13 INFO - no previously-included directories found matching 'build' 02:01:13 INFO - no previously-included directories found matching 'dist' 02:01:13 INFO - no previously-included directories found matching '.git*' 02:01:13 INFO - Installing collected packages: jsonschema, functools32 02:01:13 INFO - Running setup.py install for functools32 02:01:13 INFO - warning: no files found matching '*.txt' 02:01:13 INFO - no previously-included directories found matching 'build' 02:01:13 INFO - no previously-included directories found matching 'dist' 02:01:13 INFO - no previously-included directories found matching '.git*' 02:01:13 INFO - Successfully installed jsonschema functools32 02:01:13 INFO - Cleaning up... 02:01:13 INFO - Return code: 0 02:01:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:01:13 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')]} 02:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:13 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')]} 02:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:13 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 0x7f0e069f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', '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 02:01:13 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 02:01:13 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 02:01:13 INFO - Using env: {'DISPLAY': ':0', 02:01:13 INFO - 'HOME': '/home/cltbld', 02:01:13 INFO - 'LANG': 'en_US.UTF-8', 02:01:13 INFO - 'LANGUAGE': 'en_US:en', 02:01:13 INFO - 'LOGNAME': 'cltbld', 02:01:13 INFO - 'MAIL': '/var/mail/cltbld', 02:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:13 INFO - 'MOZ_NO_REMOTE': '1', 02:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:13 INFO - 'NO_EM_RESTART': '1', 02:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:13 INFO - 'PWD': '/builds/slave/test', 02:01:13 INFO - 'SHELL': '/bin/bash', 02:01:13 INFO - 'SHLVL': '1', 02:01:13 INFO - 'TERM': 'linux', 02:01:13 INFO - 'TMOUT': '86400', 02:01:13 INFO - 'USER': 'cltbld', 02:01:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:13 INFO - '_': '/tools/buildbot/bin/python'} 02:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:14 INFO - Downloading/unpacking flake8 02:01:14 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 02:01:14 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 02:01:14 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 02:01:14 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 02:01:14 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 02:01:14 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 02:01:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:01:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:01:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:01:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:01:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:01:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:01:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:01:16 INFO - no previously-included directories found matching 'docs/_build' 02:01:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:01:16 INFO - Running setup.py install for pep8 02:01:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:01:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:01:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:01:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:01:16 INFO - no previously-included directories found matching 'docs/_build' 02:01:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:01:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:01:17 INFO - Cleaning up... 02:01:17 INFO - Return code: 0 02:01:17 INFO - Running post-action listener: _resource_record_post_action 02:01:17 INFO - Running post-action listener: _start_resource_monitoring 02:01:17 INFO - Starting resource monitoring. 02:01:17 INFO - ##### 02:01:17 INFO - ##### Running install step. 02:01:17 INFO - ##### 02:01:17 INFO - Running pre-action listener: _resource_record_pre_action 02:01:17 INFO - Running main action method: install 02:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:01:17 INFO - Reading from file tmpfile_stdout 02:01:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:01:17 INFO - Reading from file tmpfile_stdout 02:01:17 INFO - Output received: 02:01:17 INFO - Usage: mozinstall [options] installer 02:01:17 INFO - Options: 02:01:17 INFO - -h, --help show this help message and exit 02:01:17 INFO - -d DEST, --destination=DEST 02:01:17 INFO - Directory to install application into. [default: 02:01:17 INFO - "/builds/slave/test"] 02:01:17 INFO - --app=APP Application being installed. [default: firefox] 02:01:17 INFO - mkdir: /builds/slave/test/build/application 02:01:17 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'] 02:01:17 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 02:01:33 INFO - Reading from file tmpfile_stdout 02:01:33 INFO - Output received: 02:01:33 INFO - /builds/slave/test/build/application/firefox/firefox 02:01:33 INFO - Running post-action listener: _resource_record_post_action 02:01:33 INFO - ##### 02:01:33 INFO - ##### Running run-tests step. 02:01:33 INFO - ##### 02:01:33 INFO - Running pre-action listener: _resource_record_pre_action 02:01:33 INFO - Running main action method: run_tests 02:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:01:33 INFO - Python 2.7.3 02:01:33 INFO - Return code: 0 02:01:33 INFO - grabbing minidump binary from tooltool 02:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:33 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 0x2a0b410>, '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 0x2a0c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:01:33 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 02:01:33 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 02:01:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:01:33 INFO - Return code: 0 02:01:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:01:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:01:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:01:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:01:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:01:34 INFO - Return code: 0 02:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:01:34 INFO - Using env: {'DISPLAY': ':0', 02:01:34 INFO - 'HOME': '/home/cltbld', 02:01:34 INFO - 'LANG': 'en_US.UTF-8', 02:01:34 INFO - 'LANGUAGE': 'en_US:en', 02:01:34 INFO - 'LOGNAME': 'cltbld', 02:01:34 INFO - 'MAIL': '/var/mail/cltbld', 02:01:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:01:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:34 INFO - 'MOZ_NO_REMOTE': '1', 02:01:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:01:34 INFO - 'NO_EM_RESTART': '1', 02:01:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:34 INFO - 'PWD': '/builds/slave/test', 02:01:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:01:34 INFO - 'SHELL': '/bin/bash', 02:01:34 INFO - 'SHLVL': '1', 02:01:34 INFO - 'TERM': 'linux', 02:01:34 INFO - 'TMOUT': '86400', 02:01:34 INFO - 'USER': 'cltbld', 02:01:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178', 02:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:34 INFO - '_': '/tools/buildbot/bin/python'} 02:01:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:01:35 INFO - mozversion application_buildid: 20160424232645 02:01:35 INFO - mozversion application_changeset: 0225961ad7adbef25e670abf314ec67f5e6c224d 02:01:35 INFO - mozversion application_display_name: Nightly 02:01:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:01:35 INFO - mozversion application_name: Firefox 02:01:35 INFO - mozversion application_remotingname: firefox 02:01:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:01:35 INFO - mozversion application_vendor: Mozilla 02:01:35 INFO - mozversion application_version: 48.0a1 02:01:35 INFO - mozversion platform_buildid: 20160424232645 02:01:35 INFO - mozversion platform_changeset: 0225961ad7adbef25e670abf314ec67f5e6c224d 02:01:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:01:35 INFO - mozversion platform_version: 48.0a1 02:01:35 INFO - using testdate: 1461574895 02:01:35 INFO - actual date: 1461574895 02:01:35 INFO - starting webserver on 'localhost:49476' 02:01:35 INFO - SUITE-START | Running 2 tests 02:01:35 INFO - TEST-START | dromaeo_css 02:01:35 INFO - operating with platform_type : linux_ 02:01:35 INFO - Initialising browser for dromaeo_css test... 02:01:35 INFO - TEST-INFO | started process 15254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_8eIN1/profile http://localhost:49476/getInfo.html) 02:01:38 INFO - PROCESS | 15254 | 02:01:38 INFO - PROCESS | 15254 | (process:15320): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:01:39 INFO - PROCESS | 15254 | __metrics Screen width/height:1600/1200 02:01:39 INFO - PROCESS | 15254 | colorDepth:24 02:01:39 INFO - PROCESS | 15254 | Browser inner width/height: 1024/697 02:01:39 INFO - PROCESS | 15254 | __metrics 02:01:39 ERROR - PROCESS | 15254 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:01:40 INFO - TEST-INFO | 15254: exit 0 02:01:40 INFO - Browser initialized. 02:01:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:40 INFO - TEST-INFO | started process 15371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_8eIN1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:42 INFO - PROCESS | 15371 | 02:01:42 INFO - PROCESS | 15371 | (process:15432): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:01:52 INFO - PROCESS | 15371 | RSS: Main: 164487168 02:01:52 INFO - PROCESS | 15371 | 02:02:42 INFO - PROCESS | 15371 | 1461574962125 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] 02:04:49 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49476/tests/dromaeo/cssquery-ext.html) 02:04:50 INFO - PROCESS | 15371 | RSS: Main: 169189376 02:04:50 INFO - PROCESS | 15371 | 02:07:52 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49476/tests/dromaeo/cssquery-ext.html (next: http://localhost:49476/tests/dromaeo/cssquery-jquery.html) 02:07:53 INFO - PROCESS | 15371 | RSS: Main: 166584320 02:07:53 INFO - PROCESS | 15371 | 02:10:55 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49476/tests/dromaeo/cssquery-mootools.html) 02:10:55 INFO - PROCESS | 15371 | RSS: Main: 167178240 02:10:55 INFO - PROCESS | 15371 | 02:13:57 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49476/tests/dromaeo/cssquery-prototype.html) 02:13:57 INFO - PROCESS | 15371 | RSS: Main: 164868096 02:13:57 INFO - PROCESS | 15371 | 02:17:00 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49476/tests/dromaeo/cssquery-yui.html) 02:17:01 INFO - PROCESS | 15371 | RSS: Main: 166367232 02:17:01 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | Cycle 1(1): loaded http://localhost:49476/tests/dromaeo/cssquery-yui.html (next: http://localhost:49476/tests/dromaeo/cssquery-dojo.html) 02:20:03 INFO - PROCESS | 15371 | RSS: Main: 168140800 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | __start_tp_report 02:20:03 INFO - PROCESS | 15371 | _x_x_mozilla_page_load 02:20:03 INFO - PROCESS | 15371 | _x_x_mozilla_page_load_details 02:20:03 INFO - PROCESS | 15371 | |i|pagename|runs| 02:20:03 INFO - PROCESS | 15371 | |0;dojo.html;3153.7161655451005;3193.0101668482766;3207.4707673233916;3229.3056992746556;3231.0791424444024;5368.543673787723;5372.865678358043;5378.973105134479;5379.462053794624;5426.565874730022;5343.599230057742;5406.053940560406;5450.31871016123;5458.317710286215;5560.944390556093;4845.563899249058;4911.45973942866;4965.528274813887;4986.401631804189;4986.700797952117;637.8481760538932;4954.603631709472;4966.25506174075;4989.675671081386;5020.97489512552;4895.926561101586;4925.187344088221;4929.334539837112;4933.087378834909;4959.900801983958;4793;5050.419201791804;5054.69671819692;5072.695638261716;5113.565346945514;4841.176999910023;4868.707877527324;4891.633127515451;4908.779104940286;4923.335349727777;5328.92006619901;5423.647462914898;5438.755256013489;5447.237386765816;5458.5087342139395;5838.795642152547;5862.237909071793;5863.9706801466145;5866.501347385477;5932.703364831741;5869.413058694139;5902.380250073767;5930.1994230779155;5930.851728706773;5960.850978725523;5476.4249753775675;5501.752421141058;5509.3664228613425;5517.310336207974;5518.613697041209;5877.676727779927;5943.762249509971;5982.341942386334;6007.939920600738;6027.36712645166;5802.158686990363;5808.448197421239;5810.41895810424;5810.709464526842;5812.331581868139;5870.853228669232;5872.265966754156;5875.941240587539;5886.941130588725;5899.056151015817;5739.626924249994;5849.2103566018895;5871.383504732027;5930.673812940244;5941.227640406806;5655.604107712503;5737.139429085587;5860.2381690380835;5860.8534786629825;5915.556333275022;4404.647628189801;4416;4425.269830477935;4435.689501734848;4455.420795296591;3912.941305880414;3923.3330333843314;3946.664533514626;3957.188776300909;3994.1013272014147;5543.972280138573;5549.833504994856;5552.305961754781;5553.500184983371;5554.527865131428;5787.681677507778;5895.20414744004;5907.822765317047;5914.766544601657;5950.107483877367;5404.513593776579;5440.972795135999;5513.7794488220825;5578.9163162552595;5586.860328491739;4921.827736029221;4959.801607935714;4993.076280888047;5000.799968001239;5007.899842003139;5862.325832529314;6009.879802403927;6059.757609695563;6066.878662426815;6080.209572755513;5964.970175149009;5982.012967860254;5984.1921340618455;6001.219841420588;6004.309504407049;5994.88010239784;6011.0382338825575;6014.127951446928;6020.277566692025;6022;5551.750171242223;5655.3213614364895;5660.349059858005;5683.71581420919;5764.625299355528;5946.910796338145;5952.166696662557;5953.345132035559;5954.76180952757;6017.969910150421;5741.368449470471;5770.826875193751;5773.393793651774;5778.971105144447;5793.884122317614;5591.30108736408;5641.830745077655;5711.314642242957;5729.541636668973;5785.103308987113;5495.725213739217;5608.186812912187;5657.660540367591;5669.34802497718;5752.568557358131;5770.682612456188;5778.335491418541;5799.8550036249435;5805.796797112081;5809.390014048464;5580.832575022756;5620.297462817148;5664.0937450007805;5677.772889084556;5695.288088988877 02:20:03 INFO - PROCESS | 15371 | |1;ext.html;602.2381687165736;643.7875501084643;645.9793526228557;653.1215515132147;662.3542046504658;37565.43651845221;38413.807930960305;38471.61528384715;38535;38681.61318386819;41419;41960.370594441105;42154;42313.7884310578;42376.57623423765;8627.913720862789;8744.213020828125;8767.254783343424;8842.381033327669;8852.822943541158;8659.653613855438;8730.738077857675;8736.039035706068;8785.824283514326;8824.558772061404;9012.68455604054;9034.457932524037;9109.362344635878;9119.270458363348;9133.68032118876;8895.911040889605;8936.865947010767;8961.238294744955;8979.416337938013;9007.1893529582;8924.687635932776;9002.279817614575;9012;9024.097590240988;9029.277657787361;40739.38890916639;41413.1717365651;41544.37683434751;41569.79215103905;41637;3481.9477707834403;3562.6615471530163;3583.5341405617105;4059.6143366380147;4270.444842170498;28581.428371432663;29041.128766137048;29090.272743181376;29336;29791.702082979325;4145.191687620915;4146.336586146233;4170.249355116078;4180.644645205161;4267.274563324242;209291;210041;211437.99999999846;211744;212317;35927.4610880837;36756.81621591875;36803.26393472116;53922;58532.70733646305;33881.32237355239;34159;34198.48702269468;34263;34425.827870860485;15096.924515377572;15169.924150379178;15218.086914785148;15367.692646147238;15368.231588420535;12592.4333404997;12635.620931372074;12703.555375561811;12733.36333183337;12791.36043197855;8632;8637.568121593895;8676.739697809076;8718.346124040723;8736.606852691644;3258.6904244096772;3343.38147442719;3372.2581032172884;3375.071855239829;3384.8984530464127;1073.6939972108069;1147.5735879077267;1154.8498695169742;1162.959296424638;1280.8783165599252;31055.534166987512;31997.360052798813;32030.19924501906;32313.35373292521;32828.67171328304;1163.9010684091777;1167.2821214952744;1186.6677330347516;1197.455157903152;1235.6663700800734;16603.252853621616;16719.83280167207;16961.321547137977;17246.310147593955;17376;451630;459595;460451;462080;463449;57195.14207286894;57919.420805792244;58151;58312;58334.708326458094;1356.1891086048236;1374.3677908162358;1400.8108905297859;1413.5829930170623;1420.6377373769828;30138.54792178075;30259.858331751682;30536.236594085327;31245.375092498478;31581.684183157875;49621.25568116553;49889.75055124701;50221.74889125531;50263;50391.748041261024;429155;432023;433114;435184;436796;28400;28554.714452855205;28871.711282886903;29063.709362906946;29088.272793179494;48036;48457.75771121122;48457.75771121263;48585.757071214415;48632.270515943;40088;40118.1976360477;40614.1877162461;41922.161556768086;41961;40295.39556906708;41032;41209.1758164829;41563.7921810389;42212.577874220864;38182.23635527329;40893.59106408898;41095.589044109176;41327;41956;35803.462948055276;36842.44736328904;36959.260814784095;37446.43830342602;37581;27423.725762742117;27929.581056283765;28200;28209.57685634676;28329.433411331247 02:20:03 INFO - PROCESS | 15371 | |2;jquery.html;386.84912883975255;389.9707521935854;394.6172212953435;395.63996762945726;400.1237290334168;14600;17583.73624395635;17738.290468381267;18333;18374.540636484093;18204.544886377815;18618.216686476822;18801.247950082015;19416.902915485403;19596.31412900549;5561.4716601922955;5575.2473416088915;5705.343885453184;5731.197632331477;5737.110747834093;5685.829425117253;5703.828885133432;5730.083186690131;5732;5734.455226753452;5539.141433077859;5643.746031428595;5708.857278568027;5735.053716136853;5737.540996720252;5524.475174858382;5654.773809047633;5664.178694089354;5684.2326285951285;5694.971525142369;5113.1052065888325;5126.333576635051;5160.380754309469;5164.04465173944;5175.482451754832;21772.782272177235;22269.777302226932;22283.331500055025;22433;22661.43346416336;2148.7099241602496;2547.1721690450677;2667.99950018743;2683.0609286749677;2700.486907487571;9265.351425400224;9513.857292140623;9555.856662150074;9906.356086854403;9954.601815927354;1928.662484065283;1955.6088782243608;1974.4570243183095;2000.449876284019;2049.846261530376;72635.63682181555;83807.58096209541;84273;84353.57823210844;85909.57045214796;10712.303700259614;10826.67519974402;10836.403997780199;11004.669859904216;11101.222914396076;13938.512152074629;14156.716865662835;15178.924105379623;15392.153431561372;15408.152551609544;7509.324160825552;7511.699532018767;8132.75601731949;8136.982877140357;8329.875051874227;7731.5747633879555;8039.638216280281;8045;8148.388870834711;8176.5094094353335;4580.267157254823;4600.2869555218995;4654.604358629555;4682.016776476978;4706.623470122382;1907.8378337841439;1925.258775371492;1998.8900610466274;2006.2075480185244;2010.2160157538572;925.1118925831142;991.7718924647227;993.5677980078689;1023.534291897185;1131.9773604528027;17955.281788728567;18355.174017169258;18408.723869141973;19022.334218302294;19266.22935082581;988.7429268390126;1051.164324362134;1052.4106500359824;1059.9417032063157;1089.5478376473834;10243.180545556337;10684.946575267073;10785.191110666574;10787.514561844735;10794.028537431668;480238;490302;495356;496461;514613;91244;94939;95297.52351238199;97511.51244243734;97875.14873958897;1019.7807471393686;1026.958921643126;1039.7452624107143;1041.5417216424748;1056.5509658395151;16237.918810406345;16251.268692909083;16359.754603680716;16446.095464749553;16481.258343374815;30139.3972120552;35430.64569354377;36061.0984725384;36646.450303246005;36831.263374732895;48681;49379.259311111084;49718.50281497139;49936.25095623496;50260.49739502704;7529.698812047676;7592.468527203264;7623.123340815655;7654.885176722242;7703.845923081619;12350.814737779121;12499.187552809039;12547.623571292876;12561.371931403575;12578.937105314415;9097.681581144629;10710.625128120479;11278.09775217997;11340.09279257674;11444.599439019594;10926.289791163548;11220.270682405617;11244.66266012021;11263.380514071805;11344;10469.790604188025;11171.832422513506;11193.216474847008;11409.885901140882;11811.232269902428;7636.274553917369;7691.5769632670745;7703.576303303372;7978.361731061385;7988.512600365633;10956.34261944286;11304.604338848101;11328.093752499615;11541.249818761753;11558.133140014701 02:20:03 INFO - PROCESS | 15371 | |3;mootools.html;1534.9079055256682;1556.8520990505901;1709.4956987688631;1813.5738101546142;1828.8262615051574;7225.89161162583;7927.960360198205;8176.509409435431;8225.835483290331;8235.464694794835;8229.465084769501;8343.958280208606;8346.248837604615;8348.081711011784;8360.749177524684;2261.197274967388;2296.0586159674535;2302.2747834432184;2303.4817166137655;2303.6429353450158;2262.7624099469567;2272.8295377846644;2313.4332088638225;2323.767623237671;2325.616273314901;2240.7087078679747;2259.8531095478825;2276.35123989663;2280.6579013147993;2285.931422057333;2243.910243590271;2261.08426087434;2265.4223173090754;2269.035659844568;2270.3189043286948;2183.0285522942295;2186.9562608747738;2191.8684878907316;2192.75879653238;2199.3072182262536;8183.6726530938695;8184.263416292502;8261.421700480969;8263.917360826375;8286.378521610843;4899.853004409873;5020.322256495363;5038.773255203525;5039.546440820343;5042.344495215599;3122.7189552940117;3161.8577164027442;3238.206639373345;3244.1727359523406;3381.2392211752403;1108.1245815805585;1126.5324890170568;1127.7293449572126;1133.240728711765;1140.1050175612104;11136.944315278372;11148.108151347953;11209.271397359145;11238.269512481662;11302.886971130265;4279.122779830127;4331.45856767904;4456.9108617828115;4468.620167285817;4527.864164075083;9482.194013508792;9486.193673537826;9495.810083798424;9515.762105947406;9552.474613896164;5001.974990125099;5066.6453348266;5072.746362681925;5077.822276220315;5080.618953578496;4177.101923086551;4597.977010114928;4666.533346665306;4700.388949436551;4711.811527538928;3697.8335974881193;3770.6417890300377;3833.9808300958875;3858.286217049799;3875.9418608720894;1113.8551988241477;1117.446863802423;1121.43928035982;1122.0686829931137;1182.3142577305143;847.5804476784032;948.8861336639648;959.7600599850037;962.855571664242;967.4969016111583;5289.312389389432;5293.942403177755;5338.439463856239;5414.8104816332025;5490.91763623538;419.9160167966358;424.4969710892602;433.12508732361084;438.48478038304864;442.10253186032406;3889.8444062237195;3892.922141557153;3901.453796468497;3902.35611124167;3909.3745000799736;9582.90417095834;9892.901070989343;10002.849957250646;10075.647352342632;10131.442770647538;9954.950225248973;9971.703678521892;9983.600655973825;9994.500274986221;9999.25005624581;7464.402847772165;7666.540007599562;7685.462017658822;7693.923060769433;7779.066512018594;5525.475079867406;5652.717364131695;5695.088785794253;5728.1694154348215;5774.387700375505;8781.341399395198;8911.420757650732;8922.910770892207;9063.546822658709;9233.261339092722;8896.68861589867;9018.729438116867;9038.638454461749;9100.180983711498;9329.16037556623;6685;7047.577145371294;7174.748883789042;7197.244289349753;7349.713800085071;7755.844883102193;7878.645460954385;7882.921170788448;7908.4068694846965;7926.24700653437;7061.435085193069;7095.3968912643;7103.680334384861;7226.168990565942;7276.854462910818;7006.579605223703;7060.752873649398;7122.465815063787;7148.714051437884;7203.855922881408;6279.183706118175;6561.639109849004;6605.306442823435;6606.9008964866525;6636.634985075867;4788.353572267839;4857.489963553918;4858.125537403302;4901.068796928572;4977.253411988086;4790;4826.155422800925;4841.95158048415;4894.461609222912;4901.313816065683 02:20:03 INFO - PROCESS | 15371 | |4;prototype.html;322.29095988824577;327.89015679747297;328.4367310063244;334.8242172859249;342.8542869280555;6087.452129308362;6135.601185922923;6149.108379285001;6150.077488376745;6155.784547540837;5957.165996760446;6009.549283803722;6028.698565071751;6030.246219222598;6038.8490287742825;4341.739495630264;4441.400410944513;4542.477615074259;4578.221702310599;4593.425821772278;4576.290674945372;4581.656375771814;4596.103759766846;4607.917139472238;4608.631309495232;4542.727436353813;4571.291449825282;4586.394761833365;4589.5869371756535;4589.862304130881;4349.151915376503;4578.6264120763635;4593.80561054125;4596.931046034279;4610.769461526927;4040.1919616076607;4062.2890994076215;4068.16602596467;4072.3891416287793;4073.9592604074173;5853.356130825606;5856.941430585724;5869.706514674292;5879.67661778602;5892.351841297454;5057.721825299607;5290.285811415487;5295.205719142159;5312.681239125664;5312.867178320535;6308.495320374359;6330.905036424458;6338.809835704937;6343.492520598341;6359.904601430982;4343.370211319341;4431.578999994996;4435.645148388121;4441.489893436247;4532.909341813178;6611.074449577015;6612.43794277487;6629.436497897685;6646.302138275508;6657.1012913257055;4623.791929363187;4644.2801365788355;4645.233536466445;4651.953480465219;4656.4877863434995;4558.954410455919;4672.112298663243;4683.250679891201;4714.764261786897;4718.787654555554;5317.229001794718;5362.624616276823;5376.650517716336;5382.138857782736;5386.111291636915;6239.313675495692;6316.968415157987;6353.682315884187;6370.171877655967;6393.744250230032;1571.6228105254656;1628.5602887220384;1631.3800755712991;1639.3934244329675;1639.9344026239055;1017.872765904262;1024.4621573673733;1082.410086502858;1126.4818183635455;1132.1508868348737;5999.700014999233;6032.6983650818165;6043.425874541911;6057.485113765291;6075.969620151871;6314.652694101776;6442.162518872517;6481.513886458534;6504.544681872224;6524.510661700391;5973.253343332083;6017.939820601826;6058.363871793486;6067.180930574405;6096.62825864177;3483.1640406302813;3485.337785820686;3494.7553671242767;3500.0199944015717;3506.7194624429985;6556.704948277339;6709.228438729609;6715.496337774686;6722.966385168141;6740;6576.210854697371;6607.603543787388;6640.800775976729;6650.401463868178;6676.132102826698;6592.8351791205605;6747.527673062838;6763.985402189711;6783.762568310085;6789.898151527731;6498.480121590167;6529.4776417885505;6537.7058032389605;6542.640154791532;6569.835754106186;6251.9687401562705;6397.136386587751;6415.101885735908;6436.0989461476365;6459.128017717736;6608.669566521558;6732.831679208059;6754.932450675627;6766.898496522655;6772.221194562689;4591.2194926863185;4612.238980568303;4648.2562789953445;4667.743274119956;4668.159731248408;6400.903986440114;6494.369780239011;6513.2835388108215;6518.57629254097;6549.770758023446;6325.841853953688;6326.6520341381665;6349.142865713255;6350.841228969312;6388.712507937061;6058.969705151446;6329.810105696836;6367.968160159169;6377.341891108253;6380.617162970051;6090.847728806815;6092.573519853568;6378.521610879296;6384.712687929147;6400.135981642605;6406.839829004126;6455.806325810233;6535.183102112236;6545.607263564201;6564.081028656087;6172.518595537129;6312.715927783169;6371.39471750183;6380.202474690664;6395.136656551306 02:20:03 INFO - PROCESS | 15371 | |5;yui.html;766.1266156581502;770.4876257288903;839.7228914458229;851.8040850604357;878.0166213840499;13094.541691040815;13343.266120363376;13365.131266467684;13380.933095334522;13389.732205355911;14686.63283417915;15104.924475377607;15153.166575838324;15179.316930738143;15244.466443674473;707.8478127202651;837.7528629054443;848.5290663681669;856.6230858422306;856.8971723393171;837.2422957223691;838.9790255243637;840.920112589303;849.307814131484;856.3962406503431;860.0410542245382;871.1245198575423;871.4727589808169;873.8514452543083;875.9036505984336;865.9480431174118;867.652938824469;867.6919693508809;871.2855458524012;871.8517851965149;641.8780431717959;642.5791106825037;643.9098526206288;645.399778206268;646.4053071174484;13188.208707477486;13323.666908327272;13375.799363009563;13386.531471398454;13387.062905596613;14362.425502979868;14434.783478247835;14472.565823025327;14561.344739486643;14617.415303387852;11633.6509904703;11945.28328300296;12000.09999250051;12008.519659213622;12050.698732531757;3910.198409326081;3938.330483817758;3939.6709780235656;3969.6030396960073;4025.376066709665;57220.427795721924;57842.42157578412;58720.70639646774;58946.70526647382;59001;11171.66485005451;11257.605983790529;11438.370889600985;11507.309561426342;11741.589044383576;19847.900760496104;20518.58962820735;20520.973951302374;20525.17899284012;20534.486637834172;8767;8820.2061814437;8835.514046727492;8962;9109.043550427243;4627.8843028923875;4780.211265141283;4841.394825646794;4865.026994601094;4893.73084480357;3449.379111759857;3538.9646103538635;3559.911002224965;3561.7684850484634;3564.7504674672523;622.7296315516296;629.4586655476287;632.7121159872247;647.2297965421134;648.9026646003043;719.7408932784193;742.5173637135797;764.8929149919015;770.2374649097353;783.7962129846167;9399.953000234955;9625.56684949179;9751.268654850914;9753.390690536124;9813.546613346663;733.6258508160877;737.6606760889944;746.2313816768736;752.7365422102221;754.8075240813557;4395.53846846083;4591.747453890068;4593.563611456906;4610.538946105363;4662.277347011219;61537.38462615406;62578.687106564175;62743.372566274666;63172.36827631757;63544.68227658924;50086.248706269434;55406.445935540934;55981.160282595796;57422.425775742544;57680.71159644259;41198.55805046869;47654.28518572224;49538;50669;51120.488795111574;9192.678256260999;9472.479013654316;9491.346884828818;9710.223182145553;9816.38979413391;33818.3236335267;33983;33996.150096246805;34251.314973700886;35324.47013294854;43733.34399983939;47959;48166.51833481761;48695;48790.75604621954;12051.638450846489;12107.334096624418;12192.51229950792;12206.694832629255;12710.809337860124;13271.601851944457;13401.597952061455;13471.207665307038;13824.792628110788;14021.3690383935;13252;13291.268980206181;13300.800487992881;13373.598792035866;13957.162570245819;12425.130240883413;12765.659605741263;12795.61613151607;12917.35413229316;12989.545365912525;13153.868461315264;13173.670658233237;13207.801882971955;13253;13729;10736.301796526424;10804.729881753019;10966.506507207354;11020.118390528578;11037.172212083966;10965.835512467478;11116.777664446505;11215.214934954474;11339.773204536028;11393.601223957121 02:20:03 INFO - PROCESS | 15371 | __end_tp_report 02:20:03 INFO - PROCESS | 15371 | __start_cc_report 02:20:03 INFO - PROCESS | 15371 | _x_x_mozilla_cycle_collect,341 02:20:03 INFO - PROCESS | 15371 | __end_cc_report 02:20:03 INFO - PROCESS | 15371 | __startTimestamp1461576003526__endTimestamp 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | ------- Summary: start ------- 02:20:03 INFO - PROCESS | 15371 | Number of tests: 6 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | [#0] dojo.html Cycles:165 Average:5407.43 Median:5655.60 stddev:731.08 (12.9%) stddev-sans-first:711.63 02:20:03 INFO - PROCESS | 15371 | Values: 3153.7 3193.0 3207.5 3229.3 3231.1 5368.5 5372.9 5379.0 5379.5 5426.6 5343.6 5406.1 5450.3 5458.3 5560.9 4845.6 4911.5 4965.5 4986.4 4986.7 637.8 4954.6 4966.3 4989.7 5021.0 4895.9 4925.2 4929.3 4933.1 4959.9 4793.0 5050.4 5054.7 5072.7 5113.6 4841.2 4868.7 4891.6 4908.8 4923.3 5328.9 5423.6 5438.8 5447.2 5458.5 5838.8 5862.2 5864.0 5866.5 5932.7 5869.4 5902.4 5930.2 5930.9 5960.9 5476.4 5501.8 5509.4 5517.3 5518.6 5877.7 5943.8 5982.3 6007.9 6027.4 5802.2 5808.4 5810.4 5810.7 5812.3 5870.9 5872.3 5875.9 5886.9 5899.1 5739.6 5849.2 5871.4 5930.7 5941.2 5655.6 5737.1 5860.2 5860.9 5915.6 4404.6 4416.0 4425.3 4435.7 4455.4 3912.9 3923.3 3946.7 3957.2 3994.1 5544.0 5549.8 5552.3 5553.5 5554.5 5787.7 5895.2 5907.8 5914.8 5950.1 5404.5 5441.0 5513.8 5578.9 5586.9 4921.8 4959.8 4993.1 5000.8 5007.9 5862.3 6009.9 6059.8 6066.9 6080.2 5965.0 5982.0 5984.2 6001.2 6004.3 5994.9 6011.0 6014.1 6020.3 6022.0 5551.8 5655.3 5660.3 5683.7 5764.6 5946.9 5952.2 5953.3 5954.8 6018.0 5741.4 5770.8 5773.4 5779.0 5793.9 5591.3 5641.8 5711.3 5729.5 5785.1 5495.7 5608.2 5657.7 5669.3 5752.6 5770.7 5778.3 5799.9 5805.8 5809.4 5580.8 5620.3 5664.1 5677.8 5695.3 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | [#1] ext.html Cycles:180 Average:52304.05 Median:22336.90 stddev:102112.41 (457.1%) stddev-sans-first:102325.08 02:20:03 INFO - PROCESS | 15371 | Values: 602.2 643.8 646.0 653.1 662.4 37565.4 38413.8 38471.6 38535.0 38681.6 41419.0 41960.4 42154.0 42313.8 42376.6 8627.9 8744.2 8767.3 8842.4 8852.8 8659.7 8730.7 8736.0 8785.8 8824.6 9012.7 9034.5 9109.4 9119.3 9133.7 8895.9 8936.9 8961.2 8979.4 9007.2 8924.7 9002.3 9012.0 9024.1 9029.3 40739.4 41413.2 41544.4 41569.8 41637.0 3481.9 3562.7 3583.5 4059.6 4270.4 28581.4 29041.1 29090.3 29336.0 29791.7 4145.2 4146.3 4170.2 4180.6 4267.3 209291.0 210041.0 211438.0 211744.0 212317.0 35927.5 36756.8 36803.3 53922.0 58532.7 33881.3 34159.0 34198.5 34263.0 34425.8 15096.9 15169.9 15218.1 15367.7 15368.2 12592.4 12635.6 12703.6 12733.4 12791.4 8632.0 8637.6 8676.7 8718.3 8736.6 3258.7 3343.4 3372.3 3375.1 3384.9 1073.7 1147.6 1154.8 1163.0 1280.9 31055.5 31997.4 32030.2 32313.4 32828.7 1163.9 1167.3 1186.7 1197.5 1235.7 16603.3 16719.8 16961.3 17246.3 17376.0 451630.0 459595.0 460451.0 462080.0 463449.0 57195.1 57919.4 58151.0 58312.0 58334.7 1356.2 1374.4 1400.8 1413.6 1420.6 30138.5 30259.9 30536.2 31245.4 31581.7 49621.3 49889.8 50221.7 50263.0 50391.7 429155.0 432023.0 433114.0 435184.0 436796.0 28400.0 28554.7 28871.7 29063.7 29088.3 48036.0 48457.8 48457.8 48585.8 48632.3 40088.0 40118.2 40614.2 41922.2 41961.0 40295.4 41032.0 41209.2 41563.8 42212.6 38182.2 40893.6 41095.6 41327.0 41956.0 35803.5 36842.4 36959.3 37446.4 37581.0 27423.7 27929.6 28200.0 28209.6 28329.4 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | [#2] jquery.html Cycles:180 Average:28554.70 Median:32785.02 stddev:81735.96 (249.3%) stddev-sans-first:81937.89 02:20:03 INFO - PROCESS | 15371 | Values: 386.8 390.0 394.6 395.6 400.1 14600.0 17583.7 17738.3 18333.0 18374.5 18204.5 18618.2 18801.2 19416.9 19596.3 5561.5 5575.2 5705.3 5731.2 5737.1 5685.8 5703.8 5730.1 5732.0 5734.5 5539.1 5643.7 5708.9 5735.1 5737.5 5524.5 5654.8 5664.2 5684.2 5695.0 5113.1 5126.3 5160.4 5164.0 5175.5 21772.8 22269.8 22283.3 22433.0 22661.4 2148.7 2547.2 2668.0 2683.1 2700.5 9265.4 9513.9 9555.9 9906.4 9954.6 1928.7 1955.6 1974.5 2000.4 2049.8 72635.6 83807.6 84273.0 84353.6 85909.6 10712.3 10826.7 10836.4 11004.7 11101.2 13938.5 14156.7 15178.9 15392.2 15408.2 7509.3 7511.7 8132.8 8137.0 8329.9 7731.6 8039.6 8045.0 8148.4 8176.5 4580.3 4600.3 4654.6 4682.0 4706.6 1907.8 1925.3 1998.9 2006.2 2010.2 925.1 991.8 993.6 1023.5 1132.0 17955.3 18355.2 18408.7 19022.3 19266.2 988.7 1051.2 1052.4 1059.9 1089.5 10243.2 10684.9 10785.2 10787.5 10794.0 480238.0 490302.0 495356.0 496461.0 514613.0 91244.0 94939.0 95297.5 97511.5 97875.1 1019.8 1027.0 1039.7 1041.5 1056.6 16237.9 16251.3 16359.8 16446.1 16481.3 30139.4 35430.6 36061.1 36646.5 36831.3 48681.0 49379.3 49718.5 49936.3 50260.5 7529.7 7592.5 7623.1 7654.9 7703.8 12350.8 12499.2 12547.6 12561.4 12578.9 9097.7 10710.6 11278.1 11340.1 11444.6 10926.3 11220.3 11244.7 11263.4 11344.0 10469.8 11171.8 11193.2 11409.9 11811.2 7636.3 7691.6 7703.6 7978.4 7988.5 10956.3 11304.6 11328.1 11541.2 11558.1 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | [#3] mootools.html Cycles:180 Average:5389.32 Median:5029.55 stddev:2987.78 (59.4%) stddev-sans-first:2982.12 02:20:03 INFO - PROCESS | 15371 | Values: 1534.9 1556.9 1709.5 1813.6 1828.8 7225.9 7928.0 8176.5 8225.8 8235.5 8229.5 8344.0 8346.2 8348.1 8360.7 2261.2 2296.1 2302.3 2303.5 2303.6 2262.8 2272.8 2313.4 2323.8 2325.6 2240.7 2259.9 2276.4 2280.7 2285.9 2243.9 2261.1 2265.4 2269.0 2270.3 2183.0 2187.0 2191.9 2192.8 2199.3 8183.7 8184.3 8261.4 8263.9 8286.4 4899.9 5020.3 5038.8 5039.5 5042.3 3122.7 3161.9 3238.2 3244.2 3381.2 1108.1 1126.5 1127.7 1133.2 1140.1 11136.9 11148.1 11209.3 11238.3 11302.9 4279.1 4331.5 4456.9 4468.6 4527.9 9482.2 9486.2 9495.8 9515.8 9552.5 5002.0 5066.6 5072.7 5077.8 5080.6 4177.1 4598.0 4666.5 4700.4 4711.8 3697.8 3770.6 3834.0 3858.3 3875.9 1113.9 1117.4 1121.4 1122.1 1182.3 847.6 948.9 959.8 962.9 967.5 5289.3 5293.9 5338.4 5414.8 5490.9 419.9 424.5 433.1 438.5 442.1 3889.8 3892.9 3901.5 3902.4 3909.4 9582.9 9892.9 10002.8 10075.6 10131.4 9955.0 9971.7 9983.6 9994.5 9999.3 7464.4 7666.5 7685.5 7693.9 7779.1 5525.5 5652.7 5695.1 5728.2 5774.4 8781.3 8911.4 8922.9 9063.5 9233.3 8896.7 9018.7 9038.6 9100.2 9329.2 6685.0 7047.6 7174.7 7197.2 7349.7 7755.8 7878.6 7882.9 7908.4 7926.2 7061.4 7095.4 7103.7 7226.2 7276.9 7006.6 7060.8 7122.5 7148.7 7203.9 6279.2 6561.6 6605.3 6606.9 6636.6 4788.4 4857.5 4858.1 4901.1 4977.3 4790.0 4826.2 4842.0 4894.5 4901.3 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | [#4] prototype.html Cycles:180 Average:5322.85 Median:6057.92 stddev:1590.51 (26.3%) stddev-sans-first:1550.05 02:20:03 INFO - PROCESS | 15371 | Values: 322.3 327.9 328.4 334.8 342.9 6087.5 6135.6 6149.1 6150.1 6155.8 5957.2 6009.5 6028.7 6030.2 6038.8 4341.7 4441.4 4542.5 4578.2 4593.4 4576.3 4581.7 4596.1 4607.9 4608.6 4542.7 4571.3 4586.4 4589.6 4589.9 4349.2 4578.6 4593.8 4596.9 4610.8 4040.2 4062.3 4068.2 4072.4 4074.0 5853.4 5856.9 5869.7 5879.7 5892.4 5057.7 5290.3 5295.2 5312.7 5312.9 6308.5 6330.9 6338.8 6343.5 6359.9 4343.4 4431.6 4435.6 4441.5 4532.9 6611.1 6612.4 6629.4 6646.3 6657.1 4623.8 4644.3 4645.2 4652.0 4656.5 4559.0 4672.1 4683.3 4714.8 4718.8 5317.2 5362.6 5376.7 5382.1 5386.1 6239.3 6317.0 6353.7 6370.2 6393.7 1571.6 1628.6 1631.4 1639.4 1639.9 1017.9 1024.5 1082.4 1126.5 1132.2 5999.7 6032.7 6043.4 6057.5 6076.0 6314.7 6442.2 6481.5 6504.5 6524.5 5973.3 6017.9 6058.4 6067.2 6096.6 3483.2 3485.3 3494.8 3500.0 3506.7 6556.7 6709.2 6715.5 6723.0 6740.0 6576.2 6607.6 6640.8 6650.4 6676.1 6592.8 6747.5 6764.0 6783.8 6789.9 6498.5 6529.5 6537.7 6542.6 6569.8 6252.0 6397.1 6415.1 6436.1 6459.1 6608.7 6732.8 6754.9 6766.9 6772.2 4591.2 4612.2 4648.3 4667.7 4668.2 6400.9 6494.4 6513.3 6518.6 6549.8 6325.8 6326.7 6349.1 6350.8 6388.7 6059.0 6329.8 6368.0 6377.3 6380.6 6090.8 6092.6 6378.5 6384.7 6400.1 6406.8 6455.8 6535.2 6545.6 6564.1 6172.5 6312.7 6371.4 6380.2 6395.1 02:20:03 INFO - PROCESS | 15371 | 02:20:03 INFO - PROCESS | 15371 | [#5] yui.html Cycles:180 Average:15154.77 Median:4619.21 stddev:17379.58 (376.2%) stddev-sans-first:17394.74 02:20:03 INFO - PROCESS | 15371 | Values: 766.1 770.5 839.7 851.8 878.0 13094.5 13343.3 13365.1 13380.9 13389.7 14686.6 15104.9 15153.2 15179.3 15244.5 707.8 837.8 848.5 856.6 856.9 837.2 839.0 840.9 849.3 856.4 860.0 871.1 871.5 873.9 875.9 865.9 867.7 867.7 871.3 871.9 641.9 642.6 643.9 645.4 646.4 13188.2 13323.7 13375.8 13386.5 13387.1 14362.4 14434.8 14472.6 14561.3 14617.4 11633.7 11945.3 12000.1 12008.5 12050.7 3910.2 3938.3 3939.7 3969.6 4025.4 57220.4 57842.4 58720.7 58946.7 59001.0 11171.7 11257.6 11438.4 11507.3 11741.6 19847.9 20518.6 20521.0 20525.2 20534.5 8767.0 8820.2 8835.5 8962.0 9109.0 4627.9 4780.2 4841.4 4865.0 4893.7 3449.4 3539.0 3559.9 3561.8 3564.8 622.7 629.5 632.7 647.2 648.9 719.7 742.5 764.9 770.2 783.8 9400.0 9625.6 9751.3 9753.4 9813.5 733.6 737.7 746.2 752.7 754.8 4395.5 4591.7 4593.6 4610.5 4662.3 61537.4 62578.7 62743.4 63172.4 63544.7 50086.2 55406.4 55981.2 57422.4 57680.7 41198.6 47654.3 49538.0 50669.0 51120.5 9192.7 9472.5 9491.3 9710.2 9816.4 33818.3 33983.0 33996.2 34251.3 35324.5 43733.3 47959.0 48166.5 48695.0 48790.8 12051.6 12107.3 12192.5 12206.7 12710.8 13271.6 13401.6 13471.2 13824.8 14021.4 13252.0 13291.3 13300.8 13373.6 13957.2 12425.1 12765.7 12795.6 12917.4 12989.5 13153.9 13173.7 13207.8 13253.0 13729.0 10736.3 10804.7 10966.5 11020.1 11037.2 10965.8 11116.8 11215.2 11339.8 11393.6 02:20:03 INFO - PROCESS | 15371 | -------- Summary: end -------- 02:20:03 INFO - PROCESS | 15371 | 02:20:04 INFO - TEST-INFO | 15371: exit 0 02:20:04 INFO - TEST-OK | dromaeo_css | took 1109127ms 02:20:04 INFO - TEST-START | kraken 02:20:04 INFO - operating with platform_type : linux_ 02:20:04 INFO - Initialising browser for kraken test... 02:20:04 INFO - TEST-INFO | started process 15608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5LIhM/profile http://localhost:49476/getInfo.html) 02:20:07 INFO - PROCESS | 15608 | 02:20:07 INFO - PROCESS | 15608 | (process:15677): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:20:08 INFO - PROCESS | 15608 | __metrics Screen width/height:1600/1200 02:20:08 INFO - PROCESS | 15608 | colorDepth:24 02:20:08 INFO - PROCESS | 15608 | Browser inner width/height: 1024/697 02:20:08 INFO - PROCESS | 15608 | __metrics 02:20:09 ERROR - PROCESS | 15608 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:20:09 INFO - TEST-INFO | 15608: exit 0 02:20:09 INFO - Browser initialized. 02:20:09 INFO - Running cycle 1/1 for kraken test... 02:20:09 INFO - TEST-INFO | started process 15728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX5LIhM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:11 INFO - PROCESS | 15728 | 02:20:11 INFO - PROCESS | 15728 | (process:15788): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:20:21 INFO - PROCESS | 15728 | RSS: Main: 164179968 02:20:21 INFO - PROCESS | 15728 | 02:20:24 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49476/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:25 INFO - PROCESS | 15728 | RSS: Main: 168960000 02:20:25 INFO - PROCESS | 15728 | 02:20:27 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49476/tests/kraken/driver.html?testName=audio-dft) 02:20:28 INFO - PROCESS | 15728 | RSS: Main: 172621824 02:20:28 INFO - PROCESS | 15728 | 02:20:31 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49476/tests/kraken/driver.html?testName=audio-fft) 02:20:32 INFO - PROCESS | 15728 | RSS: Main: 164515840 02:20:32 INFO - PROCESS | 15728 | 02:20:34 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49476/tests/kraken/driver.html?testName=audio-oscillator) 02:20:34 INFO - PROCESS | 15728 | RSS: Main: 165445632 02:20:34 INFO - PROCESS | 15728 | 02:20:37 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:37 INFO - PROCESS | 15728 | RSS: Main: 165847040 02:20:37 INFO - PROCESS | 15728 | 02:20:40 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49476/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:41 INFO - PROCESS | 15728 | RSS: Main: 165728256 02:20:41 INFO - PROCESS | 15728 | 02:20:44 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49476/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:45 INFO - PROCESS | 15728 | RSS: Main: 163155968 02:20:45 INFO - PROCESS | 15728 | 02:20:48 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49476/tests/kraken/driver.html?testName=json-parse-financial) 02:20:48 INFO - PROCESS | 15728 | RSS: Main: 163831808 02:20:48 INFO - PROCESS | 15728 | 02:20:50 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:50 INFO - PROCESS | 15728 | RSS: Main: 164130816 02:20:50 INFO - PROCESS | 15728 | 02:20:52 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:53 INFO - PROCESS | 15728 | RSS: Main: 164020224 02:20:53 INFO - PROCESS | 15728 | 02:20:55 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:56 INFO - PROCESS | 15728 | RSS: Main: 165249024 02:20:56 INFO - PROCESS | 15728 | 02:20:58 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:20:59 INFO - PROCESS | 15728 | RSS: Main: 164814848 02:20:59 INFO - PROCESS | 15728 | 02:21:02 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:02 INFO - PROCESS | 15728 | RSS: Main: 164794368 02:21:02 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | Cycle 1(1): loaded http://localhost:49476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49476/tests/kraken/driver.html?testName=ai-astar) 02:21:04 INFO - PROCESS | 15728 | RSS: Main: 166662144 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | __start_tp_report 02:21:04 INFO - PROCESS | 15728 | _x_x_mozilla_page_load 02:21:04 INFO - PROCESS | 15728 | _x_x_mozilla_page_load_details 02:21:04 INFO - PROCESS | 15728 | |i|pagename|runs| 02:21:04 INFO - PROCESS | 15728 | |0;ai-astar;111;108;111;111;111;124;111;111;111;114 02:21:04 INFO - PROCESS | 15728 | |1;audio-beat-detection;157;137;165;182;129;167;154;131;190;133 02:21:04 INFO - PROCESS | 15728 | |2;audio-dft;162;164;162;164;165;170;169;162;166;164 02:21:04 INFO - PROCESS | 15728 | |3;audio-fft;73;74;75;164;77;73;73;73;162;76 02:21:04 INFO - PROCESS | 15728 | |4;audio-oscillator;94;94;158;92;93;94;152;93;92;156 02:21:04 INFO - PROCESS | 15728 | |5;imaging-gaussian-blur;118;117;119;117;117;117;117;118;118;118 02:21:04 INFO - PROCESS | 15728 | |6;imaging-darkroom;147;146;147;147;147;147;146;147;146;147 02:21:04 INFO - PROCESS | 15728 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;95;95 02:21:04 INFO - PROCESS | 15728 | |8;json-parse-financial;58;61;58;59;59;58;59;70;65;56 02:21:04 INFO - PROCESS | 15728 | |9;json-stringify-tinderbox;61;62;62;62;61;60;60;61;62;61 02:21:04 INFO - PROCESS | 15728 | |10;stanford-crypto-aes;77;85;77;77;78;79;80;77;79;78 02:21:04 INFO - PROCESS | 15728 | |11;stanford-crypto-ccm;134;124;135;125;129;130;133;129;163;128 02:21:04 INFO - PROCESS | 15728 | |12;stanford-crypto-pbkdf2;168;173;173;172;166;174;171;166;168;169 02:21:04 INFO - PROCESS | 15728 | |13;stanford-crypto-sha256-iterative;70;68;68;68;66;67;69;69;66;67 02:21:04 INFO - PROCESS | 15728 | __end_tp_report 02:21:04 INFO - PROCESS | 15728 | __start_cc_report 02:21:04 INFO - PROCESS | 15728 | _x_x_mozilla_cycle_collect,840 02:21:04 INFO - PROCESS | 15728 | __end_cc_report 02:21:04 INFO - PROCESS | 15728 | __startTimestamp1461576064731__endTimestamp 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | ------- Summary: start ------- 02:21:04 INFO - PROCESS | 15728 | Number of tests: 14 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:4.35 (3.9%) stddev-sans-first:4.59 02:21:04 INFO - PROCESS | 15728 | Values: 111.0 108.0 111.0 111.0 111.0 124.0 111.0 111.0 111.0 114.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:161.00 stddev:21.76 (13.5%) stddev-sans-first:23.06 02:21:04 INFO - PROCESS | 15728 | Values: 157.0 137.0 165.0 182.0 129.0 167.0 154.0 131.0 190.0 133.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.82 (1.7%) stddev-sans-first:2.80 02:21:04 INFO - PROCESS | 15728 | Values: 162.0 164.0 162.0 164.0 165.0 170.0 169.0 162.0 166.0 164.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#3] audio-fft Cycles:10 Average:92.00 Median:73.50 stddev:37.45 (51.0%) stddev-sans-first:39.08 02:21:04 INFO - PROCESS | 15728 | Values: 73.0 74.0 75.0 164.0 77.0 73.0 73.0 73.0 162.0 76.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:93.00 stddev:30.08 (32.3%) stddev-sans-first:31.21 02:21:04 INFO - PROCESS | 15728 | Values: 94.0 94.0 158.0 92.0 93.0 94.0 152.0 93.0 92.0 156.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:21:04 INFO - PROCESS | 15728 | Values: 118.0 117.0 119.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:21:04 INFO - PROCESS | 15728 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:21:04 INFO - PROCESS | 15728 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.00 stddev:4.16 (7.1%) stddev-sans-first:4.33 02:21:04 INFO - PROCESS | 15728 | Values: 58.0 61.0 58.0 59.0 59.0 58.0 59.0 70.0 65.0 56.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 02:21:04 INFO - PROCESS | 15728 | Values: 61.0 62.0 62.0 62.0 61.0 60.0 60.0 61.0 62.0 61.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:2.45 (3.1%) stddev-sans-first:2.52 02:21:04 INFO - PROCESS | 15728 | Values: 77.0 85.0 77.0 77.0 78.0 79.0 80.0 77.0 79.0 78.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:131.50 stddev:11.14 (8.5%) stddev-sans-first:11.81 02:21:04 INFO - PROCESS | 15728 | Values: 134.0 124.0 135.0 125.0 129.0 130.0 133.0 129.0 163.0 128.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.50 stddev:2.98 (1.7%) stddev-sans-first:3.07 02:21:04 INFO - PROCESS | 15728 | Values: 168.0 173.0 173.0 172.0 166.0 174.0 171.0 166.0 168.0 169.0 02:21:04 INFO - PROCESS | 15728 | 02:21:04 INFO - PROCESS | 15728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.32 (1.9%) stddev-sans-first:1.13 02:21:04 INFO - PROCESS | 15728 | Values: 70.0 68.0 68.0 68.0 66.0 67.0 69.0 69.0 66.0 67.0 02:21:04 INFO - PROCESS | 15728 | -------- Summary: end -------- 02:21:04 INFO - PROCESS | 15728 | 02:21:05 INFO - TEST-INFO | 15728: exit 0 02:21:05 INFO - TEST-OK | kraken | took 61464ms 02:21:05 INFO - SUITE-END | took 1170s 02:21:05 INFO - Completed test suite (00:19:30) 02:21:05 INFO - javascript benchmark 02:21:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.7161655451005, 3193.0101668482766, 3207.4707673233916, 3229.3056992746556, 3231.0791424444024, 5368.543673787723, 5372.865678358043, 5378.973105134479, 5379.462053794624, 5426.565874730022, 5343.599230057742, 5406.053940560406, 5450.31871016123, 5458.317710286215, 5560.944390556093, 4845.563899249058, 4911.45973942866, 4965.528274813887, 4986.401631804189, 4986.700797952117, 637.8481760538932, 4954.603631709472, 4966.25506174075, 4989.675671081386, 5020.97489512552, 4895.926561101586, 4925.187344088221, 4929.334539837112, 4933.087378834909, 4959.900801983958, 4793.0, 5050.419201791804, 5054.69671819692, 5072.695638261716, 5113.565346945514, 4841.176999910023, 4868.707877527324, 4891.633127515451, 4908.779104940286, 4923.335349727777, 5328.92006619901, 5423.647462914898, 5438.755256013489, 5447.237386765816, 5458.5087342139395, 5838.795642152547, 5862.237909071793, 5863.9706801466145, 5866.501347385477, 5932.703364831741, 5869.413058694139, 5902.380250073767, 5930.1994230779155, 5930.851728706773, 5960.850978725523, 5476.4249753775675, 5501.752421141058, 5509.3664228613425, 5517.310336207974, 5518.613697041209, 5877.676727779927, 5943.762249509971, 5982.341942386334, 6007.939920600738, 6027.36712645166, 5802.158686990363, 5808.448197421239, 5810.41895810424, 5810.709464526842, 5812.331581868139, 5870.853228669232, 5872.265966754156, 5875.941240587539, 5886.941130588725, 5899.056151015817, 5739.626924249994, 5849.2103566018895, 5871.383504732027, 5930.673812940244, 5941.227640406806, 5655.604107712503, 5737.139429085587, 5860.2381690380835, 5860.8534786629825, 5915.556333275022, 4404.647628189801, 4416.0, 4425.269830477935, 4435.689501734848, 4455.420795296591, 3912.941305880414, 3923.3330333843314, 3946.664533514626, 3957.188776300909, 3994.1013272014147, 5543.972280138573, 5549.833504994856, 5552.305961754781, 5553.500184983371, 5554.527865131428, 5787.681677507778, 5895.20414744004, 5907.822765317047, 5914.766544601657, 5950.107483877367, 5404.513593776579, 5440.972795135999, 5513.7794488220825, 5578.9163162552595, 5586.860328491739, 4921.827736029221, 4959.801607935714, 4993.076280888047, 5000.799968001239, 5007.899842003139, 5862.325832529314, 6009.879802403927, 6059.757609695563, 6066.878662426815, 6080.209572755513, 5964.970175149009, 5982.012967860254, 5984.1921340618455, 6001.219841420588, 6004.309504407049, 5994.88010239784, 6011.0382338825575, 6014.127951446928, 6020.277566692025, 6022.0, 5551.750171242223, 5655.3213614364895, 5660.349059858005, 5683.71581420919, 5764.625299355528, 5946.910796338145, 5952.166696662557, 5953.345132035559, 5954.76180952757, 6017.969910150421, 5741.368449470471, 5770.826875193751, 5773.393793651774, 5778.971105144447, 5793.884122317614, 5591.30108736408, 5641.830745077655, 5711.314642242957, 5729.541636668973, 5785.103308987113, 5495.725213739217, 5608.186812912187, 5657.660540367591, 5669.34802497718, 5752.568557358131, 5770.682612456188, 5778.335491418541, 5799.8550036249435, 5805.796797112081, 5809.390014048464, 5580.832575022756, 5620.297462817148, 5664.0937450007805, 5677.772889084556, 5695.288088988877], "value": 5359.601552057447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.2381687165736, 643.7875501084643, 645.9793526228557, 653.1215515132147, 662.3542046504658, 37565.43651845221, 38413.807930960305, 38471.61528384715, 38535.0, 38681.61318386819, 41419.0, 41960.370594441105, 42154.0, 42313.7884310578, 42376.57623423765, 8627.913720862789, 8744.213020828125, 8767.254783343424, 8842.381033327669, 8852.822943541158, 8659.653613855438, 8730.738077857675, 8736.039035706068, 8785.824283514326, 8824.558772061404, 9012.68455604054, 9034.457932524037, 9109.362344635878, 9119.270458363348, 9133.68032118876, 8895.911040889605, 8936.865947010767, 8961.238294744955, 8979.416337938013, 9007.1893529582, 8924.687635932776, 9002.279817614575, 9012.0, 9024.097590240988, 9029.277657787361, 40739.38890916639, 41413.1717365651, 41544.37683434751, 41569.79215103905, 41637.0, 3481.9477707834403, 3562.6615471530163, 3583.5341405617105, 4059.6143366380147, 4270.444842170498, 28581.428371432663, 29041.128766137048, 29090.272743181376, 29336.0, 29791.702082979325, 4145.191687620915, 4146.336586146233, 4170.249355116078, 4180.644645205161, 4267.274563324242, 209291.0, 210041.0, 211437.99999999846, 211744.0, 212317.0, 35927.4610880837, 36756.81621591875, 36803.26393472116, 53922.0, 58532.70733646305, 33881.32237355239, 34159.0, 34198.48702269468, 34263.0, 34425.827870860485, 15096.924515377572, 15169.924150379178, 15218.086914785148, 15367.692646147238, 15368.231588420535, 12592.4333404997, 12635.620931372074, 12703.555375561811, 12733.36333183337, 12791.36043197855, 8632.0, 8637.568121593895, 8676.739697809076, 8718.346124040723, 8736.606852691644, 3258.6904244096772, 3343.38147442719, 3372.2581032172884, 3375.071855239829, 3384.8984530464127, 1073.6939972108069, 1147.5735879077267, 1154.8498695169742, 1162.959296424638, 1280.8783165599252, 31055.534166987512, 31997.360052798813, 32030.19924501906, 32313.35373292521, 32828.67171328304, 1163.9010684091777, 1167.2821214952744, 1186.6677330347516, 1197.455157903152, 1235.6663700800734, 16603.252853621616, 16719.83280167207, 16961.321547137977, 17246.310147593955, 17376.0, 451630.0, 459595.0, 460451.0, 462080.0, 463449.0, 57195.14207286894, 57919.420805792244, 58151.0, 58312.0, 58334.708326458094, 1356.1891086048236, 1374.3677908162358, 1400.8108905297859, 1413.5829930170623, 1420.6377373769828, 30138.54792178075, 30259.858331751682, 30536.236594085327, 31245.375092498478, 31581.684183157875, 49621.25568116553, 49889.75055124701, 50221.74889125531, 50263.0, 50391.748041261024, 429155.0, 432023.0, 433114.0, 435184.0, 436796.0, 28400.0, 28554.714452855205, 28871.711282886903, 29063.709362906946, 29088.272793179494, 48036.0, 48457.75771121122, 48457.75771121263, 48585.757071214415, 48632.270515943, 40088.0, 40118.1976360477, 40614.1877162461, 41922.161556768086, 41961.0, 40295.39556906708, 41032.0, 41209.1758164829, 41563.7921810389, 42212.577874220864, 38182.23635527329, 40893.59106408898, 41095.589044109176, 41327.0, 41956.0, 35803.462948055276, 36842.44736328904, 36959.260814784095, 37446.43830342602, 37581.0, 27423.725762742117, 27929.581056283765, 28200.0, 28209.57685634676, 28329.433411331247], "value": 18443.126948175282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.84912883975255, 389.9707521935854, 394.6172212953435, 395.63996762945726, 400.1237290334168, 14600.0, 17583.73624395635, 17738.290468381267, 18333.0, 18374.540636484093, 18204.544886377815, 18618.216686476822, 18801.247950082015, 19416.902915485403, 19596.31412900549, 5561.4716601922955, 5575.2473416088915, 5705.343885453184, 5731.197632331477, 5737.110747834093, 5685.829425117253, 5703.828885133432, 5730.083186690131, 5732.0, 5734.455226753452, 5539.141433077859, 5643.746031428595, 5708.857278568027, 5735.053716136853, 5737.540996720252, 5524.475174858382, 5654.773809047633, 5664.178694089354, 5684.2326285951285, 5694.971525142369, 5113.1052065888325, 5126.333576635051, 5160.380754309469, 5164.04465173944, 5175.482451754832, 21772.782272177235, 22269.777302226932, 22283.331500055025, 22433.0, 22661.43346416336, 2148.7099241602496, 2547.1721690450677, 2667.99950018743, 2683.0609286749677, 2700.486907487571, 9265.351425400224, 9513.857292140623, 9555.856662150074, 9906.356086854403, 9954.601815927354, 1928.662484065283, 1955.6088782243608, 1974.4570243183095, 2000.449876284019, 2049.846261530376, 72635.63682181555, 83807.58096209541, 84273.0, 84353.57823210844, 85909.57045214796, 10712.303700259614, 10826.67519974402, 10836.403997780199, 11004.669859904216, 11101.222914396076, 13938.512152074629, 14156.716865662835, 15178.924105379623, 15392.153431561372, 15408.152551609544, 7509.324160825552, 7511.699532018767, 8132.75601731949, 8136.982877140357, 8329.875051874227, 7731.5747633879555, 8039.638216280281, 8045.0, 8148.388870834711, 8176.5094094353335, 4580.267157254823, 4600.2869555218995, 4654.604358629555, 4682.016776476978, 4706.623470122382, 1907.8378337841439, 1925.258775371492, 1998.8900610466274, 2006.2075480185244, 2010.2160157538572, 925.1118925831142, 991.7718924647227, 993.5677980078689, 1023.534291897185, 1131.9773604528027, 17955.281788728567, 18355.174017169258, 18408.723869141973, 19022.334218302294, 19266.22935082581, 988.7429268390126, 1051.164324362134, 1052.4106500359824, 1059.9417032063157, 1089.5478376473834, 10243.180545556337, 10684.946575267073, 10785.191110666574, 10787.514561844735, 10794.028537431668, 480238.0, 490302.0, 495356.0, 496461.0, 514613.0, 91244.0, 94939.0, 95297.52351238199, 97511.51244243734, 97875.14873958897, 1019.7807471393686, 1026.958921643126, 1039.7452624107143, 1041.5417216424748, 1056.5509658395151, 16237.918810406345, 16251.268692909083, 16359.754603680716, 16446.095464749553, 16481.258343374815, 30139.3972120552, 35430.64569354377, 36061.0984725384, 36646.450303246005, 36831.263374732895, 48681.0, 49379.259311111084, 49718.50281497139, 49936.25095623496, 50260.49739502704, 7529.698812047676, 7592.468527203264, 7623.123340815655, 7654.885176722242, 7703.845923081619, 12350.814737779121, 12499.187552809039, 12547.623571292876, 12561.371931403575, 12578.937105314415, 9097.681581144629, 10710.625128120479, 11278.09775217997, 11340.09279257674, 11444.599439019594, 10926.289791163548, 11220.270682405617, 11244.66266012021, 11263.380514071805, 11344.0, 10469.790604188025, 11171.832422513506, 11193.216474847008, 11409.885901140882, 11811.232269902428, 7636.274553917369, 7691.5769632670745, 7703.576303303372, 7978.361731061385, 7988.512600365633, 10956.34261944286, 11304.604338848101, 11328.093752499615, 11541.249818761753, 11558.133140014701], "value": 8962.622544584656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.9079055256682, 1556.8520990505901, 1709.4956987688631, 1813.5738101546142, 1828.8262615051574, 7225.89161162583, 7927.960360198205, 8176.509409435431, 8225.835483290331, 8235.464694794835, 8229.465084769501, 8343.958280208606, 8346.248837604615, 8348.081711011784, 8360.749177524684, 2261.197274967388, 2296.0586159674535, 2302.2747834432184, 2303.4817166137655, 2303.6429353450158, 2262.7624099469567, 2272.8295377846644, 2313.4332088638225, 2323.767623237671, 2325.616273314901, 2240.7087078679747, 2259.8531095478825, 2276.35123989663, 2280.6579013147993, 2285.931422057333, 2243.910243590271, 2261.08426087434, 2265.4223173090754, 2269.035659844568, 2270.3189043286948, 2183.0285522942295, 2186.9562608747738, 2191.8684878907316, 2192.75879653238, 2199.3072182262536, 8183.6726530938695, 8184.263416292502, 8261.421700480969, 8263.917360826375, 8286.378521610843, 4899.853004409873, 5020.322256495363, 5038.773255203525, 5039.546440820343, 5042.344495215599, 3122.7189552940117, 3161.8577164027442, 3238.206639373345, 3244.1727359523406, 3381.2392211752403, 1108.1245815805585, 1126.5324890170568, 1127.7293449572126, 1133.240728711765, 1140.1050175612104, 11136.944315278372, 11148.108151347953, 11209.271397359145, 11238.269512481662, 11302.886971130265, 4279.122779830127, 4331.45856767904, 4456.9108617828115, 4468.620167285817, 4527.864164075083, 9482.194013508792, 9486.193673537826, 9495.810083798424, 9515.762105947406, 9552.474613896164, 5001.974990125099, 5066.6453348266, 5072.746362681925, 5077.822276220315, 5080.618953578496, 4177.101923086551, 4597.977010114928, 4666.533346665306, 4700.388949436551, 4711.811527538928, 3697.8335974881193, 3770.6417890300377, 3833.9808300958875, 3858.286217049799, 3875.9418608720894, 1113.8551988241477, 1117.446863802423, 1121.43928035982, 1122.0686829931137, 1182.3142577305143, 847.5804476784032, 948.8861336639648, 959.7600599850037, 962.855571664242, 967.4969016111583, 5289.312389389432, 5293.942403177755, 5338.439463856239, 5414.8104816332025, 5490.91763623538, 419.9160167966358, 424.4969710892602, 433.12508732361084, 438.48478038304864, 442.10253186032406, 3889.8444062237195, 3892.922141557153, 3901.453796468497, 3902.35611124167, 3909.3745000799736, 9582.90417095834, 9892.901070989343, 10002.849957250646, 10075.647352342632, 10131.442770647538, 9954.950225248973, 9971.703678521892, 9983.600655973825, 9994.500274986221, 9999.25005624581, 7464.402847772165, 7666.540007599562, 7685.462017658822, 7693.923060769433, 7779.066512018594, 5525.475079867406, 5652.717364131695, 5695.088785794253, 5728.1694154348215, 5774.387700375505, 8781.341399395198, 8911.420757650732, 8922.910770892207, 9063.546822658709, 9233.261339092722, 8896.68861589867, 9018.729438116867, 9038.638454461749, 9100.180983711498, 9329.16037556623, 6685.0, 7047.577145371294, 7174.748883789042, 7197.244289349753, 7349.713800085071, 7755.844883102193, 7878.645460954385, 7882.921170788448, 7908.4068694846965, 7926.24700653437, 7061.435085193069, 7095.3968912643, 7103.680334384861, 7226.168990565942, 7276.854462910818, 7006.579605223703, 7060.752873649398, 7122.465815063787, 7148.714051437884, 7203.855922881408, 6279.183706118175, 6561.639109849004, 6605.306442823435, 6606.9008964866525, 6636.634985075867, 4788.353572267839, 4857.489963553918, 4858.125537403302, 4901.068796928572, 4977.253411988086, 4790.0, 4826.155422800925, 4841.95158048415, 4894.461609222912, 4901.313816065683], "value": 4294.900584101297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.29095988824577, 327.89015679747297, 328.4367310063244, 334.8242172859249, 342.8542869280555, 6087.452129308362, 6135.601185922923, 6149.108379285001, 6150.077488376745, 6155.784547540837, 5957.165996760446, 6009.549283803722, 6028.698565071751, 6030.246219222598, 6038.8490287742825, 4341.739495630264, 4441.400410944513, 4542.477615074259, 4578.221702310599, 4593.425821772278, 4576.290674945372, 4581.656375771814, 4596.103759766846, 4607.917139472238, 4608.631309495232, 4542.727436353813, 4571.291449825282, 4586.394761833365, 4589.5869371756535, 4589.862304130881, 4349.151915376503, 4578.6264120763635, 4593.80561054125, 4596.931046034279, 4610.769461526927, 4040.1919616076607, 4062.2890994076215, 4068.16602596467, 4072.3891416287793, 4073.9592604074173, 5853.356130825606, 5856.941430585724, 5869.706514674292, 5879.67661778602, 5892.351841297454, 5057.721825299607, 5290.285811415487, 5295.205719142159, 5312.681239125664, 5312.867178320535, 6308.495320374359, 6330.905036424458, 6338.809835704937, 6343.492520598341, 6359.904601430982, 4343.370211319341, 4431.578999994996, 4435.645148388121, 4441.489893436247, 4532.909341813178, 6611.074449577015, 6612.43794277487, 6629.436497897685, 6646.302138275508, 6657.1012913257055, 4623.791929363187, 4644.2801365788355, 4645.233536466445, 4651.953480465219, 4656.4877863434995, 4558.954410455919, 4672.112298663243, 4683.250679891201, 4714.764261786897, 4718.787654555554, 5317.229001794718, 5362.624616276823, 5376.650517716336, 5382.138857782736, 5386.111291636915, 6239.313675495692, 6316.968415157987, 6353.682315884187, 6370.171877655967, 6393.744250230032, 1571.6228105254656, 1628.5602887220384, 1631.3800755712991, 1639.3934244329675, 1639.9344026239055, 1017.872765904262, 1024.4621573673733, 1082.410086502858, 1126.4818183635455, 1132.1508868348737, 5999.700014999233, 6032.6983650818165, 6043.425874541911, 6057.485113765291, 6075.969620151871, 6314.652694101776, 6442.162518872517, 6481.513886458534, 6504.544681872224, 6524.510661700391, 5973.253343332083, 6017.939820601826, 6058.363871793486, 6067.180930574405, 6096.62825864177, 3483.1640406302813, 3485.337785820686, 3494.7553671242767, 3500.0199944015717, 3506.7194624429985, 6556.704948277339, 6709.228438729609, 6715.496337774686, 6722.966385168141, 6740.0, 6576.210854697371, 6607.603543787388, 6640.800775976729, 6650.401463868178, 6676.132102826698, 6592.8351791205605, 6747.527673062838, 6763.985402189711, 6783.762568310085, 6789.898151527731, 6498.480121590167, 6529.4776417885505, 6537.7058032389605, 6542.640154791532, 6569.835754106186, 6251.9687401562705, 6397.136386587751, 6415.101885735908, 6436.0989461476365, 6459.128017717736, 6608.669566521558, 6732.831679208059, 6754.932450675627, 6766.898496522655, 6772.221194562689, 4591.2194926863185, 4612.238980568303, 4648.2562789953445, 4667.743274119956, 4668.159731248408, 6400.903986440114, 6494.369780239011, 6513.2835388108215, 6518.57629254097, 6549.770758023446, 6325.841853953688, 6326.6520341381665, 6349.142865713255, 6350.841228969312, 6388.712507937061, 6058.969705151446, 6329.810105696836, 6367.968160159169, 6377.341891108253, 6380.617162970051, 6090.847728806815, 6092.573519853568, 6378.521610879296, 6384.712687929147, 6400.135981642605, 6406.839829004126, 6455.806325810233, 6535.183102112236, 6545.607263564201, 6564.081028656087, 6172.518595537129, 6312.715927783169, 6371.39471750183, 6380.202474690664, 6395.136656551306], "value": 4802.281935391933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.1266156581502, 770.4876257288903, 839.7228914458229, 851.8040850604357, 878.0166213840499, 13094.541691040815, 13343.266120363376, 13365.131266467684, 13380.933095334522, 13389.732205355911, 14686.63283417915, 15104.924475377607, 15153.166575838324, 15179.316930738143, 15244.466443674473, 707.8478127202651, 837.7528629054443, 848.5290663681669, 856.6230858422306, 856.8971723393171, 837.2422957223691, 838.9790255243637, 840.920112589303, 849.307814131484, 856.3962406503431, 860.0410542245382, 871.1245198575423, 871.4727589808169, 873.8514452543083, 875.9036505984336, 865.9480431174118, 867.652938824469, 867.6919693508809, 871.2855458524012, 871.8517851965149, 641.8780431717959, 642.5791106825037, 643.9098526206288, 645.399778206268, 646.4053071174484, 13188.208707477486, 13323.666908327272, 13375.799363009563, 13386.531471398454, 13387.062905596613, 14362.425502979868, 14434.783478247835, 14472.565823025327, 14561.344739486643, 14617.415303387852, 11633.6509904703, 11945.28328300296, 12000.09999250051, 12008.519659213622, 12050.698732531757, 3910.198409326081, 3938.330483817758, 3939.6709780235656, 3969.6030396960073, 4025.376066709665, 57220.427795721924, 57842.42157578412, 58720.70639646774, 58946.70526647382, 59001.0, 11171.66485005451, 11257.605983790529, 11438.370889600985, 11507.309561426342, 11741.589044383576, 19847.900760496104, 20518.58962820735, 20520.973951302374, 20525.17899284012, 20534.486637834172, 8767.0, 8820.2061814437, 8835.514046727492, 8962.0, 9109.043550427243, 4627.8843028923875, 4780.211265141283, 4841.394825646794, 4865.026994601094, 4893.73084480357, 3449.379111759857, 3538.9646103538635, 3559.911002224965, 3561.7684850484634, 3564.7504674672523, 622.7296315516296, 629.4586655476287, 632.7121159872247, 647.2297965421134, 648.9026646003043, 719.7408932784193, 742.5173637135797, 764.8929149919015, 770.2374649097353, 783.7962129846167, 9399.953000234955, 9625.56684949179, 9751.268654850914, 9753.390690536124, 9813.546613346663, 733.6258508160877, 737.6606760889944, 746.2313816768736, 752.7365422102221, 754.8075240813557, 4395.53846846083, 4591.747453890068, 4593.563611456906, 4610.538946105363, 4662.277347011219, 61537.38462615406, 62578.687106564175, 62743.372566274666, 63172.36827631757, 63544.68227658924, 50086.248706269434, 55406.445935540934, 55981.160282595796, 57422.425775742544, 57680.71159644259, 41198.55805046869, 47654.28518572224, 49538.0, 50669.0, 51120.488795111574, 9192.678256260999, 9472.479013654316, 9491.346884828818, 9710.223182145553, 9816.38979413391, 33818.3236335267, 33983.0, 33996.150096246805, 34251.314973700886, 35324.47013294854, 43733.34399983939, 47959.0, 48166.51833481761, 48695.0, 48790.75604621954, 12051.638450846489, 12107.334096624418, 12192.51229950792, 12206.694832629255, 12710.809337860124, 13271.601851944457, 13401.597952061455, 13471.207665307038, 13824.792628110788, 14021.3690383935, 13252.0, 13291.268980206181, 13300.800487992881, 13373.598792035866, 13957.162570245819, 12425.130240883413, 12765.659605741263, 12795.61613151607, 12917.35413229316, 12989.545365912525, 13153.868461315264, 13173.670658233237, 13207.801882971955, 13253.0, 13729.0, 10736.301796526424, 10804.729881753019, 10966.506507207354, 11020.118390528578, 11037.172212083966, 10965.835512467478, 11116.777664446505, 11215.214934954474, 11339.773204536028, 11393.601223957121], "value": 6945.864794902613, "unit": "score"}], "name": "dromaeo_css", "value": 7089.16033640687, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 111.0, 111.0, 111.0, 124.0, 111.0, 111.0, 111.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 137.0, 165.0, 182.0, 129.0, 167.0, 154.0, 131.0, 190.0, 133.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 164.0, 165.0, 170.0, 169.0, 162.0, 166.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 164.0, 77.0, 73.0, 73.0, 73.0, 162.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 158.0, 92.0, 93.0, 94.0, 152.0, 93.0, 92.0, 156.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 58.0, 59.0, 59.0, 58.0, 59.0, 70.0, 65.0, 56.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 61.0, 60.0, 60.0, 61.0, 62.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 77.0, 77.0, 78.0, 79.0, 80.0, 77.0, 79.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 135.0, 125.0, 129.0, 130.0, 133.0, 129.0, 163.0, 128.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 173.0, 172.0, 166.0, 174.0, 171.0, 166.0, 168.0, 169.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 68.0, 66.0, 67.0, 69.0, 69.0, 66.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1565.9, "alertThreshold": 2.0}]} 02:21:05 INFO - Return code: 0 02:21:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:21:06 ERROR - # TBPL SUCCESS # 02:21:06 INFO - Running post-action listener: _resource_record_post_action 02:21:06 INFO - Running post-run listener: _resource_record_post_run 02:21:07 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 536563712; Read time: 0; Write time: 493176 02:21:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244465664; Read time: 0; Write time: 268332 02:21:07 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 292098048; Read time: 0; Write time: 224844 02:21:07 INFO - Running post-run listener: _upload_blobber_files 02:21:07 INFO - Blob upload gear active. 02:21:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:21:07 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 02:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:21:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:08 INFO - (blobuploader) - INFO - Done attempting. 02:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:21:09 INFO - (blobuploader) - INFO - Done attempting. 02:21:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:21:09 INFO - Return code: 0 02:21:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:21:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:21:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c5655ab0f5130c337b815595595c4687aa1758c8f822a84db71e62a24a059b280eb95b2a57f2be4b0724956bbebe5b9707057fbafff8826f017ede669792f6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eecf0835aa562660c0291ada03bea33f6cce107b117cbadab8348866c661a29a0db03e1c4e2d5dddea38e464c35acff2441f8304c8c6bb4fc5e01b65d04368d7"} 02:21:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:21:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:21:09 INFO - Contents: 02:21:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c5655ab0f5130c337b815595595c4687aa1758c8f822a84db71e62a24a059b280eb95b2a57f2be4b0724956bbebe5b9707057fbafff8826f017ede669792f6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eecf0835aa562660c0291ada03bea33f6cce107b117cbadab8348866c661a29a0db03e1c4e2d5dddea38e464c35acff2441f8304c8c6bb4fc5e01b65d04368d7"} 02:21:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:21:09 INFO - Copying logs to upload dir... 02:21:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:21:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.331669 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-25 02:21:08.066206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 02:21:08.069349) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c5655ab0f5130c337b815595595c4687aa1758c8f822a84db71e62a24a059b280eb95b2a57f2be4b0724956bbebe5b9707057fbafff8826f017ede669792f6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eecf0835aa562660c0291ada03bea33f6cce107b117cbadab8348866c661a29a0db03e1c4e2d5dddea38e464c35acff2441f8304c8c6bb4fc5e01b65d04368d7"} build_url:https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/FmDFz4SzQX-rLhB8Wl3HIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c5655ab0f5130c337b815595595c4687aa1758c8f822a84db71e62a24a059b280eb95b2a57f2be4b0724956bbebe5b9707057fbafff8826f017ede669792f6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eecf0835aa562660c0291ada03bea33f6cce107b117cbadab8348866c661a29a0db03e1c4e2d5dddea38e464c35acff2441f8304c8c6bb4fc5e01b65d04368d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 02:21:08.093307) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:21:08.093614) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461574569.366261-1182573178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004362 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 02:21:08.176409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 02:21:08.176677) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 02:21:08.176938) ========= ========= Total master_lag: 0.16 =========