builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1470109680.28 results: success (0) buildid: 20160801181550 builduid: b8e3f8a8ac384cfca678b1b56cc91e10 revision: 7c53e40a0d0391e4214f8ce7dd9fe744e00747b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.276583) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.277077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.277386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.298289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.298589) ========= 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=df17445c3590ff7897617a0e00000225-1470108575.702671-352618715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 20:48:00-- 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% 24.3M=0s 2016-08-01 20:48:00 (24.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.407410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.407724) ========= 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=df17445c3590ff7897617a0e00000225-1470108575.702671-352618715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.458652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:00.459122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c53e40a0d0391e4214f8ce7dd9fe744e00747b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c53e40a0d0391e4214f8ce7dd9fe744e00747b5 --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=df17445c3590ff7897617a0e00000225-1470108575.702671-352618715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 20:48:00,821 truncating revision to first 12 chars 2016-08-01 20:48:00,822 Setting DEBUG logging. 2016-08-01 20:48:00,822 attempt 1/10 2016-08-01 20:48:00,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7c53e40a0d03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 20:48:01,111 unpacking tar archive at: mozilla-aurora-7c53e40a0d03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:01.053510) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:01.053817) ========= script_repo_revision: 7c53e40a0d0391e4214f8ce7dd9fe744e00747b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:01.054291) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:01.054567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 20:48:01.064332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-01 20:48:01.064616) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=df17445c3590ff7897617a0e00000225-1470108575.702671-352618715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:48:01 INFO - MultiFileLogger online at 20160801 20:48:01 in /builds/slave/test 20:48:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:48:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:48:01 INFO - {'append_to_log': False, 20:48:01 INFO - 'base_work_dir': '/builds/slave/test', 20:48:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:48:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:48:01 INFO - 'branch': 'Mozilla-Aurora', 20:48:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:48:01 INFO - 'config_files': ('talos/linux_config.py',), 20:48:01 INFO - 'default_actions': ('clobber', 20:48:01 INFO - 'read-buildbot-config', 20:48:01 INFO - 'download-and-extract', 20:48:01 INFO - 'populate-webroot', 20:48:01 INFO - 'create-virtualenv', 20:48:01 INFO - 'install', 20:48:01 INFO - 'run-tests'), 20:48:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:48:01 INFO - 'download_minidump_stackwalk': True, 20:48:01 INFO - 'download_symbols': 'ondemand', 20:48:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:48:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:48:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:48:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:48:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:48:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:48:01 INFO - 'installer_path': 'installer.exe', 20:48:01 INFO - 'log_level': 'info', 20:48:01 INFO - 'log_name': 'talos', 20:48:01 INFO - 'log_to_console': True, 20:48:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:48:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:48:01 INFO - 'opt_config_files': (), 20:48:01 INFO - 'pip_index': False, 20:48:01 INFO - 'sps_profile': False, 20:48:01 INFO - 'sps_profile_interval': 0, 20:48:01 INFO - 'suite': 'dromaeojs-e10s', 20:48:01 INFO - 'system_bits': '32', 20:48:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:48:01 INFO - 'title': 'talos-linux64-ix-021', 20:48:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:48:01 INFO - 'use_talos_json': True, 20:48:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:48:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:48:01 INFO - 'work_dir': 'build'} 20:48:01 INFO - [mozharness: 2016-08-02 03:48:01.528737Z] Running clobber step. 20:48:01 INFO - Running pre-action listener: _resource_record_pre_action 20:48:01 INFO - Running main action method: clobber 20:48:01 INFO - rmtree: /builds/slave/test/build 20:48:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:48:02 INFO - Running post-action listener: _resource_record_post_action 20:48:02 INFO - [mozharness: 2016-08-02 03:48:02.000533Z] Finished clobber step (success) 20:48:02 INFO - [mozharness: 2016-08-02 03:48:02.000633Z] Running read-buildbot-config step. 20:48:02 INFO - Running pre-action listener: _resource_record_pre_action 20:48:02 INFO - Running main action method: read_buildbot_config 20:48:02 INFO - Using buildbot properties: 20:48:02 INFO - { 20:48:02 INFO - "project": "", 20:48:02 INFO - "product": "firefox", 20:48:02 INFO - "script_repo_revision": "production", 20:48:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:48:02 INFO - "repository": "", 20:48:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:48:02 INFO - "buildid": "20160801181550", 20:48:02 INFO - "pgo_build": "True", 20:48:02 INFO - "basedir": "/builds/slave/test", 20:48:02 INFO - "buildnumber": 459, 20:48:02 INFO - "slavename": "talos-linux64-ix-021", 20:48:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:48:02 INFO - "platform": "ubuntu64_hw", 20:48:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:48:02 INFO - "branch": "mozilla-aurora", 20:48:02 INFO - "repo_path": "releases/mozilla-aurora", 20:48:02 INFO - "revision": "7c53e40a0d0391e4214f8ce7dd9fe744e00747b5", 20:48:02 INFO - "stage_platform": "linux64-pgo", 20:48:02 INFO - "builduid": "b8e3f8a8ac384cfca678b1b56cc91e10", 20:48:02 INFO - "slavebuilddir": "test" 20:48:02 INFO - } 20:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 20:48:02 INFO - Running post-action listener: _resource_record_post_action 20:48:02 INFO - [mozharness: 2016-08-02 03:48:02.003059Z] Finished read-buildbot-config step (success) 20:48:02 INFO - [mozharness: 2016-08-02 03:48:02.003148Z] Running download-and-extract step. 20:48:02 INFO - Running pre-action listener: _resource_record_pre_action 20:48:02 INFO - Running main action method: download_and_extract 20:48:02 INFO - mkdir: /builds/slave/test/build/tests 20:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:02 INFO - https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:48:06 INFO - Downloaded 1361 bytes. 20:48:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:48:06 INFO - Using the following test package requirements: 20:48:06 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:48:06 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:48:06 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:48:06 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'jsshell-linux-x86_64.zip'], 20:48:06 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:48:06 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:48:06 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:48:06 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:48:06 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:48:06 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:48:06 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:48:06 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:06 INFO - https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:48:10 INFO - Downloaded 21765324 bytes. 20:48:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:48:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:48:11 INFO - Return code: 0 20:48:11 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:48:11 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')]} 20:48:11 INFO - https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:48:16 INFO - Downloaded 21765324 bytes. 20:48:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:48:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:48:17 INFO - Return code: 0 20:48:17 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')]} 20:48:17 INFO - https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:48:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:48:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:48:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:48:19 INFO - Downloaded 14413723 bytes. 20:48:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:48:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:48:19 INFO - Return code: 0 20:48: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')]} 20:48:19 INFO - https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:48:20 INFO - Downloaded 63761215 bytes. 20:48:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:48:20 INFO - mkdir: /builds/slave/test/properties 20:48:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:48:20 INFO - Writing to file /builds/slave/test/properties/build_url 20:48:20 INFO - Contents: 20:48:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:48:21 INFO - Running post-action listener: _resource_record_post_action 20:48:21 INFO - Running post-action listener: set_extra_try_arguments 20:48:21 INFO - [mozharness: 2016-08-02 03:48:21.493744Z] Finished download-and-extract step (success) 20:48:21 INFO - [mozharness: 2016-08-02 03:48:21.494067Z] Running populate-webroot step. 20:48:21 INFO - Running pre-action listener: _resource_record_pre_action 20:48:21 INFO - Running main action method: populate_webroot 20:48:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:48:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:48:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:48:21 INFO - '--tppagecycles', 20:48:21 INFO - '7'], 20:48:21 INFO - 'tests': ['tsvgm']}}, 20:48:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:48:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:48:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:48:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:48:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['damp', 'tps']}, 20:48:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'tests': ['damp', 'tps']}, 20:48:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['dromaeo_dom']}, 20:48:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:48:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['basic_compositor_video']}, 20:48:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:48:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['a11yr', 20:48:21 INFO - 'ts_paint', 20:48:21 INFO - 'tpaint', 20:48:21 INFO - 'sessionrestore', 20:48:21 INFO - 'sessionrestore_no_auto_restore', 20:48:21 INFO - 'tabpaint']}, 20:48:21 INFO - 'other-e10s': {'tests': ['a11yr', 20:48:21 INFO - 'ts_paint', 20:48:21 INFO - 'tpaint', 20:48:21 INFO - 'sessionrestore', 20:48:21 INFO - 'sessionrestore_no_auto_restore', 20:48:21 INFO - 'tabpaint']}, 20:48:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:48:21 INFO - 'ts_paint', 20:48:21 INFO - 'tpaint', 20:48:21 INFO - 'sessionrestore', 20:48:21 INFO - 'sessionrestore_no_auto_restore', 20:48:21 INFO - 'tabpaint']}, 20:48:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:48:21 INFO - 'ts_paint', 20:48:21 INFO - 'tpaint', 20:48:21 INFO - 'sessionrestore', 20:48:21 INFO - 'sessionrestore_no_auto_restore', 20:48:21 INFO - 'tabpaint']}, 20:48:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['a11yr', 20:48:21 INFO - 'ts_paint', 20:48:21 INFO - 'tpaint', 20:48:21 INFO - 'sessionrestore', 20:48:21 INFO - 'sessionrestore_no_auto_restore', 20:48:21 INFO - 'tabpaint']}, 20:48:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['a11yr', 20:48:21 INFO - 'ts_paint', 20:48:21 INFO - 'tpaint', 20:48:21 INFO - 'sessionrestore', 20:48:21 INFO - 'sessionrestore_no_auto_restore', 20:48:21 INFO - 'tabpaint']}, 20:48:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['tsvgx', 20:48:21 INFO - 'tsvgr_opacity', 20:48:21 INFO - 'tart', 20:48:21 INFO - 'tscrollx', 20:48:21 INFO - 'cart']}, 20:48:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:48:21 INFO - 'tsvgr_opacity', 20:48:21 INFO - 'tart', 20:48:21 INFO - 'tscrollx', 20:48:21 INFO - 'cart']}, 20:48:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'talos_options': ['--disable-e10s'], 20:48:21 INFO - 'tests': ['tp5o']}, 20:48:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'tests': ['tp5o']}, 20:48:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'talos_options': ['--disable-e10s', 20:48:21 INFO - '--xperf_path', 20:48:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:21 INFO - 'tests': ['tp5n']}, 20:48:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:21 INFO - 'talos_options': ['--xperf_path', 20:48:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:21 INFO - 'tests': ['tp5n']}}, 20:48:21 INFO - 'talos.zip': {'path': '', 20:48:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:48:21 INFO - Running post-action listener: _resource_record_post_action 20:48:21 INFO - [mozharness: 2016-08-02 03:48:21.517474Z] Finished populate-webroot step (success) 20:48:21 INFO - [mozharness: 2016-08-02 03:48:21.517564Z] Running create-virtualenv step. 20:48:21 INFO - Running pre-action listener: _resource_record_pre_action 20:48:21 INFO - Running main action method: create_virtualenv 20:48:21 INFO - Creating virtualenv /builds/slave/test/build/venv 20:48:21 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 20:48:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:48:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:48:21 INFO - Using real prefix '/usr' 20:48:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:48:22 INFO - Installing distribute.............................................................................................................................................................................................done. 20:48:24 INFO - Installing pip.................done. 20:48:24 INFO - Return code: 0 20:48:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:48:24 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')]} 20:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:24 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')]} 20:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:24 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:24 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 20:48:24 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 20:48:24 INFO - Using env: {'DISPLAY': ':0', 20:48:24 INFO - 'HOME': '/home/cltbld', 20:48:24 INFO - 'LANG': 'en_US.UTF-8', 20:48:24 INFO - 'LANGUAGE': 'en_US:en', 20:48:24 INFO - 'LOGNAME': 'cltbld', 20:48:24 INFO - 'MAIL': '/var/mail/cltbld', 20:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:24 INFO - 'MOZ_NO_REMOTE': '1', 20:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:24 INFO - 'NO_EM_RESTART': '1', 20:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:24 INFO - 'PWD': '/builds/slave/test', 20:48:24 INFO - 'SHELL': '/bin/bash', 20:48:24 INFO - 'SHLVL': '1', 20:48:24 INFO - 'TERM': 'linux', 20:48:24 INFO - 'TMOUT': '86400', 20:48:24 INFO - 'USER': 'cltbld', 20:48:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:24 INFO - '_': '/tools/buildbot/bin/python'} 20:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:24 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 20:48:24 INFO - Cleaning up... 20:48:24 INFO - Return code: 0 20:48:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:48:24 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')]} 20:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:24 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')]} 20:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:24 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:24 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 20:48:24 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 20:48:24 INFO - Using env: {'DISPLAY': ':0', 20:48:24 INFO - 'HOME': '/home/cltbld', 20:48:24 INFO - 'LANG': 'en_US.UTF-8', 20:48:24 INFO - 'LANGUAGE': 'en_US:en', 20:48:24 INFO - 'LOGNAME': 'cltbld', 20:48:24 INFO - 'MAIL': '/var/mail/cltbld', 20:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:24 INFO - 'MOZ_NO_REMOTE': '1', 20:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:24 INFO - 'NO_EM_RESTART': '1', 20:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:24 INFO - 'PWD': '/builds/slave/test', 20:48:24 INFO - 'SHELL': '/bin/bash', 20:48:24 INFO - 'SHLVL': '1', 20:48:24 INFO - 'TERM': 'linux', 20:48:24 INFO - 'TMOUT': '86400', 20:48:24 INFO - 'USER': 'cltbld', 20:48:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:24 INFO - '_': '/tools/buildbot/bin/python'} 20:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:24 INFO - Downloading/unpacking psutil>=3.1.1 20:48:24 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 20:48:24 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 20:48:24 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 20:48:24 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 20:48:24 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 20:48:24 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 20:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:48:26 INFO - Installing collected packages: psutil 20:48:26 INFO - Running setup.py install for psutil 20:48:26 INFO - building 'psutil._psutil_linux' extension 20:48:26 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 20:48:26 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 20:48:26 INFO - building 'psutil._psutil_posix' extension 20:48:26 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 20:48:27 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 20:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:48:27 INFO - Successfully installed psutil 20:48:27 INFO - Cleaning up... 20:48:27 INFO - Return code: 0 20:48:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:48: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')]} 20:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48: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')]} 20:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:48: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 mozsystemmonitor==0.3 20:48:27 INFO - Using env: {'DISPLAY': ':0', 20:48:27 INFO - 'HOME': '/home/cltbld', 20:48:27 INFO - 'LANG': 'en_US.UTF-8', 20:48:27 INFO - 'LANGUAGE': 'en_US:en', 20:48:27 INFO - 'LOGNAME': 'cltbld', 20:48:27 INFO - 'MAIL': '/var/mail/cltbld', 20:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:27 INFO - 'MOZ_NO_REMOTE': '1', 20:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:27 INFO - 'NO_EM_RESTART': '1', 20:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:27 INFO - 'PWD': '/builds/slave/test', 20:48:27 INFO - 'SHELL': '/bin/bash', 20:48:27 INFO - 'SHLVL': '1', 20:48:27 INFO - 'TERM': 'linux', 20:48:27 INFO - 'TMOUT': '86400', 20:48:27 INFO - 'USER': 'cltbld', 20:48:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:27 INFO - '_': '/tools/buildbot/bin/python'} 20:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48: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 20:48:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:48:29 INFO - Installing collected packages: mozsystemmonitor 20:48:29 INFO - Running setup.py install for mozsystemmonitor 20:48:29 INFO - Successfully installed mozsystemmonitor 20:48:29 INFO - Cleaning up... 20:48:29 INFO - Return code: 0 20:48:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:29 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:29 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 20:48:29 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 20:48:29 INFO - Using env: {'DISPLAY': ':0', 20:48:29 INFO - 'HOME': '/home/cltbld', 20:48:29 INFO - 'LANG': 'en_US.UTF-8', 20:48:29 INFO - 'LANGUAGE': 'en_US:en', 20:48:29 INFO - 'LOGNAME': 'cltbld', 20:48:29 INFO - 'MAIL': '/var/mail/cltbld', 20:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:29 INFO - 'MOZ_NO_REMOTE': '1', 20:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:29 INFO - 'NO_EM_RESTART': '1', 20:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:29 INFO - 'PWD': '/builds/slave/test', 20:48:29 INFO - 'SHELL': '/bin/bash', 20:48:29 INFO - 'SHLVL': '1', 20:48:29 INFO - 'TERM': 'linux', 20:48:29 INFO - 'TMOUT': '86400', 20:48:29 INFO - 'USER': 'cltbld', 20:48:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:29 INFO - '_': '/tools/buildbot/bin/python'} 20:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:29 INFO - Downloading/unpacking jsonschema==2.5.1 20:48:29 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 20:48:29 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 20:48:29 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 20:48:29 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 20:48:29 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 20:48:29 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 20:48:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:48:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:48:31 INFO - Downloading functools32-3.2.3-2.tar.gz 20:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:48:31 INFO - warning: no files found matching '*.txt' 20:48:31 INFO - no previously-included directories found matching 'build' 20:48:31 INFO - no previously-included directories found matching 'dist' 20:48:31 INFO - no previously-included directories found matching '.git*' 20:48:31 INFO - Installing collected packages: jsonschema, functools32 20:48:31 INFO - Running setup.py install for functools32 20:48:32 INFO - warning: no files found matching '*.txt' 20:48:32 INFO - no previously-included directories found matching 'build' 20:48:32 INFO - no previously-included directories found matching 'dist' 20:48:32 INFO - no previously-included directories found matching '.git*' 20:48:32 INFO - Successfully installed jsonschema functools32 20:48:32 INFO - Cleaning up... 20:48:32 INFO - Return code: 0 20:48:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:48:32 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')]} 20:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:32 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')]} 20:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:32 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:32 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 20:48:32 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 20:48:32 INFO - Using env: {'DISPLAY': ':0', 20:48:32 INFO - 'HOME': '/home/cltbld', 20:48:32 INFO - 'LANG': 'en_US.UTF-8', 20:48:32 INFO - 'LANGUAGE': 'en_US:en', 20:48:32 INFO - 'LOGNAME': 'cltbld', 20:48:32 INFO - 'MAIL': '/var/mail/cltbld', 20:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:32 INFO - 'MOZ_NO_REMOTE': '1', 20:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:32 INFO - 'NO_EM_RESTART': '1', 20:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:32 INFO - 'PWD': '/builds/slave/test', 20:48:32 INFO - 'SHELL': '/bin/bash', 20:48:32 INFO - 'SHLVL': '1', 20:48:32 INFO - 'TERM': 'linux', 20:48:32 INFO - 'TMOUT': '86400', 20:48:32 INFO - 'USER': 'cltbld', 20:48:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:32 INFO - '_': '/tools/buildbot/bin/python'} 20:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:48:32 INFO - Cleaning up... 20:48:32 INFO - Return code: 0 20:48:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:48:32 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')]} 20:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:32 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')]} 20:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:32 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:32 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 20:48:32 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 20:48:32 INFO - Using env: {'DISPLAY': ':0', 20:48:32 INFO - 'HOME': '/home/cltbld', 20:48:32 INFO - 'LANG': 'en_US.UTF-8', 20:48:32 INFO - 'LANGUAGE': 'en_US:en', 20:48:32 INFO - 'LOGNAME': 'cltbld', 20:48:32 INFO - 'MAIL': '/var/mail/cltbld', 20:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:32 INFO - 'MOZ_NO_REMOTE': '1', 20:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:32 INFO - 'NO_EM_RESTART': '1', 20:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:32 INFO - 'PWD': '/builds/slave/test', 20:48:32 INFO - 'SHELL': '/bin/bash', 20:48:32 INFO - 'SHLVL': '1', 20:48:32 INFO - 'TERM': 'linux', 20:48:32 INFO - 'TMOUT': '86400', 20:48:32 INFO - 'USER': 'cltbld', 20:48:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:32 INFO - '_': '/tools/buildbot/bin/python'} 20:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:32 INFO - Downloading/unpacking blobuploader==1.2.4 20:48:32 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 20:48:32 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 20:48:32 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 20:48:32 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 20:48:32 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 20:48:32 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 20:48:34 INFO - Downloading blobuploader-1.2.4.tar.gz 20:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:48:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:48:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 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 20:48:34 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 20:48:35 INFO - Downloading docopt-0.6.1.tar.gz 20:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:48:35 INFO - Installing collected packages: blobuploader, requests, docopt 20:48:35 INFO - Running setup.py install for blobuploader 20:48:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:48:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:48:35 INFO - Running setup.py install for requests 20:48:35 INFO - Running setup.py install for docopt 20:48:35 INFO - Successfully installed blobuploader requests docopt 20:48:35 INFO - Cleaning up... 20:48:35 INFO - Return code: 0 20:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:35 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:35 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 20:48:35 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 20:48:35 INFO - Using env: {'DISPLAY': ':0', 20:48:35 INFO - 'HOME': '/home/cltbld', 20:48:35 INFO - 'LANG': 'en_US.UTF-8', 20:48:35 INFO - 'LANGUAGE': 'en_US:en', 20:48:35 INFO - 'LOGNAME': 'cltbld', 20:48:35 INFO - 'MAIL': '/var/mail/cltbld', 20:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:35 INFO - 'MOZ_NO_REMOTE': '1', 20:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:35 INFO - 'NO_EM_RESTART': '1', 20:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:35 INFO - 'PWD': '/builds/slave/test', 20:48:35 INFO - 'SHELL': '/bin/bash', 20:48:35 INFO - 'SHLVL': '1', 20:48:35 INFO - 'TERM': 'linux', 20:48:35 INFO - 'TMOUT': '86400', 20:48:35 INFO - 'USER': 'cltbld', 20:48:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:35 INFO - '_': '/tools/buildbot/bin/python'} 20:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:48:36 INFO - Running setup.py (path:/tmp/pip-3eDBKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:48:36 INFO - Running setup.py (path:/tmp/pip-bWpPuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:36 INFO - Running setup.py (path:/tmp/pip-jDJkpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:36 INFO - Running setup.py (path:/tmp/pip-wG24sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:36 INFO - Running setup.py (path:/tmp/pip-rSrSJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:36 INFO - Running setup.py (path:/tmp/pip-hPdTJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:36 INFO - Running setup.py (path:/tmp/pip-pW6IvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:36 INFO - Running setup.py (path:/tmp/pip-tJzWxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:36 INFO - Running setup.py (path:/tmp/pip-Nj_srK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:36 INFO - Running setup.py (path:/tmp/pip-wlcE1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:36 INFO - Running setup.py (path:/tmp/pip-QXziKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:36 INFO - Running setup.py (path:/tmp/pip-pjwVdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:36 INFO - Running setup.py (path:/tmp/pip-_VQLZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:36 INFO - Running setup.py (path:/tmp/pip-5tKBeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:37 INFO - Running setup.py (path:/tmp/pip-2cdP5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:37 INFO - Running setup.py (path:/tmp/pip-DcE046-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:37 INFO - Running setup.py (path:/tmp/pip-reiKJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:48:37 INFO - Running setup.py install for manifestparser 20:48:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:48:37 INFO - Running setup.py install for mozcrash 20:48:37 INFO - Running setup.py install for mozdebug 20:48:37 INFO - Running setup.py install for mozdevice 20:48:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:48:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:48:37 INFO - Running setup.py install for mozfile 20:48:37 INFO - Running setup.py install for mozhttpd 20:48:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:48:37 INFO - Running setup.py install for mozinfo 20:48:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:48:37 INFO - Running setup.py install for mozInstall 20:48:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Running setup.py install for mozleak 20:48:38 INFO - Running setup.py install for mozlog 20:48:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Running setup.py install for moznetwork 20:48:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Running setup.py install for mozprocess 20:48:38 INFO - Running setup.py install for mozprofile 20:48:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Running setup.py install for mozrunner 20:48:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:48:38 INFO - Running setup.py install for mozscreenshot 20:48:38 INFO - Running setup.py install for moztest 20:48:38 INFO - Running setup.py install for mozversion 20:48:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:48:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:48:39 INFO - Cleaning up... 20:48:39 INFO - Return code: 0 20:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:39 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:39 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 20:48:39 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 20:48:39 INFO - Using env: {'DISPLAY': ':0', 20:48:39 INFO - 'HOME': '/home/cltbld', 20:48:39 INFO - 'LANG': 'en_US.UTF-8', 20:48:39 INFO - 'LANGUAGE': 'en_US:en', 20:48:39 INFO - 'LOGNAME': 'cltbld', 20:48:39 INFO - 'MAIL': '/var/mail/cltbld', 20:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:39 INFO - 'MOZ_NO_REMOTE': '1', 20:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:39 INFO - 'NO_EM_RESTART': '1', 20:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:39 INFO - 'PWD': '/builds/slave/test', 20:48:39 INFO - 'SHELL': '/bin/bash', 20:48:39 INFO - 'SHLVL': '1', 20:48:39 INFO - 'TERM': 'linux', 20:48:39 INFO - 'TMOUT': '86400', 20:48:39 INFO - 'USER': 'cltbld', 20:48:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:39 INFO - '_': '/tools/buildbot/bin/python'} 20:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:48:39 INFO - Running setup.py (path:/tmp/pip-YRMN7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:48:39 INFO - Running setup.py (path:/tmp/pip-atKU6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:39 INFO - Running setup.py (path:/tmp/pip-RMFvXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:39 INFO - Running setup.py (path:/tmp/pip-Q8d_zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:39 INFO - Running setup.py (path:/tmp/pip-zSao1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:39 INFO - Running setup.py (path:/tmp/pip-2Zmou3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:39 INFO - Running setup.py (path:/tmp/pip-iyzf96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:39 INFO - Running setup.py (path:/tmp/pip-JawwMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:39 INFO - Running setup.py (path:/tmp/pip-8726dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:39 INFO - Running setup.py (path:/tmp/pip-Hgq7Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:39 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)) 20:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:39 INFO - Running setup.py (path:/tmp/pip-EVMldc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:40 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)) 20:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:40 INFO - Running setup.py (path:/tmp/pip-4YvbNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:40 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)) 20:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:40 INFO - Running setup.py (path:/tmp/pip-TrCKwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:40 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)) 20:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:40 INFO - Running setup.py (path:/tmp/pip-GGAU3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:40 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)) 20:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:40 INFO - Running setup.py (path:/tmp/pip-_7cOgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:40 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)) 20:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:40 INFO - Running setup.py (path:/tmp/pip-vfSHGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:40 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)) 20:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:40 INFO - Running setup.py (path:/tmp/pip-uaWq2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:40 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)) 20:48:40 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)) 20:48:40 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)) 20:48:40 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)) 20:48:40 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)) 20:48:40 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)) 20:48:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:48:40 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 20:48:40 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 20:48:40 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 20:48:40 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 20:48:40 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 20:48:40 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 20:48:42 INFO - Downloading blessings-1.6.tar.gz 20:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:48:42 INFO - Installing collected packages: blessings 20:48:42 INFO - Running setup.py install for blessings 20:48:42 INFO - Successfully installed blessings 20:48:42 INFO - Cleaning up... 20:48:42 INFO - Return code: 0 20:48:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:42 INFO - Reading from file tmpfile_stdout 20:48:42 INFO - Current package versions: 20:48:42 INFO - argparse == 1.2.1 20:48:42 INFO - blessings == 1.6 20:48:42 INFO - blobuploader == 1.2.4 20:48:42 INFO - docopt == 0.6.1 20:48:42 INFO - functools32 == 3.2.3-2 20:48:42 INFO - jsonschema == 2.5.1 20:48:42 INFO - manifestparser == 1.1 20:48:42 INFO - mozInstall == 1.12 20:48:42 INFO - mozcrash == 0.17 20:48:42 INFO - mozdebug == 0.1 20:48:42 INFO - mozdevice == 0.48 20:48:42 INFO - mozfile == 1.2 20:48:42 INFO - mozhttpd == 0.7 20:48:42 INFO - mozinfo == 0.9 20:48:42 INFO - mozleak == 0.1 20:48:42 INFO - mozlog == 3.3 20:48:42 INFO - moznetwork == 0.27 20:48:42 INFO - mozprocess == 0.23 20:48:42 INFO - mozprofile == 0.28 20:48:42 INFO - mozrunner == 6.12 20:48:42 INFO - mozscreenshot == 0.1 20:48:42 INFO - mozsystemmonitor == 0.3 20:48:42 INFO - moztest == 0.7 20:48:42 INFO - mozversion == 1.4 20:48:42 INFO - psutil == 3.1.1 20:48:42 INFO - requests == 1.2.3 20:48:42 INFO - wsgiref == 0.1.2 20:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:42 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')]} 20:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:42 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')]} 20:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:42 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 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:42 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 20:48:42 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 20:48:42 INFO - Using env: {'DISPLAY': ':0', 20:48:42 INFO - 'HOME': '/home/cltbld', 20:48:42 INFO - 'LANG': 'en_US.UTF-8', 20:48:42 INFO - 'LANGUAGE': 'en_US:en', 20:48:42 INFO - 'LOGNAME': 'cltbld', 20:48:42 INFO - 'MAIL': '/var/mail/cltbld', 20:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:42 INFO - 'MOZ_NO_REMOTE': '1', 20:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:42 INFO - 'NO_EM_RESTART': '1', 20:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:42 INFO - 'PWD': '/builds/slave/test', 20:48:42 INFO - 'SHELL': '/bin/bash', 20:48:42 INFO - 'SHLVL': '1', 20:48:42 INFO - 'TERM': 'linux', 20:48:42 INFO - 'TMOUT': '86400', 20:48:42 INFO - 'USER': 'cltbld', 20:48:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:42 INFO - '_': '/tools/buildbot/bin/python'} 20:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 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)) 20:48:43 INFO - Cleaning up... 20:48:43 INFO - Return code: 0 20:48:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2187030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23b6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, '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': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', '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 20:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:48:43 INFO - Using env: {'DISPLAY': ':0', 20:48:43 INFO - 'HOME': '/home/cltbld', 20:48:43 INFO - 'LANG': 'en_US.UTF-8', 20:48:43 INFO - 'LANGUAGE': 'en_US:en', 20:48:43 INFO - 'LOGNAME': 'cltbld', 20:48:43 INFO - 'MAIL': '/var/mail/cltbld', 20:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:43 INFO - 'MOZ_NO_REMOTE': '1', 20:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:43 INFO - 'NO_EM_RESTART': '1', 20:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:43 INFO - 'PWD': '/builds/slave/test', 20:48:43 INFO - 'SHELL': '/bin/bash', 20:48:43 INFO - 'SHLVL': '1', 20:48:43 INFO - 'TERM': 'linux', 20:48:43 INFO - 'TMOUT': '86400', 20:48:43 INFO - 'USER': 'cltbld', 20:48:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:43 INFO - '_': '/tools/buildbot/bin/python'} 20:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:48:43 INFO - Cleaning up... 20:48:43 INFO - Return code: 0 20:48:43 INFO - Running post-action listener: _resource_record_post_action 20:48:43 INFO - Running post-action listener: _start_resource_monitoring 20:48:43 INFO - Starting resource monitoring. 20:48:43 INFO - [mozharness: 2016-08-02 03:48:43.327503Z] Finished create-virtualenv step (success) 20:48:43 INFO - [mozharness: 2016-08-02 03:48:43.327929Z] Running install step. 20:48:43 INFO - Running pre-action listener: _resource_record_pre_action 20:48:43 INFO - Running main action method: install 20:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:43 INFO - Reading from file tmpfile_stdout 20:48:43 INFO - Detecting whether we're running mozinstall >=1.0... 20:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:48:43 INFO - Reading from file tmpfile_stdout 20:48:43 INFO - Output received: 20:48:43 INFO - Usage: mozinstall [options] installer 20:48:43 INFO - Options: 20:48:43 INFO - -h, --help show this help message and exit 20:48:43 INFO - -d DEST, --destination=DEST 20:48:43 INFO - Directory to install application into. [default: 20:48:43 INFO - "/builds/slave/test"] 20:48:43 INFO - --app=APP Application being installed. [default: firefox] 20:48:43 INFO - mkdir: /builds/slave/test/build/application 20:48:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:48:59 INFO - Reading from file tmpfile_stdout 20:48:59 INFO - Output received: 20:48:59 INFO - /builds/slave/test/build/application/firefox/firefox 20:48:59 INFO - Running post-action listener: _resource_record_post_action 20:48:59 INFO - [mozharness: 2016-08-02 03:48:59.700250Z] Finished install step (success) 20:48:59 INFO - [mozharness: 2016-08-02 03:48:59.700587Z] Running run-tests step. 20:48:59 INFO - Running pre-action listener: _resource_record_pre_action 20:48:59 INFO - Running main action method: run_tests 20:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:48:59 INFO - Python 2.7.3 20:48:59 INFO - Return code: 0 20:48:59 INFO - grabbing minidump binary from tooltool 20:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:48:59 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 0x2445570>, '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 0x2446470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2446900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:48:59 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 20:48:59 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 20:48:59 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 20:48:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:48:59 INFO - Return code: 0 20:48:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:48:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:48:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:48:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:48:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 20:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 20:48:59 INFO - Using env: {'DISPLAY': ':0', 20:48:59 INFO - 'HOME': '/home/cltbld', 20:48:59 INFO - 'LANG': 'en_US.UTF-8', 20:48:59 INFO - 'LANGUAGE': 'en_US:en', 20:48:59 INFO - 'LOGNAME': 'cltbld', 20:48:59 INFO - 'MAIL': '/var/mail/cltbld', 20:48:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:48:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:59 INFO - 'MOZ_NO_REMOTE': '1', 20:48:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:48:59 INFO - 'NO_EM_RESTART': '1', 20:48:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:59 INFO - 'PWD': '/builds/slave/test', 20:48:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:48:59 INFO - 'SHELL': '/bin/bash', 20:48:59 INFO - 'SHLVL': '1', 20:48:59 INFO - 'TERM': 'linux', 20:48:59 INFO - 'TMOUT': '86400', 20:48:59 INFO - 'USER': 'cltbld', 20:48:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470108575.702671-352618715', 20:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:59 INFO - '_': '/tools/buildbot/bin/python'} 20:48:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 20:48:59 INFO - mozversion application_buildid: 20160801181550 20:48:59 INFO - mozversion application_changeset: 7c53e40a0d0391e4214f8ce7dd9fe744e00747b5 20:48:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:48:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:48:59 INFO - mozversion application_name: Firefox 20:48:59 INFO - mozversion application_remotingname: firefox-dev 20:48:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:48:59 INFO - mozversion application_vendor: Mozilla 20:48:59 INFO - mozversion application_version: 50.0a2 20:48:59 INFO - mozversion platform_buildid: 20160801181550 20:48:59 INFO - mozversion platform_changeset: 7c53e40a0d0391e4214f8ce7dd9fe744e00747b5 20:48:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:48:59 INFO - mozversion platform_version: 50.0a2 20:48:59 INFO - using testdate: 1470109739 20:48:59 INFO - actual date: 1470109739 20:48:59 INFO - starting webserver on 'localhost:41465' 20:48:59 INFO - SUITE-START | Running 2 tests 20:48:59 INFO - TEST-START | dromaeo_css 20:48:59 INFO - operating with platform_type : linux_ 20:48:59 INFO - Initialising browser for dromaeo_css test... 20:48:59 INFO - TEST-INFO | started process 28044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwB0RPl/profile http://localhost:41465/getInfo.html) 20:49:05 INFO - PROCESS | 28044 | __metrics Screen width/height:1600/1200 20:49:05 INFO - PROCESS | 28044 | colorDepth:24 20:49:05 INFO - PROCESS | 28044 | Browser inner width/height: 1024/697 20:49:05 INFO - PROCESS | 28044 | __metrics 20:49:06 ERROR - PROCESS | 28044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 20:49:06 INFO - TEST-INFO | 28044: exit 0 20:49:06 INFO - Browser initialized. 20:49:06 INFO - Running cycle 1/1 for dromaeo_css test... 20:49:06 INFO - TEST-INFO | started process 28170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwB0RPl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:49:18 INFO - PROCESS | 28170 | RSS: Main: 152453120 20:49:18 INFO - PROCESS | 28170 | 20:50:08 INFO - PROCESS | 28170 | 1470109808365 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] 20:52:16 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:41465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41465/tests/dromaeo/cssquery-ext.html) 20:52:18 INFO - PROCESS | 28170 | RSS: Main: 157433856 20:52:18 INFO - PROCESS | 28170 | 20:55:20 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:41465/tests/dromaeo/cssquery-ext.html (next: http://localhost:41465/tests/dromaeo/cssquery-jquery.html) 20:55:20 INFO - PROCESS | 28170 | RSS: Main: 154558464 20:55:20 INFO - PROCESS | 28170 | 20:58:22 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:41465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41465/tests/dromaeo/cssquery-mootools.html) 20:58:23 INFO - PROCESS | 28170 | RSS: Main: 154931200 20:58:23 INFO - PROCESS | 28170 | 21:01:24 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:41465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41465/tests/dromaeo/cssquery-prototype.html) 21:01:25 INFO - PROCESS | 28170 | RSS: Main: 153001984 21:01:25 INFO - PROCESS | 28170 | 21:04:28 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:41465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41465/tests/dromaeo/cssquery-yui.html) 21:04:28 INFO - PROCESS | 28170 | RSS: Main: 155799552 21:04:28 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:41465/tests/dromaeo/cssquery-yui.html (next: http://localhost:41465/tests/dromaeo/cssquery-dojo.html) 21:07:31 INFO - PROCESS | 28170 | RSS: Main: 155701248 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | __start_tp_report 21:07:31 INFO - PROCESS | 28170 | _x_x_mozilla_page_load 21:07:31 INFO - PROCESS | 28170 | _x_x_mozilla_page_load_details 21:07:31 INFO - PROCESS | 28170 | |i|pagename|runs| 21:07:31 INFO - PROCESS | 28170 | |0;dojo.html;3261.527078573607;3279.3605246976836;3283.16279348766;3294.0776582556878;3308.768386212966;5645.887082258358;5681.147827825818;5684.232628595144;5716.942830571693;5722.599418040739;5771.769129234836;5809.099589563624;5858.384869588695;5864.472197502224;5872.207252020976;5249.055170069396;5279.260903473517;5289.471052894718;5296.682199068049;5370.845268267321;5103.515166059218;5159.174532074869;5177.948220517785;5188.662736922088;5236.764345604438;5302.363716354023;5305.363356397218;5313.442088580701;5347.6256662033675;5383.973080134594;5360.705161216151;5363.302770639812;5381.0852155133725;5388.515033646951;5391.81128660499;4987.875303117415;5159.355080614923;5280.947190528084;5299.417064122943;5364.785408583652;5738.713064346766;5812.157237200625;5812.82561523155;5819.592628516006;5850.824475265749;6225.719842607094;6231.781887633956;6270.529710271748;6271.623702577815;6309.936900630981;6008.909866352008;6081.878362432726;6297.937020629781;6306.180196574416;6320.683965801738;5707.6290041147195;5810.128480727924;5810.50610698087;5821.708914554255;5834.299884013945;6321.873562528724;6345.49236061114;6348.492120630339;6349.873002539924;6365.649889256043;5946.821595352147;6031;6081.75672973085;6108.694565271719;6125.326214116443;6107.4197951194565;6235.937640623536;6260.092286618415;6266.279377871512;6267.592606480564;6156.507479401637;6219.253689557282;6222.377762223741;6227.377262273736;6235.376462353728;5882.23530940975;6032.276126864805;6167.383261673886;6254.405831446005;6263.123162757218;4628.67599268048;4723.7638118093955;4734.526547345238;4756.334113224151;4771.71369717818;4191.780958505982;4211.178820130045;4221.113566151082;4240.088380998101;4243.745375277432;5718.68547229898;5805.274340707411;5903.291605007426;5926.407359264039;5954.732037058343;6156;6280.7487700491465;6283.497320214372;6318.842028949313;6329.525285603599;5978.790742324085;6000.849978750566;6012.488938440194;6014.6391216527145;6034.5172386209;5129.948700512947;5286.497782710637;5368.8389348319615;5396.055690254189;5398.1093119634825;6343.682815859281;6460.3216662250725;6504.1869766279215;6504.252011018699;6509.609423434515;6304.873902522016;6313.147725057059;6316.178896743394;6317.463015643538;6322.209723784527;6123.877522449615;6333.936660633335;6439.452646525097;6509.381608747161;6533.67331633426;6135.263768347827;6170.321264660974;6185.257769067741;6188;6201.844953876189;6266.780662676784;6298.968505157445;6301.086342480223;6322.0516922462;6327.683615819283;5785.768569257182;6047.274327080779;6173.722182501888;6174.166487524127;6182.536309776695;6038.245219347582;6143.894099062211;6147.231596050494;6150.723217455135;6151.415615516519;6064.4541991221;6066.969665151646;6091.037445065382;6132.724027418866;6136.386361364007;5853.619514731528;6111.348653136637;6169.81490555284;6192.195014648067;6206.782762603287;5996.070609055603;6122.724073029453;6141.087130295835;6150.015997440388;6151.138840562236 21:07:31 INFO - PROCESS | 28170 | |1;ext.html;586.8239528141559;627.504271625416;642.7525402719955;653.3140202787075;679.2799632389664;42616.573834261646;46600.30099548505;47000;47120.29319560205;47211.29183062257;46747.298790518085;46827.76586117073;46976.76511617446;47394.28908566366;47504;9151.359404841663;9228.5847136879;9270.72187834366;9275.30435217358;9276.257899368034;9050.592723327432;9121.270298376146;9140.725778226664;9155.67955121571;9156.771080723001;9148.085191480832;9161.083891610819;9206.033366496522;9225.86161207579;9231.984481707006;9091.81816363669;9127.589258483351;9176.403533770317;9182.816343673156;9200.6779762708;9146.359754817166;9170.541472926327;9172.44965302084;9194.770130746718;9252.953735231347;43538;43684.344734828686;43778.12443751107;43816;43890.12219755587;3860.864869729546;4154.605312495308;4311.33174357975;4436.578525040116;4724.244120940667;35082;35169.47245791315;35632;35670.82164589186;36651;4609.377734005933;4609.585137337622;4646;4678.134545109166;4740.3837501124635;281293;282213;369629;383620;384336.9999999972;68186;69745.65127174332;69902;69905.3009469909;70013;40283;73297.6335118321;73711.63144184244;73812;74009.25990740131;18890.149943252585;19574.8042519573;19598.314059007866;19665.901670491556;19713.507162321057;14800.407983680747;14882.479113230986;14971.775423368657;14987.32557034936;15036.323365448581;21157.15371385158;21242.044108015176;21495;21574.676379854314;21601;7616.8476630467085;7702.383809295243;7794.3764498839955;7877.212278772192;8016.158303378062;1032.4321623107262;1076.316538997742;1121.433675993618;1130.4912789244709;1173.3253379306932;34111.488327675106;34244.31511369759;34898.651013490045;35000.29999400049;35081.82459087688;1165.9564689602928;1193.6359410379916;1210.8436443196726;1244.458660482693;1311.1477539599146;18893.338733144275;18966.715499267248;19406.611867762567;19912.303069392503;20273.69589456159;574235;579275;579909;583620;584122;66700.66649666817;67021;67070.66464667743;67086.32913670898;67184;1470.6985068061022;1483.6884254306717;1485.9331330089956;1510.1392206442442;1539.3611651164642;35119.297614047064;35155.64844351524;35524.822375887954;36163.276734464635;36258.637413625525;55918.720406397704;56760.716196420406;57020.714896425256;57074.42925570691;57115.42884571101;529087;529812;530513;531409;533728;30475.84762076264;31445.89939352112;31464.89872854439;31730;31782.84108579442;51887.74056129846;52063.219051713495;52685;53531.73234133804;53598.196027058846;44319.33520997123;44643.776781115885;44794.552054480344;45169.54830451785;45522.150956135265;43953.34069988889;44884.551154488036;45211;45407.7729611363;46204;44590.77704611456;45603.08793824171;46315.3052704203;46589.76705116588;48768.756156218995;39993.200135996536;40214.1957160861;40988;41374.37938430866;42342.78828605837;31435.214119647193;31522.684773151974;31583.36833263276;31656;31696.683033169375 21:07:31 INFO - PROCESS | 28170 | |2;jquery.html;397.09462425669466;397.7355058885841;423.7076417272082;431.6460502388042;438.59210933831525;19103.52241193971;20080.799192008075;20684.379468615945;20718;21161.788382116174;18769.343072992448;18780.342688005923;18897.716534252;18983.71524427135;19041.52396190096;5318.547923426513;5529.474699903502;5571.1086226203815;5594.608377413582;5597.076482380402;5526.309211348582;5530.087535556629;5882.14708867214;5923.081922302029;6077.179580756608;6121.479674227674;6198.132261483396;6219.657918814463;6237.625742455444;6240.8439789005415;5543.722813859311;5679.886402271932;5695.373508914016;5718.313802343725;5720.942790572082;5376.838694839161;5517.337919449652;5539.446055394468;5543.77824887004;5557.3886872444;14792.482263120739;14992.250387480692;14997.625059373493;15087.622809429851;22439.551208975892;2521.1428114440996;2585.75435333643;2608.6608740863567;2998.1976958387563;3172.9682703172903;10695.251332406735;11106.500207490682;11127.165462590337;11179.776404471864;12009.699757506132;2034.410021093881;2076.0138934006377;2100.789921007902;2139.529303553216;2161.3732017715;81833;84840;84906.5754671229;85433;85524.14475855224;11121.388323642277;11554.537818487166;11873.050155987501;11956.342401167845;11979.820302695467;16594;16604.08677522748;16628.418005369753;16707.49877503677;16710.749338759928;8465.873011904827;8984.146506081912;9009.099090090938;9110.59002344896;9201.953990230006;8444.704435344733;8470.44635664041;8710.651573936972;8791.384603077851;9068.183863452321;5044.9495505045215;5096.872578185575;5126.615503837227;5153.742312884341;5182.714950677749;1888.688366419553;1930.691089425685;1934.3133187718438;1965.1353404501974;2031.6038372517512;967.2455484721928;1037.7094413564214;1061.9628313009162;1087.3258579680648;1100.96146634869;20514.794852051586;21111.155553777677;21333.78666213349;21418.892905535686;23045.53908921812;1072.9302595331278;1089.4933855756954;1094.655183617158;1099.769048499808;1141.1213365708525;11606.593769218036;11778.5877494289;11945.522179112739;12037.097217708706;12042.75914481723;457477;467125;468521;517906;542282;105027.4748626252;108056;108294;108382.45808770906;109880.4505977465;1036.7097212780434;1045.4772613693153;1091.9508622112023;1107.457345900503;1113.8694225361264;18871.90564047171;19526.31657891967;19831.504212394804;19881;19942.30201942925;44754.55245447504;44832;45283.54716452925;46037.539624604666;46388.536114638424;61892;66252.668736656;67230.66384668046;67318;69598.30401695918;9161.404508706913;9288.442693438416;9355.532223388667;9388.530573471162;9555.761105972406;10793.73015674583;14353.425862965782;14355.210463424612;14984.400623975354;14994;12760.48958041705;12772.808407874076;12887.742245154857;12957.352132393155;12983.221006739626;11747;11820.0543956485;12277.877221228031;12303.9384803079;12544.121911466109;12051.096167787276;12205.352277442431;12512.247305592755;12536.937315313366;12584.244945303311;9266.629334826532;9359.766005849637;9394.483303418105;9494.240460762985;9497.47763872966;11656.592019279284;12185.329806860707;12186.75626487483;12253.387330633612;12253.509859605516 21:07:31 INFO - PROCESS | 28170 | |3;mootools.html;1573.488616199735;1590.1969505399773;1816.854651627869;1911.2068491575997;1941.2623203182789;8727.301815854733;9372.71881843544;9520.8571871422;10162.983701629833;10175.643852465157;9518.762030949212;9797.853032204523;9812.165965892907;9849.064338887812;9864.457454839981;2514.0823599386276;2576.703679076902;2580.6774153230845;2585.7155712871568;2593.8573378464175;2533.6832895888015;2612.6342312076326;2620.1877418000386;2620.9737902621014;2627.395698989224;2539.606361014046;2543.55487789637;2547.108512020787;2575.060103062378;2588.9741102589014;2520.78573321267;2528.962065569018;2531.7594828491265;2550.7959363250893;2559.2450227183026;2462.9261122166363;2467.6421918821848;2467.962980555293;2535.2521006303186;2555.2589748972778;9951.955044720346;10036.799264014751;10046.9497652512;10062.748431289203;10063;5591.10542313228;5713.914291285634;5721.656700597936;5725.427457254283;5736.483716465538;3328.6005679318396;3476.89569312921;3543.982280088583;3636.8180341389157;3637.7271704621994;1202.753435545711;1222.4010234984883;1226.5707002549125;1252.04218772639;1270.2632473165543;13963;13968.231747253896;13993.090449120877;14008.719825603534;14040.297985100806;4899.58353539946;5256.658317209369;5305.071612467803;5309.8938021239355;5366.838994830161;11711.1802173847;11747.588834390755;11749;11775.823362649568;11809.940950295366;5912.497437717842;5921.644701317935;5957.3744756799915;5959.433853783884;5964.701764911824;4973.925391119136;5323.813666521731;5381.0852155133725;5391.245225668409;5412.3505179377935;4520.276755719069;4556.7721613919175;4564.246899261651;4587.288970209623;4611.077784443125;1355.3223388305846;1398.119184913498;1401.6916278418732;1403.9929800350933;1416.2918540729636;1080.8000519903842;1090.1987039525943;1093.327603523827;1095.315427857589;1099.2689861242345;6499.122618446544;6508.544401891917;6653.301403352675;6797.966010169917;6805.557638753465;470.6681789338508;488.42122085329;492.8890999525078;495.8239824862194;502.7109412088064;4468;4560.4071470708595;4579.450465944108;4581.381513495702;4665.906681866411;12024.699382515331;12381.071419643562;12520;12520.186187897758;12534.122611417295;11788.528458861549;12268.509259629514;12305.507779688713;12343.19769214998;12376.381180940916;9308;9337.066293370744;9443.480608566457;9496.620135194653;9497.952510237405;6585.242697089704;6834.316568343126;6838.632273545268;6847.691853866489;6869.072675188786;11444.256123351955;11445.656630301104;11479;11502.53989840397;11661.416929153678;11503.654890353302;11589.884101158881;11691.707707307045;11749.118816088998;11790.705232369259;7909.841803163789;8598.183172598594;8645.524496152771;8746.256568191775;8783.077776833341;9442.575084121094;9628.951855240679;9657.082577155159;9669.806603867743;9674.854877176707;8601.354898382771;8661.437006594551;8707.521086340312;8765.079666635167;8772.561371931506;8528.530930798617;8537.957310213409;8594.527300998505;8639.784005399915;8706.60820263077;7793.493422927491;7962.606543854687;7972.760817175494;7998.600069996593;8003.719869804529;5613.270274864241;5679.574031947538;5735.483806457439;5800.216970708901;5934.6142500737315;5844.298684157929;5865.73604187804;5865.794697185578;5886.852828679317;5889.057750759858 21:07:31 INFO - PROCESS | 28170 | |4;prototype.html;353.5933676272288;356.4919989015653;357.6512899922575;358.5374866422314;359.82548463994976;5789.218455508505;5799.884002319951;5824.242848429703;5832;5847.210626565417;5715.885682286352;5720.0561907285355;5742.222310729211;5760.279965004374;5813.825585232439;4468.352088947101;4483.461984561857;4527.864164075083;4541.182587134314;4545.636349092065;4476.820927162909;4523.61549268311;4536.8638940831825;4546.772661366935;4583.152116858375;4497.685162038659;4525.117602067598;4535.752668016289;4561.361409402686;4563.224251877189;4446.644268458532;4476.999999999984;4480.737227700023;4522.68341216115;4541.863744087683;4013.3979903014783;4023.396490526415;4031.3348297530874;4060.8426598419605;4066.146109317047;5672.262605861211;5681.375048744635;5717.742701578439;5725.942740572583;5726.742296596663;5146.0702236661255;5248.632595718302;5257.894842103136;5271.472852714736;5331.493508116722;5989;6048.243969503812;6060.575759696823;6064.484518815906;6071.848203794896;4339.06710057336;4409.955900440987;4423.845165419195;4464.129494748526;4507.391502147201;5939.4357536034;6196.47329976957;6365.649889256089;6379.586920997244;6389.393007664265;4487.371767952489;4513.368128462018;4522.88692782683;4526.438378759322;4543.954560454419;4555.567221113989;4582.862514124582;4606.56237657422;4609.778408721691;4617.353570500132;4988.451270360258;5214.861906618268;5222.6083043771105;5223.791048358099;5236.581073514109;5977.491913187428;6017.187679663277;6042.607230530001;6097.542684298695;6175.517875709887;1519.908805471653;1533.9233038348038;1541.884358673104;1550.5968448203323;1556.6341909651223;951.8477043672979;1000.2648053680539;1003.2826529031777;1004.6785028790716;1008.3445760255746;5152.3044389007755;5192.584593232532;5194.636375453758;5246.685198888079;5262;5472.030069175094;5481.136413619389;5569.749361278752;5574.358948720949;5595.524380427628;4991.500849915052;5214.113600687892;5232.764525596357;5279.287296214962;5306.442823503477;2958.727747068781;2962.4075184963094;2993.625796775403;3021.8035827671133;3024.1723988071226;5785.103308987113;5798.246227990334;5802.4197580241635;5815.621984570989;5830.970845145747;6041.8489537761025;6408.198975128109;6439.613623182624;6472.579282346633;6485.967570162119;6561.934380656227;6610.272869984298;6642.734290628321;6649.836278651217;6652.966735166293;6199.938000619936;6363.427291543783;6374.776882809265;6399.200099987502;6410.679466026773;6323.177986861679;6331.2085989251345;6351.776878092631;6364.904526432199;6384.968075159594;6285.560010799383;6294.213223347082;6467.159269294962;6497.57765745244;6522.902156467562;4438.667099967451;4487.5063742987595;4519.932201017054;4538.001639639274;4542.409486766699;6285.622862628257;6300.810975670737;6382.90425643625;6395.1046853441485;6404.839879003062;6135.386461354007;6175.783847565313;6184.443400094013;6191.19514463117;6255.71849266775;5920.407959204045;6068.180795592715;6163.828872514208;6205.410486003822;6231.781887633911;6069.393060693896;6074.848128796815;6089.634621922522;6101.633901965896;6112.633242005316;6210.72051757681;6216.347283535164;6240.781572644935;6253.405926436982;6274.560780745486;5832.270966129234;6039.852428038658;6078.939210607838;6081.604695694766;6101.633901965896 21:07:31 INFO - PROCESS | 28170 | |5;yui.html;821.6425854753179;839.8446287436825;868.3313848336777;906.2659246010729;947.6920000999677;14893.478728244514;15491.380344786196;15575.29911153998;15712.292946817392;15729.606759831024;15253.847461525382;15349;15356.46252381167;15553.92223038886;16270.51188464348;882.7837179890936;903.6024149374288;905.1491597897988;905.1717678324359;906.0260220263243;867.1718508824058;902.7607683963755;903.6837107012526;911.9224865886407;912.0742446416892;943.7640589852537;947.303731757158;950.4724877692878;951.7953639967405;955.2596737528402;938.8357037518407;941.3457646935383;942.1002942190261;942.726609283307;946.9242460603169;703.1140762639111;703.3072423662688;703.6446594469811;704.1620471638785;704.7498138160981;16692.165391730367;16776.077315747752;16836.83163168377;16853;16868.409605663743;16065.22903564982;16288.267027983651;16385.09881956492;16588.50234492967;16652.00087994724;13392.196468211841;13439.193648381128;13493.460261589526;13498.797518037238;13904.165750055028;4154.771487568182;4186.790660466964;4187.45563076798;4202.831886724527;4329.437173167468;97140.51429742877;97698.51150744272;98746;98942.5052874731;98943;12886.935565322114;12991.545295914597;13086.803697944539;13110.672233194246;13150.408231629599;24466.388340291636;24507.14225002152;24548.38629034253;24564;24714.505709885703;9503.287253455881;9537.332386733;9566.521673916277;9585.424874507413;9679.370840895319;5222.9204441021875;5294.54996325309;5307.601929855199;5370.3287089113865;5485;3956.5449973252867;4071.1043570414463;4095.651869591118;4111.835526578963;4118.608732170439;702.7645738677601;733.6478490324674;762.8321769210764;797.9561124138228;826.7189155686975;641.3394203969918;654.3587284461255;709.2907092907093;780.6760194519325;845.1337379186383;10360.637377691744;10496.842547361795;10678.572857085785;10715.35707857531;11041.668749937515;620.8758248350348;746.5334166146158;749.7825630567074;765.9885101723479;768.5772824946257;4690.319903614025;4886.804527818918;4895.192293271642;4904.190808516626;4929.309896614477;79582.6020869892;83148;130172.3491382537;135323;137492;116689;117890.41054794671;120058;120980;123039;84442.15557844343;100672.4966375178;104976.47511762545;105104;107567.46216269025;9988.750281243027;10520.368777873353;10648.89351106479;10880.455977201267;11035.779284414428;41085.178296434504;51901;55316;55780.442195577525;56231.43768562426;46126.769366154294;79180.60409697915;79407;80345.19654803377;80850.19149808427;14131.364088615832;14519.419223230952;14682.55952321432;14953.551393458214;14954.177520236492;15680.607984800472;16547.420840270534;16621.75067373966;16635.667286653956;17793.110344482982;14722.77915831242;15223.695526089637;15394.230288485307;15614;16292.592685182964;14616.561503154922;15068.773968390264;15241.542753716963;15537.300821463288;15663.765043524585;15391.1534865579;15463.5360939172;15527.76708349353;15584.142872141687;16208;11972;12221.266723996589;12380.81428778587;12786.68033299175;13063.346832658519;12163.574274900337;12703.42834572428;13032;13090.869091308965;13147.53983610569 21:07:31 INFO - PROCESS | 28170 | __end_tp_report 21:07:31 INFO - PROCESS | 28170 | __start_cc_report 21:07:31 INFO - PROCESS | 28170 | _x_x_mozilla_cycle_collect,321 21:07:31 INFO - PROCESS | 28170 | __end_cc_report 21:07:31 INFO - PROCESS | 28170 | __startTimestamp1470110851260__endTimestamp 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | ------- Summary: start ------- 21:07:31 INFO - PROCESS | 28170 | Number of tests: 6 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | [#0] dojo.html Cycles:165 Average:5782.04 Median:6034.52 stddev:679.54 (11.3%) stddev-sans-first:652.22 21:07:31 INFO - PROCESS | 28170 | Values: 3261.5 3279.4 3283.2 3294.1 3308.8 5645.9 5681.1 5684.2 5716.9 5722.6 5771.8 5809.1 5858.4 5864.5 5872.2 5249.1 5279.3 5289.5 5296.7 5370.8 5103.5 5159.2 5177.9 5188.7 5236.8 5302.4 5305.4 5313.4 5347.6 5384.0 5360.7 5363.3 5381.1 5388.5 5391.8 4987.9 5159.4 5280.9 5299.4 5364.8 5738.7 5812.2 5812.8 5819.6 5850.8 6225.7 6231.8 6270.5 6271.6 6309.9 6008.9 6081.9 6297.9 6306.2 6320.7 5707.6 5810.1 5810.5 5821.7 5834.3 6321.9 6345.5 6348.5 6349.9 6365.6 5946.8 6031.0 6081.8 6108.7 6125.3 6107.4 6235.9 6260.1 6266.3 6267.6 6156.5 6219.3 6222.4 6227.4 6235.4 5882.2 6032.3 6167.4 6254.4 6263.1 4628.7 4723.8 4734.5 4756.3 4771.7 4191.8 4211.2 4221.1 4240.1 4243.7 5718.7 5805.3 5903.3 5926.4 5954.7 6156.0 6280.7 6283.5 6318.8 6329.5 5978.8 6000.8 6012.5 6014.6 6034.5 5129.9 5286.5 5368.8 5396.1 5398.1 6343.7 6460.3 6504.2 6504.3 6509.6 6304.9 6313.1 6316.2 6317.5 6322.2 6123.9 6333.9 6439.5 6509.4 6533.7 6135.3 6170.3 6185.3 6188.0 6201.8 6266.8 6299.0 6301.1 6322.1 6327.7 5785.8 6047.3 6173.7 6174.2 6182.5 6038.2 6143.9 6147.2 6150.7 6151.4 6064.5 6067.0 6091.0 6132.7 6136.4 5853.6 6111.3 6169.8 6192.2 6206.8 5996.1 6122.7 6141.1 6150.0 6151.1 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | [#1] ext.html Cycles:180 Average:66393.42 Median:45562.62 stddev:131574.16 (288.8%) stddev-sans-first:131850.50 21:07:31 INFO - PROCESS | 28170 | Values: 586.8 627.5 642.8 653.3 679.3 42616.6 46600.3 47000.0 47120.3 47211.3 46747.3 46827.8 46976.8 47394.3 47504.0 9151.4 9228.6 9270.7 9275.3 9276.3 9050.6 9121.3 9140.7 9155.7 9156.8 9148.1 9161.1 9206.0 9225.9 9232.0 9091.8 9127.6 9176.4 9182.8 9200.7 9146.4 9170.5 9172.4 9194.8 9253.0 43538.0 43684.3 43778.1 43816.0 43890.1 3860.9 4154.6 4311.3 4436.6 4724.2 35082.0 35169.5 35632.0 35670.8 36651.0 4609.4 4609.6 4646.0 4678.1 4740.4 281293.0 282213.0 369629.0 383620.0 384337.0 68186.0 69745.7 69902.0 69905.3 70013.0 40283.0 73297.6 73711.6 73812.0 74009.3 18890.1 19574.8 19598.3 19665.9 19713.5 14800.4 14882.5 14971.8 14987.3 15036.3 21157.2 21242.0 21495.0 21574.7 21601.0 7616.8 7702.4 7794.4 7877.2 8016.2 1032.4 1076.3 1121.4 1130.5 1173.3 34111.5 34244.3 34898.7 35000.3 35081.8 1166.0 1193.6 1210.8 1244.5 1311.1 18893.3 18966.7 19406.6 19912.3 20273.7 574235.0 579275.0 579909.0 583620.0 584122.0 66700.7 67021.0 67070.7 67086.3 67184.0 1470.7 1483.7 1485.9 1510.1 1539.4 35119.3 35155.6 35524.8 36163.3 36258.6 55918.7 56760.7 57020.7 57074.4 57115.4 529087.0 529812.0 530513.0 531409.0 533728.0 30475.8 31445.9 31464.9 31730.0 31782.8 51887.7 52063.2 52685.0 53531.7 53598.2 44319.3 44643.8 44794.6 45169.5 45522.2 43953.3 44884.6 45211.0 45407.8 46204.0 44590.8 45603.1 46315.3 46589.8 48768.8 39993.2 40214.2 40988.0 41374.4 42342.8 31435.2 31522.7 31583.4 31656.0 31696.7 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | [#2] jquery.html Cycles:180 Average:30204.30 Median:11605.97 stddev:81575.43 (702.9%) stddev-sans-first:81773.57 21:07:31 INFO - PROCESS | 28170 | Values: 397.1 397.7 423.7 431.6 438.6 19103.5 20080.8 20684.4 20718.0 21161.8 18769.3 18780.3 18897.7 18983.7 19041.5 5318.5 5529.5 5571.1 5594.6 5597.1 5526.3 5530.1 5882.1 5923.1 6077.2 6121.5 6198.1 6219.7 6237.6 6240.8 5543.7 5679.9 5695.4 5718.3 5720.9 5376.8 5517.3 5539.4 5543.8 5557.4 14792.5 14992.3 14997.6 15087.6 22439.6 2521.1 2585.8 2608.7 2998.2 3173.0 10695.3 11106.5 11127.2 11179.8 12009.7 2034.4 2076.0 2100.8 2139.5 2161.4 81833.0 84840.0 84906.6 85433.0 85524.1 11121.4 11554.5 11873.1 11956.3 11979.8 16594.0 16604.1 16628.4 16707.5 16710.7 8465.9 8984.1 9009.1 9110.6 9202.0 8444.7 8470.4 8710.7 8791.4 9068.2 5044.9 5096.9 5126.6 5153.7 5182.7 1888.7 1930.7 1934.3 1965.1 2031.6 967.2 1037.7 1062.0 1087.3 1101.0 20514.8 21111.2 21333.8 21418.9 23045.5 1072.9 1089.5 1094.7 1099.8 1141.1 11606.6 11778.6 11945.5 12037.1 12042.8 457477.0 467125.0 468521.0 517906.0 542282.0 105027.5 108056.0 108294.0 108382.5 109880.5 1036.7 1045.5 1092.0 1107.5 1113.9 18871.9 19526.3 19831.5 19881.0 19942.3 44754.6 44832.0 45283.5 46037.5 46388.5 61892.0 66252.7 67230.7 67318.0 69598.3 9161.4 9288.4 9355.5 9388.5 9555.8 10793.7 14353.4 14355.2 14984.4 14994.0 12760.5 12772.8 12887.7 12957.4 12983.2 11747.0 11820.1 12277.9 12303.9 12544.1 12051.1 12205.4 12512.2 12536.9 12584.2 9266.6 9359.8 9394.5 9494.2 9497.5 11656.6 12185.3 12186.8 12253.4 12253.5 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | [#3] mootools.html Cycles:180 Average:6510.93 Median:4571.85 stddev:3777.88 (82.6%) stddev-sans-first:3770.25 21:07:31 INFO - PROCESS | 28170 | Values: 1573.5 1590.2 1816.9 1911.2 1941.3 8727.3 9372.7 9520.9 10163.0 10175.6 9518.8 9797.9 9812.2 9849.1 9864.5 2514.1 2576.7 2580.7 2585.7 2593.9 2533.7 2612.6 2620.2 2621.0 2627.4 2539.6 2543.6 2547.1 2575.1 2589.0 2520.8 2529.0 2531.8 2550.8 2559.2 2462.9 2467.6 2468.0 2535.3 2555.3 9952.0 10036.8 10046.9 10062.7 10063.0 5591.1 5713.9 5721.7 5725.4 5736.5 3328.6 3476.9 3544.0 3636.8 3637.7 1202.8 1222.4 1226.6 1252.0 1270.3 13963.0 13968.2 13993.1 14008.7 14040.3 4899.6 5256.7 5305.1 5309.9 5366.8 11711.2 11747.6 11749.0 11775.8 11809.9 5912.5 5921.6 5957.4 5959.4 5964.7 4973.9 5323.8 5381.1 5391.2 5412.4 4520.3 4556.8 4564.2 4587.3 4611.1 1355.3 1398.1 1401.7 1404.0 1416.3 1080.8 1090.2 1093.3 1095.3 1099.3 6499.1 6508.5 6653.3 6798.0 6805.6 470.7 488.4 492.9 495.8 502.7 4468.0 4560.4 4579.5 4581.4 4665.9 12024.7 12381.1 12520.0 12520.2 12534.1 11788.5 12268.5 12305.5 12343.2 12376.4 9308.0 9337.1 9443.5 9496.6 9498.0 6585.2 6834.3 6838.6 6847.7 6869.1 11444.3 11445.7 11479.0 11502.5 11661.4 11503.7 11589.9 11691.7 11749.1 11790.7 7909.8 8598.2 8645.5 8746.3 8783.1 9442.6 9629.0 9657.1 9669.8 9674.9 8601.4 8661.4 8707.5 8765.1 8772.6 8528.5 8538.0 8594.5 8639.8 8706.6 7793.5 7962.6 7972.8 7998.6 8003.7 5613.3 5679.6 5735.5 5800.2 5934.6 5844.3 5865.7 5865.8 5886.9 5889.1 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | [#4] prototype.html Cycles:180 Average:5083.20 Median:5698.63 stddev:1507.89 (26.5%) stddev-sans-first:1469.74 21:07:31 INFO - PROCESS | 28170 | Values: 353.6 356.5 357.7 358.5 359.8 5789.2 5799.9 5824.2 5832.0 5847.2 5715.9 5720.1 5742.2 5760.3 5813.8 4468.4 4483.5 4527.9 4541.2 4545.6 4476.8 4523.6 4536.9 4546.8 4583.2 4497.7 4525.1 4535.8 4561.4 4563.2 4446.6 4477.0 4480.7 4522.7 4541.9 4013.4 4023.4 4031.3 4060.8 4066.1 5672.3 5681.4 5717.7 5725.9 5726.7 5146.1 5248.6 5257.9 5271.5 5331.5 5989.0 6048.2 6060.6 6064.5 6071.8 4339.1 4410.0 4423.8 4464.1 4507.4 5939.4 6196.5 6365.6 6379.6 6389.4 4487.4 4513.4 4522.9 4526.4 4544.0 4555.6 4582.9 4606.6 4609.8 4617.4 4988.5 5214.9 5222.6 5223.8 5236.6 5977.5 6017.2 6042.6 6097.5 6175.5 1519.9 1533.9 1541.9 1550.6 1556.6 951.8 1000.3 1003.3 1004.7 1008.3 5152.3 5192.6 5194.6 5246.7 5262.0 5472.0 5481.1 5569.7 5574.4 5595.5 4991.5 5214.1 5232.8 5279.3 5306.4 2958.7 2962.4 2993.6 3021.8 3024.2 5785.1 5798.2 5802.4 5815.6 5831.0 6041.8 6408.2 6439.6 6472.6 6486.0 6561.9 6610.3 6642.7 6649.8 6653.0 6199.9 6363.4 6374.8 6399.2 6410.7 6323.2 6331.2 6351.8 6364.9 6385.0 6285.6 6294.2 6467.2 6497.6 6522.9 4438.7 4487.5 4519.9 4538.0 4542.4 6285.6 6300.8 6382.9 6395.1 6404.8 6135.4 6175.8 6184.4 6191.2 6255.7 5920.4 6068.2 6163.8 6205.4 6231.8 6069.4 6074.8 6089.6 6101.6 6112.6 6210.7 6216.3 6240.8 6253.4 6274.6 5832.3 6039.9 6078.9 6081.6 6101.6 21:07:31 INFO - PROCESS | 28170 | 21:07:31 INFO - PROCESS | 28170 | [#5] yui.html Cycles:180 Average:23113.99 Median:14335.53 stddev:33694.14 (235.0%) stddev-sans-first:33747.08 21:07:31 INFO - PROCESS | 28170 | Values: 821.6 839.8 868.3 906.3 947.7 14893.5 15491.4 15575.3 15712.3 15729.6 15253.8 15349.0 15356.5 15553.9 16270.5 882.8 903.6 905.1 905.2 906.0 867.2 902.8 903.7 911.9 912.1 943.8 947.3 950.5 951.8 955.3 938.8 941.3 942.1 942.7 946.9 703.1 703.3 703.6 704.2 704.7 16692.2 16776.1 16836.8 16853.0 16868.4 16065.2 16288.3 16385.1 16588.5 16652.0 13392.2 13439.2 13493.5 13498.8 13904.2 4154.8 4186.8 4187.5 4202.8 4329.4 97140.5 97698.5 98746.0 98942.5 98943.0 12886.9 12991.5 13086.8 13110.7 13150.4 24466.4 24507.1 24548.4 24564.0 24714.5 9503.3 9537.3 9566.5 9585.4 9679.4 5222.9 5294.5 5307.6 5370.3 5485.0 3956.5 4071.1 4095.7 4111.8 4118.6 702.8 733.6 762.8 798.0 826.7 641.3 654.4 709.3 780.7 845.1 10360.6 10496.8 10678.6 10715.4 11041.7 620.9 746.5 749.8 766.0 768.6 4690.3 4886.8 4895.2 4904.2 4929.3 79582.6 83148.0 130172.3 135323.0 137492.0 116689.0 117890.4 120058.0 120980.0 123039.0 84442.2 100672.5 104976.5 105104.0 107567.5 9988.8 10520.4 10648.9 10880.5 11035.8 41085.2 51901.0 55316.0 55780.4 56231.4 46126.8 79180.6 79407.0 80345.2 80850.2 14131.4 14519.4 14682.6 14953.6 14954.2 15680.6 16547.4 16621.8 16635.7 17793.1 14722.8 15223.7 15394.2 15614.0 16292.6 14616.6 15068.8 15241.5 15537.3 15663.8 15391.2 15463.5 15527.8 15584.1 16208.0 11972.0 12221.3 12380.8 12786.7 13063.3 12163.6 12703.4 13032.0 13090.9 13147.5 21:07:31 INFO - PROCESS | 28170 | -------- Summary: end -------- 21:07:31 INFO - PROCESS | 28170 | 21:07:32 INFO - TEST-INFO | 28170: exit 0 21:07:32 INFO - TEST-OK | dromaeo_css | took 1112096ms 21:07:32 INFO - TEST-START | kraken 21:07:32 INFO - operating with platform_type : linux_ 21:07:32 INFO - Initialising browser for kraken test... 21:07:32 INFO - TEST-INFO | started process 28429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ5baDm/profile http://localhost:41465/getInfo.html) 21:07:37 INFO - PROCESS | 28429 | __metrics Screen width/height:1600/1200 21:07:37 INFO - PROCESS | 28429 | colorDepth:24 21:07:37 INFO - PROCESS | 28429 | Browser inner width/height: 1024/697 21:07:37 INFO - PROCESS | 28429 | __metrics 21:07:37 ERROR - PROCESS | 28429 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 21:07:38 INFO - TEST-INFO | 28429: exit 0 21:07:38 INFO - Browser initialized. 21:07:38 INFO - Running cycle 1/1 for kraken test... 21:07:38 INFO - TEST-INFO | started process 28556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ5baDm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:50 INFO - PROCESS | 28556 | RSS: Main: 153030656 21:07:50 INFO - PROCESS | 28556 | 21:07:53 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41465/tests/kraken/driver.html?testName=audio-beat-detection) 21:07:54 INFO - PROCESS | 28556 | RSS: Main: 158474240 21:07:54 INFO - PROCESS | 28556 | 21:07:56 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41465/tests/kraken/driver.html?testName=audio-dft) 21:07:57 INFO - PROCESS | 28556 | RSS: Main: 156778496 21:07:57 INFO - PROCESS | 28556 | 21:08:00 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41465/tests/kraken/driver.html?testName=audio-fft) 21:08:00 INFO - PROCESS | 28556 | RSS: Main: 157323264 21:08:00 INFO - PROCESS | 28556 | 21:08:02 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41465/tests/kraken/driver.html?testName=audio-oscillator) 21:08:03 INFO - PROCESS | 28556 | RSS: Main: 157122560 21:08:03 INFO - PROCESS | 28556 | 21:08:05 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:08:06 INFO - PROCESS | 28556 | RSS: Main: 156495872 21:08:06 INFO - PROCESS | 28556 | 21:08:09 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41465/tests/kraken/driver.html?testName=imaging-darkroom) 21:08:09 INFO - PROCESS | 28556 | RSS: Main: 156282880 21:08:09 INFO - PROCESS | 28556 | 21:08:13 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41465/tests/kraken/driver.html?testName=imaging-desaturate) 21:08:14 INFO - PROCESS | 28556 | RSS: Main: 154771456 21:08:14 INFO - PROCESS | 28556 | 21:08:16 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41465/tests/kraken/driver.html?testName=json-parse-financial) 21:08:17 INFO - PROCESS | 28556 | RSS: Main: 156286976 21:08:17 INFO - PROCESS | 28556 | 21:08:18 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:08:19 INFO - PROCESS | 28556 | RSS: Main: 156041216 21:08:19 INFO - PROCESS | 28556 | 21:08:21 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:08:22 INFO - PROCESS | 28556 | RSS: Main: 156577792 21:08:22 INFO - PROCESS | 28556 | 21:08:23 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:08:24 INFO - PROCESS | 28556 | RSS: Main: 156921856 21:08:24 INFO - PROCESS | 28556 | 21:08:27 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:08:27 INFO - PROCESS | 28556 | RSS: Main: 157261824 21:08:27 INFO - PROCESS | 28556 | 21:08:30 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:08:31 INFO - PROCESS | 28556 | RSS: Main: 157519872 21:08:31 INFO - PROCESS | 28556 | 21:08:32 INFO - PROCESS | 28556 | Cycle 1(1): loaded http://localhost:41465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41465/tests/kraken/driver.html?testName=ai-astar) 21:08:33 INFO - PROCESS | 28556 | RSS: Main: 158257152 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | __start_tp_report 21:08:33 INFO - PROCESS | 28556 | _x_x_mozilla_page_load 21:08:33 INFO - PROCESS | 28556 | _x_x_mozilla_page_load_details 21:08:33 INFO - PROCESS | 28556 | |i|pagename|runs| 21:08:33 INFO - PROCESS | 28556 | |0;ai-astar;100;110;103;110;112;111;110;110;110;110 21:08:33 INFO - PROCESS | 28556 | |1;audio-beat-detection;145;114;138;180;124;143;153;122;184;125 21:08:33 INFO - PROCESS | 28556 | |2;audio-dft;162;163;163;161;163;163;162;162;162;161 21:08:33 INFO - PROCESS | 28556 | |3;audio-fft;76;82;76;182;76;75;76;75;178;77 21:08:33 INFO - PROCESS | 28556 | |4;audio-oscillator;85;85;144;85;87;84;141;83;83;157 21:08:33 INFO - PROCESS | 28556 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;118;118;117 21:08:33 INFO - PROCESS | 28556 | |6;imaging-darkroom;147;148;148;147;149;147;147;146;200;148 21:08:33 INFO - PROCESS | 28556 | |7;imaging-desaturate;94;95;97;95;96;96;95;95;96;96 21:08:33 INFO - PROCESS | 28556 | |8;json-parse-financial;50;52;51;50;55;54;52;52;51;50 21:08:33 INFO - PROCESS | 28556 | |9;json-stringify-tinderbox;61;62;61;62;61;64;60;61;61;61 21:08:33 INFO - PROCESS | 28556 | |10;stanford-crypto-aes;73;74;72;73;78;72;72;73;73;77 21:08:33 INFO - PROCESS | 28556 | |11;stanford-crypto-ccm;126;126;124;117;126;124;122;119;162;129 21:08:33 INFO - PROCESS | 28556 | |12;stanford-crypto-pbkdf2;156;154;158;158;162;161;152;157;152;155 21:08:33 INFO - PROCESS | 28556 | |13;stanford-crypto-sha256-iterative;62;63;63;63;60;61;61;61;62;59 21:08:33 INFO - PROCESS | 28556 | __end_tp_report 21:08:33 INFO - PROCESS | 28556 | __start_cc_report 21:08:33 INFO - PROCESS | 28556 | _x_x_mozilla_cycle_collect,862 21:08:33 INFO - PROCESS | 28556 | __end_cc_report 21:08:33 INFO - PROCESS | 28556 | __startTimestamp1470110913078__endTimestamp 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | ------- Summary: start ------- 21:08:33 INFO - PROCESS | 28556 | Number of tests: 14 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:2.55 21:08:33 INFO - PROCESS | 28556 | Values: 100.0 110.0 103.0 110.0 112.0 111.0 110.0 110.0 110.0 110.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:144.00 stddev:23.91 (16.6%) stddev-sans-first:25.35 21:08:33 INFO - PROCESS | 28556 | Values: 145.0 114.0 138.0 180.0 124.0 143.0 153.0 122.0 184.0 125.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 21:08:33 INFO - PROCESS | 28556 | Values: 162.0 163.0 163.0 161.0 163.0 163.0 162.0 162.0 162.0 161.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#3] audio-fft Cycles:10 Average:97.30 Median:76.00 stddev:43.64 (57.4%) stddev-sans-first:45.60 21:08:33 INFO - PROCESS | 28556 | Values: 76.0 82.0 76.0 182.0 76.0 75.0 76.0 75.0 178.0 77.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.50 stddev:30.60 (36.2%) stddev-sans-first:31.73 21:08:33 INFO - PROCESS | 28556 | Values: 85.0 85.0 144.0 85.0 87.0 84.0 141.0 83.0 83.0 157.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:08:33 INFO - PROCESS | 28556 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:148.00 stddev:16.64 (11.2%) stddev-sans-first:17.52 21:08:33 INFO - PROCESS | 28556 | Values: 147.0 148.0 148.0 147.0 149.0 147.0 147.0 146.0 200.0 148.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 21:08:33 INFO - PROCESS | 28556 | Values: 94.0 95.0 97.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.70 (3.3%) stddev-sans-first:1.69 21:08:33 INFO - PROCESS | 28556 | Values: 50.0 52.0 51.0 50.0 55.0 54.0 52.0 52.0 51.0 50.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 21:08:33 INFO - PROCESS | 28556 | Values: 61.0 62.0 61.0 62.0 61.0 64.0 60.0 61.0 61.0 61.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.00 stddev:2.11 (2.9%) stddev-sans-first:2.22 21:08:33 INFO - PROCESS | 28556 | Values: 73.0 74.0 72.0 73.0 78.0 72.0 72.0 73.0 73.0 77.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:126.00 stddev:12.63 (10.0%) stddev-sans-first:13.39 21:08:33 INFO - PROCESS | 28556 | Values: 126.0 126.0 124.0 117.0 126.0 124.0 122.0 119.0 162.0 129.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.50 stddev:3.41 (2.2%) stddev-sans-first:3.61 21:08:33 INFO - PROCESS | 28556 | Values: 156.0 154.0 158.0 158.0 162.0 161.0 152.0 157.0 152.0 155.0 21:08:33 INFO - PROCESS | 28556 | 21:08:33 INFO - PROCESS | 28556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 21:08:33 INFO - PROCESS | 28556 | Values: 62.0 63.0 63.0 63.0 60.0 61.0 61.0 61.0 62.0 59.0 21:08:33 INFO - PROCESS | 28556 | -------- Summary: end -------- 21:08:33 INFO - PROCESS | 28556 | 21:08:34 INFO - TEST-INFO | 28556: exit 0 21:08:34 INFO - TEST-OK | kraken | took 61989ms 21:08:34 INFO - SUITE-END | took 1174s 21:08:34 INFO - Completed test suite (00:19:34) 21:08:34 INFO - javascript benchmark 21:08:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7897.644362289463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.527078573607, 3279.3605246976836, 3283.16279348766, 3294.0776582556878, 3308.768386212966, 5645.887082258358, 5681.147827825818, 5684.232628595144, 5716.942830571693, 5722.599418040739, 5771.769129234836, 5809.099589563624, 5858.384869588695, 5864.472197502224, 5872.207252020976, 5249.055170069396, 5279.260903473517, 5289.471052894718, 5296.682199068049, 5370.845268267321, 5103.515166059218, 5159.174532074869, 5177.948220517785, 5188.662736922088, 5236.764345604438, 5302.363716354023, 5305.363356397218, 5313.442088580701, 5347.6256662033675, 5383.973080134594, 5360.705161216151, 5363.302770639812, 5381.0852155133725, 5388.515033646951, 5391.81128660499, 4987.875303117415, 5159.355080614923, 5280.947190528084, 5299.417064122943, 5364.785408583652, 5738.713064346766, 5812.157237200625, 5812.82561523155, 5819.592628516006, 5850.824475265749, 6225.719842607094, 6231.781887633956, 6270.529710271748, 6271.623702577815, 6309.936900630981, 6008.909866352008, 6081.878362432726, 6297.937020629781, 6306.180196574416, 6320.683965801738, 5707.6290041147195, 5810.128480727924, 5810.50610698087, 5821.708914554255, 5834.299884013945, 6321.873562528724, 6345.49236061114, 6348.492120630339, 6349.873002539924, 6365.649889256043, 5946.821595352147, 6031.0, 6081.75672973085, 6108.694565271719, 6125.326214116443, 6107.4197951194565, 6235.937640623536, 6260.092286618415, 6266.279377871512, 6267.592606480564, 6156.507479401637, 6219.253689557282, 6222.377762223741, 6227.377262273736, 6235.376462353728, 5882.23530940975, 6032.276126864805, 6167.383261673886, 6254.405831446005, 6263.123162757218, 4628.67599268048, 4723.7638118093955, 4734.526547345238, 4756.334113224151, 4771.71369717818, 4191.780958505982, 4211.178820130045, 4221.113566151082, 4240.088380998101, 4243.745375277432, 5718.68547229898, 5805.274340707411, 5903.291605007426, 5926.407359264039, 5954.732037058343, 6156.0, 6280.7487700491465, 6283.497320214372, 6318.842028949313, 6329.525285603599, 5978.790742324085, 6000.849978750566, 6012.488938440194, 6014.6391216527145, 6034.5172386209, 5129.948700512947, 5286.497782710637, 5368.8389348319615, 5396.055690254189, 5398.1093119634825, 6343.682815859281, 6460.3216662250725, 6504.1869766279215, 6504.252011018699, 6509.609423434515, 6304.873902522016, 6313.147725057059, 6316.178896743394, 6317.463015643538, 6322.209723784527, 6123.877522449615, 6333.936660633335, 6439.452646525097, 6509.381608747161, 6533.67331633426, 6135.263768347827, 6170.321264660974, 6185.257769067741, 6188.0, 6201.844953876189, 6266.780662676784, 6298.968505157445, 6301.086342480223, 6322.0516922462, 6327.683615819283, 5785.768569257182, 6047.274327080779, 6173.722182501888, 6174.166487524127, 6182.536309776695, 6038.245219347582, 6143.894099062211, 6147.231596050494, 6150.723217455135, 6151.415615516519, 6064.4541991221, 6066.969665151646, 6091.037445065382, 6132.724027418866, 6136.386361364007, 5853.619514731528, 6111.348653136637, 6169.81490555284, 6192.195014648067, 6206.782762603287, 5996.070609055603, 6122.724073029453, 6141.087130295835, 6150.015997440388, 6151.138840562236], "value": 5734.3589617762855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8239528141559, 627.504271625416, 642.7525402719955, 653.3140202787075, 679.2799632389664, 42616.573834261646, 46600.30099548505, 47000.0, 47120.29319560205, 47211.29183062257, 46747.298790518085, 46827.76586117073, 46976.76511617446, 47394.28908566366, 47504.0, 9151.359404841663, 9228.5847136879, 9270.72187834366, 9275.30435217358, 9276.257899368034, 9050.592723327432, 9121.270298376146, 9140.725778226664, 9155.67955121571, 9156.771080723001, 9148.085191480832, 9161.083891610819, 9206.033366496522, 9225.86161207579, 9231.984481707006, 9091.81816363669, 9127.589258483351, 9176.403533770317, 9182.816343673156, 9200.6779762708, 9146.359754817166, 9170.541472926327, 9172.44965302084, 9194.770130746718, 9252.953735231347, 43538.0, 43684.344734828686, 43778.12443751107, 43816.0, 43890.12219755587, 3860.864869729546, 4154.605312495308, 4311.33174357975, 4436.578525040116, 4724.244120940667, 35082.0, 35169.47245791315, 35632.0, 35670.82164589186, 36651.0, 4609.377734005933, 4609.585137337622, 4646.0, 4678.134545109166, 4740.3837501124635, 281293.0, 282213.0, 369629.0, 383620.0, 384336.9999999972, 68186.0, 69745.65127174332, 69902.0, 69905.3009469909, 70013.0, 40283.0, 73297.6335118321, 73711.63144184244, 73812.0, 74009.25990740131, 18890.149943252585, 19574.8042519573, 19598.314059007866, 19665.901670491556, 19713.507162321057, 14800.407983680747, 14882.479113230986, 14971.775423368657, 14987.32557034936, 15036.323365448581, 21157.15371385158, 21242.044108015176, 21495.0, 21574.676379854314, 21601.0, 7616.8476630467085, 7702.383809295243, 7794.3764498839955, 7877.212278772192, 8016.158303378062, 1032.4321623107262, 1076.316538997742, 1121.433675993618, 1130.4912789244709, 1173.3253379306932, 34111.488327675106, 34244.31511369759, 34898.651013490045, 35000.29999400049, 35081.82459087688, 1165.9564689602928, 1193.6359410379916, 1210.8436443196726, 1244.458660482693, 1311.1477539599146, 18893.338733144275, 18966.715499267248, 19406.611867762567, 19912.303069392503, 20273.69589456159, 574235.0, 579275.0, 579909.0, 583620.0, 584122.0, 66700.66649666817, 67021.0, 67070.66464667743, 67086.32913670898, 67184.0, 1470.6985068061022, 1483.6884254306717, 1485.9331330089956, 1510.1392206442442, 1539.3611651164642, 35119.297614047064, 35155.64844351524, 35524.822375887954, 36163.276734464635, 36258.637413625525, 55918.720406397704, 56760.716196420406, 57020.714896425256, 57074.42925570691, 57115.42884571101, 529087.0, 529812.0, 530513.0, 531409.0, 533728.0, 30475.84762076264, 31445.89939352112, 31464.89872854439, 31730.0, 31782.84108579442, 51887.74056129846, 52063.219051713495, 52685.0, 53531.73234133804, 53598.196027058846, 44319.33520997123, 44643.776781115885, 44794.552054480344, 45169.54830451785, 45522.150956135265, 43953.34069988889, 44884.551154488036, 45211.0, 45407.7729611363, 46204.0, 44590.77704611456, 45603.08793824171, 46315.3052704203, 46589.76705116588, 48768.756156218995, 39993.200135996536, 40214.1957160861, 40988.0, 41374.37938430866, 42342.78828605837, 31435.214119647193, 31522.684773151974, 31583.36833263276, 31656.0, 31696.683033169375], "value": 22104.31357428125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.09462425669466, 397.7355058885841, 423.7076417272082, 431.6460502388042, 438.59210933831525, 19103.52241193971, 20080.799192008075, 20684.379468615945, 20718.0, 21161.788382116174, 18769.343072992448, 18780.342688005923, 18897.716534252, 18983.71524427135, 19041.52396190096, 5318.547923426513, 5529.474699903502, 5571.1086226203815, 5594.608377413582, 5597.076482380402, 5526.309211348582, 5530.087535556629, 5882.14708867214, 5923.081922302029, 6077.179580756608, 6121.479674227674, 6198.132261483396, 6219.657918814463, 6237.625742455444, 6240.8439789005415, 5543.722813859311, 5679.886402271932, 5695.373508914016, 5718.313802343725, 5720.942790572082, 5376.838694839161, 5517.337919449652, 5539.446055394468, 5543.77824887004, 5557.3886872444, 14792.482263120739, 14992.250387480692, 14997.625059373493, 15087.622809429851, 22439.551208975892, 2521.1428114440996, 2585.75435333643, 2608.6608740863567, 2998.1976958387563, 3172.9682703172903, 10695.251332406735, 11106.500207490682, 11127.165462590337, 11179.776404471864, 12009.699757506132, 2034.410021093881, 2076.0138934006377, 2100.789921007902, 2139.529303553216, 2161.3732017715, 81833.0, 84840.0, 84906.5754671229, 85433.0, 85524.14475855224, 11121.388323642277, 11554.537818487166, 11873.050155987501, 11956.342401167845, 11979.820302695467, 16594.0, 16604.08677522748, 16628.418005369753, 16707.49877503677, 16710.749338759928, 8465.873011904827, 8984.146506081912, 9009.099090090938, 9110.59002344896, 9201.953990230006, 8444.704435344733, 8470.44635664041, 8710.651573936972, 8791.384603077851, 9068.183863452321, 5044.9495505045215, 5096.872578185575, 5126.615503837227, 5153.742312884341, 5182.714950677749, 1888.688366419553, 1930.691089425685, 1934.3133187718438, 1965.1353404501974, 2031.6038372517512, 967.2455484721928, 1037.7094413564214, 1061.9628313009162, 1087.3258579680648, 1100.96146634869, 20514.794852051586, 21111.155553777677, 21333.78666213349, 21418.892905535686, 23045.53908921812, 1072.9302595331278, 1089.4933855756954, 1094.655183617158, 1099.769048499808, 1141.1213365708525, 11606.593769218036, 11778.5877494289, 11945.522179112739, 12037.097217708706, 12042.75914481723, 457477.0, 467125.0, 468521.0, 517906.0, 542282.0, 105027.4748626252, 108056.0, 108294.0, 108382.45808770906, 109880.4505977465, 1036.7097212780434, 1045.4772613693153, 1091.9508622112023, 1107.457345900503, 1113.8694225361264, 18871.90564047171, 19526.31657891967, 19831.504212394804, 19881.0, 19942.30201942925, 44754.55245447504, 44832.0, 45283.54716452925, 46037.539624604666, 46388.536114638424, 61892.0, 66252.668736656, 67230.66384668046, 67318.0, 69598.30401695918, 9161.404508706913, 9288.442693438416, 9355.532223388667, 9388.530573471162, 9555.761105972406, 10793.73015674583, 14353.425862965782, 14355.210463424612, 14984.400623975354, 14994.0, 12760.48958041705, 12772.808407874076, 12887.742245154857, 12957.352132393155, 12983.221006739626, 11747.0, 11820.0543956485, 12277.877221228031, 12303.9384803079, 12544.121911466109, 12051.096167787276, 12205.352277442431, 12512.247305592755, 12536.937315313366, 12584.244945303311, 9266.629334826532, 9359.766005849637, 9394.483303418105, 9494.240460762985, 9497.47763872966, 11656.592019279284, 12185.329806860707, 12186.75626487483, 12253.387330633612, 12253.509859605516], "value": 9744.99938604397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.488616199735, 1590.1969505399773, 1816.854651627869, 1911.2068491575997, 1941.2623203182789, 8727.301815854733, 9372.71881843544, 9520.8571871422, 10162.983701629833, 10175.643852465157, 9518.762030949212, 9797.853032204523, 9812.165965892907, 9849.064338887812, 9864.457454839981, 2514.0823599386276, 2576.703679076902, 2580.6774153230845, 2585.7155712871568, 2593.8573378464175, 2533.6832895888015, 2612.6342312076326, 2620.1877418000386, 2620.9737902621014, 2627.395698989224, 2539.606361014046, 2543.55487789637, 2547.108512020787, 2575.060103062378, 2588.9741102589014, 2520.78573321267, 2528.962065569018, 2531.7594828491265, 2550.7959363250893, 2559.2450227183026, 2462.9261122166363, 2467.6421918821848, 2467.962980555293, 2535.2521006303186, 2555.2589748972778, 9951.955044720346, 10036.799264014751, 10046.9497652512, 10062.748431289203, 10063.0, 5591.10542313228, 5713.914291285634, 5721.656700597936, 5725.427457254283, 5736.483716465538, 3328.6005679318396, 3476.89569312921, 3543.982280088583, 3636.8180341389157, 3637.7271704621994, 1202.753435545711, 1222.4010234984883, 1226.5707002549125, 1252.04218772639, 1270.2632473165543, 13963.0, 13968.231747253896, 13993.090449120877, 14008.719825603534, 14040.297985100806, 4899.58353539946, 5256.658317209369, 5305.071612467803, 5309.8938021239355, 5366.838994830161, 11711.1802173847, 11747.588834390755, 11749.0, 11775.823362649568, 11809.940950295366, 5912.497437717842, 5921.644701317935, 5957.3744756799915, 5959.433853783884, 5964.701764911824, 4973.925391119136, 5323.813666521731, 5381.0852155133725, 5391.245225668409, 5412.3505179377935, 4520.276755719069, 4556.7721613919175, 4564.246899261651, 4587.288970209623, 4611.077784443125, 1355.3223388305846, 1398.119184913498, 1401.6916278418732, 1403.9929800350933, 1416.2918540729636, 1080.8000519903842, 1090.1987039525943, 1093.327603523827, 1095.315427857589, 1099.2689861242345, 6499.122618446544, 6508.544401891917, 6653.301403352675, 6797.966010169917, 6805.557638753465, 470.6681789338508, 488.42122085329, 492.8890999525078, 495.8239824862194, 502.7109412088064, 4468.0, 4560.4071470708595, 4579.450465944108, 4581.381513495702, 4665.906681866411, 12024.699382515331, 12381.071419643562, 12520.0, 12520.186187897758, 12534.122611417295, 11788.528458861549, 12268.509259629514, 12305.507779688713, 12343.19769214998, 12376.381180940916, 9308.0, 9337.066293370744, 9443.480608566457, 9496.620135194653, 9497.952510237405, 6585.242697089704, 6834.316568343126, 6838.632273545268, 6847.691853866489, 6869.072675188786, 11444.256123351955, 11445.656630301104, 11479.0, 11502.53989840397, 11661.416929153678, 11503.654890353302, 11589.884101158881, 11691.707707307045, 11749.118816088998, 11790.705232369259, 7909.841803163789, 8598.183172598594, 8645.524496152771, 8746.256568191775, 8783.077776833341, 9442.575084121094, 9628.951855240679, 9657.082577155159, 9669.806603867743, 9674.854877176707, 8601.354898382771, 8661.437006594551, 8707.521086340312, 8765.079666635167, 8772.561371931506, 8528.530930798617, 8537.957310213409, 8594.527300998505, 8639.784005399915, 8706.60820263077, 7793.493422927491, 7962.606543854687, 7972.760817175494, 7998.600069996593, 8003.719869804529, 5613.270274864241, 5679.574031947538, 5735.483806457439, 5800.216970708901, 5934.6142500737315, 5844.298684157929, 5865.73604187804, 5865.794697185578, 5886.852828679317, 5889.057750759858], "value": 5086.612054674926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.5933676272288, 356.4919989015653, 357.6512899922575, 358.5374866422314, 359.82548463994976, 5789.218455508505, 5799.884002319951, 5824.242848429703, 5832.0, 5847.210626565417, 5715.885682286352, 5720.0561907285355, 5742.222310729211, 5760.279965004374, 5813.825585232439, 4468.352088947101, 4483.461984561857, 4527.864164075083, 4541.182587134314, 4545.636349092065, 4476.820927162909, 4523.61549268311, 4536.8638940831825, 4546.772661366935, 4583.152116858375, 4497.685162038659, 4525.117602067598, 4535.752668016289, 4561.361409402686, 4563.224251877189, 4446.644268458532, 4476.999999999984, 4480.737227700023, 4522.68341216115, 4541.863744087683, 4013.3979903014783, 4023.396490526415, 4031.3348297530874, 4060.8426598419605, 4066.146109317047, 5672.262605861211, 5681.375048744635, 5717.742701578439, 5725.942740572583, 5726.742296596663, 5146.0702236661255, 5248.632595718302, 5257.894842103136, 5271.472852714736, 5331.493508116722, 5989.0, 6048.243969503812, 6060.575759696823, 6064.484518815906, 6071.848203794896, 4339.06710057336, 4409.955900440987, 4423.845165419195, 4464.129494748526, 4507.391502147201, 5939.4357536034, 6196.47329976957, 6365.649889256089, 6379.586920997244, 6389.393007664265, 4487.371767952489, 4513.368128462018, 4522.88692782683, 4526.438378759322, 4543.954560454419, 4555.567221113989, 4582.862514124582, 4606.56237657422, 4609.778408721691, 4617.353570500132, 4988.451270360258, 5214.861906618268, 5222.6083043771105, 5223.791048358099, 5236.581073514109, 5977.491913187428, 6017.187679663277, 6042.607230530001, 6097.542684298695, 6175.517875709887, 1519.908805471653, 1533.9233038348038, 1541.884358673104, 1550.5968448203323, 1556.6341909651223, 951.8477043672979, 1000.2648053680539, 1003.2826529031777, 1004.6785028790716, 1008.3445760255746, 5152.3044389007755, 5192.584593232532, 5194.636375453758, 5246.685198888079, 5262.0, 5472.030069175094, 5481.136413619389, 5569.749361278752, 5574.358948720949, 5595.524380427628, 4991.500849915052, 5214.113600687892, 5232.764525596357, 5279.287296214962, 5306.442823503477, 2958.727747068781, 2962.4075184963094, 2993.625796775403, 3021.8035827671133, 3024.1723988071226, 5785.103308987113, 5798.246227990334, 5802.4197580241635, 5815.621984570989, 5830.970845145747, 6041.8489537761025, 6408.198975128109, 6439.613623182624, 6472.579282346633, 6485.967570162119, 6561.934380656227, 6610.272869984298, 6642.734290628321, 6649.836278651217, 6652.966735166293, 6199.938000619936, 6363.427291543783, 6374.776882809265, 6399.200099987502, 6410.679466026773, 6323.177986861679, 6331.2085989251345, 6351.776878092631, 6364.904526432199, 6384.968075159594, 6285.560010799383, 6294.213223347082, 6467.159269294962, 6497.57765745244, 6522.902156467562, 4438.667099967451, 4487.5063742987595, 4519.932201017054, 4538.001639639274, 4542.409486766699, 6285.622862628257, 6300.810975670737, 6382.90425643625, 6395.1046853441485, 6404.839879003062, 6135.386461354007, 6175.783847565313, 6184.443400094013, 6191.19514463117, 6255.71849266775, 5920.407959204045, 6068.180795592715, 6163.828872514208, 6205.410486003822, 6231.781887633911, 6069.393060693896, 6074.848128796815, 6089.634621922522, 6101.633901965896, 6112.633242005316, 6210.72051757681, 6216.347283535164, 6240.781572644935, 6253.405926436982, 6274.560780745486, 5832.270966129234, 6039.852428038658, 6078.939210607838, 6081.604695694766, 6101.633901965896], "value": 4598.38555061568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.6425854753179, 839.8446287436825, 868.3313848336777, 906.2659246010729, 947.6920000999677, 14893.478728244514, 15491.380344786196, 15575.29911153998, 15712.292946817392, 15729.606759831024, 15253.847461525382, 15349.0, 15356.46252381167, 15553.92223038886, 16270.51188464348, 882.7837179890936, 903.6024149374288, 905.1491597897988, 905.1717678324359, 906.0260220263243, 867.1718508824058, 902.7607683963755, 903.6837107012526, 911.9224865886407, 912.0742446416892, 943.7640589852537, 947.303731757158, 950.4724877692878, 951.7953639967405, 955.2596737528402, 938.8357037518407, 941.3457646935383, 942.1002942190261, 942.726609283307, 946.9242460603169, 703.1140762639111, 703.3072423662688, 703.6446594469811, 704.1620471638785, 704.7498138160981, 16692.165391730367, 16776.077315747752, 16836.83163168377, 16853.0, 16868.409605663743, 16065.22903564982, 16288.267027983651, 16385.09881956492, 16588.50234492967, 16652.00087994724, 13392.196468211841, 13439.193648381128, 13493.460261589526, 13498.797518037238, 13904.165750055028, 4154.771487568182, 4186.790660466964, 4187.45563076798, 4202.831886724527, 4329.437173167468, 97140.51429742877, 97698.51150744272, 98746.0, 98942.5052874731, 98943.0, 12886.935565322114, 12991.545295914597, 13086.803697944539, 13110.672233194246, 13150.408231629599, 24466.388340291636, 24507.14225002152, 24548.38629034253, 24564.0, 24714.505709885703, 9503.287253455881, 9537.332386733, 9566.521673916277, 9585.424874507413, 9679.370840895319, 5222.9204441021875, 5294.54996325309, 5307.601929855199, 5370.3287089113865, 5485.0, 3956.5449973252867, 4071.1043570414463, 4095.651869591118, 4111.835526578963, 4118.608732170439, 702.7645738677601, 733.6478490324674, 762.8321769210764, 797.9561124138228, 826.7189155686975, 641.3394203969918, 654.3587284461255, 709.2907092907093, 780.6760194519325, 845.1337379186383, 10360.637377691744, 10496.842547361795, 10678.572857085785, 10715.35707857531, 11041.668749937515, 620.8758248350348, 746.5334166146158, 749.7825630567074, 765.9885101723479, 768.5772824946257, 4690.319903614025, 4886.804527818918, 4895.192293271642, 4904.190808516626, 4929.309896614477, 79582.6020869892, 83148.0, 130172.3491382537, 135323.0, 137492.0, 116689.0, 117890.41054794671, 120058.0, 120980.0, 123039.0, 84442.15557844343, 100672.4966375178, 104976.47511762545, 105104.0, 107567.46216269025, 9988.750281243027, 10520.368777873353, 10648.89351106479, 10880.455977201267, 11035.779284414428, 41085.178296434504, 51901.0, 55316.0, 55780.442195577525, 56231.43768562426, 46126.769366154294, 79180.60409697915, 79407.0, 80345.19654803377, 80850.19149808427, 14131.364088615832, 14519.419223230952, 14682.55952321432, 14953.551393458214, 14954.177520236492, 15680.607984800472, 16547.420840270534, 16621.75067373966, 16635.667286653956, 17793.110344482982, 14722.77915831242, 15223.695526089637, 15394.230288485307, 15614.0, 16292.592685182964, 14616.561503154922, 15068.773968390264, 15241.542753716963, 15537.300821463288, 15663.765043524585, 15391.1534865579, 15463.5360939172, 15527.76708349353, 15584.142872141687, 16208.0, 11972.0, 12221.266723996589, 12380.81428778587, 12786.68033299175, 13063.346832658519, 12163.574274900337, 12703.42834572428, 13032.0, 13090.869091308965, 13147.53983610569], "value": 8397.81262152504, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 103.0, 110.0, 112.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 138.0, 180.0, 124.0, 143.0, 153.0, 122.0, 184.0, 125.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 76.0, 182.0, 76.0, 75.0, 76.0, 75.0, 178.0, 77.0], "value": 97.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 144.0, 85.0, 87.0, 84.0, 141.0, 83.0, 83.0, 157.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0, 146.0, 200.0, 148.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 51.0, 50.0, 55.0, 54.0, 52.0, 52.0, 51.0, 50.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 64.0, 60.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 73.0, 78.0, 72.0, 72.0, 73.0, 73.0, 77.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 124.0, 117.0, 126.0, 124.0, 122.0, 119.0, 162.0, 129.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 158.0, 158.0, 162.0, 161.0, 152.0, 157.0, 152.0, 155.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 60.0, 61.0, 61.0, 61.0, 62.0, 59.0], "value": 61.5, "unit": "score"}]}]} 21:08:34 INFO - Return code: 0 21:08:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:08:34 ERROR - # TBPL SUCCESS # 21:08:34 INFO - Running post-action listener: _resource_record_post_action 21:08:34 INFO - [mozharness: 2016-08-02 04:08:34.385839Z] Finished run-tests step (success) 21:08:34 INFO - Running post-run listener: _resource_record_post_run 21:08:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504197120; Read time: 12; Write time: 1421880 21:08:34 INFO - TinderboxPrint: CPU usage
13.4% 21:08:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:08:34 INFO - TinderboxPrint: I/O write bytes / time
504,197,120 / 1,421,880 21:08:34 INFO - TinderboxPrint: CPU idle
8,232.0 (86.6%) 21:08:34 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 21:08:34 INFO - TinderboxPrint: Swap in / out
0 / 0 21:08:34 INFO - install - Wall time: 16s; CPU: 20.0%; Read bytes: 0; Write bytes: 252063744; Read time: 0; Write time: 1113968 21:08:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 252133376; Read time: 0; Write time: 307912 21:08:35 INFO - Running post-run listener: _upload_blobber_files 21:08:35 INFO - Blob upload gear active. 21:08:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:08:35 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 21:08:35 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:08:35 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 21:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:40 INFO - (blobuploader) - INFO - Done attempting. 21:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:40 INFO - (blobuploader) - INFO - Done attempting. 21:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:41 INFO - (blobuploader) - INFO - Done attempting. 21:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 21:08:41 INFO - Return code: 0 21:08:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab66fe5495ae87804fc8a71ef73a640589a4e360ef2d09652a697278862ff63340f1e0d61bfc6025853beabc276cf944d2ece5dd18ae9395771ae5c7526b3d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/123eaf4d3181e27242188d1d27cab7b5191752d78b573106fbc7aa81aea14ca8a483aae8fd1deaee2157d2e87d8606699d69f4bcbaf2f4d4136ddb9faed71de2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841786d0bce076ea13a26ec1f48110a4b5ac7e4f1170ad34a0bfc8ea704b75a0b98ef5ccb4e83872d2f451c6e04f089e5be03712c2f0415e92ae1d3fda15dce9"} 21:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:08:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:08:41 INFO - Contents: 21:08:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab66fe5495ae87804fc8a71ef73a640589a4e360ef2d09652a697278862ff63340f1e0d61bfc6025853beabc276cf944d2ece5dd18ae9395771ae5c7526b3d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/123eaf4d3181e27242188d1d27cab7b5191752d78b573106fbc7aa81aea14ca8a483aae8fd1deaee2157d2e87d8606699d69f4bcbaf2f4d4136ddb9faed71de2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841786d0bce076ea13a26ec1f48110a4b5ac7e4f1170ad34a0bfc8ea704b75a0b98ef5ccb4e83872d2f451c6e04f089e5be03712c2f0415e92ae1d3fda15dce9"} 21:08:41 INFO - Running post-run listener: copy_logs_to_upload_dir 21:08:41 INFO - Copying logs to upload dir... 21:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs 21:08:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.184823 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-01 21:08:41.265159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 21:08:41.270609) ========= 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=df17445c3590ff7897617a0e00000225-1470108575.702671-352618715 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/Mozilla-Aurora/sha512/ab66fe5495ae87804fc8a71ef73a640589a4e360ef2d09652a697278862ff63340f1e0d61bfc6025853beabc276cf944d2ece5dd18ae9395771ae5c7526b3d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/123eaf4d3181e27242188d1d27cab7b5191752d78b573106fbc7aa81aea14ca8a483aae8fd1deaee2157d2e87d8606699d69f4bcbaf2f4d4136ddb9faed71de2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841786d0bce076ea13a26ec1f48110a4b5ac7e4f1170ad34a0bfc8ea704b75a0b98ef5ccb4e83872d2f451c6e04f089e5be03712c2f0415e92ae1d3fda15dce9"} build_url:https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/ditRsv53R--1dWatsC2RMg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab66fe5495ae87804fc8a71ef73a640589a4e360ef2d09652a697278862ff63340f1e0d61bfc6025853beabc276cf944d2ece5dd18ae9395771ae5c7526b3d24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/123eaf4d3181e27242188d1d27cab7b5191752d78b573106fbc7aa81aea14ca8a483aae8fd1deaee2157d2e87d8606699d69f4bcbaf2f4d4136ddb9faed71de2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/841786d0bce076ea13a26ec1f48110a4b5ac7e4f1170ad34a0bfc8ea704b75a0b98ef5ccb4e83872d2f451c6e04f089e5be03712c2f0415e92ae1d3fda15dce9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 21:08:41.301913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 21:08:41.302215) ========= 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=df17445c3590ff7897617a0e00000225-1470108575.702671-352618715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 21:08:41.352254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 21:08:41.352559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 21:08:41.352835) ========= ========= Total master_lag: 0.15 =========