builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1469772533.14 results: success (0) buildid: 20160728203011 builduid: c5832e779f274d1b83bfb2af852eeff3 revision: 7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.142312) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.143195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.143521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.179751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.180149) ========= 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=232498196343f89f466a4a9a000001c8-1469771575.527526-857133422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 23:08:53-- 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% 221M=0s 2016-07-28 23:08:53 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.283604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.283903) ========= 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=232498196343f89f466a4a9a000001c8-1469771575.527526-857133422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014248 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:53.334466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 23:08:53.334794) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899 --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 7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899 --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=232498196343f89f466a4a9a000001c8-1469771575.527526-857133422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 23:08:53,971 truncating revision to first 12 chars 2016-07-28 23:08:53,971 Setting DEBUG logging. 2016-07-28 23:08:53,971 attempt 1/10 2016-07-28 23:08:53,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7fd2a709bd6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 23:08:54,669 unpacking tar archive at: fx-team-7fd2a709bd6c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.028229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 23:08:54.375968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:54.376270) ========= script_repo_revision: 7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:54.376684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:54.376948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 23:08:54.384638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-28 23:08:54.384951) ========= /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=232498196343f89f466a4a9a000001c8-1469771575.527526-857133422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:08:55 INFO - MultiFileLogger online at 20160728 23:08:55 in /builds/slave/test 23:08:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:08:55 INFO - {'append_to_log': False, 23:08:55 INFO - 'base_work_dir': '/builds/slave/test', 23:08:55 INFO - 'blob_upload_branch': 'Fx-Team', 23:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:08:55 INFO - 'branch': 'Fx-Team', 23:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 23:08:55 INFO - 'config_files': ('talos/linux_config.py',), 23:08:55 INFO - 'default_actions': ('clobber', 23:08:55 INFO - 'read-buildbot-config', 23:08:55 INFO - 'download-and-extract', 23:08:55 INFO - 'populate-webroot', 23:08:55 INFO - 'create-virtualenv', 23:08:55 INFO - 'install', 23:08:55 INFO - 'run-tests'), 23:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:08:55 INFO - 'download_minidump_stackwalk': True, 23:08:55 INFO - 'download_symbols': 'ondemand', 23:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 23:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 23:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:08:55 INFO - 'installer_path': 'installer.exe', 23:08:55 INFO - 'log_level': 'info', 23:08:55 INFO - 'log_name': 'talos', 23:08:55 INFO - 'log_to_console': True, 23:08:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:08:55 INFO - 'opt_config_files': (), 23:08:55 INFO - 'pip_index': False, 23:08:55 INFO - 'sps_profile': False, 23:08:55 INFO - 'sps_profile_interval': 0, 23:08:55 INFO - 'suite': 'dromaeojs-e10s', 23:08:55 INFO - 'system_bits': '32', 23:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:08:55 INFO - 'title': 'talos-linux64-ix-025', 23:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:08:55 INFO - 'use_talos_json': True, 23:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:08:55 INFO - 'work_dir': 'build'} 23:08:55 INFO - [mozharness: 2016-07-29 06:08:55.113382Z] Running clobber step. 23:08:55 INFO - Running pre-action listener: _resource_record_pre_action 23:08:55 INFO - Running main action method: clobber 23:08:55 INFO - rmtree: /builds/slave/test/build 23:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:08:56 INFO - Running post-action listener: _resource_record_post_action 23:08:56 INFO - [mozharness: 2016-07-29 06:08:56.094737Z] Finished clobber step (success) 23:08:56 INFO - [mozharness: 2016-07-29 06:08:56.094837Z] Running read-buildbot-config step. 23:08:56 INFO - Running pre-action listener: _resource_record_pre_action 23:08:56 INFO - Running main action method: read_buildbot_config 23:08:56 INFO - Using buildbot properties: 23:08:56 INFO - { 23:08:56 INFO - "project": "", 23:08:56 INFO - "product": "firefox", 23:08:56 INFO - "script_repo_revision": "production", 23:08:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:08:56 INFO - "repository": "", 23:08:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:08:56 INFO - "buildid": "20160728203011", 23:08:56 INFO - "pgo_build": "True", 23:08:56 INFO - "basedir": "/builds/slave/test", 23:08:56 INFO - "buildnumber": 989, 23:08:56 INFO - "slavename": "talos-linux64-ix-025", 23:08:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:08:56 INFO - "platform": "ubuntu64_hw", 23:08:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:08:56 INFO - "branch": "fx-team", 23:08:56 INFO - "repo_path": "integration/fx-team", 23:08:56 INFO - "revision": "7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899", 23:08:56 INFO - "stage_platform": "linux64-pgo", 23:08:56 INFO - "builduid": "c5832e779f274d1b83bfb2af852eeff3", 23:08:56 INFO - "slavebuilddir": "test" 23:08:56 INFO - } 23:08:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:08:56 INFO - Running post-action listener: _resource_record_post_action 23:08:56 INFO - [mozharness: 2016-07-29 06:08:56.097298Z] Finished read-buildbot-config step (success) 23:08:56 INFO - [mozharness: 2016-07-29 06:08:56.097388Z] Running download-and-extract step. 23:08:56 INFO - Running pre-action listener: _resource_record_pre_action 23:08:56 INFO - Running main action method: download_and_extract 23:08:56 INFO - mkdir: /builds/slave/test/build/tests 23:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:56 INFO - https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:09:01 INFO - Downloaded 1361 bytes. 23:09:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:01 INFO - Using the following test package requirements: 23:09:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'jsshell-linux-x86_64.zip'], 23:09:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:01 INFO - https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:08 INFO - Downloaded 24321954 bytes. 23:09:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:09 INFO - Return code: 0 23:09:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:09 INFO - https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:10 INFO - Downloaded 24321954 bytes. 23:09:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:12 INFO - Return code: 0 23:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:12 INFO - https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:09:13 INFO - Downloaded 14413725 bytes. 23:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:09:13 INFO - Return code: 0 23:09: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')]} 23:09:13 INFO - https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:09:16 INFO - Downloaded 61018196 bytes. 23:09:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:16 INFO - mkdir: /builds/slave/test/properties 23:09:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:16 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:16 INFO - Contents: 23:09:16 INFO - build_url:https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:17 INFO - Running post-action listener: _resource_record_post_action 23:09:17 INFO - Running post-action listener: set_extra_try_arguments 23:09:17 INFO - [mozharness: 2016-07-29 06:09:17.303577Z] Finished download-and-extract step (success) 23:09:17 INFO - [mozharness: 2016-07-29 06:09:17.303811Z] Running populate-webroot step. 23:09:17 INFO - Running pre-action listener: _resource_record_pre_action 23:09:17 INFO - Running main action method: populate_webroot 23:09:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:17 INFO - '--tppagecycles', 23:09:17 INFO - '7'], 23:09:17 INFO - 'tests': ['tsvgm']}}, 23:09:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['damp', 'tps']}, 23:09:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'tests': ['damp', 'tps']}, 23:09:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['dromaeo_dom']}, 23:09:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['basic_compositor_video']}, 23:09:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:09:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['a11yr', 23:09:17 INFO - 'ts_paint', 23:09:17 INFO - 'tpaint', 23:09:17 INFO - 'sessionrestore', 23:09:17 INFO - 'sessionrestore_no_auto_restore', 23:09:17 INFO - 'tabpaint']}, 23:09:17 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:17 INFO - 'ts_paint', 23:09:17 INFO - 'tpaint', 23:09:17 INFO - 'sessionrestore', 23:09:17 INFO - 'sessionrestore_no_auto_restore', 23:09:17 INFO - 'tabpaint']}, 23:09:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:17 INFO - 'ts_paint', 23:09:17 INFO - 'tpaint', 23:09:17 INFO - 'sessionrestore', 23:09:17 INFO - 'sessionrestore_no_auto_restore', 23:09:17 INFO - 'tabpaint']}, 23:09:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:17 INFO - 'ts_paint', 23:09:17 INFO - 'tpaint', 23:09:17 INFO - 'sessionrestore', 23:09:17 INFO - 'sessionrestore_no_auto_restore', 23:09:17 INFO - 'tabpaint']}, 23:09:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['a11yr', 23:09:17 INFO - 'ts_paint', 23:09:17 INFO - 'tpaint', 23:09:17 INFO - 'sessionrestore', 23:09:17 INFO - 'sessionrestore_no_auto_restore', 23:09:17 INFO - 'tabpaint']}, 23:09:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['a11yr', 23:09:17 INFO - 'ts_paint', 23:09:17 INFO - 'tpaint', 23:09:17 INFO - 'sessionrestore', 23:09:17 INFO - 'sessionrestore_no_auto_restore', 23:09:17 INFO - 'tabpaint']}, 23:09:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['tsvgx', 23:09:17 INFO - 'tsvgr_opacity', 23:09:17 INFO - 'tart', 23:09:17 INFO - 'tscrollx', 23:09:17 INFO - 'cart']}, 23:09:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:17 INFO - 'tsvgr_opacity', 23:09:17 INFO - 'tart', 23:09:17 INFO - 'tscrollx', 23:09:17 INFO - 'cart']}, 23:09:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'talos_options': ['--disable-e10s'], 23:09:17 INFO - 'tests': ['tp5o']}, 23:09:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'tests': ['tp5o']}, 23:09:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'talos_options': ['--disable-e10s', 23:09:17 INFO - '--xperf_path', 23:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:17 INFO - 'tests': ['tp5n']}, 23:09:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:17 INFO - 'talos_options': ['--xperf_path', 23:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:17 INFO - 'tests': ['tp5n']}}, 23:09:17 INFO - 'talos.zip': {'path': '', 23:09:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:17 INFO - Running post-action listener: _resource_record_post_action 23:09:17 INFO - [mozharness: 2016-07-29 06:09:17.322786Z] Finished populate-webroot step (success) 23:09:17 INFO - [mozharness: 2016-07-29 06:09:17.322875Z] Running create-virtualenv step. 23:09:17 INFO - Running pre-action listener: _resource_record_pre_action 23:09:17 INFO - Running main action method: create_virtualenv 23:09:17 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:09:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:17 INFO - Using real prefix '/usr' 23:09:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:19 INFO - Installing pip.................done. 23:09:19 INFO - Return code: 0 23:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:19 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 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:09:19 INFO - Using env: {'DISPLAY': ':0', 23:09:19 INFO - 'HOME': '/home/cltbld', 23:09:19 INFO - 'LANG': 'en_US.UTF-8', 23:09:19 INFO - 'LANGUAGE': 'en_US:en', 23:09:19 INFO - 'LOGNAME': 'cltbld', 23:09:19 INFO - 'MAIL': '/var/mail/cltbld', 23:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:19 INFO - 'MOZ_NO_REMOTE': '1', 23:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:19 INFO - 'NO_EM_RESTART': '1', 23:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:19 INFO - 'PWD': '/builds/slave/test', 23:09:19 INFO - 'SHELL': '/bin/bash', 23:09:19 INFO - 'SHLVL': '1', 23:09:19 INFO - 'TERM': 'linux', 23:09:19 INFO - 'TMOUT': '86400', 23:09:19 INFO - 'USER': 'cltbld', 23:09:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:19 INFO - '_': '/tools/buildbot/bin/python'} 23:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:09:20 INFO - Cleaning up... 23:09:20 INFO - Return code: 0 23:09:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:09:20 INFO - Using env: {'DISPLAY': ':0', 23:09:20 INFO - 'HOME': '/home/cltbld', 23:09:20 INFO - 'LANG': 'en_US.UTF-8', 23:09:20 INFO - 'LANGUAGE': 'en_US:en', 23:09:20 INFO - 'LOGNAME': 'cltbld', 23:09:20 INFO - 'MAIL': '/var/mail/cltbld', 23:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:20 INFO - 'MOZ_NO_REMOTE': '1', 23:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:20 INFO - 'NO_EM_RESTART': '1', 23:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:20 INFO - 'PWD': '/builds/slave/test', 23:09:20 INFO - 'SHELL': '/bin/bash', 23:09:20 INFO - 'SHLVL': '1', 23:09:20 INFO - 'TERM': 'linux', 23:09:20 INFO - 'TMOUT': '86400', 23:09:20 INFO - 'USER': 'cltbld', 23:09:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:20 INFO - '_': '/tools/buildbot/bin/python'} 23:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:20 INFO - Downloading/unpacking psutil>=3.1.1 23:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:22 INFO - Installing collected packages: psutil 23:09:22 INFO - Running setup.py install for psutil 23:09:22 INFO - building 'psutil._psutil_linux' extension 23:09:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:09:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:09:22 INFO - building 'psutil._psutil_posix' extension 23:09:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:09:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:22 INFO - Successfully installed psutil 23:09:22 INFO - Cleaning up... 23:09:22 INFO - Return code: 0 23:09:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:09:22 INFO - Using env: {'DISPLAY': ':0', 23:09:22 INFO - 'HOME': '/home/cltbld', 23:09:22 INFO - 'LANG': 'en_US.UTF-8', 23:09:22 INFO - 'LANGUAGE': 'en_US:en', 23:09:22 INFO - 'LOGNAME': 'cltbld', 23:09:22 INFO - 'MAIL': '/var/mail/cltbld', 23:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:22 INFO - 'MOZ_NO_REMOTE': '1', 23:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:22 INFO - 'NO_EM_RESTART': '1', 23:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:22 INFO - 'PWD': '/builds/slave/test', 23:09:22 INFO - 'SHELL': '/bin/bash', 23:09:22 INFO - 'SHLVL': '1', 23:09:22 INFO - 'TERM': 'linux', 23:09:22 INFO - 'TMOUT': '86400', 23:09:22 INFO - 'USER': 'cltbld', 23:09:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:22 INFO - '_': '/tools/buildbot/bin/python'} 23:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:25 INFO - Installing collected packages: mozsystemmonitor 23:09:25 INFO - Running setup.py install for mozsystemmonitor 23:09:25 INFO - Successfully installed mozsystemmonitor 23:09:25 INFO - Cleaning up... 23:09:25 INFO - Return code: 0 23:09:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:25 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==2.5.1'] in /builds/slave/test/build 23:09:25 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==2.5.1 23:09:25 INFO - Using env: {'DISPLAY': ':0', 23:09:25 INFO - 'HOME': '/home/cltbld', 23:09:25 INFO - 'LANG': 'en_US.UTF-8', 23:09:25 INFO - 'LANGUAGE': 'en_US:en', 23:09:25 INFO - 'LOGNAME': 'cltbld', 23:09:25 INFO - 'MAIL': '/var/mail/cltbld', 23:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:25 INFO - 'MOZ_NO_REMOTE': '1', 23:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:25 INFO - 'NO_EM_RESTART': '1', 23:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:25 INFO - 'PWD': '/builds/slave/test', 23:09:25 INFO - 'SHELL': '/bin/bash', 23:09:25 INFO - 'SHLVL': '1', 23:09:25 INFO - 'TERM': 'linux', 23:09:25 INFO - 'TMOUT': '86400', 23:09:25 INFO - 'USER': 'cltbld', 23:09:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:25 INFO - '_': '/tools/buildbot/bin/python'} 23:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:25 INFO - Downloading/unpacking jsonschema==2.5.1 23:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:27 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:27 INFO - warning: no files found matching '*.txt' 23:09:27 INFO - no previously-included directories found matching 'build' 23:09:27 INFO - no previously-included directories found matching 'dist' 23:09:27 INFO - no previously-included directories found matching '.git*' 23:09:27 INFO - Installing collected packages: jsonschema, functools32 23:09:27 INFO - Running setup.py install for functools32 23:09:27 INFO - warning: no files found matching '*.txt' 23:09:27 INFO - no previously-included directories found matching 'build' 23:09:27 INFO - no previously-included directories found matching 'dist' 23:09:27 INFO - no previously-included directories found matching '.git*' 23:09:27 INFO - Successfully installed jsonschema functools32 23:09:27 INFO - Cleaning up... 23:09:27 INFO - Return code: 0 23:09:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:27 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:27 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:09:27 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 functools32==3.2.3-2 23:09:27 INFO - Using env: {'DISPLAY': ':0', 23:09:27 INFO - 'HOME': '/home/cltbld', 23:09:27 INFO - 'LANG': 'en_US.UTF-8', 23:09:27 INFO - 'LANGUAGE': 'en_US:en', 23:09:27 INFO - 'LOGNAME': 'cltbld', 23:09:27 INFO - 'MAIL': '/var/mail/cltbld', 23:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:27 INFO - 'MOZ_NO_REMOTE': '1', 23:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:27 INFO - 'NO_EM_RESTART': '1', 23:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:27 INFO - 'PWD': '/builds/slave/test', 23:09:27 INFO - 'SHELL': '/bin/bash', 23:09:27 INFO - 'SHLVL': '1', 23:09:27 INFO - 'TERM': 'linux', 23:09:27 INFO - 'TMOUT': '86400', 23:09:27 INFO - 'USER': 'cltbld', 23:09:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:27 INFO - '_': '/tools/buildbot/bin/python'} 23:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:09:27 INFO - Cleaning up... 23:09:27 INFO - Return code: 0 23:09:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:27 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 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:09:27 INFO - Using env: {'DISPLAY': ':0', 23:09:27 INFO - 'HOME': '/home/cltbld', 23:09:27 INFO - 'LANG': 'en_US.UTF-8', 23:09:27 INFO - 'LANGUAGE': 'en_US:en', 23:09:27 INFO - 'LOGNAME': 'cltbld', 23:09:27 INFO - 'MAIL': '/var/mail/cltbld', 23:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:27 INFO - 'MOZ_NO_REMOTE': '1', 23:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:27 INFO - 'NO_EM_RESTART': '1', 23:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:27 INFO - 'PWD': '/builds/slave/test', 23:09:27 INFO - 'SHELL': '/bin/bash', 23:09:27 INFO - 'SHLVL': '1', 23:09:27 INFO - 'TERM': 'linux', 23:09:27 INFO - 'TMOUT': '86400', 23:09:27 INFO - 'USER': 'cltbld', 23:09:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:27 INFO - '_': '/tools/buildbot/bin/python'} 23:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:28 INFO - Downloading/unpacking blobuploader==1.2.4 23:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:29 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:30 INFO - Downloading docopt-0.6.1.tar.gz 23:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:30 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:30 INFO - Running setup.py install for blobuploader 23:09:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:30 INFO - Running setup.py install for requests 23:09:31 INFO - Running setup.py install for docopt 23:09:31 INFO - Successfully installed blobuploader requests docopt 23:09:31 INFO - Cleaning up... 23:09:31 INFO - Return code: 0 23:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:31 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 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:31 INFO - Using env: {'DISPLAY': ':0', 23:09:31 INFO - 'HOME': '/home/cltbld', 23:09:31 INFO - 'LANG': 'en_US.UTF-8', 23:09:31 INFO - 'LANGUAGE': 'en_US:en', 23:09:31 INFO - 'LOGNAME': 'cltbld', 23:09:31 INFO - 'MAIL': '/var/mail/cltbld', 23:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:31 INFO - 'MOZ_NO_REMOTE': '1', 23:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:31 INFO - 'NO_EM_RESTART': '1', 23:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:31 INFO - 'PWD': '/builds/slave/test', 23:09:31 INFO - 'SHELL': '/bin/bash', 23:09:31 INFO - 'SHLVL': '1', 23:09:31 INFO - 'TERM': 'linux', 23:09:31 INFO - 'TMOUT': '86400', 23:09:31 INFO - 'USER': 'cltbld', 23:09:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:31 INFO - '_': '/tools/buildbot/bin/python'} 23:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:31 INFO - Running setup.py (path:/tmp/pip-rclScX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:31 INFO - Running setup.py (path:/tmp/pip-qsrX1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:31 INFO - Running setup.py (path:/tmp/pip-pciplz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:31 INFO - Running setup.py (path:/tmp/pip-3AlBCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:31 INFO - Running setup.py (path:/tmp/pip-ephKwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:31 INFO - Running setup.py (path:/tmp/pip-hpsoGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:32 INFO - Running setup.py (path:/tmp/pip-odVg2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:32 INFO - Running setup.py (path:/tmp/pip-GHBhiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:32 INFO - Running setup.py (path:/tmp/pip-5_8n_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:32 INFO - Running setup.py (path:/tmp/pip-dchV4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:32 INFO - Running setup.py (path:/tmp/pip-92k9I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:32 INFO - Running setup.py (path:/tmp/pip-BY0Cfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:32 INFO - Running setup.py (path:/tmp/pip-MdEs4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:32 INFO - Running setup.py (path:/tmp/pip-BBYMqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:32 INFO - Running setup.py (path:/tmp/pip-NkFLW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:32 INFO - Running setup.py (path:/tmp/pip-WgUaed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:32 INFO - Running setup.py (path:/tmp/pip-SOqdop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:32 INFO - Running setup.py install for manifestparser 23:09:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:32 INFO - Running setup.py install for mozcrash 23:09:33 INFO - Running setup.py install for mozdebug 23:09:33 INFO - Running setup.py install for mozdevice 23:09:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Running setup.py install for mozfile 23:09:33 INFO - Running setup.py install for mozhttpd 23:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Running setup.py install for mozinfo 23:09:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Running setup.py install for mozInstall 23:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Running setup.py install for mozleak 23:09:33 INFO - Running setup.py install for mozlog 23:09:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Running setup.py install for moznetwork 23:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:33 INFO - Running setup.py install for mozprocess 23:09:34 INFO - Running setup.py install for mozprofile 23:09:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:34 INFO - Running setup.py install for mozrunner 23:09:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:34 INFO - Running setup.py install for mozscreenshot 23:09:34 INFO - Running setup.py install for moztest 23:09:34 INFO - Running setup.py install for mozversion 23:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:34 INFO - Cleaning up... 23:09:34 INFO - Return code: 0 23:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:34 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 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:34 INFO - Using env: {'DISPLAY': ':0', 23:09:34 INFO - 'HOME': '/home/cltbld', 23:09:34 INFO - 'LANG': 'en_US.UTF-8', 23:09:34 INFO - 'LANGUAGE': 'en_US:en', 23:09:34 INFO - 'LOGNAME': 'cltbld', 23:09:34 INFO - 'MAIL': '/var/mail/cltbld', 23:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:34 INFO - 'MOZ_NO_REMOTE': '1', 23:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:34 INFO - 'NO_EM_RESTART': '1', 23:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:34 INFO - 'PWD': '/builds/slave/test', 23:09:34 INFO - 'SHELL': '/bin/bash', 23:09:34 INFO - 'SHLVL': '1', 23:09:34 INFO - 'TERM': 'linux', 23:09:34 INFO - 'TMOUT': '86400', 23:09:34 INFO - 'USER': 'cltbld', 23:09:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:34 INFO - '_': '/tools/buildbot/bin/python'} 23:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:34 INFO - Running setup.py (path:/tmp/pip-gZVlPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:34 INFO - Running setup.py (path:/tmp/pip-cGSNhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:34 INFO - Running setup.py (path:/tmp/pip-GBtj9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:35 INFO - Running setup.py (path:/tmp/pip-EsR4JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:35 INFO - Running setup.py (path:/tmp/pip-ep6lQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:35 INFO - Running setup.py (path:/tmp/pip-vpaQSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:35 INFO - Running setup.py (path:/tmp/pip-SQq8kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:35 INFO - Running setup.py (path:/tmp/pip-JsxrYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:35 INFO - Running setup.py (path:/tmp/pip-72elSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:35 INFO - Running setup.py (path:/tmp/pip-rPtEwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:35 INFO - Running setup.py (path:/tmp/pip-jlGMpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:35 INFO - Running setup.py (path:/tmp/pip-YTXXJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:35 INFO - Running setup.py (path:/tmp/pip-d4GLBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:35 INFO - Running setup.py (path:/tmp/pip-87DAkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:35 INFO - Running setup.py (path:/tmp/pip-8Cr7Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:35 INFO - Running setup.py (path:/tmp/pip-F2MKkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:36 INFO - Running setup.py (path:/tmp/pip-CwVJLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:37 INFO - Downloading blessings-1.6.tar.gz 23:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:38 INFO - Installing collected packages: blessings 23:09:38 INFO - Running setup.py install for blessings 23:09:38 INFO - Successfully installed blessings 23:09:38 INFO - Cleaning up... 23:09:38 INFO - Return code: 0 23:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:38 INFO - Reading from file tmpfile_stdout 23:09:38 INFO - Current package versions: 23:09:38 INFO - argparse == 1.2.1 23:09:38 INFO - blessings == 1.6 23:09:38 INFO - blobuploader == 1.2.4 23:09:38 INFO - docopt == 0.6.1 23:09:38 INFO - functools32 == 3.2.3-2 23:09:38 INFO - jsonschema == 2.5.1 23:09:38 INFO - manifestparser == 1.1 23:09:38 INFO - mozInstall == 1.12 23:09:38 INFO - mozcrash == 0.17 23:09:38 INFO - mozdebug == 0.1 23:09:38 INFO - mozdevice == 0.48 23:09:38 INFO - mozfile == 1.2 23:09:38 INFO - mozhttpd == 0.7 23:09:38 INFO - mozinfo == 0.9 23:09:38 INFO - mozleak == 0.1 23:09:38 INFO - mozlog == 3.3 23:09:38 INFO - moznetwork == 0.27 23:09:38 INFO - mozprocess == 0.23 23:09:38 INFO - mozprofile == 0.28 23:09:38 INFO - mozrunner == 6.12 23:09:38 INFO - mozscreenshot == 0.1 23:09:38 INFO - mozsystemmonitor == 0.3 23:09:38 INFO - moztest == 0.7 23:09:38 INFO - mozversion == 1.4 23:09:38 INFO - psutil == 3.1.1 23:09:38 INFO - requests == 1.2.3 23:09:38 INFO - wsgiref == 0.1.2 23:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 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 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:09:38 INFO - Using env: {'DISPLAY': ':0', 23:09:38 INFO - 'HOME': '/home/cltbld', 23:09:38 INFO - 'LANG': 'en_US.UTF-8', 23:09:38 INFO - 'LANGUAGE': 'en_US:en', 23:09:38 INFO - 'LOGNAME': 'cltbld', 23:09:38 INFO - 'MAIL': '/var/mail/cltbld', 23:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:38 INFO - 'MOZ_NO_REMOTE': '1', 23:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:38 INFO - 'NO_EM_RESTART': '1', 23:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:38 INFO - 'PWD': '/builds/slave/test', 23:09:38 INFO - 'SHELL': '/bin/bash', 23:09:38 INFO - 'SHLVL': '1', 23:09:38 INFO - 'TERM': 'linux', 23:09:38 INFO - 'TMOUT': '86400', 23:09:38 INFO - 'USER': 'cltbld', 23:09:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:38 INFO - '_': '/tools/buildbot/bin/python'} 23:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:09:38 INFO - Cleaning up... 23:09:38 INFO - Return code: 0 23:09:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 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 0x1819030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, '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': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:09:38 INFO - Using env: {'DISPLAY': ':0', 23:09:38 INFO - 'HOME': '/home/cltbld', 23:09:38 INFO - 'LANG': 'en_US.UTF-8', 23:09:38 INFO - 'LANGUAGE': 'en_US:en', 23:09:38 INFO - 'LOGNAME': 'cltbld', 23:09:38 INFO - 'MAIL': '/var/mail/cltbld', 23:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:38 INFO - 'MOZ_NO_REMOTE': '1', 23:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:38 INFO - 'NO_EM_RESTART': '1', 23:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:38 INFO - 'PWD': '/builds/slave/test', 23:09:38 INFO - 'SHELL': '/bin/bash', 23:09:38 INFO - 'SHLVL': '1', 23:09:38 INFO - 'TERM': 'linux', 23:09:38 INFO - 'TMOUT': '86400', 23:09:38 INFO - 'USER': 'cltbld', 23:09:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:38 INFO - '_': '/tools/buildbot/bin/python'} 23:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:09:38 INFO - Cleaning up... 23:09:38 INFO - Return code: 0 23:09:38 INFO - Running post-action listener: _resource_record_post_action 23:09:38 INFO - Running post-action listener: _start_resource_monitoring 23:09:38 INFO - Starting resource monitoring. 23:09:38 INFO - [mozharness: 2016-07-29 06:09:38.901312Z] Finished create-virtualenv step (success) 23:09:38 INFO - [mozharness: 2016-07-29 06:09:38.901792Z] Running install step. 23:09:38 INFO - Running pre-action listener: _resource_record_pre_action 23:09:38 INFO - Running main action method: install 23:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:39 INFO - Reading from file tmpfile_stdout 23:09:39 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:39 INFO - Reading from file tmpfile_stdout 23:09:39 INFO - Output received: 23:09:39 INFO - Usage: mozinstall [options] installer 23:09:39 INFO - Options: 23:09:39 INFO - -h, --help show this help message and exit 23:09:39 INFO - -d DEST, --destination=DEST 23:09:39 INFO - Directory to install application into. [default: 23:09:39 INFO - "/builds/slave/test"] 23:09:39 INFO - --app=APP Application being installed. [default: firefox] 23:09:39 INFO - mkdir: /builds/slave/test/build/application 23:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:09:56 INFO - Reading from file tmpfile_stdout 23:09:56 INFO - Output received: 23:09:56 INFO - /builds/slave/test/build/application/firefox/firefox 23:09:56 INFO - Running post-action listener: _resource_record_post_action 23:09:56 INFO - [mozharness: 2016-07-29 06:09:56.503617Z] Finished install step (success) 23:09:56 INFO - [mozharness: 2016-07-29 06:09:56.503891Z] Running run-tests step. 23:09:56 INFO - Running pre-action listener: _resource_record_pre_action 23:09:56 INFO - Running main action method: run_tests 23:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:09:56 INFO - Python 2.7.3 23:09:56 INFO - Return code: 0 23:09:56 INFO - grabbing minidump binary from tooltool 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad83b0>, '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 0x1ad92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:09:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:09:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:09:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:09:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:09:56 INFO - Return code: 0 23:09:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:09:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:09:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:09:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:09:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:09:56 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/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:09:56 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/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:09:56 INFO - Using env: {'DISPLAY': ':0', 23:09:56 INFO - 'HOME': '/home/cltbld', 23:09:56 INFO - 'LANG': 'en_US.UTF-8', 23:09:56 INFO - 'LANGUAGE': 'en_US:en', 23:09:56 INFO - 'LOGNAME': 'cltbld', 23:09:56 INFO - 'MAIL': '/var/mail/cltbld', 23:09:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:09:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:56 INFO - 'MOZ_NO_REMOTE': '1', 23:09:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:56 INFO - 'NO_EM_RESTART': '1', 23:09:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:56 INFO - 'PWD': '/builds/slave/test', 23:09:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:09:56 INFO - 'SHELL': '/bin/bash', 23:09:56 INFO - 'SHLVL': '1', 23:09:56 INFO - 'TERM': 'linux', 23:09:56 INFO - 'TMOUT': '86400', 23:09:56 INFO - 'USER': 'cltbld', 23:09:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469771575.527526-857133422', 23:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:56 INFO - '_': '/tools/buildbot/bin/python'} 23:09:56 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/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:09:56 INFO - mozversion application_buildid: 20160728203011 23:09:56 INFO - mozversion application_changeset: 7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899 23:09:56 INFO - mozversion application_display_name: Nightly 23:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:09:56 INFO - mozversion application_name: Firefox 23:09:56 INFO - mozversion application_remotingname: firefox 23:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:09:56 INFO - mozversion application_vendor: Mozilla 23:09:56 INFO - mozversion application_version: 50.0a1 23:09:56 INFO - mozversion platform_buildid: 20160728203011 23:09:56 INFO - mozversion platform_changeset: 7fd2a709bd6cd1714d8e6639dce3fda9f7b7d899 23:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:09:56 INFO - mozversion platform_version: 50.0a1 23:09:56 INFO - using testdate: 1469772596 23:09:56 INFO - actual date: 1469772596 23:09:56 INFO - starting webserver on 'localhost:35823' 23:09:56 INFO - SUITE-START | Running 2 tests 23:09:56 INFO - TEST-START | dromaeo_css 23:09:56 INFO - operating with platform_type : linux_ 23:09:56 INFO - Initialising browser for dromaeo_css test... 23:09:56 INFO - TEST-INFO | started process 25183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZe7Sc8/profile http://localhost:35823/getInfo.html) 23:09:59 INFO - PROCESS | 25183 | JavaScript error: , line 0: uncaught exception: undefined 23:10:01 INFO - PROCESS | 25183 | __metrics Screen width/height:1600/1200 23:10:01 INFO - PROCESS | 25183 | colorDepth:24 23:10:01 INFO - PROCESS | 25183 | Browser inner width/height: 1024/697 23:10:01 INFO - PROCESS | 25183 | __metrics 23:10:01 ERROR - PROCESS | 25183 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:10:02 INFO - TEST-INFO | 25183: exit 0 23:10:02 INFO - Browser initialized. 23:10:02 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:02 INFO - TEST-INFO | started process 25302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZe7Sc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:14 INFO - PROCESS | 25302 | RSS: Main: 164933632 23:10:14 INFO - PROCESS | 25302 | 23:11:03 INFO - PROCESS | 25302 | 1469772663936 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:13:12 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:35823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35823/tests/dromaeo/cssquery-ext.html) 23:13:13 INFO - PROCESS | 25302 | RSS: Main: 169365504 23:13:13 INFO - PROCESS | 25302 | 23:16:15 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:35823/tests/dromaeo/cssquery-ext.html (next: http://localhost:35823/tests/dromaeo/cssquery-jquery.html) 23:16:15 INFO - PROCESS | 25302 | RSS: Main: 166510592 23:16:15 INFO - PROCESS | 25302 | 23:19:17 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:35823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35823/tests/dromaeo/cssquery-mootools.html) 23:19:18 INFO - PROCESS | 25302 | RSS: Main: 171253760 23:19:18 INFO - PROCESS | 25302 | 23:22:20 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:35823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35823/tests/dromaeo/cssquery-prototype.html) 23:22:20 INFO - PROCESS | 25302 | RSS: Main: 165376000 23:22:20 INFO - PROCESS | 25302 | 23:25:23 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:35823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35823/tests/dromaeo/cssquery-yui.html) 23:25:23 INFO - PROCESS | 25302 | RSS: Main: 167219200 23:25:23 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:35823/tests/dromaeo/cssquery-yui.html (next: http://localhost:35823/tests/dromaeo/cssquery-dojo.html) 23:28:27 INFO - PROCESS | 25302 | RSS: Main: 170725376 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | __start_tp_report 23:28:27 INFO - PROCESS | 25302 | _x_x_mozilla_page_load 23:28:27 INFO - PROCESS | 25302 | _x_x_mozilla_page_load_details 23:28:27 INFO - PROCESS | 25302 | |i|pagename|runs| 23:28:27 INFO - PROCESS | 25302 | |0;dojo.html;3065.6014718086644;3089.3357928045466;3100.689931006899;3111.95332070019;3117.2518595537063;5158.123119069758;5320.334958130234;5401.162819762933;5416.970775552642;5494.80768173114;5320.388155362135;5383.623146379755;5402.9729851350685;5413.133898576229;5416.593755468336;4771.141194584973;4808.062427826558;4848.296996935443;4870.659053866213;4923.606111511071;4920.188168952119;4951.282064100703;4989.077020751154;4995.100881841267;5004.449510553836;699.771711246667;4867.075255701406;4982.327385802906;4994.051130285252;5052.0906236877345;4952.801887924478;4965.180745177042;4974.950250497521;4985.52637499437;5002.099622068026;4905.509449055102;4910.288008238821;4919.581835543983;4920.991196804646;4970.577500912391;5141.2288156776785;5241.31862857826;5242.501962313574;5265.289185959885;5265.447128051538;5602.943970560283;5628.240187574666;5635.71821408932;5669.404712505168;5694.715264236813;5726.742296596663;5728.22668939692;5732.140178973145;5752;5758.740856661419;5188.351456067991;5335.19553072625;5336.146216605324;5345.786168553253;5346.091164502005;5797.420257974169;5835.562332825055;5856.853578660568;5903;5942.524598032147;5656.971715141398;5663.631863928831;5668.064769313017;5671.347795003545;5686.2039314496005;5584.078627026495;5751.913721294184;5755.395683453177;5781.768729250867;5785.50823180026;5637.661740295595;5711.657300561979;5719.5138413235345;5781.624194427349;5830.4461076197695;5759.424057594207;5760.74076666551;5767.279090113736;5795.913061304083;5798.362180160179;4349.9130017399475;4428.889277768081;4441.866743997685;4461.308497182942;4501.594856462934;3862.2854771867296;3906.531216254011;3908.6286802753693;3911.7457365271166;3958.7030972677167;5465.453454654503;5481.150421684565;5487.039768040657;5499.532539734088;5500.614956952975;5622.46586574283;5661.575381846378;5710.628809127394;5756.42435756421;5763.106718458645;5426.996005738951;5452.618316717871;5470.972645136749;5474.562035037187;5477.507024367826;4911.435184953776;4926.285688575136;4936.284238785428;4948.950510494849;4950.752462376867;5838.095095260242;5865.442782935615;5908.940910590925;5916.674582897982;5924.703764811742;5702.059160238514;5740.253767010262;5751.482366587027;5795.217645617788;5810.1575271586225;5964.552658550713;5970.76116955317;5980.9401905980385;5992.13114098462;5996.190514280516;5484.917726234189;5523.585731070106;5619.578531610227;5636.210930469655;5657.660540367591;5720.313562372542;5813.505852002627;5818.592698511064;5845.064789633639;5883.29400471929;5612.270404847507;5655.377908430151;5657.264555607745;5661.46216109469;5668.234788303526;5424.2406063151975;5521.751521181637;5608.4111168326735;5648.689322087324;5651.689157096234;5507.586930980113;5516.117421212587;5519.613627046228;5536.307961504812;5580.274564306615;5595.328560572757;5599.216109744558;5607;5631.943680563142;5645.4072322405555;5413.756380962787;5442.455754424526;5482.39693633692;5510.8071217507195;5578.721063946868 23:28:27 INFO - PROCESS | 25302 | |1;ext.html;569.3509399284816;601.8805022657856;603.354410780465;617.3240301869453;652.6508318049845;40904.79547602261;45628.77185614075;45782.542174578244;45855.770721146386;45946.770266148626;45168.54831451693;45463.318050229274;45718.085638287215;45909.31136032962;46040.539594604044;8903.332250081237;9046.231070359026;9059.184673379394;9082.182603565678;9107.772305692377;8971.282297416192;9076.183143517082;9079.046700096495;9082.59128339223;9096.317776166781;9038.638454461814;9091.409058411182;9099.545022748869;9122.133397327243;9136.725898223063;9004;9056.954715226448;9063.773405664846;9091.818163636757;9102.63589456421;8928.776780580472;9004.954975225082;9008.414453060595;9019.549022548847;9042.819143617156;42990.57009429897;43530.78234608838;43694.56305436968;43882.12235755267;43889.78055109736;2986.9103926882012;2998.4602771501122;3281.1305004173673;3511.719062474996;3639.053846000059;33608.6639133608;33644.49533257003;34362.82818585916;34845.30309393823;35629;4366.345048242757;4389.912201755979;4518.728876267434;4521.118381915528;4559.202139625585;372631;375921;379390;381386.0930695357;385051;65161.674191628736;65985.67007164934;66271.02373857488;66290.66854665696;66311;36363.4545481818;36967.81516092456;37317.81341093331;39776.60223397787;69619.65190174017;17317.220725067404;17333.826661733223;17479.126043697765;17502.649947000988;17509.12454377276;12519.186252893533;12630.368481576068;12640.936795315965;12651;12734.80897786534;20204.79795202029;20306.390808275777;20581.794182058286;20643;20863.582728345347;7590.848183036308;7906.802329941683;7909.960450197827;7936.960315198387;7978;939.2110627073291;1058.4654749351528;1081.4592703648175;1165.551262763842;1177.8233265010147;32774.67225327764;32775.34449311048;32944.670553294636;32974.67025329764;33322.83338583291;1090.0788833435734;1113.4154568851418;1118.7594667146602;1131.0047158500631;1185.4783895086307;17222.569435763955;17356.3057477702;17459.563510912074;17571.824281757275;17587.56031099207;497887;498819;500443;502168;505726;40109.1978160441;40256.79871600623;40394;40420;40666;1286.4468278640275;1317.9341032948314;1356.5455572383362;1365.3446345754094;1378.9034767566175;30466.543001854545;32042.19894502656;32598;32776.08358746207;33038.66961330356;51905.22142167795;51942;52000.73999629977;52011.73994130005;52553.21170182527;330090.7963681426;330136;331402;331409;331762;28168.85915570409;29322.56016159802;29335.85332073326;29419;29445.11664650064;48097;48195.51804482051;48352.758236208596;49184.508154917996;49494;40334.39498407467;42468.36297455479;42821.78589107034;43083.569164307955;43331.78334108309;41184.58815411808;41702.79148604238;42104;42467;42971.78514107409;40921.79539102285;41211;41952.160956780084;42040.57959420489;42210.78894605507;33758.49362259617;37273.25453490969;37387.43918841274;37622.435663465614;38028.619713803615;28018.2995425116;28704.13887583376;28902.42195156127;28964.26214427141;28965.56551651769 23:28:27 INFO - PROCESS | 25302 | |2;jquery.html;377.4074702716734;380.8609857402048;382.31374682445;386.8046636448593;397.36620090954915;15561.688766224697;18045.368412105563;19034.428967130974;19763.40709778709;20814.6877796833;17997.820021799776;18759.624807503842;18801.24795008198;18942.905285473553;19093;5527.060399732035;5675.744591493382;5754.3094828620415;5784.623999440023;5865.618734782225;5734.168545560891;5823.767049318022;5856.97071514644;5858.88282234355;5891.88216235675;5852.12218167274;5857.7949771757785;5890.676012819294;5969;5976;6507.4143327100555;6532.771353002622;6553.082568440422;6559.967200163993;6575.539712220123;5591.832245032656;5691.544676425876;5797.652140871562;5803;5804.970975145097;13420.932895335558;13537.18776873381;13572.524961626394;14039.508617198451;23013.079476820905;2141.389703934387;2241.4284357488737;2424.9515009699885;2583.2379448062866;2603.5053339865367;9733.270004749602;9966.501674916226;10125.189984801198;10359.63741269052;10392.79214415715;1882.576420305434;1960.255103060842;2004.9398518044482;2006.8595198336122;2009.387136923238;80758.36350003237;82171;82246.58876705638;82400;82544.58727706384;9747.951260243653;10011.549480273405;10032.648857290105;10062.138504376713;10282.177425806067;12061.216020958609;12469.438875250635;13403.865961340261;13507.797383039262;13590.660233494242;7689.307962283421;7773;7996.56018918965;8021.077576078826;8136.593170341459;7661.195574464601;7877.527348359002;7971.1630278819885;7985.5208687478935;8300.83398332042;4055.0876052887866;4168.499780026416;4240.724352917051;4256.404103425523;4580.290055041474;1834.5138538287365;1837.7886543047453;1860.6929856573513;1898.3450709505198;1943.3101249056665;410.94657694499523;438;449.1735207218668;465.3578062274108;1013.3058854684565;11227.831582526269;11521.884781152248;11879.881201187878;11955.88044119565;12386.194897331645;448.128390280907;452.7532494790347;459.8482500774736;480.3835094905617;494.7427337784332;6265.937340626627;6420.101185833987;6478.384553467413;6492.350764923564;6524.347565243438;488290;493268;495393;504421;509665;59413;84726;87142.56428717816;96396.03603964011;99219.50390248002;469.31011413222507;471.86080106368706;474.28146358267253;475.43185892858395;476.88077980504875;10799;10997.395143267197;11099.611513596985;11294.322340659586;11317.094632429222;38674;39600.40599391069;39835;40193.79903100583;45199.32201017053;52565.21152182644;61263.69368153131;61712;63124.36875631185;63395;6982.231954485104;7237.276272372721;7681.617308884454;8094.757157285291;8184.345252379914;10874.293170943864;12284.570040048555;12295.385230738248;12360.81458778137;12784.424700888296;5785.768569257182;8910.509921954095;9140.405873618194;11063.944680276547;11093.833592496281;10613.09788667972;10706.785864282827;10777.299475534066;10861.294015888941;10977.121830253402;6150.876982460236;9116.407433517066;10943.726406839893;11021.724456888642;11101.50043248072;7136.5004449690105;7247.697335842246;7272.090988626422;7283.053203083778;7415.3326200642205;8240.299574536231;9924.305298629026;10595.576176952836;10762.784744304914;11338.716532086764 23:28:27 INFO - PROCESS | 25302 | |3;mootools.html;1403.1651167555303;1453.8764205042573;1537.5233677559957;1658.9419370322041;1676.455152075575;7288.198298187209;7934.008248968879;8371.204735550113;8410.915890841097;8419.957900210498;8465.365097617672;8640.611172497236;8806.383553151281;8815.471071735685;8846.469211847278;2269.5234000859796;2317.073170731704;2317.6639387288833;2320.6751054852334;2329.1847853251397;2255.3008567344095;2264.1056782570877;2356.304890057437;2361.2089949866813;2371.739108698042;2328.278233747535;2328.4993726348916;2346.718393792739;2351.1653363056125;2362.527494501098;2262.7737226277404;2267.6938613287243;2274.1812947338944;2274.4655006073644;2280.5324908393823;2214.136486770161;2230.453538882984;2233.519793244444;2248.201888329636;2251.538434620899;8438.493690378535;8604.1826026528;8621.13788621139;8623.956880215621;8629.65481380744;5022.296878437021;5144.176931690949;5165;5171.844844654666;5173.32746742921;3249.0902547286796;3301.4057469655454;3436.1066122808;3437.4843773433936;3454.136465883529;1124.7188202949262;1130.9038731707815;1156.5258244119955;1161.8373427720126;1195;11705.3562054087;11751.764964700658;11893.52425902963;11933.761324773543;11937.462814173383;4236.639885609696;4351.82592696295;4542.954570454253;4545.704529205591;4558.202314594932;10186.592536298465;10236.948815255875;10239.385636861663;10251.282410231212;10270.948645256725;5023.874403139877;5044.142495775727;5055.292259083732;5057.898842023139;5065.468125846806;4149.937750933738;4550.681452298373;4598.0803839232285;4694.694844835075;4712;3760.7179461540495;3887.922241555153;3933.272344616255;3941.152652179795;3999.480067591253;1209.4799236328463;1246.993765031169;1254.3352023427599;1265.7531781302741;1277.8274932884128;825.5830805443333;930.8929473110679;941.228192881844;946.6355453150586;985.3742873275378;5740.6268592541355;5808.82573522795;5817.912731309034;5853.414658534112;5979.521638268928;947.1806887042659;987.9675738852916;992.2111921022804;1030.2324768047702;1034.9896501035043;3656.323580137683;3792.639699228569;3890.8638197662945;3892.902677433087;3989.4414781930554;10748.946255268673;10950.561977520969;11085.612003579998;11093.278936869077;11119.499622516845;10768.623098191525;10794.082502987178;10946.890531094587;11015.173861960386;11015.284006539548;8132.024157101067;8188.14024527428;8261.339092872557;8262.545559994138;8304.501729896225;5457.754401051883;5513.58648101386;5633.239512665901;5685.744141513559;5750.079987202028;10095.798084038131;10157.949210254197;10158.44128572906;10222.080012798884;10256;9654.662086826927;10061.798764024532;10076.596936122767;10271.691849244535;10367.32612380193;7065.470089743187;7727.304542591194;7870.331021863206;7961.72133975308;8072.677092916218;8886.688965886164;8949.015608283215;8952.552372381486;8954;8958.552072396484;7706.576138312446;7738.187490313661;7821.882671759814;7999.720009799629;8036.035675718951;7645.120811106572;7650.655720492702;7712.074551053685;7743.496672716481;7853.332466740391;7059.2940705928995;7177.354038136593;7182.245864184394;7193.928060719326;7242.746503872339;5070.873228169326;5136;5147.794088236428;5151.5363617274625;5336.146216605324;4807.4471435785335;4915.4592994771265;4988.201887697951;5043.092243396224;5083.92374114396 23:28:27 INFO - PROCESS | 25302 | |4;prototype.html;306.8435098099968;315.3771301679183;317.0994375972238;321.7924438737013;324.10708498087774;5386.757595908184;5487.807926722566;5512.944870551299;5579.33048034236;5581.218629391883;5436.130219164935;5504.339479262484;5515.531179849718;5520.530754885839;5533.6956467394375;4328.935065974013;4336.956630433687;4383.298672212447;4384.079343337903;4400.889977750549;4108.116754897696;4317.69776115672;4330.462685746546;4395.560443955595;4400.713953593022;4273.957260427403;4282.601743023916;4290.206311832306;4291.6566674665955;4298.226319262531;4303.763293018883;4317.848875289365;4319.460067491579;4326.048269380763;4327.545607711177;3692.538432695913;3726.329260733067;3791.905202369935;3799.3161230978412;3803.7717736935597;5311.787528498855;5379.892402151974;5386.892262154735;5388.6828663674605;5418.349798024223;4886.438059623153;4895.192293271606;4908.263760435928;4910.901781964377;4921.8523444296725;5517.724113794335;5734.4803627038455;5765.434381700145;5775.768969241225;5782.7108644568025;4068.8982775430554;4078.673706103534;4079.4900637420324;4103.589641035873;4103.651189648884;5989.9101513477335;6049.788257411014;6082.452579267843;6090.512758979316;6099.5425343099005;4105.029585798774;4138.317177665712;4170.72890262132;4199.622034016892;4229.682773791917;4216.198922204771;4236.9364459533135;4238.470191226097;4244.87265382039;4251.87244382669;4871.878203044881;4874.53691899269;4876.829310974099;4883.560479556857;4891.192953162759;5589.74846131925;5845.9707701462075;5875.618084824473;5893.5579831512805;5898;1447.2185020089244;1466.2668665667165;1467.9633009174856;1469.4489566412594;1469.5003698742478;902.3277658144724;927.1470247372433;931.5668214280392;943.4009404028354;951.4529145741227;4956.290079922421;4957.454679985199;5030;5031.144705400091;5037.899242015139;5202.3497062867145;5309.628326017219;5329.520343169133;5351.655215490318;5372.650777699437;5004.624653151028;5007.724575148329;5061.73456635841;5273.920891186635;5712.171735098387;3149.7480201583817;3171.920701982469;3180.332130252673;3180.427523045828;3185.347003864202;6040.426159514839;6137.41694539018;6155.538334624921;6188.783392581328;6224.502039836802;6005.888910551562;6050.183225264621;6062.545309101747;6071.392860713893;6084.787032453843;6151.5386346024225;6171.574775999364;6189.783357582463;6211.81364559064;6213.2233470816145;5780.913286300793;5790.276215473066;5859.648421094748;5898.55760817949;5926.67403292823;5878.2064421304285;5879.176915231957;5880.323762767336;5886.440788125121;5894.410558944071;5854;6151.815445536641;6166.660833654192;6174.166487524127;6230.252369715663;4152.667786577127;4189.97905010473;4197.790110494524;4205.264078786261;4207.4109624651965;5954.910676339945;6055.515558755377;6057.606255593372;6083.939160608337;6095.329513753395;5709.54323654115;5838.241028666246;5850.882982340415;5880.94119058804;5889.293284805851;5833.416658334133;5843.094320380348;5861.32594751609;5862;5869.970650146722;5710.714464276853;5743.224664670216;5746.8506298739585;5785.450382213683;5814.296352196249;5714.885702286014;5820.187777006068;5828.388019257917;5832.687645279778;5842.649441033552;5680.204771331934;5744.770209191585;5746.885062298814;5751.4536119068625;5757.366689664217 23:28:27 INFO - PROCESS | 25302 | |5;yui.html;765.406809722465;786.9331106855917;802.8996375453069;813.8250276190618;848.6011574559957;13812.58562243133;14819.036762610423;14836.777448338284;14864.479743208989;14873.628159296022;15090.09459432432;15182.772258416106;15189.620259493518;15211.923940380282;15221;647.7959442775534;758.4993904023346;786.5713186313459;805.9274665280124;809.3323008517996;774.0440555913442;797.6809276289501;797.7128233835814;798.9201079891993;801.5831767480936;844.0588743550927;844.8732690096473;852.9701460448886;853.5860107847689;855.6620135046653;833.7707130539089;841.4026041510505;842.7050532313702;845.8054647431095;847.5126802088793;622.5766478794418;622.9719662615194;623.4264476681464;624.0202881476084;626.7712285015937;15517.456889008943;15700.136492492908;15731.68536629261;15758;15836.287367068395;13797.655058623513;13835.30823458823;14204.715905681931;14288.57134285973;16553.503394898173;13382.263975481344;13489.051677280037;13713.931430342884;14061.086029408158;14476.131432114107;4547.15877562652;4559.840405585788;4562.520935301779;4722.881927951795;4790.80836766529;74757.6262118686;81028.59485702592;83084;83806;84670.57664711699;11433.599824006285;11443.427828608535;11489.138314626436;11673.182877198684;12035.518579256906;20778.896105519678;20825.271115510885;20930.476738081365;20992.956021376816;21036.789632103788;8692.78268043304;8704.869426958601;8771.079036701054;9134.451932883916;9143.54282285883;4725.621950243973;4905.264210368402;5008.64939454242;5027.773750181251;5070;3470.340635279289;3495.7552971291766;3530.505729197914;3535.328287625343;3551.7691350062164;596.4989408896548;609.20194545146;610.91141784441;618.2333905956582;619.6127420362274;588.6997631208114;610.5634471352915;673.9764108256187;685.324954919404;709.4218212157178;9073.228775554151;9445.811083778286;9756.658516951873;9774.95112524447;9824.214062875095;688.2669956496316;697.4072038767109;697.8150790040643;709.3615745828795;724.0731863215093;4626.4910859805395;4676.134915040729;4684.836030738976;4687.62499000086;4690.366800481959;66297;73142;111646.44176779065;118274.4086279563;121670;87766.12233877707;100450;104219.478902605;105096.47451762692;105565.47217263865;78693.60653196697;84848.57575712082;86052.56973715092;91382.54308728414;92852;9909.405435673883;10081.294309398272;10166.796664066826;10439.791204176026;10698.090662293793;51025;51732.48267517427;51959.740201300265;52728.47271527236;53024;72043.27956720366;75776;78656.60671696605;79592;81596;13484.932575337061;13634.318284085954;13701.657458563615;13976.440942362598;14013.369398377301;15505.844941550891;15668.451604193799;15675.451359202374;15772.211389430711;16442.424515141913;14368.209748463934;14453.855461445251;15217.543473695807;15649.374025038871;15654;13572.389242483914;14475.420983160555;14644.341004654603;14710.338034788674;15303.234838258266;13914.234717090252;13963.092398994033;13993.720125597227;14018.719625607635;14467.223941899803;11724.58963936258;12193;12201.267923924594;12270;12512.37438128108;10584.312019718695;10678.8398174029;10969.526888331442;12166.57416990401;12632.494700211888 23:28:27 INFO - PROCESS | 25302 | __end_tp_report 23:28:27 INFO - PROCESS | 25302 | __start_cc_report 23:28:27 INFO - PROCESS | 25302 | _x_x_mozilla_cycle_collect,331 23:28:27 INFO - PROCESS | 25302 | __end_cc_report 23:28:27 INFO - PROCESS | 25302 | __startTimestamp1469773707315__endTimestamp 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | ------- Summary: start ------- 23:28:27 INFO - PROCESS | 25302 | Number of tests: 6 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | [#0] dojo.html Cycles:165 Average:5309.27 Median:5519.61 stddev:698.04 (12.6%) stddev-sans-first:677.63 23:28:27 INFO - PROCESS | 25302 | Values: 3065.6 3089.3 3100.7 3112.0 3117.3 5158.1 5320.3 5401.2 5417.0 5494.8 5320.4 5383.6 5403.0 5413.1 5416.6 4771.1 4808.1 4848.3 4870.7 4923.6 4920.2 4951.3 4989.1 4995.1 5004.4 699.8 4867.1 4982.3 4994.1 5052.1 4952.8 4965.2 4975.0 4985.5 5002.1 4905.5 4910.3 4919.6 4921.0 4970.6 5141.2 5241.3 5242.5 5265.3 5265.4 5602.9 5628.2 5635.7 5669.4 5694.7 5726.7 5728.2 5732.1 5752.0 5758.7 5188.4 5335.2 5336.1 5345.8 5346.1 5797.4 5835.6 5856.9 5903.0 5942.5 5657.0 5663.6 5668.1 5671.3 5686.2 5584.1 5751.9 5755.4 5781.8 5785.5 5637.7 5711.7 5719.5 5781.6 5830.4 5759.4 5760.7 5767.3 5795.9 5798.4 4349.9 4428.9 4441.9 4461.3 4501.6 3862.3 3906.5 3908.6 3911.7 3958.7 5465.5 5481.2 5487.0 5499.5 5500.6 5622.5 5661.6 5710.6 5756.4 5763.1 5427.0 5452.6 5471.0 5474.6 5477.5 4911.4 4926.3 4936.3 4949.0 4950.8 5838.1 5865.4 5908.9 5916.7 5924.7 5702.1 5740.3 5751.5 5795.2 5810.2 5964.6 5970.8 5980.9 5992.1 5996.2 5484.9 5523.6 5619.6 5636.2 5657.7 5720.3 5813.5 5818.6 5845.1 5883.3 5612.3 5655.4 5657.3 5661.5 5668.2 5424.2 5521.8 5608.4 5648.7 5651.7 5507.6 5516.1 5519.6 5536.3 5580.3 5595.3 5599.2 5607.0 5631.9 5645.4 5413.8 5442.5 5482.4 5510.8 5578.7 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | [#1] ext.html Cycles:180 Average:56930.78 Median:41053.19 stddev:108307.08 (263.8%) stddev-sans-first:108528.24 23:28:27 INFO - PROCESS | 25302 | Values: 569.4 601.9 603.4 617.3 652.7 40904.8 45628.8 45782.5 45855.8 45946.8 45168.5 45463.3 45718.1 45909.3 46040.5 8903.3 9046.2 9059.2 9082.2 9107.8 8971.3 9076.2 9079.0 9082.6 9096.3 9038.6 9091.4 9099.5 9122.1 9136.7 9004.0 9057.0 9063.8 9091.8 9102.6 8928.8 9005.0 9008.4 9019.5 9042.8 42990.6 43530.8 43694.6 43882.1 43889.8 2986.9 2998.5 3281.1 3511.7 3639.1 33608.7 33644.5 34362.8 34845.3 35629.0 4366.3 4389.9 4518.7 4521.1 4559.2 372631.0 375921.0 379390.0 381386.1 385051.0 65161.7 65985.7 66271.0 66290.7 66311.0 36363.5 36967.8 37317.8 39776.6 69619.7 17317.2 17333.8 17479.1 17502.6 17509.1 12519.2 12630.4 12640.9 12651.0 12734.8 20204.8 20306.4 20581.8 20643.0 20863.6 7590.8 7906.8 7910.0 7937.0 7978.0 939.2 1058.5 1081.5 1165.6 1177.8 32774.7 32775.3 32944.7 32974.7 33322.8 1090.1 1113.4 1118.8 1131.0 1185.5 17222.6 17356.3 17459.6 17571.8 17587.6 497887.0 498819.0 500443.0 502168.0 505726.0 40109.2 40256.8 40394.0 40420.0 40666.0 1286.4 1317.9 1356.5 1365.3 1378.9 30466.5 32042.2 32598.0 32776.1 33038.7 51905.2 51942.0 52000.7 52011.7 52553.2 330090.8 330136.0 331402.0 331409.0 331762.0 28168.9 29322.6 29335.9 29419.0 29445.1 48097.0 48195.5 48352.8 49184.5 49494.0 40334.4 42468.4 42821.8 43083.6 43331.8 41184.6 41702.8 42104.0 42467.0 42971.8 40921.8 41211.0 41952.2 42040.6 42210.8 33758.5 37273.3 37387.4 37622.4 38028.6 28018.3 28704.1 28902.4 28964.3 28965.6 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | [#2] jquery.html Cycles:180 Average:27970.95 Median:2520.07 stddev:82265.88 (3264.4%) stddev-sans-first:82470.57 23:28:27 INFO - PROCESS | 25302 | Values: 377.4 380.9 382.3 386.8 397.4 15561.7 18045.4 19034.4 19763.4 20814.7 17997.8 18759.6 18801.2 18942.9 19093.0 5527.1 5675.7 5754.3 5784.6 5865.6 5734.2 5823.8 5857.0 5858.9 5891.9 5852.1 5857.8 5890.7 5969.0 5976.0 6507.4 6532.8 6553.1 6560.0 6575.5 5591.8 5691.5 5797.7 5803.0 5805.0 13420.9 13537.2 13572.5 14039.5 23013.1 2141.4 2241.4 2425.0 2583.2 2603.5 9733.3 9966.5 10125.2 10359.6 10392.8 1882.6 1960.3 2004.9 2006.9 2009.4 80758.4 82171.0 82246.6 82400.0 82544.6 9748.0 10011.5 10032.6 10062.1 10282.2 12061.2 12469.4 13403.9 13507.8 13590.7 7689.3 7773.0 7996.6 8021.1 8136.6 7661.2 7877.5 7971.2 7985.5 8300.8 4055.1 4168.5 4240.7 4256.4 4580.3 1834.5 1837.8 1860.7 1898.3 1943.3 410.9 438.0 449.2 465.4 1013.3 11227.8 11521.9 11879.9 11955.9 12386.2 448.1 452.8 459.8 480.4 494.7 6265.9 6420.1 6478.4 6492.4 6524.3 488290.0 493268.0 495393.0 504421.0 509665.0 59413.0 84726.0 87142.6 96396.0 99219.5 469.3 471.9 474.3 475.4 476.9 10799.0 10997.4 11099.6 11294.3 11317.1 38674.0 39600.4 39835.0 40193.8 45199.3 52565.2 61263.7 61712.0 63124.4 63395.0 6982.2 7237.3 7681.6 8094.8 8184.3 10874.3 12284.6 12295.4 12360.8 12784.4 5785.8 8910.5 9140.4 11063.9 11093.8 10613.1 10706.8 10777.3 10861.3 10977.1 6150.9 9116.4 10943.7 11021.7 11101.5 7136.5 7247.7 7272.1 7283.1 7415.3 8240.3 9924.3 10595.6 10762.8 11338.7 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | [#3] mootools.html Cycles:180 Average:5737.19 Median:4548.19 stddev:3281.85 (72.2%) stddev-sans-first:3274.89 23:28:27 INFO - PROCESS | 25302 | Values: 1403.2 1453.9 1537.5 1658.9 1676.5 7288.2 7934.0 8371.2 8410.9 8420.0 8465.4 8640.6 8806.4 8815.5 8846.5 2269.5 2317.1 2317.7 2320.7 2329.2 2255.3 2264.1 2356.3 2361.2 2371.7 2328.3 2328.5 2346.7 2351.2 2362.5 2262.8 2267.7 2274.2 2274.5 2280.5 2214.1 2230.5 2233.5 2248.2 2251.5 8438.5 8604.2 8621.1 8624.0 8629.7 5022.3 5144.2 5165.0 5171.8 5173.3 3249.1 3301.4 3436.1 3437.5 3454.1 1124.7 1130.9 1156.5 1161.8 1195.0 11705.4 11751.8 11893.5 11933.8 11937.5 4236.6 4351.8 4543.0 4545.7 4558.2 10186.6 10236.9 10239.4 10251.3 10270.9 5023.9 5044.1 5055.3 5057.9 5065.5 4149.9 4550.7 4598.1 4694.7 4712.0 3760.7 3887.9 3933.3 3941.2 3999.5 1209.5 1247.0 1254.3 1265.8 1277.8 825.6 930.9 941.2 946.6 985.4 5740.6 5808.8 5817.9 5853.4 5979.5 947.2 988.0 992.2 1030.2 1035.0 3656.3 3792.6 3890.9 3892.9 3989.4 10748.9 10950.6 11085.6 11093.3 11119.5 10768.6 10794.1 10946.9 11015.2 11015.3 8132.0 8188.1 8261.3 8262.5 8304.5 5457.8 5513.6 5633.2 5685.7 5750.1 10095.8 10157.9 10158.4 10222.1 10256.0 9654.7 10061.8 10076.6 10271.7 10367.3 7065.5 7727.3 7870.3 7961.7 8072.7 8886.7 8949.0 8952.6 8954.0 8958.6 7706.6 7738.2 7821.9 7999.7 8036.0 7645.1 7650.7 7712.1 7743.5 7853.3 7059.3 7177.4 7182.2 7193.9 7242.7 5070.9 5136.0 5147.8 5151.5 5336.1 4807.4 4915.5 4988.2 5043.1 5083.9 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | [#4] prototype.html Cycles:180 Average:4838.84 Median:5461.97 stddev:1435.00 (26.3%) stddev-sans-first:1398.13 23:28:27 INFO - PROCESS | 25302 | Values: 306.8 315.4 317.1 321.8 324.1 5386.8 5487.8 5512.9 5579.3 5581.2 5436.1 5504.3 5515.5 5520.5 5533.7 4328.9 4337.0 4383.3 4384.1 4400.9 4108.1 4317.7 4330.5 4395.6 4400.7 4274.0 4282.6 4290.2 4291.7 4298.2 4303.8 4317.8 4319.5 4326.0 4327.5 3692.5 3726.3 3791.9 3799.3 3803.8 5311.8 5379.9 5386.9 5388.7 5418.3 4886.4 4895.2 4908.3 4910.9 4921.9 5517.7 5734.5 5765.4 5775.8 5782.7 4068.9 4078.7 4079.5 4103.6 4103.7 5989.9 6049.8 6082.5 6090.5 6099.5 4105.0 4138.3 4170.7 4199.6 4229.7 4216.2 4236.9 4238.5 4244.9 4251.9 4871.9 4874.5 4876.8 4883.6 4891.2 5589.7 5846.0 5875.6 5893.6 5898.0 1447.2 1466.3 1468.0 1469.4 1469.5 902.3 927.1 931.6 943.4 951.5 4956.3 4957.5 5030.0 5031.1 5037.9 5202.3 5309.6 5329.5 5351.7 5372.7 5004.6 5007.7 5061.7 5273.9 5712.2 3149.7 3171.9 3180.3 3180.4 3185.3 6040.4 6137.4 6155.5 6188.8 6224.5 6005.9 6050.2 6062.5 6071.4 6084.8 6151.5 6171.6 6189.8 6211.8 6213.2 5780.9 5790.3 5859.6 5898.6 5926.7 5878.2 5879.2 5880.3 5886.4 5894.4 5854.0 6151.8 6166.7 6174.2 6230.3 4152.7 4190.0 4197.8 4205.3 4207.4 5954.9 6055.5 6057.6 6083.9 6095.3 5709.5 5838.2 5850.9 5880.9 5889.3 5833.4 5843.1 5861.3 5862.0 5870.0 5710.7 5743.2 5746.9 5785.5 5814.3 5714.9 5820.2 5828.4 5832.7 5842.6 5680.2 5744.8 5746.9 5751.5 5757.4 23:28:27 INFO - PROCESS | 25302 | 23:28:27 INFO - PROCESS | 25302 | [#5] yui.html Cycles:180 Average:20919.12 Median:4680.49 stddev:29398.46 (628.1%) stddev-sans-first:29441.98 23:28:27 INFO - PROCESS | 25302 | Values: 765.4 786.9 802.9 813.8 848.6 13812.6 14819.0 14836.8 14864.5 14873.6 15090.1 15182.8 15189.6 15211.9 15221.0 647.8 758.5 786.6 805.9 809.3 774.0 797.7 797.7 798.9 801.6 844.1 844.9 853.0 853.6 855.7 833.8 841.4 842.7 845.8 847.5 622.6 623.0 623.4 624.0 626.8 15517.5 15700.1 15731.7 15758.0 15836.3 13797.7 13835.3 14204.7 14288.6 16553.5 13382.3 13489.1 13713.9 14061.1 14476.1 4547.2 4559.8 4562.5 4722.9 4790.8 74757.6 81028.6 83084.0 83806.0 84670.6 11433.6 11443.4 11489.1 11673.2 12035.5 20778.9 20825.3 20930.5 20993.0 21036.8 8692.8 8704.9 8771.1 9134.5 9143.5 4725.6 4905.3 5008.6 5027.8 5070.0 3470.3 3495.8 3530.5 3535.3 3551.8 596.5 609.2 610.9 618.2 619.6 588.7 610.6 674.0 685.3 709.4 9073.2 9445.8 9756.7 9775.0 9824.2 688.3 697.4 697.8 709.4 724.1 4626.5 4676.1 4684.8 4687.6 4690.4 66297.0 73142.0 111646.4 118274.4 121670.0 87766.1 100450.0 104219.5 105096.5 105565.5 78693.6 84848.6 86052.6 91382.5 92852.0 9909.4 10081.3 10166.8 10439.8 10698.1 51025.0 51732.5 51959.7 52728.5 53024.0 72043.3 75776.0 78656.6 79592.0 81596.0 13484.9 13634.3 13701.7 13976.4 14013.4 15505.8 15668.5 15675.5 15772.2 16442.4 14368.2 14453.9 15217.5 15649.4 15654.0 13572.4 14475.4 14644.3 14710.3 15303.2 13914.2 13963.1 13993.7 14018.7 14467.2 11724.6 12193.0 12201.3 12270.0 12512.4 10584.3 10678.8 10969.5 12166.6 12632.5 23:28:27 INFO - PROCESS | 25302 | -------- Summary: end -------- 23:28:27 INFO - PROCESS | 25302 | 23:28:28 INFO - TEST-INFO | 25302: exit 0 23:28:28 INFO - TEST-OK | dromaeo_css | took 1111305ms 23:28:28 INFO - TEST-START | kraken 23:28:28 INFO - operating with platform_type : linux_ 23:28:28 INFO - Initialising browser for kraken test... 23:28:28 INFO - TEST-INFO | started process 25545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22bSsa/profile http://localhost:35823/getInfo.html) 23:28:31 INFO - PROCESS | 25545 | JavaScript error: , line 0: uncaught exception: undefined 23:28:32 INFO - PROCESS | 25545 | __metrics Screen width/height:1600/1200 23:28:32 INFO - PROCESS | 25545 | colorDepth:24 23:28:32 INFO - PROCESS | 25545 | Browser inner width/height: 1024/697 23:28:32 INFO - PROCESS | 25545 | __metrics 23:28:33 ERROR - PROCESS | 25545 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 23:28:33 INFO - TEST-INFO | 25545: exit 0 23:28:33 INFO - Browser initialized. 23:28:33 INFO - Running cycle 1/1 for kraken test... 23:28:33 INFO - TEST-INFO | started process 25666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22bSsa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:45 INFO - PROCESS | 25666 | RSS: Main: 165289984 23:28:45 INFO - PROCESS | 25666 | 23:28:48 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35823/tests/kraken/driver.html?testName=audio-beat-detection) 23:28:49 INFO - PROCESS | 25666 | RSS: Main: 170868736 23:28:49 INFO - PROCESS | 25666 | 23:28:51 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35823/tests/kraken/driver.html?testName=audio-dft) 23:28:52 INFO - PROCESS | 25666 | RSS: Main: 169914368 23:28:52 INFO - PROCESS | 25666 | 23:28:55 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35823/tests/kraken/driver.html?testName=audio-fft) 23:28:56 INFO - PROCESS | 25666 | RSS: Main: 165580800 23:28:56 INFO - PROCESS | 25666 | 23:28:58 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35823/tests/kraken/driver.html?testName=audio-oscillator) 23:28:58 INFO - PROCESS | 25666 | RSS: Main: 166793216 23:28:58 INFO - PROCESS | 25666 | 23:29:00 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:01 INFO - PROCESS | 25666 | RSS: Main: 166920192 23:29:01 INFO - PROCESS | 25666 | 23:29:04 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35823/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:05 INFO - PROCESS | 25666 | RSS: Main: 167153664 23:29:05 INFO - PROCESS | 25666 | 23:29:08 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35823/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:09 INFO - PROCESS | 25666 | RSS: Main: 168239104 23:29:09 INFO - PROCESS | 25666 | 23:29:12 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35823/tests/kraken/driver.html?testName=json-parse-financial) 23:29:12 INFO - PROCESS | 25666 | RSS: Main: 167763968 23:29:12 INFO - PROCESS | 25666 | 23:29:14 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:14 INFO - PROCESS | 25666 | RSS: Main: 167436288 23:29:14 INFO - PROCESS | 25666 | 23:29:16 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:17 INFO - PROCESS | 25666 | RSS: Main: 167772160 23:29:17 INFO - PROCESS | 25666 | 23:29:19 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:20 INFO - PROCESS | 25666 | RSS: Main: 168394752 23:29:20 INFO - PROCESS | 25666 | 23:29:22 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:23 INFO - PROCESS | 25666 | RSS: Main: 167911424 23:29:23 INFO - PROCESS | 25666 | 23:29:26 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:26 INFO - PROCESS | 25666 | RSS: Main: 168476672 23:29:26 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:35823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35823/tests/kraken/driver.html?testName=ai-astar) 23:29:28 INFO - PROCESS | 25666 | RSS: Main: 169193472 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | __start_tp_report 23:29:28 INFO - PROCESS | 25666 | _x_x_mozilla_page_load 23:29:28 INFO - PROCESS | 25666 | _x_x_mozilla_page_load_details 23:29:28 INFO - PROCESS | 25666 | |i|pagename|runs| 23:29:28 INFO - PROCESS | 25666 | |0;ai-astar;102;113;106;111;111;110;111;112;111;110 23:29:28 INFO - PROCESS | 25666 | |1;audio-beat-detection;151;118;148;178;132;148;149;124;182;117 23:29:28 INFO - PROCESS | 25666 | |2;audio-dft;164;163;164;162;163;176;163;164;162;162 23:29:28 INFO - PROCESS | 25666 | |3;audio-fft;75;75;76;177;76;77;76;76;156;75 23:29:28 INFO - PROCESS | 25666 | |4;audio-oscillator;83;83;153;85;84;85;138;85;85;142 23:29:28 INFO - PROCESS | 25666 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;118;118;117 23:29:28 INFO - PROCESS | 25666 | |6;imaging-darkroom;147;147;149;148;148;147;147;147;149;147 23:29:28 INFO - PROCESS | 25666 | |7;imaging-desaturate;95;97;95;96;96;96;95;96;96;95 23:29:28 INFO - PROCESS | 25666 | |8;json-parse-financial;53;52;58;58;55;53;54;53;54;54 23:29:28 INFO - PROCESS | 25666 | |9;json-stringify-tinderbox;65;64;64;65;65;64;67;66;64;66 23:29:28 INFO - PROCESS | 25666 | |10;stanford-crypto-aes;78;77;76;79;78;77;78;76;82;75 23:29:28 INFO - PROCESS | 25666 | |11;stanford-crypto-ccm;130;126;131;128;121;124;128;123;173;134 23:29:28 INFO - PROCESS | 25666 | |12;stanford-crypto-pbkdf2;164;159;158;158;158;158;162;159;164;158 23:29:28 INFO - PROCESS | 25666 | |13;stanford-crypto-sha256-iterative;67;64;65;64;64;66;63;64;64;62 23:29:28 INFO - PROCESS | 25666 | __end_tp_report 23:29:28 INFO - PROCESS | 25666 | __start_cc_report 23:29:28 INFO - PROCESS | 25666 | _x_x_mozilla_cycle_collect,897 23:29:28 INFO - PROCESS | 25666 | __end_cc_report 23:29:28 INFO - PROCESS | 25666 | __startTimestamp1469773768621__endTimestamp 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | ------- Summary: start ------- 23:29:28 INFO - PROCESS | 25666 | Number of tests: 14 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.27 (2.9%) stddev-sans-first:1.94 23:29:28 INFO - PROCESS | 25666 | Values: 102.0 113.0 106.0 111.0 111.0 110.0 111.0 112.0 111.0 110.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:148.50 stddev:22.73 (15.3%) stddev-sans-first:23.99 23:29:28 INFO - PROCESS | 25666 | Values: 151.0 118.0 148.0 178.0 132.0 148.0 149.0 124.0 182.0 117.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:4.19 (2.6%) stddev-sans-first:4.44 23:29:28 INFO - PROCESS | 25666 | Values: 164.0 163.0 164.0 162.0 163.0 176.0 163.0 164.0 162.0 162.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.59 (50.8%) stddev-sans-first:40.32 23:29:28 INFO - PROCESS | 25666 | Values: 75.0 75.0 76.0 177.0 76.0 77.0 76.0 76.0 156.0 75.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.50 stddev:29.25 (34.6%) stddev-sans-first:30.17 23:29:28 INFO - PROCESS | 25666 | Values: 83.0 83.0 153.0 85.0 84.0 85.0 138.0 85.0 85.0 142.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:29:28 INFO - PROCESS | 25666 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 23:29:28 INFO - PROCESS | 25666 | Values: 147.0 147.0 149.0 148.0 148.0 147.0 147.0 147.0 149.0 147.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 23:29:28 INFO - PROCESS | 25666 | Values: 95.0 97.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.07 (3.8%) stddev-sans-first:2.13 23:29:28 INFO - PROCESS | 25666 | Values: 53.0 52.0 58.0 58.0 55.0 53.0 54.0 53.0 54.0 54.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 23:29:28 INFO - PROCESS | 25666 | Values: 65.0 64.0 64.0 65.0 65.0 64.0 67.0 66.0 64.0 66.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:1.96 (2.5%) stddev-sans-first:2.07 23:29:28 INFO - PROCESS | 25666 | Values: 78.0 77.0 76.0 79.0 78.0 77.0 78.0 76.0 82.0 75.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:129.00 stddev:14.99 (11.6%) stddev-sans-first:15.89 23:29:28 INFO - PROCESS | 25666 | Values: 130.0 126.0 131.0 128.0 121.0 124.0 128.0 123.0 173.0 134.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:159.00 stddev:2.53 (1.6%) stddev-sans-first:2.18 23:29:28 INFO - PROCESS | 25666 | Values: 164.0 159.0 158.0 158.0 158.0 158.0 162.0 159.0 164.0 158.0 23:29:28 INFO - PROCESS | 25666 | 23:29:28 INFO - PROCESS | 25666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.12 23:29:28 INFO - PROCESS | 25666 | Values: 67.0 64.0 65.0 64.0 64.0 66.0 63.0 64.0 64.0 62.0 23:29:28 INFO - PROCESS | 25666 | -------- Summary: end -------- 23:29:28 INFO - PROCESS | 25666 | 23:29:29 INFO - TEST-INFO | 25666: exit 0 23:29:29 INFO - TEST-OK | kraken | took 61532ms 23:29:29 INFO - SUITE-END | took 1172s 23:29:29 INFO - Completed test suite (00:19:33) 23:29:29 INFO - javascript benchmark 23:29:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7121.217669561729, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.6014718086644, 3089.3357928045466, 3100.689931006899, 3111.95332070019, 3117.2518595537063, 5158.123119069758, 5320.334958130234, 5401.162819762933, 5416.970775552642, 5494.80768173114, 5320.388155362135, 5383.623146379755, 5402.9729851350685, 5413.133898576229, 5416.593755468336, 4771.141194584973, 4808.062427826558, 4848.296996935443, 4870.659053866213, 4923.606111511071, 4920.188168952119, 4951.282064100703, 4989.077020751154, 4995.100881841267, 5004.449510553836, 699.771711246667, 4867.075255701406, 4982.327385802906, 4994.051130285252, 5052.0906236877345, 4952.801887924478, 4965.180745177042, 4974.950250497521, 4985.52637499437, 5002.099622068026, 4905.509449055102, 4910.288008238821, 4919.581835543983, 4920.991196804646, 4970.577500912391, 5141.2288156776785, 5241.31862857826, 5242.501962313574, 5265.289185959885, 5265.447128051538, 5602.943970560283, 5628.240187574666, 5635.71821408932, 5669.404712505168, 5694.715264236813, 5726.742296596663, 5728.22668939692, 5732.140178973145, 5752.0, 5758.740856661419, 5188.351456067991, 5335.19553072625, 5336.146216605324, 5345.786168553253, 5346.091164502005, 5797.420257974169, 5835.562332825055, 5856.853578660568, 5903.0, 5942.524598032147, 5656.971715141398, 5663.631863928831, 5668.064769313017, 5671.347795003545, 5686.2039314496005, 5584.078627026495, 5751.913721294184, 5755.395683453177, 5781.768729250867, 5785.50823180026, 5637.661740295595, 5711.657300561979, 5719.5138413235345, 5781.624194427349, 5830.4461076197695, 5759.424057594207, 5760.74076666551, 5767.279090113736, 5795.913061304083, 5798.362180160179, 4349.9130017399475, 4428.889277768081, 4441.866743997685, 4461.308497182942, 4501.594856462934, 3862.2854771867296, 3906.531216254011, 3908.6286802753693, 3911.7457365271166, 3958.7030972677167, 5465.453454654503, 5481.150421684565, 5487.039768040657, 5499.532539734088, 5500.614956952975, 5622.46586574283, 5661.575381846378, 5710.628809127394, 5756.42435756421, 5763.106718458645, 5426.996005738951, 5452.618316717871, 5470.972645136749, 5474.562035037187, 5477.507024367826, 4911.435184953776, 4926.285688575136, 4936.284238785428, 4948.950510494849, 4950.752462376867, 5838.095095260242, 5865.442782935615, 5908.940910590925, 5916.674582897982, 5924.703764811742, 5702.059160238514, 5740.253767010262, 5751.482366587027, 5795.217645617788, 5810.1575271586225, 5964.552658550713, 5970.76116955317, 5980.9401905980385, 5992.13114098462, 5996.190514280516, 5484.917726234189, 5523.585731070106, 5619.578531610227, 5636.210930469655, 5657.660540367591, 5720.313562372542, 5813.505852002627, 5818.592698511064, 5845.064789633639, 5883.29400471929, 5612.270404847507, 5655.377908430151, 5657.264555607745, 5661.46216109469, 5668.234788303526, 5424.2406063151975, 5521.751521181637, 5608.4111168326735, 5648.689322087324, 5651.689157096234, 5507.586930980113, 5516.117421212587, 5519.613627046228, 5536.307961504812, 5580.274564306615, 5595.328560572757, 5599.216109744558, 5607.0, 5631.943680563142, 5645.4072322405555, 5413.756380962787, 5442.455754424526, 5482.39693633692, 5510.8071217507195, 5578.721063946868], "value": 5264.854381486508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3509399284816, 601.8805022657856, 603.354410780465, 617.3240301869453, 652.6508318049845, 40904.79547602261, 45628.77185614075, 45782.542174578244, 45855.770721146386, 45946.770266148626, 45168.54831451693, 45463.318050229274, 45718.085638287215, 45909.31136032962, 46040.539594604044, 8903.332250081237, 9046.231070359026, 9059.184673379394, 9082.182603565678, 9107.772305692377, 8971.282297416192, 9076.183143517082, 9079.046700096495, 9082.59128339223, 9096.317776166781, 9038.638454461814, 9091.409058411182, 9099.545022748869, 9122.133397327243, 9136.725898223063, 9004.0, 9056.954715226448, 9063.773405664846, 9091.818163636757, 9102.63589456421, 8928.776780580472, 9004.954975225082, 9008.414453060595, 9019.549022548847, 9042.819143617156, 42990.57009429897, 43530.78234608838, 43694.56305436968, 43882.12235755267, 43889.78055109736, 2986.9103926882012, 2998.4602771501122, 3281.1305004173673, 3511.719062474996, 3639.053846000059, 33608.6639133608, 33644.49533257003, 34362.82818585916, 34845.30309393823, 35629.0, 4366.345048242757, 4389.912201755979, 4518.728876267434, 4521.118381915528, 4559.202139625585, 372631.0, 375921.0, 379390.0, 381386.0930695357, 385051.0, 65161.674191628736, 65985.67007164934, 66271.02373857488, 66290.66854665696, 66311.0, 36363.4545481818, 36967.81516092456, 37317.81341093331, 39776.60223397787, 69619.65190174017, 17317.220725067404, 17333.826661733223, 17479.126043697765, 17502.649947000988, 17509.12454377276, 12519.186252893533, 12630.368481576068, 12640.936795315965, 12651.0, 12734.80897786534, 20204.79795202029, 20306.390808275777, 20581.794182058286, 20643.0, 20863.582728345347, 7590.848183036308, 7906.802329941683, 7909.960450197827, 7936.960315198387, 7978.0, 939.2110627073291, 1058.4654749351528, 1081.4592703648175, 1165.551262763842, 1177.8233265010147, 32774.67225327764, 32775.34449311048, 32944.670553294636, 32974.67025329764, 33322.83338583291, 1090.0788833435734, 1113.4154568851418, 1118.7594667146602, 1131.0047158500631, 1185.4783895086307, 17222.569435763955, 17356.3057477702, 17459.563510912074, 17571.824281757275, 17587.56031099207, 497887.0, 498819.0, 500443.0, 502168.0, 505726.0, 40109.1978160441, 40256.79871600623, 40394.0, 40420.0, 40666.0, 1286.4468278640275, 1317.9341032948314, 1356.5455572383362, 1365.3446345754094, 1378.9034767566175, 30466.543001854545, 32042.19894502656, 32598.0, 32776.08358746207, 33038.66961330356, 51905.22142167795, 51942.0, 52000.73999629977, 52011.73994130005, 52553.21170182527, 330090.7963681426, 330136.0, 331402.0, 331409.0, 331762.0, 28168.85915570409, 29322.56016159802, 29335.85332073326, 29419.0, 29445.11664650064, 48097.0, 48195.51804482051, 48352.758236208596, 49184.508154917996, 49494.0, 40334.39498407467, 42468.36297455479, 42821.78589107034, 43083.569164307955, 43331.78334108309, 41184.58815411808, 41702.79148604238, 42104.0, 42467.0, 42971.78514107409, 40921.79539102285, 41211.0, 41952.160956780084, 42040.57959420489, 42210.78894605507, 33758.49362259617, 37273.25453490969, 37387.43918841274, 37622.435663465614, 38028.619713803615, 28018.2995425116, 28704.13887583376, 28902.42195156127, 28964.26214427141, 28965.56551651769], "value": 20065.404639603003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.4074702716734, 380.8609857402048, 382.31374682445, 386.8046636448593, 397.36620090954915, 15561.688766224697, 18045.368412105563, 19034.428967130974, 19763.40709778709, 20814.6877796833, 17997.820021799776, 18759.624807503842, 18801.24795008198, 18942.905285473553, 19093.0, 5527.060399732035, 5675.744591493382, 5754.3094828620415, 5784.623999440023, 5865.618734782225, 5734.168545560891, 5823.767049318022, 5856.97071514644, 5858.88282234355, 5891.88216235675, 5852.12218167274, 5857.7949771757785, 5890.676012819294, 5969.0, 5976.0, 6507.4143327100555, 6532.771353002622, 6553.082568440422, 6559.967200163993, 6575.539712220123, 5591.832245032656, 5691.544676425876, 5797.652140871562, 5803.0, 5804.970975145097, 13420.932895335558, 13537.18776873381, 13572.524961626394, 14039.508617198451, 23013.079476820905, 2141.389703934387, 2241.4284357488737, 2424.9515009699885, 2583.2379448062866, 2603.5053339865367, 9733.270004749602, 9966.501674916226, 10125.189984801198, 10359.63741269052, 10392.79214415715, 1882.576420305434, 1960.255103060842, 2004.9398518044482, 2006.8595198336122, 2009.387136923238, 80758.36350003237, 82171.0, 82246.58876705638, 82400.0, 82544.58727706384, 9747.951260243653, 10011.549480273405, 10032.648857290105, 10062.138504376713, 10282.177425806067, 12061.216020958609, 12469.438875250635, 13403.865961340261, 13507.797383039262, 13590.660233494242, 7689.307962283421, 7773.0, 7996.56018918965, 8021.077576078826, 8136.593170341459, 7661.195574464601, 7877.527348359002, 7971.1630278819885, 7985.5208687478935, 8300.83398332042, 4055.0876052887866, 4168.499780026416, 4240.724352917051, 4256.404103425523, 4580.290055041474, 1834.5138538287365, 1837.7886543047453, 1860.6929856573513, 1898.3450709505198, 1943.3101249056665, 410.94657694499523, 438.0, 449.1735207218668, 465.3578062274108, 1013.3058854684565, 11227.831582526269, 11521.884781152248, 11879.881201187878, 11955.88044119565, 12386.194897331645, 448.128390280907, 452.7532494790347, 459.8482500774736, 480.3835094905617, 494.7427337784332, 6265.937340626627, 6420.101185833987, 6478.384553467413, 6492.350764923564, 6524.347565243438, 488290.0, 493268.0, 495393.0, 504421.0, 509665.0, 59413.0, 84726.0, 87142.56428717816, 96396.03603964011, 99219.50390248002, 469.31011413222507, 471.86080106368706, 474.28146358267253, 475.43185892858395, 476.88077980504875, 10799.0, 10997.395143267197, 11099.611513596985, 11294.322340659586, 11317.094632429222, 38674.0, 39600.40599391069, 39835.0, 40193.79903100583, 45199.32201017053, 52565.21152182644, 61263.69368153131, 61712.0, 63124.36875631185, 63395.0, 6982.231954485104, 7237.276272372721, 7681.617308884454, 8094.757157285291, 8184.345252379914, 10874.293170943864, 12284.570040048555, 12295.385230738248, 12360.81458778137, 12784.424700888296, 5785.768569257182, 8910.509921954095, 9140.405873618194, 11063.944680276547, 11093.833592496281, 10613.09788667972, 10706.785864282827, 10777.299475534066, 10861.294015888941, 10977.121830253402, 6150.876982460236, 9116.407433517066, 10943.726406839893, 11021.724456888642, 11101.50043248072, 7136.5004449690105, 7247.697335842246, 7272.090988626422, 7283.053203083778, 7415.3326200642205, 8240.299574536231, 9924.305298629026, 10595.576176952836, 10762.784744304914, 11338.716532086764], "value": 7971.689285611067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.1651167555303, 1453.8764205042573, 1537.5233677559957, 1658.9419370322041, 1676.455152075575, 7288.198298187209, 7934.008248968879, 8371.204735550113, 8410.915890841097, 8419.957900210498, 8465.365097617672, 8640.611172497236, 8806.383553151281, 8815.471071735685, 8846.469211847278, 2269.5234000859796, 2317.073170731704, 2317.6639387288833, 2320.6751054852334, 2329.1847853251397, 2255.3008567344095, 2264.1056782570877, 2356.304890057437, 2361.2089949866813, 2371.739108698042, 2328.278233747535, 2328.4993726348916, 2346.718393792739, 2351.1653363056125, 2362.527494501098, 2262.7737226277404, 2267.6938613287243, 2274.1812947338944, 2274.4655006073644, 2280.5324908393823, 2214.136486770161, 2230.453538882984, 2233.519793244444, 2248.201888329636, 2251.538434620899, 8438.493690378535, 8604.1826026528, 8621.13788621139, 8623.956880215621, 8629.65481380744, 5022.296878437021, 5144.176931690949, 5165.0, 5171.844844654666, 5173.32746742921, 3249.0902547286796, 3301.4057469655454, 3436.1066122808, 3437.4843773433936, 3454.136465883529, 1124.7188202949262, 1130.9038731707815, 1156.5258244119955, 1161.8373427720126, 1195.0, 11705.3562054087, 11751.764964700658, 11893.52425902963, 11933.761324773543, 11937.462814173383, 4236.639885609696, 4351.82592696295, 4542.954570454253, 4545.704529205591, 4558.202314594932, 10186.592536298465, 10236.948815255875, 10239.385636861663, 10251.282410231212, 10270.948645256725, 5023.874403139877, 5044.142495775727, 5055.292259083732, 5057.898842023139, 5065.468125846806, 4149.937750933738, 4550.681452298373, 4598.0803839232285, 4694.694844835075, 4712.0, 3760.7179461540495, 3887.922241555153, 3933.272344616255, 3941.152652179795, 3999.480067591253, 1209.4799236328463, 1246.993765031169, 1254.3352023427599, 1265.7531781302741, 1277.8274932884128, 825.5830805443333, 930.8929473110679, 941.228192881844, 946.6355453150586, 985.3742873275378, 5740.6268592541355, 5808.82573522795, 5817.912731309034, 5853.414658534112, 5979.521638268928, 947.1806887042659, 987.9675738852916, 992.2111921022804, 1030.2324768047702, 1034.9896501035043, 3656.323580137683, 3792.639699228569, 3890.8638197662945, 3892.902677433087, 3989.4414781930554, 10748.946255268673, 10950.561977520969, 11085.612003579998, 11093.278936869077, 11119.499622516845, 10768.623098191525, 10794.082502987178, 10946.890531094587, 11015.173861960386, 11015.284006539548, 8132.024157101067, 8188.14024527428, 8261.339092872557, 8262.545559994138, 8304.501729896225, 5457.754401051883, 5513.58648101386, 5633.239512665901, 5685.744141513559, 5750.079987202028, 10095.798084038131, 10157.949210254197, 10158.44128572906, 10222.080012798884, 10256.0, 9654.662086826927, 10061.798764024532, 10076.596936122767, 10271.691849244535, 10367.32612380193, 7065.470089743187, 7727.304542591194, 7870.331021863206, 7961.72133975308, 8072.677092916218, 8886.688965886164, 8949.015608283215, 8952.552372381486, 8954.0, 8958.552072396484, 7706.576138312446, 7738.187490313661, 7821.882671759814, 7999.720009799629, 8036.035675718951, 7645.120811106572, 7650.655720492702, 7712.074551053685, 7743.496672716481, 7853.332466740391, 7059.2940705928995, 7177.354038136593, 7182.245864184394, 7193.928060719326, 7242.746503872339, 5070.873228169326, 5136.0, 5147.794088236428, 5151.5363617274625, 5336.146216605324, 4807.4471435785335, 4915.4592994771265, 4988.201887697951, 5043.092243396224, 5083.92374114396], "value": 4588.283144639125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.8435098099968, 315.3771301679183, 317.0994375972238, 321.7924438737013, 324.10708498087774, 5386.757595908184, 5487.807926722566, 5512.944870551299, 5579.33048034236, 5581.218629391883, 5436.130219164935, 5504.339479262484, 5515.531179849718, 5520.530754885839, 5533.6956467394375, 4328.935065974013, 4336.956630433687, 4383.298672212447, 4384.079343337903, 4400.889977750549, 4108.116754897696, 4317.69776115672, 4330.462685746546, 4395.560443955595, 4400.713953593022, 4273.957260427403, 4282.601743023916, 4290.206311832306, 4291.6566674665955, 4298.226319262531, 4303.763293018883, 4317.848875289365, 4319.460067491579, 4326.048269380763, 4327.545607711177, 3692.538432695913, 3726.329260733067, 3791.905202369935, 3799.3161230978412, 3803.7717736935597, 5311.787528498855, 5379.892402151974, 5386.892262154735, 5388.6828663674605, 5418.349798024223, 4886.438059623153, 4895.192293271606, 4908.263760435928, 4910.901781964377, 4921.8523444296725, 5517.724113794335, 5734.4803627038455, 5765.434381700145, 5775.768969241225, 5782.7108644568025, 4068.8982775430554, 4078.673706103534, 4079.4900637420324, 4103.589641035873, 4103.651189648884, 5989.9101513477335, 6049.788257411014, 6082.452579267843, 6090.512758979316, 6099.5425343099005, 4105.029585798774, 4138.317177665712, 4170.72890262132, 4199.622034016892, 4229.682773791917, 4216.198922204771, 4236.9364459533135, 4238.470191226097, 4244.87265382039, 4251.87244382669, 4871.878203044881, 4874.53691899269, 4876.829310974099, 4883.560479556857, 4891.192953162759, 5589.74846131925, 5845.9707701462075, 5875.618084824473, 5893.5579831512805, 5898.0, 1447.2185020089244, 1466.2668665667165, 1467.9633009174856, 1469.4489566412594, 1469.5003698742478, 902.3277658144724, 927.1470247372433, 931.5668214280392, 943.4009404028354, 951.4529145741227, 4956.290079922421, 4957.454679985199, 5030.0, 5031.144705400091, 5037.899242015139, 5202.3497062867145, 5309.628326017219, 5329.520343169133, 5351.655215490318, 5372.650777699437, 5004.624653151028, 5007.724575148329, 5061.73456635841, 5273.920891186635, 5712.171735098387, 3149.7480201583817, 3171.920701982469, 3180.332130252673, 3180.427523045828, 3185.347003864202, 6040.426159514839, 6137.41694539018, 6155.538334624921, 6188.783392581328, 6224.502039836802, 6005.888910551562, 6050.183225264621, 6062.545309101747, 6071.392860713893, 6084.787032453843, 6151.5386346024225, 6171.574775999364, 6189.783357582463, 6211.81364559064, 6213.2233470816145, 5780.913286300793, 5790.276215473066, 5859.648421094748, 5898.55760817949, 5926.67403292823, 5878.2064421304285, 5879.176915231957, 5880.323762767336, 5886.440788125121, 5894.410558944071, 5854.0, 6151.815445536641, 6166.660833654192, 6174.166487524127, 6230.252369715663, 4152.667786577127, 4189.97905010473, 4197.790110494524, 4205.264078786261, 4207.4109624651965, 5954.910676339945, 6055.515558755377, 6057.606255593372, 6083.939160608337, 6095.329513753395, 5709.54323654115, 5838.241028666246, 5850.882982340415, 5880.94119058804, 5889.293284805851, 5833.416658334133, 5843.094320380348, 5861.32594751609, 5862.0, 5869.970650146722, 5710.714464276853, 5743.224664670216, 5746.8506298739585, 5785.450382213683, 5814.296352196249, 5714.885702286014, 5820.187777006068, 5828.388019257917, 5832.687645279778, 5842.649441033552, 5680.204771331934, 5744.770209191585, 5746.885062298814, 5751.4536119068625, 5757.366689664217], "value": 4370.339962664881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.406809722465, 786.9331106855917, 802.8996375453069, 813.8250276190618, 848.6011574559957, 13812.58562243133, 14819.036762610423, 14836.777448338284, 14864.479743208989, 14873.628159296022, 15090.09459432432, 15182.772258416106, 15189.620259493518, 15211.923940380282, 15221.0, 647.7959442775534, 758.4993904023346, 786.5713186313459, 805.9274665280124, 809.3323008517996, 774.0440555913442, 797.6809276289501, 797.7128233835814, 798.9201079891993, 801.5831767480936, 844.0588743550927, 844.8732690096473, 852.9701460448886, 853.5860107847689, 855.6620135046653, 833.7707130539089, 841.4026041510505, 842.7050532313702, 845.8054647431095, 847.5126802088793, 622.5766478794418, 622.9719662615194, 623.4264476681464, 624.0202881476084, 626.7712285015937, 15517.456889008943, 15700.136492492908, 15731.68536629261, 15758.0, 15836.287367068395, 13797.655058623513, 13835.30823458823, 14204.715905681931, 14288.57134285973, 16553.503394898173, 13382.263975481344, 13489.051677280037, 13713.931430342884, 14061.086029408158, 14476.131432114107, 4547.15877562652, 4559.840405585788, 4562.520935301779, 4722.881927951795, 4790.80836766529, 74757.6262118686, 81028.59485702592, 83084.0, 83806.0, 84670.57664711699, 11433.599824006285, 11443.427828608535, 11489.138314626436, 11673.182877198684, 12035.518579256906, 20778.896105519678, 20825.271115510885, 20930.476738081365, 20992.956021376816, 21036.789632103788, 8692.78268043304, 8704.869426958601, 8771.079036701054, 9134.451932883916, 9143.54282285883, 4725.621950243973, 4905.264210368402, 5008.64939454242, 5027.773750181251, 5070.0, 3470.340635279289, 3495.7552971291766, 3530.505729197914, 3535.328287625343, 3551.7691350062164, 596.4989408896548, 609.20194545146, 610.91141784441, 618.2333905956582, 619.6127420362274, 588.6997631208114, 610.5634471352915, 673.9764108256187, 685.324954919404, 709.4218212157178, 9073.228775554151, 9445.811083778286, 9756.658516951873, 9774.95112524447, 9824.214062875095, 688.2669956496316, 697.4072038767109, 697.8150790040643, 709.3615745828795, 724.0731863215093, 4626.4910859805395, 4676.134915040729, 4684.836030738976, 4687.62499000086, 4690.366800481959, 66297.0, 73142.0, 111646.44176779065, 118274.4086279563, 121670.0, 87766.12233877707, 100450.0, 104219.478902605, 105096.47451762692, 105565.47217263865, 78693.60653196697, 84848.57575712082, 86052.56973715092, 91382.54308728414, 92852.0, 9909.405435673883, 10081.294309398272, 10166.796664066826, 10439.791204176026, 10698.090662293793, 51025.0, 51732.48267517427, 51959.740201300265, 52728.47271527236, 53024.0, 72043.27956720366, 75776.0, 78656.60671696605, 79592.0, 81596.0, 13484.932575337061, 13634.318284085954, 13701.657458563615, 13976.440942362598, 14013.369398377301, 15505.844941550891, 15668.451604193799, 15675.451359202374, 15772.211389430711, 16442.424515141913, 14368.209748463934, 14453.855461445251, 15217.543473695807, 15649.374025038871, 15654.0, 13572.389242483914, 14475.420983160555, 14644.341004654603, 14710.338034788674, 15303.234838258266, 13914.234717090252, 13963.092398994033, 13993.720125597227, 14018.719625607635, 14467.223941899803, 11724.58963936258, 12193.0, 12201.267923924594, 12270.0, 12512.37438128108, 10584.312019718695, 10678.8398174029, 10969.526888331442, 12166.57416990401, 12632.494700211888], "value": 7722.048615718473, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 106.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 148.0, 178.0, 132.0, 148.0, 149.0, 124.0, 182.0, 117.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 163.0, 176.0, 163.0, 164.0, 162.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 177.0, 76.0, 77.0, 76.0, 76.0, 156.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 153.0, 85.0, 84.0, 85.0, 138.0, 85.0, 85.0, 142.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 58.0, 58.0, 55.0, 53.0, 54.0, 53.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 67.0, 66.0, 64.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 79.0, 78.0, 77.0, 78.0, 76.0, 82.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 131.0, 128.0, 121.0, 124.0, 128.0, 123.0, 173.0, 134.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 158.0, 158.0, 158.0, 158.0, 162.0, 159.0, 164.0, 158.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 65.0, 64.0, 64.0, 66.0, 63.0, 64.0, 64.0, 62.0], "value": 64.3, "unit": "score"}]}]} 23:29:29 INFO - Return code: 0 23:29:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:29:29 ERROR - # TBPL SUCCESS # 23:29:29 INFO - Running post-action listener: _resource_record_post_action 23:29:29 INFO - [mozharness: 2016-07-29 06:29:29.943590Z] Finished run-tests step (success) 23:29:29 INFO - Running post-run listener: _resource_record_post_run 23:29:30 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555016192; Read time: 8; Write time: 466024 23:29:30 INFO - TinderboxPrint: CPU usage
13.3% 23:29:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:29:30 INFO - TinderboxPrint: I/O write bytes / time
555,016,192 / 466,024 23:29:30 INFO - TinderboxPrint: CPU idle
8,227.8 (86.6%) 23:29:30 INFO - TinderboxPrint: CPU user
1,211.7 (12.8%) 23:29:30 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:30 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257646592; Read time: 0; Write time: 287792 23:29:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297369600; Read time: 0; Write time: 178232 23:29:30 INFO - Running post-run listener: _upload_blobber_files 23:29:30 INFO - Blob upload gear active. 23:29:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:29:30 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:37 INFO - (blobuploader) - INFO - Done attempting. 23:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:38 INFO - (blobuploader) - INFO - Done attempting. 23:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:38 INFO - (blobuploader) - INFO - Done attempting. 23:29:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:29:38 INFO - Return code: 0 23:29:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:29:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:29:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90b13c4042d29dc8be8927e6370ace82505e70dc7a6b0840fabbd5fa3952dc26e9402e81a6d7e4fc4101647ba31769b78cd59dabc496051740aa47d7b8fd5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a51aa5a7db91753f82d2ea348c8c7b3ec6641cc89487bc76419981c9574bb35afe214b570c0f55f62dd5ed1734124c12d2d7ab4d2d03a4090b0c06de804408bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc54f3c0e87869a84e39585e691bc21a132d5513723dfe2aed9592f2c447b07c74992dddb1fab354b5d89fa12a738faca47c017232a0f41d22462795552448e"} 23:29:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:29:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:29:38 INFO - Contents: 23:29:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90b13c4042d29dc8be8927e6370ace82505e70dc7a6b0840fabbd5fa3952dc26e9402e81a6d7e4fc4101647ba31769b78cd59dabc496051740aa47d7b8fd5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a51aa5a7db91753f82d2ea348c8c7b3ec6641cc89487bc76419981c9574bb35afe214b570c0f55f62dd5ed1734124c12d2d7ab4d2d03a4090b0c06de804408bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc54f3c0e87869a84e39585e691bc21a132d5513723dfe2aed9592f2c447b07c74992dddb1fab354b5d89fa12a738faca47c017232a0f41d22462795552448e"} 23:29:38 INFO - Running post-run listener: copy_logs_to_upload_dir 23:29:38 INFO - Copying logs to upload dir... 23:29:38 INFO - mkdir: /builds/slave/test/build/upload/logs 23:29:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.991835 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-28 23:29:38.386810) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 23:29:38.390736) ========= 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=232498196343f89f466a4a9a000001c8-1469771575.527526-857133422 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/90b13c4042d29dc8be8927e6370ace82505e70dc7a6b0840fabbd5fa3952dc26e9402e81a6d7e4fc4101647ba31769b78cd59dabc496051740aa47d7b8fd5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a51aa5a7db91753f82d2ea348c8c7b3ec6641cc89487bc76419981c9574bb35afe214b570c0f55f62dd5ed1734124c12d2d7ab4d2d03a4090b0c06de804408bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc54f3c0e87869a84e39585e691bc21a132d5513723dfe2aed9592f2c447b07c74992dddb1fab354b5d89fa12a738faca47c017232a0f41d22462795552448e"} build_url:https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/akNjU5X5TDKdTU7k5HcPvw/artifacts/public/build/firefox-50.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/90b13c4042d29dc8be8927e6370ace82505e70dc7a6b0840fabbd5fa3952dc26e9402e81a6d7e4fc4101647ba31769b78cd59dabc496051740aa47d7b8fd5dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a51aa5a7db91753f82d2ea348c8c7b3ec6641cc89487bc76419981c9574bb35afe214b570c0f55f62dd5ed1734124c12d2d7ab4d2d03a4090b0c06de804408bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7cc54f3c0e87869a84e39585e691bc21a132d5513723dfe2aed9592f2c447b07c74992dddb1fab354b5d89fa12a738faca47c017232a0f41d22462795552448e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 23:29:38.415941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 23:29:38.416263) ========= 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=232498196343f89f466a4a9a000001c8-1469771575.527526-857133422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004709 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 23:29:38.507286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 23:29:38.507611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 23:29:38.507876) ========= ========= Total master_lag: 0.18 =========