builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1470142496.94 results: success (0) buildid: 20160802030437 builduid: e43386202116435b9dd202cd12c75fa7 revision: ffac2798999c5b84f1b4605a1280994bb665a406 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:56.940414) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:56.940890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:56.941387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:57.006248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:57.006582) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 05:54:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2016-08-02 05:54:57 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:57.108676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:57.109292) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:57.161923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 05:54:57.162261) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffac2798999c5b84f1b4605a1280994bb665a406 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ffac2798999c5b84f1b4605a1280994bb665a406 --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=9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 05:54:57,495 truncating revision to first 12 chars 2016-08-02 05:54:57,495 Setting DEBUG logging. 2016-08-02 05:54:57,495 attempt 1/10 2016-08-02 05:54:57,495 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffac2798999c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 05:54:58,767 unpacking tar archive at: mozilla-central-ffac2798999c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.610066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 05:54:58.786258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:58.786588) ========= script_repo_revision: ffac2798999c5b84f1b4605a1280994bb665a406 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:58.786987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:58.787271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 05:54:58.795913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-02 05:54:58.796301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:59 INFO - MultiFileLogger online at 20160802 05:54:59 in /builds/slave/test 05:54:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:59 INFO - {'append_to_log': False, 05:54:59 INFO - 'base_work_dir': '/builds/slave/test', 05:54:59 INFO - 'blob_upload_branch': 'Firefox', 05:54:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:59 INFO - 'branch': 'Firefox', 05:54:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:59 INFO - 'config_files': ('talos/linux_config.py',), 05:54:59 INFO - 'default_actions': ('clobber', 05:54:59 INFO - 'read-buildbot-config', 05:54:59 INFO - 'download-and-extract', 05:54:59 INFO - 'populate-webroot', 05:54:59 INFO - 'create-virtualenv', 05:54:59 INFO - 'install', 05:54:59 INFO - 'run-tests'), 05:54:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:59 INFO - 'download_minidump_stackwalk': True, 05:54:59 INFO - 'download_symbols': 'ondemand', 05:54:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:59 INFO - 'installer_path': 'installer.exe', 05:54:59 INFO - 'log_level': 'info', 05:54:59 INFO - 'log_name': 'talos', 05:54:59 INFO - 'log_to_console': True, 05:54:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:59 INFO - 'opt_config_files': (), 05:54:59 INFO - 'pip_index': False, 05:54:59 INFO - 'sps_profile': False, 05:54:59 INFO - 'sps_profile_interval': 0, 05:54:59 INFO - 'suite': 'dromaeojs', 05:54:59 INFO - 'system_bits': '32', 05:54:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:59 INFO - 'title': 'talos-linux64-ix-022', 05:54:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:59 INFO - 'use_talos_json': True, 05:54:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:59 INFO - 'work_dir': 'build'} 05:54:59 INFO - [mozharness: 2016-08-02 12:54:59.223306Z] Running clobber step. 05:54:59 INFO - Running pre-action listener: _resource_record_pre_action 05:54:59 INFO - Running main action method: clobber 05:54:59 INFO - rmtree: /builds/slave/test/build 05:54:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:55:00 INFO - Running post-action listener: _resource_record_post_action 05:55:00 INFO - [mozharness: 2016-08-02 12:55:00.198508Z] Finished clobber step (success) 05:55:00 INFO - [mozharness: 2016-08-02 12:55:00.198609Z] Running read-buildbot-config step. 05:55:00 INFO - Running pre-action listener: _resource_record_pre_action 05:55:00 INFO - Running main action method: read_buildbot_config 05:55:00 INFO - Using buildbot properties: 05:55:00 INFO - { 05:55:00 INFO - "project": "", 05:55:00 INFO - "product": "firefox", 05:55:00 INFO - "script_repo_revision": "production", 05:55:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:55:00 INFO - "repository": "", 05:55:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:55:00 INFO - "buildid": "20160802030437", 05:55:00 INFO - "stage_platform": "linux64-pgo", 05:55:00 INFO - "basedir": "/builds/slave/test", 05:55:00 INFO - "nightly_build": "True", 05:55:00 INFO - "buildnumber": 818, 05:55:00 INFO - "slavename": "talos-linux64-ix-022", 05:55:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:55:00 INFO - "platform": "ubuntu64_hw", 05:55:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:55:00 INFO - "branch": "mozilla-central", 05:55:00 INFO - "repo_path": "mozilla-central", 05:55:00 INFO - "revision": "ffac2798999c5b84f1b4605a1280994bb665a406", 05:55:00 INFO - "pgo_build": "True", 05:55:00 INFO - "builduid": "e43386202116435b9dd202cd12c75fa7", 05:55:00 INFO - "slavebuilddir": "test" 05:55:00 INFO - } 05:55:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:55:00 INFO - Running post-action listener: _resource_record_post_action 05:55:00 INFO - [mozharness: 2016-08-02 12:55:00.201108Z] Finished read-buildbot-config step (success) 05:55:00 INFO - [mozharness: 2016-08-02 12:55:00.201196Z] Running download-and-extract step. 05:55:00 INFO - Running pre-action listener: _resource_record_pre_action 05:55:00 INFO - Running main action method: download_and_extract 05:55:00 INFO - mkdir: /builds/slave/test/build/tests 05:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:00 INFO - https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:55:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:55:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:55:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:55:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:55:03 INFO - Downloaded 1361 bytes. 05:55:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:55:03 INFO - Using the following test package requirements: 05:55:03 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:55:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:55:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:55:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'jsshell-linux-x86_64.zip'], 05:55:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:55:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:55:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:55:03 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:55:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:55:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:55:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:55:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:03 INFO - https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:55:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:55:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:55:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:55:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:55:04 INFO - Downloaded 21808924 bytes. 05:55:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:55:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:55:05 INFO - Return code: 0 05:55:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:05 INFO - https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:55:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:55:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:55:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:55:16 INFO - Downloaded 21808924 bytes. 05:55:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:55:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:55:17 INFO - Return code: 0 05:55: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')]} 05:55:17 INFO - https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:55:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:55:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:55:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:55:18 INFO - Downloaded 14413723 bytes. 05:55:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:55:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:55:19 INFO - Return code: 0 05:55: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')]} 05:55:19 INFO - https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:55:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:55:21 INFO - Downloaded 59366871 bytes. 05:55:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:21 INFO - mkdir: /builds/slave/test/properties 05:55:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:21 INFO - Contents: 05:55:21 INFO - build_url:https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:21 INFO - Running post-action listener: _resource_record_post_action 05:55:21 INFO - Running post-action listener: set_extra_try_arguments 05:55:21 INFO - [mozharness: 2016-08-02 12:55:21.901454Z] Finished download-and-extract step (success) 05:55:21 INFO - [mozharness: 2016-08-02 12:55:21.901686Z] Running populate-webroot step. 05:55:21 INFO - Running pre-action listener: _resource_record_pre_action 05:55:21 INFO - Running main action method: populate_webroot 05:55:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:55:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:55:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:55:21 INFO - '--tppagecycles', 05:55:21 INFO - '7'], 05:55:21 INFO - 'tests': ['tsvgm']}}, 05:55:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:55:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:55:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['damp', 'tps']}, 05:55:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'tests': ['damp', 'tps']}, 05:55:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['dromaeo_dom']}, 05:55:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['basic_compositor_video']}, 05:55:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:55:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['a11yr', 05:55:21 INFO - 'ts_paint', 05:55:21 INFO - 'tpaint', 05:55:21 INFO - 'sessionrestore', 05:55:21 INFO - 'sessionrestore_no_auto_restore', 05:55:21 INFO - 'tabpaint']}, 05:55:21 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:21 INFO - 'ts_paint', 05:55:21 INFO - 'tpaint', 05:55:21 INFO - 'sessionrestore', 05:55:21 INFO - 'sessionrestore_no_auto_restore', 05:55:21 INFO - 'tabpaint']}, 05:55:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:55:21 INFO - 'ts_paint', 05:55:21 INFO - 'tpaint', 05:55:21 INFO - 'sessionrestore', 05:55:21 INFO - 'sessionrestore_no_auto_restore', 05:55:21 INFO - 'tabpaint']}, 05:55:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:55:21 INFO - 'ts_paint', 05:55:21 INFO - 'tpaint', 05:55:21 INFO - 'sessionrestore', 05:55:21 INFO - 'sessionrestore_no_auto_restore', 05:55:21 INFO - 'tabpaint']}, 05:55:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['a11yr', 05:55:21 INFO - 'ts_paint', 05:55:21 INFO - 'tpaint', 05:55:21 INFO - 'sessionrestore', 05:55:21 INFO - 'sessionrestore_no_auto_restore', 05:55:21 INFO - 'tabpaint']}, 05:55:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['a11yr', 05:55:21 INFO - 'ts_paint', 05:55:21 INFO - 'tpaint', 05:55:21 INFO - 'sessionrestore', 05:55:21 INFO - 'sessionrestore_no_auto_restore', 05:55:21 INFO - 'tabpaint']}, 05:55:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['tsvgx', 05:55:21 INFO - 'tsvgr_opacity', 05:55:21 INFO - 'tart', 05:55:21 INFO - 'tscrollx', 05:55:21 INFO - 'cart']}, 05:55:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:21 INFO - 'tsvgr_opacity', 05:55:21 INFO - 'tart', 05:55:21 INFO - 'tscrollx', 05:55:21 INFO - 'cart']}, 05:55:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'talos_options': ['--disable-e10s'], 05:55:21 INFO - 'tests': ['tp5o']}, 05:55:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'tests': ['tp5o']}, 05:55:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'talos_options': ['--disable-e10s', 05:55:21 INFO - '--xperf_path', 05:55:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:21 INFO - 'tests': ['tp5n']}, 05:55:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:21 INFO - 'talos_options': ['--xperf_path', 05:55:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:21 INFO - 'tests': ['tp5n']}}, 05:55:21 INFO - 'talos.zip': {'path': '', 05:55:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:55:21 INFO - Running post-action listener: _resource_record_post_action 05:55:21 INFO - [mozharness: 2016-08-02 12:55:21.922867Z] Finished populate-webroot step (success) 05:55:21 INFO - [mozharness: 2016-08-02 12:55:21.922956Z] Running create-virtualenv step. 05:55:21 INFO - Running pre-action listener: _resource_record_pre_action 05:55:21 INFO - Running main action method: create_virtualenv 05:55:21 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55: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 05:55:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:22 INFO - Using real prefix '/usr' 05:55:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:24 INFO - Installing pip.................done. 05:55:24 INFO - Return code: 0 05:55:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:24 INFO - Using env: {'DISPLAY': ':0', 05:55:24 INFO - 'HOME': '/home/cltbld', 05:55:24 INFO - 'LANG': 'en_US.UTF-8', 05:55:24 INFO - 'LANGUAGE': 'en_US:en', 05:55:24 INFO - 'LOGNAME': 'cltbld', 05:55:24 INFO - 'MAIL': '/var/mail/cltbld', 05:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:24 INFO - 'MOZ_NO_REMOTE': '1', 05:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:24 INFO - 'NO_EM_RESTART': '1', 05:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:24 INFO - 'PWD': '/builds/slave/test', 05:55:24 INFO - 'SHELL': '/bin/bash', 05:55:24 INFO - 'SHLVL': '1', 05:55:24 INFO - 'TERM': 'linux', 05:55:24 INFO - 'TMOUT': '86400', 05:55:24 INFO - 'USER': 'cltbld', 05:55:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:24 INFO - '_': '/tools/buildbot/bin/python'} 05:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55: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 05:55:24 INFO - Cleaning up... 05:55:24 INFO - Return code: 0 05:55:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:24 INFO - Using env: {'DISPLAY': ':0', 05:55:24 INFO - 'HOME': '/home/cltbld', 05:55:24 INFO - 'LANG': 'en_US.UTF-8', 05:55:24 INFO - 'LANGUAGE': 'en_US:en', 05:55:24 INFO - 'LOGNAME': 'cltbld', 05:55:24 INFO - 'MAIL': '/var/mail/cltbld', 05:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:24 INFO - 'MOZ_NO_REMOTE': '1', 05:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:24 INFO - 'NO_EM_RESTART': '1', 05:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:24 INFO - 'PWD': '/builds/slave/test', 05:55:24 INFO - 'SHELL': '/bin/bash', 05:55:24 INFO - 'SHLVL': '1', 05:55:24 INFO - 'TERM': 'linux', 05:55:24 INFO - 'TMOUT': '86400', 05:55:24 INFO - 'USER': 'cltbld', 05:55:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:24 INFO - '_': '/tools/buildbot/bin/python'} 05:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:24 INFO - Downloading/unpacking psutil>=3.1.1 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:26 INFO - Installing collected packages: psutil 05:55:26 INFO - Running setup.py install for psutil 05:55:26 INFO - building 'psutil._psutil_linux' extension 05:55: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 05:55: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:55:27 INFO - building 'psutil._psutil_posix' extension 05:55:27 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 05:55: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 05:55:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:27 INFO - Successfully installed psutil 05:55:27 INFO - Cleaning up... 05:55:27 INFO - Return code: 0 05:55:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:27 INFO - Using env: {'DISPLAY': ':0', 05:55:27 INFO - 'HOME': '/home/cltbld', 05:55:27 INFO - 'LANG': 'en_US.UTF-8', 05:55:27 INFO - 'LANGUAGE': 'en_US:en', 05:55:27 INFO - 'LOGNAME': 'cltbld', 05:55:27 INFO - 'MAIL': '/var/mail/cltbld', 05:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:27 INFO - 'MOZ_NO_REMOTE': '1', 05:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:27 INFO - 'NO_EM_RESTART': '1', 05:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:27 INFO - 'PWD': '/builds/slave/test', 05:55:27 INFO - 'SHELL': '/bin/bash', 05:55:27 INFO - 'SHLVL': '1', 05:55:27 INFO - 'TERM': 'linux', 05:55:27 INFO - 'TMOUT': '86400', 05:55:27 INFO - 'USER': 'cltbld', 05:55:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:27 INFO - '_': '/tools/buildbot/bin/python'} 05:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:55:29 INFO - Installing collected packages: mozsystemmonitor 05:55:29 INFO - Running setup.py install for mozsystemmonitor 05:55:29 INFO - Successfully installed mozsystemmonitor 05:55:29 INFO - Cleaning up... 05:55:29 INFO - Return code: 0 05:55:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:29 INFO - Using env: {'DISPLAY': ':0', 05:55:29 INFO - 'HOME': '/home/cltbld', 05:55:29 INFO - 'LANG': 'en_US.UTF-8', 05:55:29 INFO - 'LANGUAGE': 'en_US:en', 05:55:29 INFO - 'LOGNAME': 'cltbld', 05:55:29 INFO - 'MAIL': '/var/mail/cltbld', 05:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:29 INFO - 'MOZ_NO_REMOTE': '1', 05:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:29 INFO - 'NO_EM_RESTART': '1', 05:55:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:29 INFO - 'PWD': '/builds/slave/test', 05:55:29 INFO - 'SHELL': '/bin/bash', 05:55:29 INFO - 'SHLVL': '1', 05:55:29 INFO - 'TERM': 'linux', 05:55:29 INFO - 'TMOUT': '86400', 05:55:29 INFO - 'USER': 'cltbld', 05:55:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:29 INFO - '_': '/tools/buildbot/bin/python'} 05:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:29 INFO - Downloading/unpacking jsonschema==2.5.1 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:32 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:32 INFO - warning: no files found matching '*.txt' 05:55:32 INFO - no previously-included directories found matching 'build' 05:55:32 INFO - no previously-included directories found matching 'dist' 05:55:32 INFO - no previously-included directories found matching '.git*' 05:55:32 INFO - Installing collected packages: jsonschema, functools32 05:55:32 INFO - Running setup.py install for functools32 05:55:32 INFO - warning: no files found matching '*.txt' 05:55:32 INFO - no previously-included directories found matching 'build' 05:55:32 INFO - no previously-included directories found matching 'dist' 05:55:32 INFO - no previously-included directories found matching '.git*' 05:55:32 INFO - Successfully installed jsonschema functools32 05:55:32 INFO - Cleaning up... 05:55:32 INFO - Return code: 0 05:55:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:32 INFO - Using env: {'DISPLAY': ':0', 05:55:32 INFO - 'HOME': '/home/cltbld', 05:55:32 INFO - 'LANG': 'en_US.UTF-8', 05:55:32 INFO - 'LANGUAGE': 'en_US:en', 05:55:32 INFO - 'LOGNAME': 'cltbld', 05:55:32 INFO - 'MAIL': '/var/mail/cltbld', 05:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:32 INFO - 'MOZ_NO_REMOTE': '1', 05:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:32 INFO - 'NO_EM_RESTART': '1', 05:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:32 INFO - 'PWD': '/builds/slave/test', 05:55:32 INFO - 'SHELL': '/bin/bash', 05:55:32 INFO - 'SHLVL': '1', 05:55:32 INFO - 'TERM': 'linux', 05:55:32 INFO - 'TMOUT': '86400', 05:55:32 INFO - 'USER': 'cltbld', 05:55:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:32 INFO - '_': '/tools/buildbot/bin/python'} 05:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:55:32 INFO - Cleaning up... 05:55:32 INFO - Return code: 0 05:55:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:32 INFO - Using env: {'DISPLAY': ':0', 05:55:32 INFO - 'HOME': '/home/cltbld', 05:55:32 INFO - 'LANG': 'en_US.UTF-8', 05:55:32 INFO - 'LANGUAGE': 'en_US:en', 05:55:32 INFO - 'LOGNAME': 'cltbld', 05:55:32 INFO - 'MAIL': '/var/mail/cltbld', 05:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:32 INFO - 'MOZ_NO_REMOTE': '1', 05:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:32 INFO - 'NO_EM_RESTART': '1', 05:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:32 INFO - 'PWD': '/builds/slave/test', 05:55:32 INFO - 'SHELL': '/bin/bash', 05:55:32 INFO - 'SHLVL': '1', 05:55:32 INFO - 'TERM': 'linux', 05:55:32 INFO - 'TMOUT': '86400', 05:55:32 INFO - 'USER': 'cltbld', 05:55:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:32 INFO - '_': '/tools/buildbot/bin/python'} 05:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:34 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55:35 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 05:55:35 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 05:55:35 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 05:55:35 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 05:55:35 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 05:55:35 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 05:55:35 INFO - Downloading docopt-0.6.1.tar.gz 05:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:35 INFO - Running setup.py install for blobuploader 05:55:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:35 INFO - Running setup.py install for requests 05:55:35 INFO - Running setup.py install for docopt 05:55:35 INFO - Successfully installed blobuploader requests docopt 05:55:35 INFO - Cleaning up... 05:55:36 INFO - Return code: 0 05:55:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:36 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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55:36 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 05:55:36 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 05:55:36 INFO - Using env: {'DISPLAY': ':0', 05:55:36 INFO - 'HOME': '/home/cltbld', 05:55:36 INFO - 'LANG': 'en_US.UTF-8', 05:55:36 INFO - 'LANGUAGE': 'en_US:en', 05:55:36 INFO - 'LOGNAME': 'cltbld', 05:55:36 INFO - 'MAIL': '/var/mail/cltbld', 05:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:36 INFO - 'MOZ_NO_REMOTE': '1', 05:55:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:36 INFO - 'NO_EM_RESTART': '1', 05:55:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:36 INFO - 'PWD': '/builds/slave/test', 05:55:36 INFO - 'SHELL': '/bin/bash', 05:55:36 INFO - 'SHLVL': '1', 05:55:36 INFO - 'TERM': 'linux', 05:55:36 INFO - 'TMOUT': '86400', 05:55:36 INFO - 'USER': 'cltbld', 05:55:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:36 INFO - '_': '/tools/buildbot/bin/python'} 05:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:36 INFO - Running setup.py (path:/tmp/pip-7gEnnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:36 INFO - Running setup.py (path:/tmp/pip-QHWiaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:36 INFO - Running setup.py (path:/tmp/pip-OCGrT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:36 INFO - Running setup.py (path:/tmp/pip-qCINfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:36 INFO - Running setup.py (path:/tmp/pip-ZCcJ4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:36 INFO - Running setup.py (path:/tmp/pip-5TDsAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:36 INFO - Running setup.py (path:/tmp/pip-yTS56L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:36 INFO - Running setup.py (path:/tmp/pip-KyE0zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:36 INFO - Running setup.py (path:/tmp/pip-3vm0nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:36 INFO - Running setup.py (path:/tmp/pip-i2HNbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:36 INFO - Running setup.py (path:/tmp/pip-M1fo2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:37 INFO - Running setup.py (path:/tmp/pip-8NnXXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:37 INFO - Running setup.py (path:/tmp/pip-koJzr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:37 INFO - Running setup.py (path:/tmp/pip-bhIvLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:37 INFO - Running setup.py (path:/tmp/pip-gp0DLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:37 INFO - Running setup.py (path:/tmp/pip-rYL2tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:37 INFO - Running setup.py (path:/tmp/pip-AptGsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:37 INFO - Running setup.py install for manifestparser 05:55:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:37 INFO - Running setup.py install for mozcrash 05:55:37 INFO - Running setup.py install for mozdebug 05:55:37 INFO - Running setup.py install for mozdevice 05:55:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:37 INFO - Running setup.py install for mozfile 05:55:38 INFO - Running setup.py install for mozhttpd 05:55:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for mozinfo 05:55:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for mozInstall 05:55:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for mozleak 05:55:38 INFO - Running setup.py install for mozlog 05:55:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for moznetwork 05:55:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for mozprocess 05:55:38 INFO - Running setup.py install for mozprofile 05:55:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for mozrunner 05:55:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:38 INFO - Running setup.py install for mozscreenshot 05:55:39 INFO - Running setup.py install for moztest 05:55:39 INFO - Running setup.py install for mozversion 05:55:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:39 INFO - Cleaning up... 05:55:39 INFO - Return code: 0 05:55:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:39 INFO - Using env: {'DISPLAY': ':0', 05:55:39 INFO - 'HOME': '/home/cltbld', 05:55:39 INFO - 'LANG': 'en_US.UTF-8', 05:55:39 INFO - 'LANGUAGE': 'en_US:en', 05:55:39 INFO - 'LOGNAME': 'cltbld', 05:55:39 INFO - 'MAIL': '/var/mail/cltbld', 05:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:39 INFO - 'MOZ_NO_REMOTE': '1', 05:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:39 INFO - 'NO_EM_RESTART': '1', 05:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:39 INFO - 'PWD': '/builds/slave/test', 05:55:39 INFO - 'SHELL': '/bin/bash', 05:55:39 INFO - 'SHLVL': '1', 05:55:39 INFO - 'TERM': 'linux', 05:55:39 INFO - 'TMOUT': '86400', 05:55:39 INFO - 'USER': 'cltbld', 05:55:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:39 INFO - '_': '/tools/buildbot/bin/python'} 05:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:39 INFO - Running setup.py (path:/tmp/pip-7GAa2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55: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)) 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:39 INFO - Running setup.py (path:/tmp/pip-AIQJ9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55: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)) 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:39 INFO - Running setup.py (path:/tmp/pip-RLCbpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55: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)) 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:39 INFO - Running setup.py (path:/tmp/pip-LBhbbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55: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)) 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:39 INFO - Running setup.py (path:/tmp/pip-58CEDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55: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)) 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:39 INFO - Running setup.py (path:/tmp/pip-WFLxuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55: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)) 05:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:39 INFO - Running setup.py (path:/tmp/pip-afM3mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:40 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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:40 INFO - Running setup.py (path:/tmp/pip-v1gPWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:40 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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:40 INFO - Running setup.py (path:/tmp/pip-kYNh0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:40 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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:40 INFO - Running setup.py (path:/tmp/pip-cysC7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:40 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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:40 INFO - Running setup.py (path:/tmp/pip-1rCxep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55: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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:40 INFO - Running setup.py (path:/tmp/pip-Oy0bcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55: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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:40 INFO - Running setup.py (path:/tmp/pip-kdWd74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55: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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:40 INFO - Running setup.py (path:/tmp/pip-4pR__M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55: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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:40 INFO - Running setup.py (path:/tmp/pip-CW6wRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55: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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:40 INFO - Running setup.py (path:/tmp/pip-LZs3GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55: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)) 05:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:40 INFO - Running setup.py (path:/tmp/pip-5BbY3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:42 INFO - Downloading blessings-1.6.tar.gz 05:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:42 INFO - Installing collected packages: blessings 05:55:42 INFO - Running setup.py install for blessings 05:55:42 INFO - Successfully installed blessings 05:55:42 INFO - Cleaning up... 05:55:42 INFO - Return code: 0 05:55:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:43 INFO - Reading from file tmpfile_stdout 05:55:43 INFO - Current package versions: 05:55:43 INFO - argparse == 1.2.1 05:55:43 INFO - blessings == 1.6 05:55:43 INFO - blobuploader == 1.2.4 05:55:43 INFO - docopt == 0.6.1 05:55:43 INFO - functools32 == 3.2.3-2 05:55:43 INFO - jsonschema == 2.5.1 05:55:43 INFO - manifestparser == 1.1 05:55:43 INFO - mozInstall == 1.12 05:55:43 INFO - mozcrash == 0.17 05:55:43 INFO - mozdebug == 0.1 05:55:43 INFO - mozdevice == 0.48 05:55:43 INFO - mozfile == 1.2 05:55:43 INFO - mozhttpd == 0.7 05:55:43 INFO - mozinfo == 0.9 05:55:43 INFO - mozleak == 0.1 05:55:43 INFO - mozlog == 3.3 05:55:43 INFO - moznetwork == 0.27 05:55:43 INFO - mozprocess == 0.23 05:55:43 INFO - mozprofile == 0.28 05:55:43 INFO - mozrunner == 6.12 05:55:43 INFO - mozscreenshot == 0.1 05:55:43 INFO - mozsystemmonitor == 0.3 05:55:43 INFO - moztest == 0.7 05:55:43 INFO - mozversion == 1.4 05:55:43 INFO - psutil == 3.1.1 05:55:43 INFO - requests == 1.2.3 05:55:43 INFO - wsgiref == 0.1.2 05:55:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:43 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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55:43 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 05:55:43 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 05:55:43 INFO - Using env: {'DISPLAY': ':0', 05:55:43 INFO - 'HOME': '/home/cltbld', 05:55:43 INFO - 'LANG': 'en_US.UTF-8', 05:55:43 INFO - 'LANGUAGE': 'en_US:en', 05:55:43 INFO - 'LOGNAME': 'cltbld', 05:55:43 INFO - 'MAIL': '/var/mail/cltbld', 05:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:43 INFO - 'MOZ_NO_REMOTE': '1', 05:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:43 INFO - 'NO_EM_RESTART': '1', 05:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:43 INFO - 'PWD': '/builds/slave/test', 05:55:43 INFO - 'SHELL': '/bin/bash', 05:55:43 INFO - 'SHLVL': '1', 05:55:43 INFO - 'TERM': 'linux', 05:55:43 INFO - 'TMOUT': '86400', 05:55:43 INFO - 'USER': 'cltbld', 05:55:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:43 INFO - '_': '/tools/buildbot/bin/python'} 05:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55: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)) 05:55:43 INFO - Cleaning up... 05:55:43 INFO - Return code: 0 05:55:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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 0x28a6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b67180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', '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 05:55: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 05:55: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 05:55:43 INFO - Using env: {'DISPLAY': ':0', 05:55:43 INFO - 'HOME': '/home/cltbld', 05:55:43 INFO - 'LANG': 'en_US.UTF-8', 05:55:43 INFO - 'LANGUAGE': 'en_US:en', 05:55:43 INFO - 'LOGNAME': 'cltbld', 05:55:43 INFO - 'MAIL': '/var/mail/cltbld', 05:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:43 INFO - 'MOZ_NO_REMOTE': '1', 05:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:43 INFO - 'NO_EM_RESTART': '1', 05:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:43 INFO - 'PWD': '/builds/slave/test', 05:55:43 INFO - 'SHELL': '/bin/bash', 05:55:43 INFO - 'SHLVL': '1', 05:55:43 INFO - 'TERM': 'linux', 05:55:43 INFO - 'TMOUT': '86400', 05:55:43 INFO - 'USER': 'cltbld', 05:55:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:43 INFO - '_': '/tools/buildbot/bin/python'} 05:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:43 INFO - Cleaning up... 05:55:43 INFO - Return code: 0 05:55:43 INFO - Running post-action listener: _resource_record_post_action 05:55:43 INFO - Running post-action listener: _start_resource_monitoring 05:55:43 INFO - Starting resource monitoring. 05:55:43 INFO - [mozharness: 2016-08-02 12:55:43.563251Z] Finished create-virtualenv step (success) 05:55:43 INFO - [mozharness: 2016-08-02 12:55:43.563696Z] Running install step. 05:55:43 INFO - Running pre-action listener: _resource_record_pre_action 05:55:43 INFO - Running main action method: install 05:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:43 INFO - Reading from file tmpfile_stdout 05:55:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:43 INFO - Reading from file tmpfile_stdout 05:55:43 INFO - Output received: 05:55:43 INFO - Usage: mozinstall [options] installer 05:55:43 INFO - Options: 05:55:43 INFO - -h, --help show this help message and exit 05:55:43 INFO - -d DEST, --destination=DEST 05:55:43 INFO - Directory to install application into. [default: 05:55:43 INFO - "/builds/slave/test"] 05:55:43 INFO - --app=APP Application being installed. [default: firefox] 05:55:43 INFO - mkdir: /builds/slave/test/build/application 05:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:56:00 INFO - Reading from file tmpfile_stdout 05:56:00 INFO - Output received: 05:56:00 INFO - /builds/slave/test/build/application/firefox/firefox 05:56:00 INFO - Running post-action listener: _resource_record_post_action 05:56:00 INFO - [mozharness: 2016-08-02 12:56:00.759159Z] Finished install step (success) 05:56:00 INFO - [mozharness: 2016-08-02 12:56:00.759432Z] Running run-tests step. 05:56:00 INFO - Running pre-action listener: _resource_record_pre_action 05:56:00 INFO - Running main action method: run_tests 05:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:56:00 INFO - Python 2.7.3 05:56:00 INFO - Return code: 0 05:56:00 INFO - grabbing minidump binary from tooltool 05:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:00 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 0x2b653b0>, '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 0x2b662b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b66740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:56:00 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 05:56:00 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 05:56:00 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 05:56:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:56:00 INFO - Return code: 0 05:56:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:56:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:56:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:56:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:56:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:56:00 INFO - Using env: {'DISPLAY': ':0', 05:56:00 INFO - 'HOME': '/home/cltbld', 05:56:00 INFO - 'LANG': 'en_US.UTF-8', 05:56:00 INFO - 'LANGUAGE': 'en_US:en', 05:56:00 INFO - 'LOGNAME': 'cltbld', 05:56:00 INFO - 'MAIL': '/var/mail/cltbld', 05:56:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:56:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:00 INFO - 'MOZ_NO_REMOTE': '1', 05:56:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:00 INFO - 'NO_EM_RESTART': '1', 05:56:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:00 INFO - 'PWD': '/builds/slave/test', 05:56:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:56:00 INFO - 'SHELL': '/bin/bash', 05:56:00 INFO - 'SHLVL': '1', 05:56:00 INFO - 'TERM': 'linux', 05:56:00 INFO - 'TMOUT': '86400', 05:56:00 INFO - 'USER': 'cltbld', 05:56:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206', 05:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:00 INFO - '_': '/tools/buildbot/bin/python'} 05:56:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:56:01 INFO - mozversion application_buildid: 20160802030437 05:56:01 INFO - mozversion application_changeset: ffac2798999c5b84f1b4605a1280994bb665a406 05:56:01 INFO - mozversion application_display_name: Nightly 05:56:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:56:01 INFO - mozversion application_name: Firefox 05:56:01 INFO - mozversion application_remotingname: firefox 05:56:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:56:01 INFO - mozversion application_vendor: Mozilla 05:56:01 INFO - mozversion application_version: 51.0a1 05:56:01 INFO - mozversion platform_buildid: 20160802030437 05:56:01 INFO - mozversion platform_changeset: ffac2798999c5b84f1b4605a1280994bb665a406 05:56:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:56:01 INFO - mozversion platform_version: 51.0a1 05:56:01 INFO - using testdate: 1470142561 05:56:01 INFO - actual date: 1470142561 05:56:01 INFO - starting webserver on 'localhost:36505' 05:56:01 INFO - SUITE-START | Running 2 tests 05:56:01 INFO - TEST-START | dromaeo_css 05:56:01 INFO - operating with platform_type : linux_ 05:56:01 INFO - Initialising browser for dromaeo_css test... 05:56:01 INFO - TEST-INFO | started process 3025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvu_uSi/profile http://localhost:36505/getInfo.html) 05:56:05 INFO - PROCESS | 3025 | __metrics Screen width/height:1600/1200 05:56:05 INFO - PROCESS | 3025 | colorDepth:24 05:56:05 INFO - PROCESS | 3025 | Browser inner width/height: 1024/697 05:56:05 INFO - PROCESS | 3025 | __metrics 05:56:06 INFO - PROCESS | 3025 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:56:06 INFO - PROCESS | 3025 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:56:06 INFO - PROCESS | 3025 | console.error: PushService: 05:56:06 INFO - PROCESS | 3025 | stateChangeProcessEnqueue: Error transitioning state 05:56:06 INFO - PROCESS | 3025 | UnknownError 05:56:07 INFO - TEST-INFO | 3025: exit 0 05:56:07 INFO - Browser initialized. 05:56:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:56:07 INFO - TEST-INFO | started process 3106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvu_uSi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:18 INFO - PROCESS | 3106 | RSS: Main: 156049408 05:56:18 INFO - PROCESS | 3106 | 05:57:10 INFO - PROCESS | 3106 | 1470142630293 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] 05:59:18 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:36505/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36505/tests/dromaeo/cssquery-ext.html) 05:59:20 INFO - PROCESS | 3106 | RSS: Main: 275533824 05:59:20 INFO - PROCESS | 3106 | 06:02:22 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:36505/tests/dromaeo/cssquery-ext.html (next: http://localhost:36505/tests/dromaeo/cssquery-jquery.html) 06:02:22 INFO - PROCESS | 3106 | RSS: Main: 244080640 06:02:22 INFO - PROCESS | 3106 | 06:05:24 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:36505/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36505/tests/dromaeo/cssquery-mootools.html) 06:05:25 INFO - PROCESS | 3106 | RSS: Main: 201859072 06:05:25 INFO - PROCESS | 3106 | 06:08:27 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:36505/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36505/tests/dromaeo/cssquery-prototype.html) 06:08:27 INFO - PROCESS | 3106 | RSS: Main: 226127872 06:08:27 INFO - PROCESS | 3106 | 06:11:30 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:36505/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36505/tests/dromaeo/cssquery-yui.html) 06:11:31 INFO - PROCESS | 3106 | RSS: Main: 182403072 06:11:31 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:36505/tests/dromaeo/cssquery-yui.html (next: http://localhost:36505/tests/dromaeo/cssquery-dojo.html) 06:14:33 INFO - PROCESS | 3106 | RSS: Main: 273842176 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | __start_tp_report 06:14:33 INFO - PROCESS | 3106 | _x_x_mozilla_page_load 06:14:33 INFO - PROCESS | 3106 | _x_x_mozilla_page_load_details 06:14:33 INFO - PROCESS | 3106 | |i|pagename|runs| 06:14:33 INFO - PROCESS | 3106 | |0;dojo.html;3006.9699303006964;3019.1093627379923;3033.8634761435733;3033.878644854206;3062.739667128294;5137.049645815527;5215.739213039343;5219.217117432382;5288.735563221838;5333.866653333664;5255.947440525593;5323.441038690939;5391.892162156764;5412.4587541245855;5432.75552600133;4775.379200703904;4790.089882922242;4824.179889418807;4829.541193586604;4930.506949305059;4856.6357523185725;4888.657793954425;4898.804047838083;4912.778924948386;4921.335619691349;4700.29495575663;4722;4732.834350797705;4776.952230477686;4797.280407938802;4789.664723469358;4793.832215872462;4798.568128868418;4799.400074990626;4805;4754.857354279377;4758.3576217210575;4779.163646361872;4780.80876764929;4783.736894470802;5180.844574662766;5207.791688332462;5216.556592689626;5232.502912223333;5268.578513718893;5598.412166722517;5608.383077861432;5614.073677843151;5659.434056594308;5664.178694089334;5656.632318899258;5665.773369065232;5692.544596432317;5714.771409143629;5718.79984200551;5157.819476318311;5161.045206636784;5161.4322424533275;5169.741512924414;5216.008958297987;5766.221560089418;5775.451332123442;5786.768529258867;5788;5788.565857560699;5419.810306639328;5561.916571251434;5569.610127291051;5570.442955704397;5570.721463926788;5528.612997090165;5591.580631452657;5599.244102046172;5627.099664053731;5683.687397193112;5612.35457922336;5618.073017952074;5619.4099619540175;5619.7471113799975;5661.518770904437;5559.555235581144;5568.359638641527;5634.60557760961;5638.85902852432;5639.971800140973;4305.095929854766;4336.783160841946;4337.50118736343;4338.240807858612;4349.325854492558;3825.081980324702;3858.5948475409677;3861.787601681878;3888.2806680764147;3896.0649444133205;5142.280080788692;5261.736913154327;5281.735913204325;5288.021715982555;5307.177387504943;5585.832425027255;5590.8043218487155;5611.130274807411;5658.377578466366;5736.856578585569;5341.359036915595;5368.141097424472;5371.811986580451;5372.409035006146;5373.838784836461;4836.322914791932;4921.630877684116;4928.088303663833;4936.802527898915;4969.378827646544;5801.187833703285;5874.9118763218585;5895.941040589625;5928.140419639042;5954.077118046623;5668.51817595509;5696.202531645656;5696.487316141567;5705.286839145107;5715.542756579547;5694.487496125369;5901.675407852609;5915.91126133117;5923.970380148244;5924.407559244041;5420.728963551728;5497.340319161726;5501.982133305191;5510.6969116698965;5569.721513924369;5592.468715472024;5595.776168953196;5636.2954630671165;5637.661740295595;5640.182173584725;5419.376771671308;5519.254900588529;5524.861878453071;5531;5565.833025009256;5402.486763757437;5485.341758988947;5492.505674489155;5513.5037846594;5551.084071128219;5384.865378365572;5423.511883930465;5429.375621803543;5434.701091439851;5440.7551660174595;5401.054815407367;5520.199571062254;5588.161775733673;5596.3284405871555;5599.160125981135;5324.148136298174;5392.5416339611575;5401.594880383908;5423.159410291411;5474.5894057945015 06:14:33 INFO - PROCESS | 3106 | |1;ext.html;590.3211306996953;601.6991504247876;603.9909401358977;625.4496043481736;626.9216347956507;43399.349009764876;44123.338149927775;44210.55789442109;44396.778016109914;48470.75764621181;46009.30986035212;46396.30405543919;46441.76779116099;46449.7677511612;46511.06977860441;9046.77383065422;9166.358354915159;9186.035466276046;9212.769680757967;9219.631214751402;8771.649134034631;8859;8869.068747781486;8871.157240062184;8874.467531948072;8926.598303076376;8961.865572016392;8962.417442866194;8965.686200982967;8976.192142707156;8867.068957759438;8901.599428025755;8905.73282801517;8920.241779448756;8921.107889211093;8878.334124940655;8942.552872356357;8945.239654629364;8949.731508054769;8949.910500894974;44126;44128.77935610333;44176.3373549397;44256.11487770259;44487.33269000967;3339.231976645361;3527.6295988921306;3540.3450361682912;3572.142685755426;3941.921161576752;33534.49698254528;33888.32223355544;33917.49123763145;33931.15172120692;34807.4778878317;4107.815148318333;4161.354581673307;4255.765932873691;4265.573442655709;4328.242557552416;352081;353126;353575;354060;354598;62764.68617656882;63137.368626313146;63140;63152.36847631557;63184;36315.63684363176;65354;65434.672826635564;65440;65527.67236163884;16159.353625855068;16757.581060473585;16785;16808.243629036722;16830.83169168317;12101.757964840654;12166.087543434278;12169.391530423443;12174.45214965311;12181.573644922386;19879.10544025522;20173.697394539093;20181.899090504452;20194.293199738233;20235;6965.268646792115;7108.329542557495;7110.502264841515;7124.145102587722;7216.855662886713;995.4176806568239;1041.7499800048085;1073.8711354637337;1097.9011888930036;1117.5641499815079;33324.50013249803;33607.49588756171;33638.327233455195;33796.49305260423;33939.490907636406;1085.289135616157;1118.8209886418133;1153.6654370232538;1164.9184557080923;1173.436750359832;17278;17388.217530211172;17432.302707891544;17473.563160920825;17555.561110972074;558933;562182;563719;566137;566728;58977;59409.702951484964;59591.70204149038;59631;59737;1227.8096894981293;1265.6645988812973;1319.7690404179039;1361.3737680667004;1374.7387996280875;32104.518432224002;34825.65174348326;34857.47713784346;34933.65066349304;35361.64638353584;52689.47310526999;52700;52985.47014529805;53051.73474132759;53135.73432132815;379957;381189;381415;382234;382837;28656.713432865403;29166.416671666873;29851.402971940006;29873.253168670955;30689.53965690561;49311.75344123256;49728.75135624299;49729.75135124301;50012.74993625009;50069.49930500648;41471.58528414798;41923.58076419197;43034.13931721285;43178;44209.557904420544;41898.37152442777;42121.157576848906;42673.573264268205;43620.34569481397;43691.78154109209;41778.79110604549;42086.36870446885;42946.57053429426;43026;43043.3543496854;35096.29807403786;37723.62276377201;37996.43005354867;38164;38702.80648596739;28772.424551508433;28930;29167.208262925684;29386.853065734533;29454 06:14:33 INFO - PROCESS | 3106 | |2;jquery.html;354.6630700834208;370.92766910452457;379.09207448161646;380.39327272999566;391.43633168237733;14520.927395363022;18457.81542184578;18989.715154272697;19585.706214406797;20832.47918802027;18778.812211877877;19287.517812054706;19595;19749.11128999195;19752.90123549384;5523.613347065717;5744.454276843693;5747.195392645033;5751.7986870459545;5761.107028410603;5619.185218143367;5641.956238095945;5699.202111704365;5702.65784052956;5709.4290570942985;5671.829845104653;5679;5681.943180568203;5682.147677848315;5709.971450142743;5502;5685.914711279334;5705;5731.799387021434;5732.914006289909;5055.266986287004;5067.290579318898;5077.111505486562;5081.339425874649;5115.7442127893455;23454.06183752648;23616.1734339299;23617.645735313985;23772.28683139491;23774.405639858967;2426.963595546068;2437.7196622388296;2712.5524288492375;2753.821001634887;2906.564015397686;14177.716445671029;14551.417943282257;14614.780778288334;14665.340059697339;14822.332995015251;1900.106949733623;1967.1147983407525;2001.2695366191235;2004.65920793464;2010.2361102780997;82717;83171.5841420795;83823.3235335296;86002.13997860004;87053.56473217593;9751.90248097524;9886.950565247127;10095.596176153018;10124.797504049879;10503.894961050444;14239.85760142406;14499;14572.927135364256;14574.125552466887;14613.342399592044;7647.655855486517;7929.246721561442;7932.722354717557;8008.439409241414;8022.638981245858;7685.154632990367;7786.8751569339465;7842.764717058498;7956.5226086435;7989.680412783539;6415.582987105823;6483.157189565326;6510.674466276762;6516.543841931019;6624.701888415033;1847.3718935561974;1857.489190472604;1860.851131909444;1889.6409682160345;1909.961800763977;967.1430852762712;980.7302991677203;982.6118683120128;994.1698681600944;1131.4342828585707;20110.39668809938;20419.183232670825;20670.483237919172;20885;20905;1005.3364779245809;1022.9795404091876;1049.7638031442864;1064.435849000031;1107.2083460325744;10701.658283950126;11587.826182607268;11610.187286889837;11691.532338706527;11792.469338879771;497636;499839;504710;506285;520290;81555;84099;84343.15656843476;85852.57073714591;86061;1019.2050200843206;1025.8102251083574;1045.2369770067894;1052.1687866585312;1054.3252318516156;16385.91807040957;17265.82734172642;18079;18118.728219076987;18149.818501814814;39345;42675.57324426716;42678;43981.78009109934;44240.336394953454;50327.74836125796;54130.729346353015;57548;57617;57913.42086579249;7965.56189409588;7982.960085199769;8089.8382032360205;8369.0375606806;8560.186782255676;11943.880561194277;12786.808197877226;12857.1000029997;12943.223406595635;13302.334883255991;11162.609308674157;11342.659720208407;11414.771704565695;11654.825177622173;11772.764544709229;11224.887751122711;11474.598389056342;11553.422328883355;11656.475458604553;11902;11180.329180249211;11264.211505194886;11523.711907202387;11561.132915031238;11766;7850.411219158472;7974.521528708064;8114.715984940499;8165.101838797608;8214.13751556078;10566.101881339864;10806.243562950833;10921.399323037309;11231.213815033196;11308.604198853001 06:14:33 INFO - PROCESS | 3106 | |3;mootools.html;1319.722858199778;1483.258370814593;1524.9618759531013;1587.1667374628319;1693.2972816281244;8239.794005149874;8731.825363492735;8759.91240087599;8820.338474614398;8859.51272680004;8708.390412671115;8825.823483530325;8830.91169088309;8831.735047948556;8832.33757468191;2311.711036120485;2337.1936681844822;2350.6356514740155;2352.6588644646517;2354.693889794324;2228.4985878177363;2249.6737972993906;2270.239469777618;2275.852069615478;2276.430892276931;2265.161890100665;2268.9546209075806;2294.7590502997195;2340.730815956161;2344.4373350395954;2219.3896678413403;2238.5187184755273;2239.708837851069;2243.3830696558493;2251.954960900781;2240.913157118796;2243.9663405048937;2244.046280330853;2250.0437314141423;2252.7296724393013;8609.139086091403;8739.694110706096;8742.519161446118;8809.515476648781;8831.690890818854;4998.875028124289;5178.326817513699;5183.403908550527;5183.714895680736;5197.272381866504;3284.540164376989;3333.2666813301275;3340.782849114824;3363.6468170841954;3366.646502117291;1063.8510608514814;1091.2961140064692;1091.9890801091967;1092.3118435385657;1117.6032508459543;12183.208091474025;12184.695382615417;12234.327112008836;12260.632181034494;12278.079144064142;4238.0888109056705;4271;4411.2941929291155;4414.050979039522;4458.821647134143;9275.628974841065;9301.116393942564;9302.720918372459;9463.952680236554;9471.431714097176;5052;5052.823151189691;5053.772580233898;5055.494450554988;5057.342545469065;4223.831046758157;4586.059857729158;4715.74063426508;4737.478877323491;4749.548792864673;3642.7085833133287;3703.981480092636;3766.0584853786554;3782.8486860525823;3787.0910981364273;1063.2025980514613;1067.1782727299935;1110.3116068037707;1117.4524483003433;1122.9887701123048;942.8350038743192;947.0955237747934;960.7790208252142;973.4597298499259;988.4316518002178;5714.342850572154;5862.501687356623;5886.941130588725;5975.551833612496;6068.089786532056;429.79442663329036;430.9159713855768;431.5576534052621;432.71657064622724;962.37926537383;3681.5766186888313;3853.3641949078087;3868.845246190177;3933.8819835404984;3964.7621142731527;10143.898561014443;10356.482175891175;10447.68656940293;10467.319624224401;10480.895191048145;10163.339382940234;10402.739931501621;10407.58369665205;10416.791664166674;10558.208134389952;8255.42212045163;8451.830963380698;8456.11210822867;8462.534560599226;8468.44955077918;5633.295838020247;5847.619904706181;5868.706564671835;5965.343812180743;6056.9697151513965;10080.445575493419;10116.190704743456;10288.12550933179;10295.588176472857;10302.896971030194;10508.054275115277;10545.736356591147;10578.259521833397;10613.09788667972;10691.786164276826;7156.427485801019;7263.295709269793;7337.119545654342;7835.3731701464885;7943.324817390587;7984.6406911687955;8474.110218426977;8580.14198580162;8747.125287471203;8749.518776467356;7527.8118047049265;7612.467127301035;7774.378049756119;7801.258880406353;7819.569923654253;7447.739329123455;7474.439417043634;7502.399808015237;7545.962270188614;7619.428542859197;6845.863082738417;6948.235694073749;6950.33971772701;6950.54821436605;6956.443484521327;4922.1632322505975;5021.949780502148;5049.31834202378;5062.468440813662;5116.923246151385;4906.754662266943;4946.777395017305;4978.327925730125;5134.717590532557;5376.73116344189 06:14:33 INFO - PROCESS | 3106 | |4;prototype.html;314.41518775078333;315.903649386937;321.5129079444642;323.36136131140984;323.80733463589155;5263.34208223972;5271.868203294919;5325.893482130355;5328.6269961102735;5347.946520534799;4986.476419975905;5016;5118.698439506526;5187.6887386756825;5216;4074.348104303312;4091.0999580092334;4112.876613701594;4139.5446500884955;4147.979260103695;4132.628063474287;4141.772202528859;4153.54311025787;4154.875353739392;4179.1223842993;3895.376739721645;3942.3100957332495;4088.0597462583623;4122.6083522065355;4132.5454200037975;4033.9596604033877;4061.959380406188;4105.486814148231;4116.217918595472;4140.855070072548;3615.94576081359;3638.289474341606;3644.125409901631;3663.4504824276305;3685.244524872395;5051.3433253676785;5128.461511541309;5161.483851614846;5182.714950677711;5214.400343960418;4712.505186955389;4726.125666751662;4731.266653668687;4739.976300118512;4751.239801631757;5418.322709661293;5436.157395603688;5486.1222204447495;5487.835364939058;5489.286392768954;3867.7485963412287;3935.330993731073;3938.741754847442;3980.44273801668;4002.4996875390575;5629.915551266734;5647.830565083054;5654.5193658538665;5656.773729050833;5663.66018038919;4065.97967010169;4078.4290199372113;4083.5508094109623;4084.2648323301496;4096.32410652245;3850.614938506127;4141.8964525887095;4152.152292229989;4159.939215500028;4168.562300958416;4610;4613.146567884952;4633.2818413146015;4662.160811053975;4673.275642275453;5441.945580544223;5465.480779325958;5472.890542189134;5474.3704473986;5493.615446918758;1353.7157196988742;1395.2884029145007;1409.3869166912425;1416.2423103639503;1418.4964337660188;884.7478468636536;897.9057198994142;906.7733066733317;913.4610579757842;920.8342498350228;4747.786349614275;4763.476017638057;4787.3987434701485;4794.640401969797;4807.4471435785335;4644.86065418038;4989.975050124799;5076.289319495274;5076.42630784458;5096.898062038813;4715.133590455794;4735.59747421473;4749.833755818529;4760.523947605212;4772.041334372641;2655.7211492793367;2658.481596088744;2658.5613373793494;2664.5603475426337;2685.1675980446125;5131.974340128276;5199.350081239845;5218.295530103387;5246.580273578104;5549;5800.274965629296;5809.128630705428;5811.738471768781;5814.854628634318;5829.387914269026;5838.357780644125;5878.853028674317;5899.321578018583;5995.730192141364;5997.460228579362;5523.447655234605;5668.837888232985;5702.203805801159;5706.600537962303;5739.139129130664;5575.804846830341;5584.46947539983;5614.606977511535;5646.644805246793;5651.971740141273;5647.108218746602;5874.559408044328;5877.794277200277;5926;5963.4334738199805;3952.150287688161;3972.7684417830565;3985.083430810988;3994.680425566006;3996.2407142642805;5432.837014889559;5553.500184983371;5577.0797818359515;5585.860353491195;5714.171445140514;5370.543503802064;5459.69971651563;5484.341878974548;5488.1614659089655;5512.448755124456;5352.250684904195;5506.476884696108;5509.944900551103;5545.584081193846;5549.250851135045;5417.941182350682;5435.239066530768;5482.725863706719;5494.2582751328055;5497.532709719719;5581.7767289309595;5614.7192640367;5624.437556244343;5681.204631351697;5685.545156387397;5182.585393168612;5427.674339539641;5442.265294185234;5483.396826349019;5522.86192845166 06:14:33 INFO - PROCESS | 3106 | |5;yui.html;732.2860211293993;750.9061367329084;777.194328474208;788.3023524181098;844.3582877013467;14890.478833240839;15749.448769293078;15754.606134846634;15790.526284211477;15808;15118;15210.771838422404;15219.46731864385;15231.54305370838;15232.314545845436;662.903878937555;798.3533337996213;814.771863878115;821.1788211788212;832.7376876283981;825.0759149752286;829.2868133405267;831.7546323834483;831.9334453243725;834.1241696218976;870.8301881133182;873.5937788928147;873.9868901966476;874.0298268921492;874.3092956564307;694.989575156373;836.7071524966274;853.799357151069;858.935579831512;869.070094998352;628.1551313483403;628.8899442597573;629.1129507394597;629.3832044596276;629.5561629051554;14779.704405911822;14799.482018129422;14868.330925108396;14898.627534311621;14964.551063468114;14553.054051486619;14729.484468043567;14805.407783688639;14921.626959325995;14960.401583936738;13306.268155251457;13353.799693004612;13488.325583720873;13493.325333733274;13694.52069177584;4433.2685106957315;4511.684182107254;4515.503294637587;4516.16450956574;4619.284010978304;84778.57610711906;88761.66857497208;90016.54991725065;90563.54718226366;92202.53898730464;11501.654950351503;11536;11743.588974385855;11880.287182769061;12250.264984100982;21136;21241.68137477939;21333.46666333354;21377;21397;8277.420580559303;8286.792830179173;8414.957925210458;8439.451435656663;8649.308055355556;4660.884726067785;4755.167845627001;4781.856544303607;4860.659753817269;4896.706197628154;3459.619441861393;3604.6575575320303;3608.9458658120147;3614.493970844084;3841.8463261469788;628.9496840252768;644.8549076457759;649.6686689788243;651.9608823470512;696.8571442854203;691.5366704308126;698.1464212515779;726.8800647893144;729.7628270811902;741.2476336518438;9517.476538790295;9814.901850981541;10095.444750538643;10280.177585793119;10295.330803497749;592.2448877680991;631.2677294338545;640.5708175522411;646.9353064693587;680.6269717067918;4776.522347765195;4933.827316043921;4976.676516026447;4987.900241995139;5003.174476211457;124665;126013;127547;133590;136109.3194534021;64617.67691161608;65920;67536;91704.6244306336;105199;59879.401205987386;60047.39952600506;78457.60771196222;94703.52648236853;96874.51562742282;9096.771633232378;9144.679936202201;9337.953310233406;9451.480168590793;9570.103149319655;55105;55459;55474;55805.44194558002;56012.159817603584;69349;77991.61004194943;84723.5763821177;85614.57192713997;85983.5700821517;12815.387591324248;13014.804777928528;13355.332233388486;13440;13566.59300220995;15022.399104035716;15103;15111.244437778287;15624.453144139901;15982.360705571647;12473.313967731861;12794.168379055332;12800.231986080866;13240.404181812035;13342.599722008355;13248.375812093953;13737.656558586115;13877.722445551235;14552.345144468736;14720.705585888436;13336.599902002956;13497.527586534425;13556.322183890568;13754;13816;11479.196456248317;11592.594259200887;11636.185467017565;11670.533178673099;12266.693332666755;11330;11385.772284554097;11412.82880756806;11495.942520287344;11920.582779602672 06:14:33 INFO - PROCESS | 3106 | __end_tp_report 06:14:33 INFO - PROCESS | 3106 | __start_cc_report 06:14:33 INFO - PROCESS | 3106 | _x_x_mozilla_cycle_collect,994 06:14:33 INFO - PROCESS | 3106 | __end_cc_report 06:14:33 INFO - PROCESS | 3106 | __startTimestamp1470143673963__endTimestamp 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | ------- Summary: start ------- 06:14:33 INFO - PROCESS | 3106 | Number of tests: 6 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | [#0] dojo.html Cycles:165 Average:5238.51 Median:5420.73 stddev:594.10 (11.0%) stddev-sans-first:569.55 06:14:33 INFO - PROCESS | 3106 | Values: 3007.0 3019.1 3033.9 3033.9 3062.7 5137.0 5215.7 5219.2 5288.7 5333.9 5255.9 5323.4 5391.9 5412.5 5432.8 4775.4 4790.1 4824.2 4829.5 4930.5 4856.6 4888.7 4898.8 4912.8 4921.3 4700.3 4722.0 4732.8 4777.0 4797.3 4789.7 4793.8 4798.6 4799.4 4805.0 4754.9 4758.4 4779.2 4780.8 4783.7 5180.8 5207.8 5216.6 5232.5 5268.6 5598.4 5608.4 5614.1 5659.4 5664.2 5656.6 5665.8 5692.5 5714.8 5718.8 5157.8 5161.0 5161.4 5169.7 5216.0 5766.2 5775.5 5786.8 5788.0 5788.6 5419.8 5561.9 5569.6 5570.4 5570.7 5528.6 5591.6 5599.2 5627.1 5683.7 5612.4 5618.1 5619.4 5619.7 5661.5 5559.6 5568.4 5634.6 5638.9 5640.0 4305.1 4336.8 4337.5 4338.2 4349.3 3825.1 3858.6 3861.8 3888.3 3896.1 5142.3 5261.7 5281.7 5288.0 5307.2 5585.8 5590.8 5611.1 5658.4 5736.9 5341.4 5368.1 5371.8 5372.4 5373.8 4836.3 4921.6 4928.1 4936.8 4969.4 5801.2 5874.9 5895.9 5928.1 5954.1 5668.5 5696.2 5696.5 5705.3 5715.5 5694.5 5901.7 5915.9 5924.0 5924.4 5420.7 5497.3 5502.0 5510.7 5569.7 5592.5 5595.8 5636.3 5637.7 5640.2 5419.4 5519.3 5524.9 5531.0 5565.8 5402.5 5485.3 5492.5 5513.5 5551.1 5384.9 5423.5 5429.4 5434.7 5440.8 5401.1 5520.2 5588.2 5596.3 5599.2 5324.1 5392.5 5401.6 5423.2 5474.6 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | [#1] ext.html Cycles:180 Average:60436.28 Median:42810.07 stddev:117341.75 (274.1%) stddev-sans-first:117584.89 06:14:33 INFO - PROCESS | 3106 | Values: 590.3 601.7 604.0 625.4 626.9 43399.3 44123.3 44210.6 44396.8 48470.8 46009.3 46396.3 46441.8 46449.8 46511.1 9046.8 9166.4 9186.0 9212.8 9219.6 8771.6 8859.0 8869.1 8871.2 8874.5 8926.6 8961.9 8962.4 8965.7 8976.2 8867.1 8901.6 8905.7 8920.2 8921.1 8878.3 8942.6 8945.2 8949.7 8949.9 44126.0 44128.8 44176.3 44256.1 44487.3 3339.2 3527.6 3540.3 3572.1 3941.9 33534.5 33888.3 33917.5 33931.2 34807.5 4107.8 4161.4 4255.8 4265.6 4328.2 352081.0 353126.0 353575.0 354060.0 354598.0 62764.7 63137.4 63140.0 63152.4 63184.0 36315.6 65354.0 65434.7 65440.0 65527.7 16159.4 16757.6 16785.0 16808.2 16830.8 12101.8 12166.1 12169.4 12174.5 12181.6 19879.1 20173.7 20181.9 20194.3 20235.0 6965.3 7108.3 7110.5 7124.1 7216.9 995.4 1041.7 1073.9 1097.9 1117.6 33324.5 33607.5 33638.3 33796.5 33939.5 1085.3 1118.8 1153.7 1164.9 1173.4 17278.0 17388.2 17432.3 17473.6 17555.6 558933.0 562182.0 563719.0 566137.0 566728.0 58977.0 59409.7 59591.7 59631.0 59737.0 1227.8 1265.7 1319.8 1361.4 1374.7 32104.5 34825.7 34857.5 34933.7 35361.6 52689.5 52700.0 52985.5 53051.7 53135.7 379957.0 381189.0 381415.0 382234.0 382837.0 28656.7 29166.4 29851.4 29873.3 30689.5 49311.8 49728.8 49729.8 50012.7 50069.5 41471.6 41923.6 43034.1 43178.0 44209.6 41898.4 42121.2 42673.6 43620.3 43691.8 41778.8 42086.4 42946.6 43026.0 43043.4 35096.3 37723.6 37996.4 38164.0 38702.8 28772.4 28930.0 29167.2 29386.9 29454.0 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | [#2] jquery.html Cycles:180 Average:29380.29 Median:2575.14 stddev:83193.77 (3230.7%) stddev-sans-first:83398.61 06:14:33 INFO - PROCESS | 3106 | Values: 354.7 370.9 379.1 380.4 391.4 14520.9 18457.8 18989.7 19585.7 20832.5 18778.8 19287.5 19595.0 19749.1 19752.9 5523.6 5744.5 5747.2 5751.8 5761.1 5619.2 5642.0 5699.2 5702.7 5709.4 5671.8 5679.0 5681.9 5682.1 5710.0 5502.0 5685.9 5705.0 5731.8 5732.9 5055.3 5067.3 5077.1 5081.3 5115.7 23454.1 23616.2 23617.6 23772.3 23774.4 2427.0 2437.7 2712.6 2753.8 2906.6 14177.7 14551.4 14614.8 14665.3 14822.3 1900.1 1967.1 2001.3 2004.7 2010.2 82717.0 83171.6 83823.3 86002.1 87053.6 9751.9 9887.0 10095.6 10124.8 10503.9 14239.9 14499.0 14572.9 14574.1 14613.3 7647.7 7929.2 7932.7 8008.4 8022.6 7685.2 7786.9 7842.8 7956.5 7989.7 6415.6 6483.2 6510.7 6516.5 6624.7 1847.4 1857.5 1860.9 1889.6 1910.0 967.1 980.7 982.6 994.2 1131.4 20110.4 20419.2 20670.5 20885.0 20905.0 1005.3 1023.0 1049.8 1064.4 1107.2 10701.7 11587.8 11610.2 11691.5 11792.5 497636.0 499839.0 504710.0 506285.0 520290.0 81555.0 84099.0 84343.2 85852.6 86061.0 1019.2 1025.8 1045.2 1052.2 1054.3 16385.9 17265.8 18079.0 18118.7 18149.8 39345.0 42675.6 42678.0 43981.8 44240.3 50327.7 54130.7 57548.0 57617.0 57913.4 7965.6 7983.0 8089.8 8369.0 8560.2 11943.9 12786.8 12857.1 12943.2 13302.3 11162.6 11342.7 11414.8 11654.8 11772.8 11224.9 11474.6 11553.4 11656.5 11902.0 11180.3 11264.2 11523.7 11561.1 11766.0 7850.4 7974.5 8114.7 8165.1 8214.1 10566.1 10806.2 10921.4 11231.2 11308.6 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | [#3] mootools.html Cycles:180 Average:5682.32 Median:4650.90 stddev:3279.06 (70.5%) stddev-sans-first:3271.87 06:14:33 INFO - PROCESS | 3106 | Values: 1319.7 1483.3 1525.0 1587.2 1693.3 8239.8 8731.8 8759.9 8820.3 8859.5 8708.4 8825.8 8830.9 8831.7 8832.3 2311.7 2337.2 2350.6 2352.7 2354.7 2228.5 2249.7 2270.2 2275.9 2276.4 2265.2 2269.0 2294.8 2340.7 2344.4 2219.4 2238.5 2239.7 2243.4 2252.0 2240.9 2244.0 2244.0 2250.0 2252.7 8609.1 8739.7 8742.5 8809.5 8831.7 4998.9 5178.3 5183.4 5183.7 5197.3 3284.5 3333.3 3340.8 3363.6 3366.6 1063.9 1091.3 1092.0 1092.3 1117.6 12183.2 12184.7 12234.3 12260.6 12278.1 4238.1 4271.0 4411.3 4414.1 4458.8 9275.6 9301.1 9302.7 9464.0 9471.4 5052.0 5052.8 5053.8 5055.5 5057.3 4223.8 4586.1 4715.7 4737.5 4749.5 3642.7 3704.0 3766.1 3782.8 3787.1 1063.2 1067.2 1110.3 1117.5 1123.0 942.8 947.1 960.8 973.5 988.4 5714.3 5862.5 5886.9 5975.6 6068.1 429.8 430.9 431.6 432.7 962.4 3681.6 3853.4 3868.8 3933.9 3964.8 10143.9 10356.5 10447.7 10467.3 10480.9 10163.3 10402.7 10407.6 10416.8 10558.2 8255.4 8451.8 8456.1 8462.5 8468.4 5633.3 5847.6 5868.7 5965.3 6057.0 10080.4 10116.2 10288.1 10295.6 10302.9 10508.1 10545.7 10578.3 10613.1 10691.8 7156.4 7263.3 7337.1 7835.4 7943.3 7984.6 8474.1 8580.1 8747.1 8749.5 7527.8 7612.5 7774.4 7801.3 7819.6 7447.7 7474.4 7502.4 7546.0 7619.4 6845.9 6948.2 6950.3 6950.5 6956.4 4922.2 5021.9 5049.3 5062.5 5116.9 4906.8 4946.8 4978.3 5134.7 5376.7 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | [#4] prototype.html Cycles:180 Average:4573.28 Median:5146.73 stddev:1353.85 (26.3%) stddev-sans-first:1319.38 06:14:33 INFO - PROCESS | 3106 | Values: 314.4 315.9 321.5 323.4 323.8 5263.3 5271.9 5325.9 5328.6 5347.9 4986.5 5016.0 5118.7 5187.7 5216.0 4074.3 4091.1 4112.9 4139.5 4148.0 4132.6 4141.8 4153.5 4154.9 4179.1 3895.4 3942.3 4088.1 4122.6 4132.5 4034.0 4062.0 4105.5 4116.2 4140.9 3615.9 3638.3 3644.1 3663.5 3685.2 5051.3 5128.5 5161.5 5182.7 5214.4 4712.5 4726.1 4731.3 4740.0 4751.2 5418.3 5436.2 5486.1 5487.8 5489.3 3867.7 3935.3 3938.7 3980.4 4002.5 5629.9 5647.8 5654.5 5656.8 5663.7 4066.0 4078.4 4083.6 4084.3 4096.3 3850.6 4141.9 4152.2 4159.9 4168.6 4610.0 4613.1 4633.3 4662.2 4673.3 5441.9 5465.5 5472.9 5474.4 5493.6 1353.7 1395.3 1409.4 1416.2 1418.5 884.7 897.9 906.8 913.5 920.8 4747.8 4763.5 4787.4 4794.6 4807.4 4644.9 4990.0 5076.3 5076.4 5096.9 4715.1 4735.6 4749.8 4760.5 4772.0 2655.7 2658.5 2658.6 2664.6 2685.2 5132.0 5199.4 5218.3 5246.6 5549.0 5800.3 5809.1 5811.7 5814.9 5829.4 5838.4 5878.9 5899.3 5995.7 5997.5 5523.4 5668.8 5702.2 5706.6 5739.1 5575.8 5584.5 5614.6 5646.6 5652.0 5647.1 5874.6 5877.8 5926.0 5963.4 3952.2 3972.8 3985.1 3994.7 3996.2 5432.8 5553.5 5577.1 5585.9 5714.2 5370.5 5459.7 5484.3 5488.2 5512.4 5352.3 5506.5 5509.9 5545.6 5549.3 5417.9 5435.2 5482.7 5494.3 5497.5 5581.8 5614.7 5624.4 5681.2 5685.5 5182.6 5427.7 5442.3 5483.4 5522.9 06:14:33 INFO - PROCESS | 3106 | 06:14:33 INFO - PROCESS | 3106 | [#5] yui.html Cycles:180 Average:21218.78 Median:4765.85 stddev:30971.10 (649.9%) stddev-sans-first:31019.78 06:14:33 INFO - PROCESS | 3106 | Values: 732.3 750.9 777.2 788.3 844.4 14890.5 15749.4 15754.6 15790.5 15808.0 15118.0 15210.8 15219.5 15231.5 15232.3 662.9 798.4 814.8 821.2 832.7 825.1 829.3 831.8 831.9 834.1 870.8 873.6 874.0 874.0 874.3 695.0 836.7 853.8 858.9 869.1 628.2 628.9 629.1 629.4 629.6 14779.7 14799.5 14868.3 14898.6 14964.6 14553.1 14729.5 14805.4 14921.6 14960.4 13306.3 13353.8 13488.3 13493.3 13694.5 4433.3 4511.7 4515.5 4516.2 4619.3 84778.6 88761.7 90016.5 90563.5 92202.5 11501.7 11536.0 11743.6 11880.3 12250.3 21136.0 21241.7 21333.5 21377.0 21397.0 8277.4 8286.8 8415.0 8439.5 8649.3 4660.9 4755.2 4781.9 4860.7 4896.7 3459.6 3604.7 3608.9 3614.5 3841.8 628.9 644.9 649.7 652.0 696.9 691.5 698.1 726.9 729.8 741.2 9517.5 9814.9 10095.4 10280.2 10295.3 592.2 631.3 640.6 646.9 680.6 4776.5 4933.8 4976.7 4987.9 5003.2 124665.0 126013.0 127547.0 133590.0 136109.3 64617.7 65920.0 67536.0 91704.6 105199.0 59879.4 60047.4 78457.6 94703.5 96874.5 9096.8 9144.7 9338.0 9451.5 9570.1 55105.0 55459.0 55474.0 55805.4 56012.2 69349.0 77991.6 84723.6 85614.6 85983.6 12815.4 13014.8 13355.3 13440.0 13566.6 15022.4 15103.0 15111.2 15624.5 15982.4 12473.3 12794.2 12800.2 13240.4 13342.6 13248.4 13737.7 13877.7 14552.3 14720.7 13336.6 13497.5 13556.3 13754.0 13816.0 11479.2 11592.6 11636.2 11670.5 12266.7 11330.0 11385.8 11412.8 11495.9 11920.6 06:14:33 INFO - PROCESS | 3106 | -------- Summary: end -------- 06:14:33 INFO - PROCESS | 3106 | 06:14:34 INFO - TEST-INFO | 3106: exit 0 06:14:34 INFO - TEST-OK | dromaeo_css | took 1113731ms 06:14:34 INFO - TEST-START | kraken 06:14:34 INFO - operating with platform_type : linux_ 06:14:34 INFO - Initialising browser for kraken test... 06:14:34 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoy0UIU/profile http://localhost:36505/getInfo.html) 06:14:38 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 06:14:38 INFO - PROCESS | 3295 | colorDepth:24 06:14:38 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 06:14:38 INFO - PROCESS | 3295 | __metrics 06:14:39 INFO - PROCESS | 3295 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:14:39 INFO - PROCESS | 3295 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:40 INFO - PROCESS | 3295 | console.error: PushService: 06:14:40 INFO - PROCESS | 3295 | stateChangeProcessEnqueue: Error transitioning state 06:14:40 INFO - PROCESS | 3295 | UnknownError 06:14:40 INFO - TEST-INFO | 3295: exit 0 06:14:40 INFO - Browser initialized. 06:14:40 INFO - Running cycle 1/1 for kraken test... 06:14:40 INFO - TEST-INFO | started process 3374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoy0UIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:52 INFO - PROCESS | 3374 | RSS: Main: 155934720 06:14:52 INFO - PROCESS | 3374 | 06:14:55 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36505/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:55 INFO - PROCESS | 3374 | RSS: Main: 212738048 06:14:55 INFO - PROCESS | 3374 | 06:14:58 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36505/tests/kraken/driver.html?testName=audio-dft) 06:14:59 INFO - PROCESS | 3374 | RSS: Main: 190959616 06:14:59 INFO - PROCESS | 3374 | 06:15:02 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36505/tests/kraken/driver.html?testName=audio-fft) 06:15:02 INFO - PROCESS | 3374 | RSS: Main: 269086720 06:15:02 INFO - PROCESS | 3374 | 06:15:05 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36505/tests/kraken/driver.html?testName=audio-oscillator) 06:15:05 INFO - PROCESS | 3374 | RSS: Main: 179310592 06:15:05 INFO - PROCESS | 3374 | 06:15:07 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36505/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:15:08 INFO - PROCESS | 3374 | RSS: Main: 184266752 06:15:08 INFO - PROCESS | 3374 | 06:15:11 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36505/tests/kraken/driver.html?testName=imaging-darkroom) 06:15:11 INFO - PROCESS | 3374 | RSS: Main: 218951680 06:15:11 INFO - PROCESS | 3374 | 06:15:15 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36505/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:15 INFO - PROCESS | 3374 | RSS: Main: 219447296 06:15:15 INFO - PROCESS | 3374 | 06:15:18 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36505/tests/kraken/driver.html?testName=json-parse-financial) 06:15:19 INFO - PROCESS | 3374 | RSS: Main: 219176960 06:15:19 INFO - PROCESS | 3374 | 06:15:20 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36505/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:21 INFO - PROCESS | 3374 | RSS: Main: 183517184 06:15:21 INFO - PROCESS | 3374 | 06:15:23 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:23 INFO - PROCESS | 3374 | RSS: Main: 188039168 06:15:23 INFO - PROCESS | 3374 | 06:15:25 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:26 INFO - PROCESS | 3374 | RSS: Main: 193765376 06:15:26 INFO - PROCESS | 3374 | 06:15:28 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:29 INFO - PROCESS | 3374 | RSS: Main: 189595648 06:15:29 INFO - PROCESS | 3374 | 06:15:32 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:32 INFO - PROCESS | 3374 | RSS: Main: 192352256 06:15:32 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:36505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36505/tests/kraken/driver.html?testName=ai-astar) 06:15:34 INFO - PROCESS | 3374 | RSS: Main: 243343360 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | __start_tp_report 06:15:34 INFO - PROCESS | 3374 | _x_x_mozilla_page_load 06:15:34 INFO - PROCESS | 3374 | _x_x_mozilla_page_load_details 06:15:34 INFO - PROCESS | 3374 | |i|pagename|runs| 06:15:34 INFO - PROCESS | 3374 | |0;ai-astar;104;112;113;112;112;111;111;110;113;111 06:15:34 INFO - PROCESS | 3374 | |1;audio-beat-detection;143;118;118;181;119;120;146;119;152;115 06:15:34 INFO - PROCESS | 3374 | |2;audio-dft;160;160;160;160;161;161;160;160;161;161 06:15:34 INFO - PROCESS | 3374 | |3;audio-fft;76;76;74;115;75;75;75;74;108;74 06:15:34 INFO - PROCESS | 3374 | |4;audio-oscillator;82;83;116;85;84;83;122;84;83;130 06:15:34 INFO - PROCESS | 3374 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;117;118 06:15:34 INFO - PROCESS | 3374 | |6;imaging-darkroom;146;146;145;146;145;145;146;145;145;145 06:15:34 INFO - PROCESS | 3374 | |7;imaging-desaturate;95;94;95;94;95;96;94;94;94;95 06:15:34 INFO - PROCESS | 3374 | |8;json-parse-financial;53;53;53;53;53;54;55;52;53;51 06:15:34 INFO - PROCESS | 3374 | |9;json-stringify-tinderbox;61;61;61;61;61;60;60;61;62;61 06:15:34 INFO - PROCESS | 3374 | |10;stanford-crypto-aes;81;76;74;75;74;76;75;74;75;85 06:15:34 INFO - PROCESS | 3374 | |11;stanford-crypto-ccm;120;126;122;120;138;118;127;131;173;124 06:15:34 INFO - PROCESS | 3374 | |12;stanford-crypto-pbkdf2;160;161;160;160;157;162;159;156;156;161 06:15:34 INFO - PROCESS | 3374 | |13;stanford-crypto-sha256-iterative;65;67;66;63;62;62;68;61;63;60 06:15:34 INFO - PROCESS | 3374 | __end_tp_report 06:15:34 INFO - PROCESS | 3374 | __start_cc_report 06:15:34 INFO - PROCESS | 3374 | _x_x_mozilla_cycle_collect,1702 06:15:34 INFO - PROCESS | 3374 | __end_cc_report 06:15:34 INFO - PROCESS | 3374 | __startTimestamp1470143734814__endTimestamp 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | ------- Summary: start ------- 06:15:34 INFO - PROCESS | 3374 | Number of tests: 14 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 06:15:34 INFO - PROCESS | 3374 | Values: 104.0 112.0 113.0 112.0 112.0 111.0 111.0 110.0 113.0 111.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:131.50 stddev:21.78 (16.6%) stddev-sans-first:22.80 06:15:34 INFO - PROCESS | 3374 | Values: 143.0 118.0 118.0 181.0 119.0 120.0 146.0 119.0 152.0 115.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:15:34 INFO - PROCESS | 3374 | Values: 160.0 160.0 160.0 160.0 161.0 161.0 160.0 160.0 161.0 161.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:15.55 (20.7%) stddev-sans-first:16.33 06:15:34 INFO - PROCESS | 3374 | Values: 76.0 76.0 74.0 115.0 75.0 75.0 75.0 74.0 108.0 74.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:83.00 stddev:19.26 (23.2%) stddev-sans-first:19.82 06:15:34 INFO - PROCESS | 3374 | Values: 82.0 83.0 116.0 85.0 84.0 83.0 122.0 84.0 83.0 130.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:15:34 INFO - PROCESS | 3374 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:15:34 INFO - PROCESS | 3374 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 06:15:34 INFO - PROCESS | 3374 | Values: 95.0 94.0 95.0 94.0 95.0 96.0 94.0 94.0 94.0 95.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.05 (2.0%) stddev-sans-first:1.12 06:15:34 INFO - PROCESS | 3374 | Values: 53.0 53.0 53.0 53.0 53.0 54.0 55.0 52.0 53.0 51.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:15:34 INFO - PROCESS | 3374 | Values: 61.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 62.0 61.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:75.50 stddev:3.63 (4.8%) stddev-sans-first:3.46 06:15:34 INFO - PROCESS | 3374 | Values: 81.0 76.0 74.0 75.0 74.0 76.0 75.0 74.0 75.0 85.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:126.50 stddev:16.27 (12.9%) stddev-sans-first:16.86 06:15:34 INFO - PROCESS | 3374 | Values: 120.0 126.0 122.0 120.0 138.0 118.0 127.0 131.0 173.0 124.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:2.15 (1.3%) stddev-sans-first:2.26 06:15:34 INFO - PROCESS | 3374 | Values: 160.0 161.0 160.0 160.0 157.0 162.0 159.0 156.0 156.0 161.0 06:15:34 INFO - PROCESS | 3374 | 06:15:34 INFO - PROCESS | 3374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.67 (4.2%) stddev-sans-first:2.79 06:15:34 INFO - PROCESS | 3374 | Values: 65.0 67.0 66.0 63.0 62.0 62.0 68.0 61.0 63.0 60.0 06:15:34 INFO - PROCESS | 3374 | -------- Summary: end -------- 06:15:34 INFO - PROCESS | 3374 | 06:15:35 INFO - TEST-INFO | 3374: exit 0 06:15:35 INFO - TEST-OK | kraken | took 61075ms 06:15:35 INFO - SUITE-END | took 1174s 06:15:35 INFO - Completed test suite (00:19:34) 06:15:35 INFO - javascript benchmark 06:15:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3006.9699303006964, 3019.1093627379923, 3033.8634761435733, 3033.878644854206, 3062.739667128294, 5137.049645815527, 5215.739213039343, 5219.217117432382, 5288.735563221838, 5333.866653333664, 5255.947440525593, 5323.441038690939, 5391.892162156764, 5412.4587541245855, 5432.75552600133, 4775.379200703904, 4790.089882922242, 4824.179889418807, 4829.541193586604, 4930.506949305059, 4856.6357523185725, 4888.657793954425, 4898.804047838083, 4912.778924948386, 4921.335619691349, 4700.29495575663, 4722.0, 4732.834350797705, 4776.952230477686, 4797.280407938802, 4789.664723469358, 4793.832215872462, 4798.568128868418, 4799.400074990626, 4805.0, 4754.857354279377, 4758.3576217210575, 4779.163646361872, 4780.80876764929, 4783.736894470802, 5180.844574662766, 5207.791688332462, 5216.556592689626, 5232.502912223333, 5268.578513718893, 5598.412166722517, 5608.383077861432, 5614.073677843151, 5659.434056594308, 5664.178694089334, 5656.632318899258, 5665.773369065232, 5692.544596432317, 5714.771409143629, 5718.79984200551, 5157.819476318311, 5161.045206636784, 5161.4322424533275, 5169.741512924414, 5216.008958297987, 5766.221560089418, 5775.451332123442, 5786.768529258867, 5788.0, 5788.565857560699, 5419.810306639328, 5561.916571251434, 5569.610127291051, 5570.442955704397, 5570.721463926788, 5528.612997090165, 5591.580631452657, 5599.244102046172, 5627.099664053731, 5683.687397193112, 5612.35457922336, 5618.073017952074, 5619.4099619540175, 5619.7471113799975, 5661.518770904437, 5559.555235581144, 5568.359638641527, 5634.60557760961, 5638.85902852432, 5639.971800140973, 4305.095929854766, 4336.783160841946, 4337.50118736343, 4338.240807858612, 4349.325854492558, 3825.081980324702, 3858.5948475409677, 3861.787601681878, 3888.2806680764147, 3896.0649444133205, 5142.280080788692, 5261.736913154327, 5281.735913204325, 5288.021715982555, 5307.177387504943, 5585.832425027255, 5590.8043218487155, 5611.130274807411, 5658.377578466366, 5736.856578585569, 5341.359036915595, 5368.141097424472, 5371.811986580451, 5372.409035006146, 5373.838784836461, 4836.322914791932, 4921.630877684116, 4928.088303663833, 4936.802527898915, 4969.378827646544, 5801.187833703285, 5874.9118763218585, 5895.941040589625, 5928.140419639042, 5954.077118046623, 5668.51817595509, 5696.202531645656, 5696.487316141567, 5705.286839145107, 5715.542756579547, 5694.487496125369, 5901.675407852609, 5915.91126133117, 5923.970380148244, 5924.407559244041, 5420.728963551728, 5497.340319161726, 5501.982133305191, 5510.6969116698965, 5569.721513924369, 5592.468715472024, 5595.776168953196, 5636.2954630671165, 5637.661740295595, 5640.182173584725, 5419.376771671308, 5519.254900588529, 5524.861878453071, 5531.0, 5565.833025009256, 5402.486763757437, 5485.341758988947, 5492.505674489155, 5513.5037846594, 5551.084071128219, 5384.865378365572, 5423.511883930465, 5429.375621803543, 5434.701091439851, 5440.7551660174595, 5401.054815407367, 5520.199571062254, 5588.161775733673, 5596.3284405871555, 5599.160125981135, 5324.148136298174, 5392.5416339611575, 5401.594880383908, 5423.159410291411, 5474.5894057945015], "value": 5198.279548969714, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3211306996953, 601.6991504247876, 603.9909401358977, 625.4496043481736, 626.9216347956507, 43399.349009764876, 44123.338149927775, 44210.55789442109, 44396.778016109914, 48470.75764621181, 46009.30986035212, 46396.30405543919, 46441.76779116099, 46449.7677511612, 46511.06977860441, 9046.77383065422, 9166.358354915159, 9186.035466276046, 9212.769680757967, 9219.631214751402, 8771.649134034631, 8859.0, 8869.068747781486, 8871.157240062184, 8874.467531948072, 8926.598303076376, 8961.865572016392, 8962.417442866194, 8965.686200982967, 8976.192142707156, 8867.068957759438, 8901.599428025755, 8905.73282801517, 8920.241779448756, 8921.107889211093, 8878.334124940655, 8942.552872356357, 8945.239654629364, 8949.731508054769, 8949.910500894974, 44126.0, 44128.77935610333, 44176.3373549397, 44256.11487770259, 44487.33269000967, 3339.231976645361, 3527.6295988921306, 3540.3450361682912, 3572.142685755426, 3941.921161576752, 33534.49698254528, 33888.32223355544, 33917.49123763145, 33931.15172120692, 34807.4778878317, 4107.815148318333, 4161.354581673307, 4255.765932873691, 4265.573442655709, 4328.242557552416, 352081.0, 353126.0, 353575.0, 354060.0, 354598.0, 62764.68617656882, 63137.368626313146, 63140.0, 63152.36847631557, 63184.0, 36315.63684363176, 65354.0, 65434.672826635564, 65440.0, 65527.67236163884, 16159.353625855068, 16757.581060473585, 16785.0, 16808.243629036722, 16830.83169168317, 12101.757964840654, 12166.087543434278, 12169.391530423443, 12174.45214965311, 12181.573644922386, 19879.10544025522, 20173.697394539093, 20181.899090504452, 20194.293199738233, 20235.0, 6965.268646792115, 7108.329542557495, 7110.502264841515, 7124.145102587722, 7216.855662886713, 995.4176806568239, 1041.7499800048085, 1073.8711354637337, 1097.9011888930036, 1117.5641499815079, 33324.50013249803, 33607.49588756171, 33638.327233455195, 33796.49305260423, 33939.490907636406, 1085.289135616157, 1118.8209886418133, 1153.6654370232538, 1164.9184557080923, 1173.436750359832, 17278.0, 17388.217530211172, 17432.302707891544, 17473.563160920825, 17555.561110972074, 558933.0, 562182.0, 563719.0, 566137.0, 566728.0, 58977.0, 59409.702951484964, 59591.70204149038, 59631.0, 59737.0, 1227.8096894981293, 1265.6645988812973, 1319.7690404179039, 1361.3737680667004, 1374.7387996280875, 32104.518432224002, 34825.65174348326, 34857.47713784346, 34933.65066349304, 35361.64638353584, 52689.47310526999, 52700.0, 52985.47014529805, 53051.73474132759, 53135.73432132815, 379957.0, 381189.0, 381415.0, 382234.0, 382837.0, 28656.713432865403, 29166.416671666873, 29851.402971940006, 29873.253168670955, 30689.53965690561, 49311.75344123256, 49728.75135624299, 49729.75135124301, 50012.74993625009, 50069.49930500648, 41471.58528414798, 41923.58076419197, 43034.13931721285, 43178.0, 44209.557904420544, 41898.37152442777, 42121.157576848906, 42673.573264268205, 43620.34569481397, 43691.78154109209, 41778.79110604549, 42086.36870446885, 42946.57053429426, 43026.0, 43043.3543496854, 35096.29807403786, 37723.62276377201, 37996.43005354867, 38164.0, 38702.80648596739, 28772.424551508433, 28930.0, 29167.208262925684, 29386.853065734533, 29454.0], "value": 20531.52387200573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.6630700834208, 370.92766910452457, 379.09207448161646, 380.39327272999566, 391.43633168237733, 14520.927395363022, 18457.81542184578, 18989.715154272697, 19585.706214406797, 20832.47918802027, 18778.812211877877, 19287.517812054706, 19595.0, 19749.11128999195, 19752.90123549384, 5523.613347065717, 5744.454276843693, 5747.195392645033, 5751.7986870459545, 5761.107028410603, 5619.185218143367, 5641.956238095945, 5699.202111704365, 5702.65784052956, 5709.4290570942985, 5671.829845104653, 5679.0, 5681.943180568203, 5682.147677848315, 5709.971450142743, 5502.0, 5685.914711279334, 5705.0, 5731.799387021434, 5732.914006289909, 5055.266986287004, 5067.290579318898, 5077.111505486562, 5081.339425874649, 5115.7442127893455, 23454.06183752648, 23616.1734339299, 23617.645735313985, 23772.28683139491, 23774.405639858967, 2426.963595546068, 2437.7196622388296, 2712.5524288492375, 2753.821001634887, 2906.564015397686, 14177.716445671029, 14551.417943282257, 14614.780778288334, 14665.340059697339, 14822.332995015251, 1900.106949733623, 1967.1147983407525, 2001.2695366191235, 2004.65920793464, 2010.2361102780997, 82717.0, 83171.5841420795, 83823.3235335296, 86002.13997860004, 87053.56473217593, 9751.90248097524, 9886.950565247127, 10095.596176153018, 10124.797504049879, 10503.894961050444, 14239.85760142406, 14499.0, 14572.927135364256, 14574.125552466887, 14613.342399592044, 7647.655855486517, 7929.246721561442, 7932.722354717557, 8008.439409241414, 8022.638981245858, 7685.154632990367, 7786.8751569339465, 7842.764717058498, 7956.5226086435, 7989.680412783539, 6415.582987105823, 6483.157189565326, 6510.674466276762, 6516.543841931019, 6624.701888415033, 1847.3718935561974, 1857.489190472604, 1860.851131909444, 1889.6409682160345, 1909.961800763977, 967.1430852762712, 980.7302991677203, 982.6118683120128, 994.1698681600944, 1131.4342828585707, 20110.39668809938, 20419.183232670825, 20670.483237919172, 20885.0, 20905.0, 1005.3364779245809, 1022.9795404091876, 1049.7638031442864, 1064.435849000031, 1107.2083460325744, 10701.658283950126, 11587.826182607268, 11610.187286889837, 11691.532338706527, 11792.469338879771, 497636.0, 499839.0, 504710.0, 506285.0, 520290.0, 81555.0, 84099.0, 84343.15656843476, 85852.57073714591, 86061.0, 1019.2050200843206, 1025.8102251083574, 1045.2369770067894, 1052.1687866585312, 1054.3252318516156, 16385.91807040957, 17265.82734172642, 18079.0, 18118.728219076987, 18149.818501814814, 39345.0, 42675.57324426716, 42678.0, 43981.78009109934, 44240.336394953454, 50327.74836125796, 54130.729346353015, 57548.0, 57617.0, 57913.42086579249, 7965.56189409588, 7982.960085199769, 8089.8382032360205, 8369.0375606806, 8560.186782255676, 11943.880561194277, 12786.808197877226, 12857.1000029997, 12943.223406595635, 13302.334883255991, 11162.609308674157, 11342.659720208407, 11414.771704565695, 11654.825177622173, 11772.764544709229, 11224.887751122711, 11474.598389056342, 11553.422328883355, 11656.475458604553, 11902.0, 11180.329180249211, 11264.211505194886, 11523.711907202387, 11561.132915031238, 11766.0, 7850.411219158472, 7974.521528708064, 8114.715984940499, 8165.101838797608, 8214.13751556078, 10566.101881339864, 10806.243562950833, 10921.399323037309, 11231.213815033196, 11308.604198853001], "value": 9318.749836402745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.722858199778, 1483.258370814593, 1524.9618759531013, 1587.1667374628319, 1693.2972816281244, 8239.794005149874, 8731.825363492735, 8759.91240087599, 8820.338474614398, 8859.51272680004, 8708.390412671115, 8825.823483530325, 8830.91169088309, 8831.735047948556, 8832.33757468191, 2311.711036120485, 2337.1936681844822, 2350.6356514740155, 2352.6588644646517, 2354.693889794324, 2228.4985878177363, 2249.6737972993906, 2270.239469777618, 2275.852069615478, 2276.430892276931, 2265.161890100665, 2268.9546209075806, 2294.7590502997195, 2340.730815956161, 2344.4373350395954, 2219.3896678413403, 2238.5187184755273, 2239.708837851069, 2243.3830696558493, 2251.954960900781, 2240.913157118796, 2243.9663405048937, 2244.046280330853, 2250.0437314141423, 2252.7296724393013, 8609.139086091403, 8739.694110706096, 8742.519161446118, 8809.515476648781, 8831.690890818854, 4998.875028124289, 5178.326817513699, 5183.403908550527, 5183.714895680736, 5197.272381866504, 3284.540164376989, 3333.2666813301275, 3340.782849114824, 3363.6468170841954, 3366.646502117291, 1063.8510608514814, 1091.2961140064692, 1091.9890801091967, 1092.3118435385657, 1117.6032508459543, 12183.208091474025, 12184.695382615417, 12234.327112008836, 12260.632181034494, 12278.079144064142, 4238.0888109056705, 4271.0, 4411.2941929291155, 4414.050979039522, 4458.821647134143, 9275.628974841065, 9301.116393942564, 9302.720918372459, 9463.952680236554, 9471.431714097176, 5052.0, 5052.823151189691, 5053.772580233898, 5055.494450554988, 5057.342545469065, 4223.831046758157, 4586.059857729158, 4715.74063426508, 4737.478877323491, 4749.548792864673, 3642.7085833133287, 3703.981480092636, 3766.0584853786554, 3782.8486860525823, 3787.0910981364273, 1063.2025980514613, 1067.1782727299935, 1110.3116068037707, 1117.4524483003433, 1122.9887701123048, 942.8350038743192, 947.0955237747934, 960.7790208252142, 973.4597298499259, 988.4316518002178, 5714.342850572154, 5862.501687356623, 5886.941130588725, 5975.551833612496, 6068.089786532056, 429.79442663329036, 430.9159713855768, 431.5576534052621, 432.71657064622724, 962.37926537383, 3681.5766186888313, 3853.3641949078087, 3868.845246190177, 3933.8819835404984, 3964.7621142731527, 10143.898561014443, 10356.482175891175, 10447.68656940293, 10467.319624224401, 10480.895191048145, 10163.339382940234, 10402.739931501621, 10407.58369665205, 10416.791664166674, 10558.208134389952, 8255.42212045163, 8451.830963380698, 8456.11210822867, 8462.534560599226, 8468.44955077918, 5633.295838020247, 5847.619904706181, 5868.706564671835, 5965.343812180743, 6056.9697151513965, 10080.445575493419, 10116.190704743456, 10288.12550933179, 10295.588176472857, 10302.896971030194, 10508.054275115277, 10545.736356591147, 10578.259521833397, 10613.09788667972, 10691.786164276826, 7156.427485801019, 7263.295709269793, 7337.119545654342, 7835.3731701464885, 7943.324817390587, 7984.6406911687955, 8474.110218426977, 8580.14198580162, 8747.125287471203, 8749.518776467356, 7527.8118047049265, 7612.467127301035, 7774.378049756119, 7801.258880406353, 7819.569923654253, 7447.739329123455, 7474.439417043634, 7502.399808015237, 7545.962270188614, 7619.428542859197, 6845.863082738417, 6948.235694073749, 6950.33971772701, 6950.54821436605, 6956.443484521327, 4922.1632322505975, 5021.949780502148, 5049.31834202378, 5062.468440813662, 5116.923246151385, 4906.754662266943, 4946.777395017305, 4978.327925730125, 5134.717590532557, 5376.73116344189], "value": 4465.41281240686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.41518775078333, 315.903649386937, 321.5129079444642, 323.36136131140984, 323.80733463589155, 5263.34208223972, 5271.868203294919, 5325.893482130355, 5328.6269961102735, 5347.946520534799, 4986.476419975905, 5016.0, 5118.698439506526, 5187.6887386756825, 5216.0, 4074.348104303312, 4091.0999580092334, 4112.876613701594, 4139.5446500884955, 4147.979260103695, 4132.628063474287, 4141.772202528859, 4153.54311025787, 4154.875353739392, 4179.1223842993, 3895.376739721645, 3942.3100957332495, 4088.0597462583623, 4122.6083522065355, 4132.5454200037975, 4033.9596604033877, 4061.959380406188, 4105.486814148231, 4116.217918595472, 4140.855070072548, 3615.94576081359, 3638.289474341606, 3644.125409901631, 3663.4504824276305, 3685.244524872395, 5051.3433253676785, 5128.461511541309, 5161.483851614846, 5182.714950677711, 5214.400343960418, 4712.505186955389, 4726.125666751662, 4731.266653668687, 4739.976300118512, 4751.239801631757, 5418.322709661293, 5436.157395603688, 5486.1222204447495, 5487.835364939058, 5489.286392768954, 3867.7485963412287, 3935.330993731073, 3938.741754847442, 3980.44273801668, 4002.4996875390575, 5629.915551266734, 5647.830565083054, 5654.5193658538665, 5656.773729050833, 5663.66018038919, 4065.97967010169, 4078.4290199372113, 4083.5508094109623, 4084.2648323301496, 4096.32410652245, 3850.614938506127, 4141.8964525887095, 4152.152292229989, 4159.939215500028, 4168.562300958416, 4610.0, 4613.146567884952, 4633.2818413146015, 4662.160811053975, 4673.275642275453, 5441.945580544223, 5465.480779325958, 5472.890542189134, 5474.3704473986, 5493.615446918758, 1353.7157196988742, 1395.2884029145007, 1409.3869166912425, 1416.2423103639503, 1418.4964337660188, 884.7478468636536, 897.9057198994142, 906.7733066733317, 913.4610579757842, 920.8342498350228, 4747.786349614275, 4763.476017638057, 4787.3987434701485, 4794.640401969797, 4807.4471435785335, 4644.86065418038, 4989.975050124799, 5076.289319495274, 5076.42630784458, 5096.898062038813, 4715.133590455794, 4735.59747421473, 4749.833755818529, 4760.523947605212, 4772.041334372641, 2655.7211492793367, 2658.481596088744, 2658.5613373793494, 2664.5603475426337, 2685.1675980446125, 5131.974340128276, 5199.350081239845, 5218.295530103387, 5246.580273578104, 5549.0, 5800.274965629296, 5809.128630705428, 5811.738471768781, 5814.854628634318, 5829.387914269026, 5838.357780644125, 5878.853028674317, 5899.321578018583, 5995.730192141364, 5997.460228579362, 5523.447655234605, 5668.837888232985, 5702.203805801159, 5706.600537962303, 5739.139129130664, 5575.804846830341, 5584.46947539983, 5614.606977511535, 5646.644805246793, 5651.971740141273, 5647.108218746602, 5874.559408044328, 5877.794277200277, 5926.0, 5963.4334738199805, 3952.150287688161, 3972.7684417830565, 3985.083430810988, 3994.680425566006, 3996.2407142642805, 5432.837014889559, 5553.500184983371, 5577.0797818359515, 5585.860353491195, 5714.171445140514, 5370.543503802064, 5459.69971651563, 5484.341878974548, 5488.1614659089655, 5512.448755124456, 5352.250684904195, 5506.476884696108, 5509.944900551103, 5545.584081193846, 5549.250851135045, 5417.941182350682, 5435.239066530768, 5482.725863706719, 5494.2582751328055, 5497.532709719719, 5581.7767289309595, 5614.7192640367, 5624.437556244343, 5681.204631351697, 5685.545156387397, 5182.585393168612, 5427.674339539641, 5442.265294185234, 5483.396826349019, 5522.86192845166], "value": 4138.501834286941, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.2860211293993, 750.9061367329084, 777.194328474208, 788.3023524181098, 844.3582877013467, 14890.478833240839, 15749.448769293078, 15754.606134846634, 15790.526284211477, 15808.0, 15118.0, 15210.771838422404, 15219.46731864385, 15231.54305370838, 15232.314545845436, 662.903878937555, 798.3533337996213, 814.771863878115, 821.1788211788212, 832.7376876283981, 825.0759149752286, 829.2868133405267, 831.7546323834483, 831.9334453243725, 834.1241696218976, 870.8301881133182, 873.5937788928147, 873.9868901966476, 874.0298268921492, 874.3092956564307, 694.989575156373, 836.7071524966274, 853.799357151069, 858.935579831512, 869.070094998352, 628.1551313483403, 628.8899442597573, 629.1129507394597, 629.3832044596276, 629.5561629051554, 14779.704405911822, 14799.482018129422, 14868.330925108396, 14898.627534311621, 14964.551063468114, 14553.054051486619, 14729.484468043567, 14805.407783688639, 14921.626959325995, 14960.401583936738, 13306.268155251457, 13353.799693004612, 13488.325583720873, 13493.325333733274, 13694.52069177584, 4433.2685106957315, 4511.684182107254, 4515.503294637587, 4516.16450956574, 4619.284010978304, 84778.57610711906, 88761.66857497208, 90016.54991725065, 90563.54718226366, 92202.53898730464, 11501.654950351503, 11536.0, 11743.588974385855, 11880.287182769061, 12250.264984100982, 21136.0, 21241.68137477939, 21333.46666333354, 21377.0, 21397.0, 8277.420580559303, 8286.792830179173, 8414.957925210458, 8439.451435656663, 8649.308055355556, 4660.884726067785, 4755.167845627001, 4781.856544303607, 4860.659753817269, 4896.706197628154, 3459.619441861393, 3604.6575575320303, 3608.9458658120147, 3614.493970844084, 3841.8463261469788, 628.9496840252768, 644.8549076457759, 649.6686689788243, 651.9608823470512, 696.8571442854203, 691.5366704308126, 698.1464212515779, 726.8800647893144, 729.7628270811902, 741.2476336518438, 9517.476538790295, 9814.901850981541, 10095.444750538643, 10280.177585793119, 10295.330803497749, 592.2448877680991, 631.2677294338545, 640.5708175522411, 646.9353064693587, 680.6269717067918, 4776.522347765195, 4933.827316043921, 4976.676516026447, 4987.900241995139, 5003.174476211457, 124665.0, 126013.0, 127547.0, 133590.0, 136109.3194534021, 64617.67691161608, 65920.0, 67536.0, 91704.6244306336, 105199.0, 59879.401205987386, 60047.39952600506, 78457.60771196222, 94703.52648236853, 96874.51562742282, 9096.771633232378, 9144.679936202201, 9337.953310233406, 9451.480168590793, 9570.103149319655, 55105.0, 55459.0, 55474.0, 55805.44194558002, 56012.159817603584, 69349.0, 77991.61004194943, 84723.5763821177, 85614.57192713997, 85983.5700821517, 12815.387591324248, 13014.804777928528, 13355.332233388486, 13440.0, 13566.59300220995, 15022.399104035716, 15103.0, 15111.244437778287, 15624.453144139901, 15982.360705571647, 12473.313967731861, 12794.168379055332, 12800.231986080866, 13240.404181812035, 13342.599722008355, 13248.375812093953, 13737.656558586115, 13877.722445551235, 14552.345144468736, 14720.705585888436, 13336.599902002956, 13497.527586534425, 13556.322183890568, 13754.0, 13816.0, 11479.196456248317, 11592.594259200887, 11636.185467017565, 11670.533178673099, 12266.693332666755, 11330.0, 11385.772284554097, 11412.82880756806, 11495.942520287344, 11920.582779602672], "value": 7696.357400516152, "unit": "score"}], "name": "dromaeo_css", "value": 7218.487886563383, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 112.0, 111.0, 111.0, 110.0, 113.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 118.0, 181.0, 119.0, 120.0, 146.0, 119.0, 152.0, 115.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 115.0, 75.0, 75.0, 75.0, 74.0, 108.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 116.0, 85.0, 84.0, 83.0, 122.0, 84.0, 83.0, 130.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 52.0, 53.0, 51.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 62.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 74.0, 75.0, 74.0, 76.0, 75.0, 74.0, 75.0, 85.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 122.0, 120.0, 138.0, 118.0, 127.0, 131.0, 173.0, 124.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 157.0, 162.0, 159.0, 156.0, 156.0, 161.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 63.0, 62.0, 62.0, 68.0, 61.0, 63.0, 60.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1482.1000000000001, "alertThreshold": 2.0}]} 06:15:36 INFO - Return code: 0 06:15:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:36 INFO - # TBPL SUCCESS # 06:15:36 INFO - Running post-action listener: _resource_record_post_action 06:15:36 INFO - [mozharness: 2016-08-02 13:15:36.112112Z] Finished run-tests step (success) 06:15:36 INFO - Running post-run listener: _resource_record_post_run 06:15:36 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538828800; Read time: 184; Write time: 432896 06:15:36 INFO - TinderboxPrint: CPU usage
13.0% 06:15:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 06:15:36 INFO - TinderboxPrint: I/O write bytes / time
538,828,800 / 432,896 06:15:36 INFO - TinderboxPrint: CPU idle
8,276.8 (87.0%) 06:15:36 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 06:15:36 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247521280; Read time: 0; Write time: 241760 06:15:36 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290824192; Read time: 168; Write time: 191072 06:15:36 INFO - Running post-run listener: _upload_blobber_files 06:15:36 INFO - Blob upload gear active. 06:15:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:36 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 06:15:36 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:36 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:37 INFO - (blobuploader) - INFO - Done attempting. 06:15:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:41 INFO - (blobuploader) - INFO - Done attempting. 06:15:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:42 INFO - (blobuploader) - INFO - Done attempting. 06:15:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:42 INFO - Return code: 0 06:15:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/724a1ae166bfcf13f1c49c2aa7fa01e457b7b5206eaca726aa2b7877e0340da0a6d6ada7473a7f2e533d91557c088a79d89baf81362d7fc151100865f442c03d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26df2b0d2074c3233b879d8b8a5ee37cf25105bbd3a735326ba619587a8894e4d9101fd007903f99daaac1af57755ada01195c9f669673834c51b15eec4ba5a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0abb202efbeb5c9bde8f7f8ab3386af15158ff98c2ee9e8a03923917239ede56b12ce5c6d78abbb0aabae1020ab2836b61e6568c9517185c4278a23171212e2b"} 06:15:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:42 INFO - Contents: 06:15:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/724a1ae166bfcf13f1c49c2aa7fa01e457b7b5206eaca726aa2b7877e0340da0a6d6ada7473a7f2e533d91557c088a79d89baf81362d7fc151100865f442c03d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26df2b0d2074c3233b879d8b8a5ee37cf25105bbd3a735326ba619587a8894e4d9101fd007903f99daaac1af57755ada01195c9f669673834c51b15eec4ba5a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0abb202efbeb5c9bde8f7f8ab3386af15158ff98c2ee9e8a03923917239ede56b12ce5c6d78abbb0aabae1020ab2836b61e6568c9517185c4278a23171212e2b"} 06:15:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:42 INFO - Copying logs to upload dir... 06:15:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.101822 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-02 06:15:41.913657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 06:15:41.916711) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/724a1ae166bfcf13f1c49c2aa7fa01e457b7b5206eaca726aa2b7877e0340da0a6d6ada7473a7f2e533d91557c088a79d89baf81362d7fc151100865f442c03d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26df2b0d2074c3233b879d8b8a5ee37cf25105bbd3a735326ba619587a8894e4d9101fd007903f99daaac1af57755ada01195c9f669673834c51b15eec4ba5a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0abb202efbeb5c9bde8f7f8ab3386af15158ff98c2ee9e8a03923917239ede56b12ce5c6d78abbb0aabae1020ab2836b61e6568c9517185c4278a23171212e2b"} build_url:https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/fBJhWoKmSpiNYhDQt8WmsA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/724a1ae166bfcf13f1c49c2aa7fa01e457b7b5206eaca726aa2b7877e0340da0a6d6ada7473a7f2e533d91557c088a79d89baf81362d7fc151100865f442c03d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26df2b0d2074c3233b879d8b8a5ee37cf25105bbd3a735326ba619587a8894e4d9101fd007903f99daaac1af57755ada01195c9f669673834c51b15eec4ba5a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0abb202efbeb5c9bde8f7f8ab3386af15158ff98c2ee9e8a03923917239ede56b12ce5c6d78abbb0aabae1020ab2836b61e6568c9517185c4278a23171212e2b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 06:15:41.941083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 06:15:41.941380) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470142036.910633-2142935206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 06:15:42.023770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 06:15:42.024057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 06:15:42.024327) ========= ========= Total master_lag: 0.17 =========