builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1470140276.85 results: success (0) buildid: 20160802023001 builduid: 0a47c78022ac422d9749978ea3b47f9b revision: 46045ec8a4aa09a341b7209170089ade3c27c1a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:56.850031) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:56.850623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:56.850896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:56.876853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:56.877105) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 05:17: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% 219M=0s 2016-08-02 05:17:57 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124009 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:57.023597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:57.023880) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020067 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:57.100617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 05:17:57.100917) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46045ec8a4aa09a341b7209170089ade3c27c1a5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46045ec8a4aa09a341b7209170089ade3c27c1a5 --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=934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 05:17:57,282 truncating revision to first 12 chars 2016-08-02 05:17:57,282 Setting DEBUG logging. 2016-08-02 05:17:57,282 attempt 1/10 2016-08-02 05:17:57,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46045ec8a4aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 05:17:58,316 unpacking tar archive at: fx-team-46045ec8a4aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-02 05:17:58.471390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:58.471714) ========= script_repo_revision: 46045ec8a4aa09a341b7209170089ade3c27c1a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:58.472123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:58.472415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 05:17:58.483509) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-02 05:17:58.483818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:58 INFO - MultiFileLogger online at 20160802 05:17:58 in /builds/slave/test 05:17:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:17:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:58 INFO - {'append_to_log': False, 05:17:58 INFO - 'base_work_dir': '/builds/slave/test', 05:17:58 INFO - 'blob_upload_branch': 'Fx-Team', 05:17:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:58 INFO - 'branch': 'Fx-Team', 05:17:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:58 INFO - 'config_files': ('talos/linux_config.py',), 05:17:58 INFO - 'default_actions': ('clobber', 05:17:58 INFO - 'read-buildbot-config', 05:17:58 INFO - 'download-and-extract', 05:17:58 INFO - 'populate-webroot', 05:17:58 INFO - 'create-virtualenv', 05:17:58 INFO - 'install', 05:17:58 INFO - 'run-tests'), 05:17:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:58 INFO - 'download_minidump_stackwalk': True, 05:17:58 INFO - 'download_symbols': 'ondemand', 05:17:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:58 INFO - 'installer_path': 'installer.exe', 05:17:58 INFO - 'log_level': 'info', 05:17:58 INFO - 'log_name': 'talos', 05:17:58 INFO - 'log_to_console': True, 05:17:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:58 INFO - 'opt_config_files': (), 05:17:58 INFO - 'pip_index': False, 05:17:58 INFO - 'sps_profile': False, 05:17:58 INFO - 'sps_profile_interval': 0, 05:17:58 INFO - 'suite': 'dromaeojs', 05:17:58 INFO - 'system_bits': '32', 05:17:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:58 INFO - 'title': 'talos-linux64-ix-057', 05:17:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:58 INFO - 'use_talos_json': True, 05:17:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:58 INFO - 'work_dir': 'build'} 05:17:58 INFO - [mozharness: 2016-08-02 12:17:58.770205Z] Running clobber step. 05:17:58 INFO - Running pre-action listener: _resource_record_pre_action 05:17:58 INFO - Running main action method: clobber 05:17:58 INFO - rmtree: /builds/slave/test/build 05:17:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:59 INFO - Running post-action listener: _resource_record_post_action 05:17:59 INFO - [mozharness: 2016-08-02 12:17:59.226029Z] Finished clobber step (success) 05:17:59 INFO - [mozharness: 2016-08-02 12:17:59.226132Z] Running read-buildbot-config step. 05:17:59 INFO - Running pre-action listener: _resource_record_pre_action 05:17:59 INFO - Running main action method: read_buildbot_config 05:17:59 INFO - Using buildbot properties: 05:17:59 INFO - { 05:17:59 INFO - "project": "", 05:17:59 INFO - "product": "firefox", 05:17:59 INFO - "script_repo_revision": "production", 05:17:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:17:59 INFO - "repository": "", 05:17:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:17:59 INFO - "buildid": "20160802023001", 05:17:59 INFO - "pgo_build": "True", 05:17:59 INFO - "basedir": "/builds/slave/test", 05:17:59 INFO - "buildnumber": 1408, 05:17:59 INFO - "slavename": "talos-linux64-ix-057", 05:17:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:17:59 INFO - "platform": "ubuntu64_hw", 05:17:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:17:59 INFO - "branch": "fx-team", 05:17:59 INFO - "repo_path": "integration/fx-team", 05:17:59 INFO - "revision": "46045ec8a4aa09a341b7209170089ade3c27c1a5", 05:17:59 INFO - "stage_platform": "linux64-pgo", 05:17:59 INFO - "builduid": "0a47c78022ac422d9749978ea3b47f9b", 05:17:59 INFO - "slavebuilddir": "test" 05:17:59 INFO - } 05:17:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:17:59 INFO - Running post-action listener: _resource_record_post_action 05:17:59 INFO - [mozharness: 2016-08-02 12:17:59.228578Z] Finished read-buildbot-config step (success) 05:17:59 INFO - [mozharness: 2016-08-02 12:17:59.228667Z] Running download-and-extract step. 05:17:59 INFO - Running pre-action listener: _resource_record_pre_action 05:17:59 INFO - Running main action method: download_and_extract 05:17:59 INFO - mkdir: /builds/slave/test/build/tests 05:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:59 INFO - https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:02 INFO - Downloaded 1361 bytes. 05:18:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:18:02 INFO - Using the following test package requirements: 05:18:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:18:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'jsshell-linux-x86_64.zip'], 05:18:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:18:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:18:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:02 INFO - https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:18:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:18:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:03 INFO - Downloaded 21809159 bytes. 05:18:03 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:18:03 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:18:04 INFO - Return code: 0 05:18:04 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:18:04 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:18:04 INFO - https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:07 INFO - Downloaded 21809159 bytes. 05:18:07 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:18:07 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:18:08 INFO - Return code: 0 05:18:08 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:18:08 INFO - https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:10 INFO - Downloaded 14413723 bytes. 05:18:10 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:18:10 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:18:10 INFO - Return code: 0 05:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:10 INFO - https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:18:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:18:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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:18:13 INFO - Downloaded 59388049 bytes. 05:18:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:18:13 INFO - mkdir: /builds/slave/test/properties 05:18:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:13 INFO - Contents: 05:18:13 INFO - build_url:https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:18:14 INFO - Running post-action listener: _resource_record_post_action 05:18:14 INFO - Running post-action listener: set_extra_try_arguments 05:18:14 INFO - [mozharness: 2016-08-02 12:18:14.314528Z] Finished download-and-extract step (success) 05:18:14 INFO - [mozharness: 2016-08-02 12:18:14.314761Z] Running populate-webroot step. 05:18:14 INFO - Running pre-action listener: _resource_record_pre_action 05:18:14 INFO - Running main action method: populate_webroot 05:18:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:14 INFO - '--tppagecycles', 05:18:14 INFO - '7'], 05:18:14 INFO - 'tests': ['tsvgm']}}, 05:18:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['damp', 'tps']}, 05:18:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'tests': ['damp', 'tps']}, 05:18:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['dromaeo_dom']}, 05:18:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['basic_compositor_video']}, 05:18:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:18:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['a11yr', 05:18:14 INFO - 'ts_paint', 05:18:14 INFO - 'tpaint', 05:18:14 INFO - 'sessionrestore', 05:18:14 INFO - 'sessionrestore_no_auto_restore', 05:18:14 INFO - 'tabpaint']}, 05:18:14 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:14 INFO - 'ts_paint', 05:18:14 INFO - 'tpaint', 05:18:14 INFO - 'sessionrestore', 05:18:14 INFO - 'sessionrestore_no_auto_restore', 05:18:14 INFO - 'tabpaint']}, 05:18:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:14 INFO - 'ts_paint', 05:18:14 INFO - 'tpaint', 05:18:14 INFO - 'sessionrestore', 05:18:14 INFO - 'sessionrestore_no_auto_restore', 05:18:14 INFO - 'tabpaint']}, 05:18:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:14 INFO - 'ts_paint', 05:18:14 INFO - 'tpaint', 05:18:14 INFO - 'sessionrestore', 05:18:14 INFO - 'sessionrestore_no_auto_restore', 05:18:14 INFO - 'tabpaint']}, 05:18:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['a11yr', 05:18:14 INFO - 'ts_paint', 05:18:14 INFO - 'tpaint', 05:18:14 INFO - 'sessionrestore', 05:18:14 INFO - 'sessionrestore_no_auto_restore', 05:18:14 INFO - 'tabpaint']}, 05:18:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['a11yr', 05:18:14 INFO - 'ts_paint', 05:18:14 INFO - 'tpaint', 05:18:14 INFO - 'sessionrestore', 05:18:14 INFO - 'sessionrestore_no_auto_restore', 05:18:14 INFO - 'tabpaint']}, 05:18:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['tsvgx', 05:18:14 INFO - 'tsvgr_opacity', 05:18:14 INFO - 'tart', 05:18:14 INFO - 'tscrollx', 05:18:14 INFO - 'cart']}, 05:18:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:14 INFO - 'tsvgr_opacity', 05:18:14 INFO - 'tart', 05:18:14 INFO - 'tscrollx', 05:18:14 INFO - 'cart']}, 05:18:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'talos_options': ['--disable-e10s'], 05:18:14 INFO - 'tests': ['tp5o']}, 05:18:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'tests': ['tp5o']}, 05:18:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'talos_options': ['--disable-e10s', 05:18:14 INFO - '--xperf_path', 05:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:14 INFO - 'tests': ['tp5n']}, 05:18:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:14 INFO - 'talos_options': ['--xperf_path', 05:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:14 INFO - 'tests': ['tp5n']}}, 05:18:14 INFO - 'talos.zip': {'path': '', 05:18:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:14 INFO - Running post-action listener: _resource_record_post_action 05:18:14 INFO - [mozharness: 2016-08-02 12:18:14.332220Z] Finished populate-webroot step (success) 05:18:14 INFO - [mozharness: 2016-08-02 12:18:14.332309Z] Running create-virtualenv step. 05:18:14 INFO - Running pre-action listener: _resource_record_pre_action 05:18:14 INFO - Running main action method: create_virtualenv 05:18:14 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:14 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:18:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:14 INFO - Using real prefix '/usr' 05:18:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:16 INFO - Installing pip.................done. 05:18:16 INFO - Return code: 0 05:18:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:18:16 INFO - Using env: {'DISPLAY': ':0', 05:18:16 INFO - 'HOME': '/home/cltbld', 05:18:16 INFO - 'LANG': 'en_US.UTF-8', 05:18:16 INFO - 'LANGUAGE': 'en_US:en', 05:18:16 INFO - 'LOGNAME': 'cltbld', 05:18:16 INFO - 'MAIL': '/var/mail/cltbld', 05:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:16 INFO - 'MOZ_NO_REMOTE': '1', 05:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:16 INFO - 'NO_EM_RESTART': '1', 05:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:16 INFO - 'PWD': '/builds/slave/test', 05:18:16 INFO - 'SHELL': '/bin/bash', 05:18:16 INFO - 'SHLVL': '1', 05:18:16 INFO - 'TERM': 'linux', 05:18:16 INFO - 'TMOUT': '86400', 05:18:16 INFO - 'USER': 'cltbld', 05:18:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:16 INFO - '_': '/tools/buildbot/bin/python'} 05:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:17 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:18:17 INFO - Cleaning up... 05:18:17 INFO - Return code: 0 05:18:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:18: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:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:17 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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:17 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:18:17 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:18:17 INFO - Using env: {'DISPLAY': ':0', 05:18:17 INFO - 'HOME': '/home/cltbld', 05:18:17 INFO - 'LANG': 'en_US.UTF-8', 05:18:17 INFO - 'LANGUAGE': 'en_US:en', 05:18:17 INFO - 'LOGNAME': 'cltbld', 05:18:17 INFO - 'MAIL': '/var/mail/cltbld', 05:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:17 INFO - 'MOZ_NO_REMOTE': '1', 05:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:17 INFO - 'NO_EM_RESTART': '1', 05:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:17 INFO - 'PWD': '/builds/slave/test', 05:18:17 INFO - 'SHELL': '/bin/bash', 05:18:17 INFO - 'SHLVL': '1', 05:18:17 INFO - 'TERM': 'linux', 05:18:17 INFO - 'TMOUT': '86400', 05:18:17 INFO - 'USER': 'cltbld', 05:18:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:17 INFO - '_': '/tools/buildbot/bin/python'} 05:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:17 INFO - Downloading/unpacking psutil>=3.1.1 05:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:17 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:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:19 INFO - Installing collected packages: psutil 05:18:19 INFO - Running setup.py install for psutil 05:18:19 INFO - building 'psutil._psutil_linux' extension 05:18:19 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:18:19 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:18:19 INFO - building 'psutil._psutil_posix' extension 05:18:19 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:18:19 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:18:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:19 INFO - Successfully installed psutil 05:18:19 INFO - Cleaning up... 05:18:19 INFO - Return code: 0 05:18:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:18: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:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:18:19 INFO - Using env: {'DISPLAY': ':0', 05:18:19 INFO - 'HOME': '/home/cltbld', 05:18:19 INFO - 'LANG': 'en_US.UTF-8', 05:18:19 INFO - 'LANGUAGE': 'en_US:en', 05:18:19 INFO - 'LOGNAME': 'cltbld', 05:18:19 INFO - 'MAIL': '/var/mail/cltbld', 05:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:19 INFO - 'MOZ_NO_REMOTE': '1', 05:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:19 INFO - 'NO_EM_RESTART': '1', 05:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:19 INFO - 'PWD': '/builds/slave/test', 05:18:19 INFO - 'SHELL': '/bin/bash', 05:18:19 INFO - 'SHLVL': '1', 05:18:19 INFO - 'TERM': 'linux', 05:18:19 INFO - 'TMOUT': '86400', 05:18:19 INFO - 'USER': 'cltbld', 05:18:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:19 INFO - '_': '/tools/buildbot/bin/python'} 05:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:18:22 INFO - Installing collected packages: mozsystemmonitor 05:18:22 INFO - Running setup.py install for mozsystemmonitor 05:18:22 INFO - Successfully installed mozsystemmonitor 05:18:22 INFO - Cleaning up... 05:18:22 INFO - Return code: 0 05:18:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:18:22 INFO - Using env: {'DISPLAY': ':0', 05:18:22 INFO - 'HOME': '/home/cltbld', 05:18:22 INFO - 'LANG': 'en_US.UTF-8', 05:18:22 INFO - 'LANGUAGE': 'en_US:en', 05:18:22 INFO - 'LOGNAME': 'cltbld', 05:18:22 INFO - 'MAIL': '/var/mail/cltbld', 05:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:22 INFO - 'MOZ_NO_REMOTE': '1', 05:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:22 INFO - 'NO_EM_RESTART': '1', 05:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:22 INFO - 'PWD': '/builds/slave/test', 05:18:22 INFO - 'SHELL': '/bin/bash', 05:18:22 INFO - 'SHLVL': '1', 05:18:22 INFO - 'TERM': 'linux', 05:18:22 INFO - 'TMOUT': '86400', 05:18:22 INFO - 'USER': 'cltbld', 05:18:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:22 INFO - '_': '/tools/buildbot/bin/python'} 05:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:22 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:18:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:24 INFO - warning: no files found matching '*.txt' 05:18:24 INFO - no previously-included directories found matching 'build' 05:18:24 INFO - no previously-included directories found matching 'dist' 05:18:24 INFO - no previously-included directories found matching '.git*' 05:18:24 INFO - Installing collected packages: jsonschema, functools32 05:18:24 INFO - Running setup.py install for functools32 05:18:24 INFO - warning: no files found matching '*.txt' 05:18:24 INFO - no previously-included directories found matching 'build' 05:18:24 INFO - no previously-included directories found matching 'dist' 05:18:24 INFO - no previously-included directories found matching '.git*' 05:18:24 INFO - Successfully installed jsonschema functools32 05:18:24 INFO - Cleaning up... 05:18:24 INFO - Return code: 0 05:18:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:18: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:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', '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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:18: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 functools32==3.2.3-2 05:18:24 INFO - Using env: {'DISPLAY': ':0', 05:18:24 INFO - 'HOME': '/home/cltbld', 05:18:24 INFO - 'LANG': 'en_US.UTF-8', 05:18:24 INFO - 'LANGUAGE': 'en_US:en', 05:18:24 INFO - 'LOGNAME': 'cltbld', 05:18:24 INFO - 'MAIL': '/var/mail/cltbld', 05:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:24 INFO - 'MOZ_NO_REMOTE': '1', 05:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:24 INFO - 'NO_EM_RESTART': '1', 05:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:24 INFO - 'PWD': '/builds/slave/test', 05:18:24 INFO - 'SHELL': '/bin/bash', 05:18:24 INFO - 'SHLVL': '1', 05:18:24 INFO - 'TERM': 'linux', 05:18:24 INFO - 'TMOUT': '86400', 05:18:24 INFO - 'USER': 'cltbld', 05:18:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:24 INFO - '_': '/tools/buildbot/bin/python'} 05:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:18:24 INFO - Cleaning up... 05:18:24 INFO - Return code: 0 05:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18: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:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', '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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:18: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 blobuploader==1.2.4 05:18:24 INFO - Using env: {'DISPLAY': ':0', 05:18:24 INFO - 'HOME': '/home/cltbld', 05:18:24 INFO - 'LANG': 'en_US.UTF-8', 05:18:24 INFO - 'LANGUAGE': 'en_US:en', 05:18:24 INFO - 'LOGNAME': 'cltbld', 05:18:24 INFO - 'MAIL': '/var/mail/cltbld', 05:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:24 INFO - 'MOZ_NO_REMOTE': '1', 05:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:24 INFO - 'NO_EM_RESTART': '1', 05:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:24 INFO - 'PWD': '/builds/slave/test', 05:18:24 INFO - 'SHELL': '/bin/bash', 05:18:24 INFO - 'SHLVL': '1', 05:18:24 INFO - 'TERM': 'linux', 05:18:24 INFO - 'TMOUT': '86400', 05:18:24 INFO - 'USER': 'cltbld', 05:18:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:24 INFO - '_': '/tools/buildbot/bin/python'} 05:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18: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:18: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:18: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:18: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:18: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:18: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:18:27 INFO - Downloading docopt-0.6.1.tar.gz 05:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:27 INFO - Running setup.py install for blobuploader 05:18:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:27 INFO - Running setup.py install for requests 05:18:28 INFO - Running setup.py install for docopt 05:18:28 INFO - Successfully installed blobuploader requests docopt 05:18:28 INFO - Cleaning up... 05:18:28 INFO - Return code: 0 05:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:28 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:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:28 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:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:28 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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:28 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:18:28 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:18:28 INFO - Using env: {'DISPLAY': ':0', 05:18:28 INFO - 'HOME': '/home/cltbld', 05:18:28 INFO - 'LANG': 'en_US.UTF-8', 05:18:28 INFO - 'LANGUAGE': 'en_US:en', 05:18:28 INFO - 'LOGNAME': 'cltbld', 05:18:28 INFO - 'MAIL': '/var/mail/cltbld', 05:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:28 INFO - 'MOZ_NO_REMOTE': '1', 05:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:28 INFO - 'NO_EM_RESTART': '1', 05:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:28 INFO - 'PWD': '/builds/slave/test', 05:18:28 INFO - 'SHELL': '/bin/bash', 05:18:28 INFO - 'SHLVL': '1', 05:18:28 INFO - 'TERM': 'linux', 05:18:28 INFO - 'TMOUT': '86400', 05:18:28 INFO - 'USER': 'cltbld', 05:18:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:28 INFO - '_': '/tools/buildbot/bin/python'} 05:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:28 INFO - Running setup.py (path:/tmp/pip-pL64nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:28 INFO - Running setup.py (path:/tmp/pip-NNuZN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:28 INFO - Running setup.py (path:/tmp/pip-DuqWyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:28 INFO - Running setup.py (path:/tmp/pip-qBxm18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:28 INFO - Running setup.py (path:/tmp/pip-QRWTrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:29 INFO - Running setup.py (path:/tmp/pip-AXm0EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:29 INFO - Running setup.py (path:/tmp/pip-4LLS9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:29 INFO - Running setup.py (path:/tmp/pip-UoHO5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:29 INFO - Running setup.py (path:/tmp/pip-17TrNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:29 INFO - Running setup.py (path:/tmp/pip-saThM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:29 INFO - Running setup.py (path:/tmp/pip-iZHgZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:29 INFO - Running setup.py (path:/tmp/pip-dfDP3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:29 INFO - Running setup.py (path:/tmp/pip-zrDu4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:29 INFO - Running setup.py (path:/tmp/pip-PvYuy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:29 INFO - Running setup.py (path:/tmp/pip-KDOXHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:29 INFO - Running setup.py (path:/tmp/pip-nCYslO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:29 INFO - Running setup.py (path:/tmp/pip-EQgwpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:29 INFO - Running setup.py install for manifestparser 05:18:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Running setup.py install for mozcrash 05:18:30 INFO - Running setup.py install for mozdebug 05:18:30 INFO - Running setup.py install for mozdevice 05:18:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Running setup.py install for mozfile 05:18:30 INFO - Running setup.py install for mozhttpd 05:18:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Running setup.py install for mozinfo 05:18:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Running setup.py install for mozInstall 05:18:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Running setup.py install for mozleak 05:18:30 INFO - Running setup.py install for mozlog 05:18:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:30 INFO - Running setup.py install for moznetwork 05:18:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:31 INFO - Running setup.py install for mozprocess 05:18:31 INFO - Running setup.py install for mozprofile 05:18:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:31 INFO - Running setup.py install for mozrunner 05:18:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:31 INFO - Running setup.py install for mozscreenshot 05:18:31 INFO - Running setup.py install for moztest 05:18:31 INFO - Running setup.py install for mozversion 05:18:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:31 INFO - Cleaning up... 05:18:31 INFO - Return code: 0 05:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:31 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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:31 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:18:31 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:18:31 INFO - Using env: {'DISPLAY': ':0', 05:18:31 INFO - 'HOME': '/home/cltbld', 05:18:31 INFO - 'LANG': 'en_US.UTF-8', 05:18:31 INFO - 'LANGUAGE': 'en_US:en', 05:18:31 INFO - 'LOGNAME': 'cltbld', 05:18:31 INFO - 'MAIL': '/var/mail/cltbld', 05:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:31 INFO - 'MOZ_NO_REMOTE': '1', 05:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:31 INFO - 'NO_EM_RESTART': '1', 05:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:31 INFO - 'PWD': '/builds/slave/test', 05:18:31 INFO - 'SHELL': '/bin/bash', 05:18:31 INFO - 'SHLVL': '1', 05:18:31 INFO - 'TERM': 'linux', 05:18:31 INFO - 'TMOUT': '86400', 05:18:31 INFO - 'USER': 'cltbld', 05:18:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:31 INFO - '_': '/tools/buildbot/bin/python'} 05:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:31 INFO - Running setup.py (path:/tmp/pip-c0Odru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:31 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:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:31 INFO - Running setup.py (path:/tmp/pip-iToOUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:32 INFO - Running setup.py (path:/tmp/pip-uRCLFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:32 INFO - Running setup.py (path:/tmp/pip-50SyCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:32 INFO - Running setup.py (path:/tmp/pip-pUtDby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:32 INFO - Running setup.py (path:/tmp/pip-8rQOgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:32 INFO - Running setup.py (path:/tmp/pip-dPuw34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:32 INFO - Running setup.py (path:/tmp/pip-l7Lv0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:32 INFO - Running setup.py (path:/tmp/pip-iPzcfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:32 INFO - Running setup.py (path:/tmp/pip-MGDk6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:32 INFO - Running setup.py (path:/tmp/pip-v0uGds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:32 INFO - Running setup.py (path:/tmp/pip-nEesdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:32 INFO - Running setup.py (path:/tmp/pip-Zfok6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:32 INFO - Running setup.py (path:/tmp/pip-uWvBTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:32 INFO - Running setup.py (path:/tmp/pip-Fo92Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:33 INFO - Running setup.py (path:/tmp/pip-Z77FVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:33 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:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:33 INFO - Running setup.py (path:/tmp/pip-MgqYHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:35 INFO - Downloading blessings-1.6.tar.gz 05:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:35 INFO - Installing collected packages: blessings 05:18:35 INFO - Running setup.py install for blessings 05:18:35 INFO - Successfully installed blessings 05:18:35 INFO - Cleaning up... 05:18:35 INFO - Return code: 0 05:18:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:35 INFO - Reading from file tmpfile_stdout 05:18:35 INFO - Current package versions: 05:18:35 INFO - argparse == 1.2.1 05:18:35 INFO - blessings == 1.6 05:18:35 INFO - blobuploader == 1.2.4 05:18:35 INFO - docopt == 0.6.1 05:18:35 INFO - functools32 == 3.2.3-2 05:18:35 INFO - jsonschema == 2.5.1 05:18:35 INFO - manifestparser == 1.1 05:18:35 INFO - mozInstall == 1.12 05:18:35 INFO - mozcrash == 0.17 05:18:35 INFO - mozdebug == 0.1 05:18:35 INFO - mozdevice == 0.48 05:18:35 INFO - mozfile == 1.2 05:18:35 INFO - mozhttpd == 0.7 05:18:35 INFO - mozinfo == 0.9 05:18:35 INFO - mozleak == 0.1 05:18:35 INFO - mozlog == 3.3 05:18:35 INFO - moznetwork == 0.27 05:18:35 INFO - mozprocess == 0.23 05:18:35 INFO - mozprofile == 0.28 05:18:35 INFO - mozrunner == 6.12 05:18:35 INFO - mozscreenshot == 0.1 05:18:35 INFO - mozsystemmonitor == 0.3 05:18:35 INFO - moztest == 0.7 05:18:35 INFO - mozversion == 1.4 05:18:35 INFO - psutil == 3.1.1 05:18:35 INFO - requests == 1.2.3 05:18:35 INFO - wsgiref == 0.1.2 05:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:35 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:18:35 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:18:35 INFO - Using env: {'DISPLAY': ':0', 05:18:35 INFO - 'HOME': '/home/cltbld', 05:18:35 INFO - 'LANG': 'en_US.UTF-8', 05:18:35 INFO - 'LANGUAGE': 'en_US:en', 05:18:35 INFO - 'LOGNAME': 'cltbld', 05:18:35 INFO - 'MAIL': '/var/mail/cltbld', 05:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:35 INFO - 'MOZ_NO_REMOTE': '1', 05:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:35 INFO - 'NO_EM_RESTART': '1', 05:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:35 INFO - 'PWD': '/builds/slave/test', 05:18:35 INFO - 'SHELL': '/bin/bash', 05:18:35 INFO - 'SHLVL': '1', 05:18:35 INFO - 'TERM': 'linux', 05:18:35 INFO - 'TMOUT': '86400', 05:18:35 INFO - 'USER': 'cltbld', 05:18:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:35 INFO - '_': '/tools/buildbot/bin/python'} 05:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 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:18:35 INFO - Cleaning up... 05:18:35 INFO - Return code: 0 05:18:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 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 0xbf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', '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:18:35 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:18:35 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:18:35 INFO - Using env: {'DISPLAY': ':0', 05:18:35 INFO - 'HOME': '/home/cltbld', 05:18:35 INFO - 'LANG': 'en_US.UTF-8', 05:18:35 INFO - 'LANGUAGE': 'en_US:en', 05:18:35 INFO - 'LOGNAME': 'cltbld', 05:18:35 INFO - 'MAIL': '/var/mail/cltbld', 05:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:35 INFO - 'MOZ_NO_REMOTE': '1', 05:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:35 INFO - 'NO_EM_RESTART': '1', 05:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:35 INFO - 'PWD': '/builds/slave/test', 05:18:35 INFO - 'SHELL': '/bin/bash', 05:18:35 INFO - 'SHLVL': '1', 05:18:35 INFO - 'TERM': 'linux', 05:18:35 INFO - 'TMOUT': '86400', 05:18:35 INFO - 'USER': 'cltbld', 05:18:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:35 INFO - '_': '/tools/buildbot/bin/python'} 05:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:18:35 INFO - Cleaning up... 05:18:35 INFO - Return code: 0 05:18:35 INFO - Running post-action listener: _resource_record_post_action 05:18:35 INFO - Running post-action listener: _start_resource_monitoring 05:18:35 INFO - Starting resource monitoring. 05:18:35 INFO - [mozharness: 2016-08-02 12:18:35.973021Z] Finished create-virtualenv step (success) 05:18:35 INFO - [mozharness: 2016-08-02 12:18:35.973574Z] Running install step. 05:18:35 INFO - Running pre-action listener: _resource_record_pre_action 05:18:35 INFO - Running main action method: install 05:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:36 INFO - Reading from file tmpfile_stdout 05:18:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:36 INFO - Reading from file tmpfile_stdout 05:18:36 INFO - Output received: 05:18:36 INFO - Usage: mozinstall [options] installer 05:18:36 INFO - Options: 05:18:36 INFO - -h, --help show this help message and exit 05:18:36 INFO - -d DEST, --destination=DEST 05:18:36 INFO - Directory to install application into. [default: 05:18:36 INFO - "/builds/slave/test"] 05:18:36 INFO - --app=APP Application being installed. [default: firefox] 05:18:36 INFO - mkdir: /builds/slave/test/build/application 05:18:36 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:18:36 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:18:53 INFO - Reading from file tmpfile_stdout 05:18:53 INFO - Output received: 05:18:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:18:53 INFO - Running post-action listener: _resource_record_post_action 05:18:53 INFO - [mozharness: 2016-08-02 12:18:53.143225Z] Finished install step (success) 05:18:53 INFO - [mozharness: 2016-08-02 12:18:53.143503Z] Running run-tests step. 05:18:53 INFO - Running pre-action listener: _resource_record_pre_action 05:18:53 INFO - Running main action method: run_tests 05:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:53 INFO - Python 2.7.3 05:18:53 INFO - Return code: 0 05:18:53 INFO - grabbing minidump binary from tooltool 05:18:53 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:18:53 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 0xeb03b0>, '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 0xeb12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:53 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:18:53 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:18:53 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:18:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:53 INFO - Return code: 0 05:18:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:18:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:18:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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:18:53 INFO - Using env: {'DISPLAY': ':0', 05:18:53 INFO - 'HOME': '/home/cltbld', 05:18:53 INFO - 'LANG': 'en_US.UTF-8', 05:18:53 INFO - 'LANGUAGE': 'en_US:en', 05:18:53 INFO - 'LOGNAME': 'cltbld', 05:18:53 INFO - 'MAIL': '/var/mail/cltbld', 05:18:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:53 INFO - 'MOZ_NO_REMOTE': '1', 05:18:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:53 INFO - 'NO_EM_RESTART': '1', 05:18:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:53 INFO - 'PWD': '/builds/slave/test', 05:18:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:53 INFO - 'SHELL': '/bin/bash', 05:18:53 INFO - 'SHLVL': '1', 05:18:53 INFO - 'TERM': 'linux', 05:18:53 INFO - 'TMOUT': '86400', 05:18:53 INFO - 'USER': 'cltbld', 05:18:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654', 05:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:53 INFO - '_': '/tools/buildbot/bin/python'} 05:18:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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:18:53 INFO - mozversion application_buildid: 20160802023001 05:18:53 INFO - mozversion application_changeset: 46045ec8a4aa09a341b7209170089ade3c27c1a5 05:18:53 INFO - mozversion application_display_name: Nightly 05:18:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:53 INFO - mozversion application_name: Firefox 05:18:53 INFO - mozversion application_remotingname: firefox 05:18:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:18:53 INFO - mozversion application_vendor: Mozilla 05:18:53 INFO - mozversion application_version: 51.0a1 05:18:53 INFO - mozversion platform_buildid: 20160802023001 05:18:53 INFO - mozversion platform_changeset: 46045ec8a4aa09a341b7209170089ade3c27c1a5 05:18:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:18:53 INFO - mozversion platform_version: 51.0a1 05:18:53 INFO - using testdate: 1470140333 05:18:53 INFO - actual date: 1470140333 05:18:53 INFO - starting webserver on 'localhost:44387' 05:18:53 INFO - SUITE-START | Running 2 tests 05:18:53 INFO - TEST-START | dromaeo_css 05:18:53 INFO - operating with platform_type : linux_ 05:18:53 INFO - Initialising browser for dromaeo_css test... 05:18:53 INFO - TEST-INFO | started process 9969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYt1Xe/profile http://localhost:44387/getInfo.html) 05:18:57 INFO - PROCESS | 9969 | __metrics Screen width/height:1600/1200 05:18:57 INFO - PROCESS | 9969 | colorDepth:24 05:18:57 INFO - PROCESS | 9969 | Browser inner width/height: 1024/697 05:18:57 INFO - PROCESS | 9969 | __metrics 05:18:58 INFO - PROCESS | 9969 | 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:18:58 INFO - PROCESS | 9969 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:58 INFO - PROCESS | 9969 | console.error: PushService: 05:18:58 INFO - PROCESS | 9969 | stateChangeProcessEnqueue: Error transitioning state 05:18:58 INFO - PROCESS | 9969 | UnknownError 05:18:59 INFO - TEST-INFO | 9969: exit 0 05:18:59 INFO - Browser initialized. 05:18:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:59 INFO - TEST-INFO | started process 10049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYt1Xe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:10 INFO - PROCESS | 10049 | RSS: Main: 155926528 05:19:10 INFO - PROCESS | 10049 | 05:20:01 INFO - PROCESS | 10049 | 1470140401968 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:22:11 INFO - PROCESS | 10049 | Cycle 1(1): loaded http://localhost:44387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44387/tests/dromaeo/cssquery-ext.html) 05:22:12 INFO - PROCESS | 10049 | RSS: Main: 255840256 05:22:12 INFO - PROCESS | 10049 | 05:25:14 INFO - PROCESS | 10049 | Cycle 1(1): loaded http://localhost:44387/tests/dromaeo/cssquery-ext.html (next: http://localhost:44387/tests/dromaeo/cssquery-jquery.html) 05:25:15 INFO - PROCESS | 10049 | RSS: Main: 240152576 05:25:15 INFO - PROCESS | 10049 | 05:28:17 INFO - PROCESS | 10049 | Cycle 1(1): loaded http://localhost:44387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44387/tests/dromaeo/cssquery-mootools.html) 05:28:17 INFO - PROCESS | 10049 | RSS: Main: 220962816 05:28:17 INFO - PROCESS | 10049 | 05:31:19 INFO - PROCESS | 10049 | Cycle 1(1): loaded http://localhost:44387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44387/tests/dromaeo/cssquery-prototype.html) 05:31:20 INFO - PROCESS | 10049 | RSS: Main: 230748160 05:31:20 INFO - PROCESS | 10049 | 05:34:22 INFO - PROCESS | 10049 | Cycle 1(1): loaded http://localhost:44387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44387/tests/dromaeo/cssquery-yui.html) 05:34:23 INFO - PROCESS | 10049 | RSS: Main: 187416576 05:34:23 INFO - PROCESS | 10049 | 05:37:25 INFO - PROCESS | 10049 | Cycle 1(1): loaded http://localhost:44387/tests/dromaeo/cssquery-yui.html (next: http://localhost:44387/tests/dromaeo/cssquery-dojo.html) 05:37:26 INFO - PROCESS | 10049 | RSS: Main: 275288064 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | __start_tp_report 05:37:26 INFO - PROCESS | 10049 | _x_x_mozilla_page_load 05:37:26 INFO - PROCESS | 10049 | _x_x_mozilla_page_load_details 05:37:26 INFO - PROCESS | 10049 | |i|pagename|runs| 05:37:26 INFO - PROCESS | 10049 | |0;dojo.html;3052.0538633023766;3061.5407688846685;3092.7835051546385;3093.0875391759428;3107.7979931304462;5292.841214763564;5301.257823904656;5318.840434786957;5411.431799661038;5437.564994800421;5359.38367087785;5393.298871146755;5414.377346605142;5437.157240627709;5477.3427188737305;4824.131656301855;4896.192128298826;4898.069366820293;4902.3626928499425;5044.369453818273;4956.157453232959;4987.725675087869;4990.700557966516;5011.298418221452;5015.84952451427;4776.713397196162;4896.192128298826;4942.752862356868;4968.056069346812;4978.178600530908;4887.608991280689;4892.706437613754;4905.950940490585;4978.900421991576;5025.648204625678;4907.509249075099;4947.109520286347;4948.851534453972;4956.925646115311;4968.90062198754;5271.130263506555;5356.0894647909945;5383.327084114486;5441.945580544223;5472.206530053159;5814.854628634275;5876;5878.823635290948;5895.498882594985;5898.911516327258;5925.081612350093;5925.881482370329;5926.8814623707285;5934;5950.345461999176;5263.552598029134;5308.654937429054;5346.652467589594;5353.57171426285;5470.17947307903;5969.940300597025;5977.432143946318;5981.491573216238;5990.6705131218205;5995.950708625973;5693.943060569424;5698.487136157766;5703.344115426779;5708.40061793514;5711.286089238845;5655.349634791969;5658.886822263614;5809.651420914759;5819.476247137778;5831.766729330864;5653.434656534314;5719.2279042328755;5754.88490230193;5769.509591684669;5771.538276937835;5681;5700.458456446631;5736.311642602831;5740.0815869460685;5742.7415766290615;4421.646268298528;4430.756308403004;4440.045390241114;4445.666575006888;4469.128519938646;3874.5156855393075;3896.298666240104;3934.940975885364;3978.1844721831953;3979.781112038808;5544.528715059185;5562.916556251659;5562.916556251659;5564.415736347706;5593.7693707384315;5827.5920685552455;5876.7649294028615;5895.263092113486;5906.527477801766;5936.554758393051;5355.062863998784;5402.783888644411;5440.91838622421;5447.155690867922;5530.834074977757;5018.247262910592;5024.874378140503;5027.0197311524635;5028.793089658456;5067.3412456381175;5964.761409543657;5995.280566332068;6023.3073196582955;6027.0356742921795;6066.1204125402455;5710.971445142748;5756.07902735577;5793.420657934173;5803.245578074823;5812.854678633068;5985.790497332572;6030.547708921761;6030.939690603038;6036.3058248302;6079.270487541523;5685.687287199078;5735.283089613798;5736.885262294814;5740.913886291793;5746.051901436216;5625.268715067015;5725.08398656213;5761.769529218952;5780.450857168562;5830.679312637845;5679.460451257124;5686.687232202268;5690.203371527907;5692.288463942007;5725.570582206435;5618.2415373924;5676.20533125371;5679.148127780866;5681.602287839977;5685.886282274414;5486.835394938158;5573.470520300565;5590.468905453975;5606.607537472338;5652.943470565242;5791.652500849962;5826.242588463472;5838.912416313674;5846.883062338815;5853.824385268449;5663.830085097454;5671.914921276267;5672.035753921926;5673.631213971079;5673.8297851064535 05:37:26 INFO - PROCESS | 10049 | |1;ext.html;578.5284992730926;608.9604175728578;630.7256343490582;631.3717850738516;637.0953246390126;44078.33882491765;45227.547724522745;45239.77380113103;45333.32000020002;49175.50824491754;46651.766741166335;47121.29318060223;47149.528504714945;47188.2921756174;47206;9060;9212.263018958467;9214.677486287981;9214.76963075925;9218.400803947756;9042.819143617124;9127.726168214931;9132.726018219464;9136.040715724854;9138.451692898447;9167.816643667122;9200.539973001356;9201.125893040184;9206.585703643319;9209.125133112377;9137.817243655123;9174.266058715353;9178.173964343241;9179.990201077877;9181.0818918108;8951.462912225288;9003.819923601492;9024.639014439415;9025.097490250988;9028.232600228988;43831.561684383385;44099;44304.3354349685;44315;44366.77816610929;3488.7906725596545;3539.2744487380023;3594.6944509716704;3654.305681920453;3658.5609726832686;33937.49093763596;34476.65523344785;34574.82712586446;34660;35209.295814083576;4498.595126438603;4545.977270113662;4548.522405147478;4642.419697537808;4673.696209746356;377445;378994;379483;381008;381997.9999999972;55951;56036;56079.43920560742;56080.43919560752;56087.71956140275;36141;36917.815410922776;37099.443508347395;38420.807895960344;38477.80761096177;17248.655026899392;17566.824331756776;17600.735988960176;17602.38391656286;17615.911920440572;13373.331333433289;13524.661883452993;13530.391132399065;13533.52632657872;13557.728845423037;19752.60494790096;19774.703379449318;19786;19841.20635174577;19910;6672.232693240242;6906.896396554056;7079.194805324712;7096.50324477292;7105.502614816914;992.4888682328607;1066.4294602387686;1098.741795678015;1155.4453862146217;1161.175565348612;33021.50467742986;33132;33258.3348333032;33262;33600.32799343999;1082.5723839083519;1129.5989923577176;1151.6257216404701;1154.8440960470398;1186.347508870118;16899.831001690072;17688.251402784135;17725.202365893565;17728.493078088508;17793.911030445022;581423;589532;590122;591548;592367;59786;60260.69869650711;60365.396346036854;60444;60508;1238.4674589926237;1353.41126609925;1374.8556401577891;1393.4844107680224;1413.130924481457;29931.401371972002;34166.14584635404;34457.82771086128;34471.82764086164;34996.300073998886;51735;53154.20268695895;53158;53220.73389633027;53292;325232;326588;326785;327177;329128;25024.499510009333;28004.85997569999;28706;29106.7089329104;29189.41621167607;47725;48576.75711621419;48592;49045.75477122592;49600;41269.58730412657;41429.79285103676;42398.36402454027;43562.34656480092;44046.77976610096;41748.3737743928;41915;42647;43433.565664342954;43908.78045609751;31723.682763172073;41286.1742765149;41761;42198;44365.33451998287;36189.457158143174;37930.24139517139;37977.4303385455;38208.23583528258;38311.04222394463;28573.571396429485;28655.856720716263;28742.568861467513;28997.565036524047;29076.56385154182 05:37:26 INFO - PROCESS | 10049 | |2;jquery.html;363.3369101389964;364.7993603518068;378.42290506976855;386.4994831692957;404.3207411548597;15381.769273460906;17615.207315670792;19168.712469312955;19263.133159007844;19883.105260263288;18225.088745562734;18442.815571844276;18679.71980420295;18731.3444029459;19184.328548500805;5679.914801277984;5773.393793651659;5981.222441082653;5985.132155837401;5988.281406231236;5739.799107031255;5782.653040817543;5783.942160578404;5822.970885145568;5825.621334613236;5571.860703482425;5626.54987600993;5677.403872593381;5698.173764804101;5698.629589076718;5643.379228284885;5661.094224924033;5675.574331925101;5714.200011998323;5778.3354914184565;5009.974950125263;5029.245613158019;5073.112205364084;5074.619403544749;5201.791928322863;23236.76763232363;23360.64959025616;23362.766372336228;23489.53020939589;23533.94097265627;2370.6444033394955;2408.903643854244;2465.5438743832447;2651.5890037044287;2820.3795165063652;14474.131552106906;14493.347799348949;14609.123452592772;14701.485448009375;15022.248887555688;1922.7308176855252;1930.2954421636143;1957.4421289932443;1989.184434381911;2054.496648321156;76900;79060.60469697672;80425;81313.18686813115;81767;10177.389356638625;10197.13324367437;10285.897141028643;10411.11505522039;10416.687499375032;14047.648808779863;14066.929665351812;14068;14068.296585170701;14083.084599501;7812.257835505618;7879.645415956295;7927.286544210933;7993.360531157494;8015.519068855887;7681;7718.961405192938;7784.844303113906;7989.400794940403;7989.880151797728;6342.143810585604;6412.198475190601;6443.613383197023;6510.121133646991;6546.934530654633;1840.6744151244736;1890.1966664167949;1894.9052547372576;1932.5361913140746;1948.366780796247;903.1735961595198;976.4287891583504;979.1285755677453;988.515627342597;991.7867658453323;18912.338068167548;19926.402207933785;20148.496287592636;20236.392908212776;20490;989.5101924547251;1015.9034891685278;1034.6068493972243;1064.8030114428855;1077.5635867473686;10192;11625.6512304631;11674.241174323643;11710.76578468426;11740.295582265091;497629;499912;501045;501716;511626;75081.6245918767;79363.60318198372;80564.59717701492;80919;84096.57951710203;1045.816982028142;1050.7373156710823;1053.8629978102797;1058.296233005043;1060.9416482093404;17285.827141728423;17733.822661773218;18074.728879066563;18172.182251798964;18388.540286492946;39894.40158397568;40125;40333.596664032986;40373.39439908345;41140.58859411367;52652;53588;53724.194137087194;53739.73130134324;54664.453355465936;8277.83444331122;8291.58542072906;8427.662893484192;8585.399022068395;8841.115888411108;13079.01907356933;13297.80053299182;13377.598672039854;13502.257375844423;13604.86395136036;11720.472578734149;11739.765204695688;11761.88238117608;11905.821412678644;12200;11510.539578417105;11619.36093514831;11621.186516943733;11684.88315116838;12189.207701499374;11827.231229970024;11857.940710296394;11861.288322700666;11913.16607837443;11962.162648614514;8418;8440.15598440151;8449.747865594789;8637.093105223861;8784.736457906272;11730.589429369931;11812.645620631394;11905.166638335233;11943.343116128697;12000.879991199976 05:37:26 INFO - PROCESS | 10049 | |3;mootools.html;1313.474610155938;1456.934437950292;1525.2983627531335;1644.4408900973667;1776.0498133498581;8579.227869491744;8886.066962968893;8993.59528821203;9253.76865578361;9266.629334826599;9042.457452552835;9176.908230917688;9181.95409022954;9190.908090919089;9197.862032069525;2288.9771102288973;2308.988455057722;2319.211468100845;2325.500017496238;2326.9185578504757;2352.435415500276;2371.2530552875874;2395.2933884504114;2403.5433267679086;2404.0504000919627;2370.063824789207;2381.583222935988;2385.71371435428;2390.486045500217;2398.95202095958;2302.458922153293;2318.7217533895955;2324.2097686786574;2326.685897403854;2338.871362075085;2281.3384118605586;2299.1148407862925;2307.90768369265;2308.7806658367426;2308.8845557722047;8917.108289171096;9011.504367259799;9080.137386948229;9081.909180908173;9082.40964337316;5091.974540127276;5287.312649355559;5310.389305229909;5317.335333083364;5321.148616221425;3403;3421.726261899042;3456.861725530976;3496.318217947501;3497.318022985519;1101.6089288302696;1113.3153110836859;1118.9776204475945;1122.3378206857992;1122.8708698499695;12827.807582886264;12903.419346129447;12995.220286782824;13013.414396352187;13025.739485210242;4316.309390497506;4369.912601748011;4471.6646251531265;4506.639468842484;4582.312653102062;10066.295359324777;10077.69766906994;10077.748056298651;10081.546330415149;10085.546150423248;5206.271122042917;5215.608829337815;5215.7913683453;5218.66078704883;5220.451852555503;4281.464816897887;4608.101420223024;4744.217204161275;4780.1873681474235;4896.387951506062;3728.3102626014274;3789.7157713171623;3840.0591854995146;3856.5564960029396;3894.5910679378826;1062.8565143705655;1064.8243039898484;1094.4035500652165;1105.0551778229658;1107.8892110789018;979.9755006124904;985.1281615770096;998.3610489286863;1001.4241810958728;1014.3406785589426;6172.4136207060255;6232.189815323979;6268;6395.20059992501;6513.934860651428;420.1198489165255;425.97870106494554;437.35271797739523;441.4305545845887;442.62819231845407;4080.7959602020373;4281.957180428218;4318.481782186158;4327.091310824699;4337.696361254745;11103.555857765761;11206.943965280285;11219.887801122048;11223.943880280709;11403.372814495116;11091.778164436666;11104.333739975627;11134.777304453866;11149.498272577754;11163.330200187853;7810.6875724971505;8126.2686358226865;8136.918630813616;8283.29591984688;8520.786980325418;6066.696665166635;6226.315105338319;6320.178376810985;6353.68231588428;6447.065175549613;10098.242631802497;10252.846207307046;10341.9482902585;10345.120664743581;10354.1198998086;10333.070023697603;10644.733881653021;10781.730456738644;10999.395033273247;11048.060914822008;7791.766247012599;7996.760097197093;8035.879461807961;8098;8192.467489613156;8824.735257942271;8860.468371897707;8863.601137948679;8865.867011994955;8909;7300.744473943387;7304.379127774198;7697.230276972258;7755;8025.438219324591;7532.698692052257;7547.773566793005;7573.9242607573215;7705.6147192641265;7780.260875216845;7009.474289428212;7092.361687448154;7127.2516385778745;7134.964325178341;7137.429005679637;5412.512873841373;5451.400345961862;5470.070088084955;5510.944890551204;5554.4445555445745;5540.501354878081;5623.522000629992;5646.520045796154;5752.194692743103;5865.149553314831 05:37:26 INFO - PROCESS | 10049 | |4;prototype.html;284.7750277280948;299.28769528522116;303.9407315573464;312.4859605948215;319.16697419734487;5049.368828896388;5141.331626888508;5203.089459344618;5246.658967167136;5247.291615631889;5133.4609865964;5180.378354597444;5181.119209734345;5208.671788693878;5238.5023422774875;4097.201045796071;4097.364908439196;4101.384792281159;4105.384192371153;4105.753654780723;3923.411488276767;4038.5355684096266;4097.405876147956;4102.79486025699;4103.835846566149;4031.3549832026883;4031.737937034098;4034.2334956358345;4034.7780872052026;4036.1927614477077;4003.919921601581;4029.6977726670325;4033.608405100236;4039.171969746195;4043.716939814214;3459.8443070061658;3552.3250582389264;3552.626974167727;3565.4651802229873;3578.4970312468827;5082.23766435034;5083.6441449098575;5090.414602320743;5093.236014597803;5105.5149760772665;4610.925083712343;4614.746188959606;4616.3537104805355;4617.907641847178;4631.698939568917;5296.612273679806;5308.230306605559;5404.675719456806;5420.593455490854;5442.829791594826;3881.243157584272;3882;3882.3594106972314;3887;3899.454076429302;5632.859178520529;5679.432056794329;5681.153625071868;5681.619436435356;5684.147377893308;3803.790791506494;3883.37865941448;3895.2014836958356;3915.138669492707;3920.1963597463023;3944.2111577684004;3944.2505923874373;3947.519680119955;3957.465742124834;3961.2473630010204;4540.523245059221;4551.954480455153;4552.544745525421;4559.224931761609;4562.270036794097;5309.761060752276;5444.156155795858;5468.699221542774;5482.671039737628;5489.807856724996;1355.4510423278589;1378.6622277542067;1379.2552021908057;1391.4156054457153;1393.136255521583;855.9813821552333;893.1693525021662;894.4454438248328;895.1317222294364;897.2014906733012;4661.813527458864;4685.789139488731;4698.976505117453;4700.623950083985;4741.57325840676;4919.975400123048;4922.409310882717;4938;4947.554720075211;4977.303177555145;4408.382826404306;4688.835890743876;4724.653473759962;4731.432228132646;4761.642876784185;2636.49906517761;2643.299525625711;2652.721464246265;2657.5649149459077;2660.2418310781723;5116.923246151311;5134.614903882224;5157.974210128926;5159.458256883048;5169.948300517022;4692;5002.774875130628;5038.496150384932;5048.5203905628905;5062.367204099488;5095.210242412358;5097.668651537638;5098.439171691111;5127.512886275797;5138.563222126161;4944.8763780905765;4956.355673762388;4956.355673762388;4960.429550601727;4970.65205435616;4702.7162409701;4757.476677565534;4850.593327935;4899.240617704261;4917.360743103373;5059.86153115546;5107.9686508789555;5120.257562653469;5130.563902068366;5131.435542090442;3664.5419322584676;3786.7917264550715;3786.905327366838;3935.8622448214173;3963.544192417909;5562.360328562268;5575.12880866346;5578.406041190866;5584.46947539983;5586.944130558642;5344.46555344478;5375.881988446769;5399.920015996738;5404.405515393225;5420.268263784496;5167.457416971164;5387.148189044852;5402.459754024566;5433.673979561239;5451.182322651475;5357.651467832605;5373.946260537345;5380.246765452762;5388.568914486753;5416.674999500043;5354.892902142014;5430.544092281701;5452.672839629635;5499.257600223918;5505.201745746925;5344.839654810362;5347.598930080182;5354.839354819362;5359.758810853599;5377.677339359651 05:37:26 INFO - PROCESS | 10049 | |5;yui.html;720.0926832191441;741.4883730226147;768.5926458976744;804.9637766300518;806.6208881825542;15561.766573501392;16622.75065874013;16655.417060402888;16660.250288737006;16677.49967500977;15177;15268.618284542892;15321.616959575987;15333.156676382794;15333.463328783495;658.2528829778188;780.55898417394;798.6086817459461;802.1256830055239;812.0823469479479;807.2855522862279;817.3665409307804;817.5748610722421;817.6770175780563;817.7301490508119;866.8699695045763;867.7743786615493;868.1622234543664;868.700298397052;868.9312146060349;693.1958927643959;838.4675730910855;856.9785755356104;862.4480332587149;865.9567021648924;610.1640752169557;612.3631423319742;612.6599737145882;613.9723712432951;614.6127939398151;14560.781588276184;14649.633759156;14650.120992740469;14678.119312841263;14684;13991.440342386293;14077.15537067769;14149.221792801392;14214.289285535786;14473.493427729978;12734.490620375174;12926.935365323114;13071.673208169872;13120.47518099275;13408.664783380396;4410.404595379615;4458.885823398007;4554.658400619934;4562.680612357136;4573.451185857685;79930;80890.78663820047;81378.18621813825;81540;81623;10595.417252051211;10725.195610329256;10908.23642345044;11213.607523736793;11273.830892536618;18923.716144257847;19016.429507114808;19443.4166974991;19690.113944872515;19754;8514.276286515715;8542.017667968263;8585.699500517452;8876;8906.86639700405;4620.0990806793025;4685.625149987993;4749.976250118727;4752.453467851241;4768.046390721869;3471.2363280078343;3537.7523573349617;3560.3235385276716;3568.37553428149;3580.0870777951454;597.5578072226608;603.0532064658531;632.1402892066785;632.8101569529123;639.2616527910271;577.5264283287664;661.8014595621295;708.8582283543312;713.1192976673804;801.5591424716382;9338.953305233566;10312.381257124596;10425;10567.418791966516;10720.678379648623;654.9443297319781;759.8214419611387;774;780.6292011294589;788.873780195166;4677.345171675968;4825.179719447632;5042.268871013683;5061;5140.254663073908;129156;130638;131250;131283;135317.3234133823;86445;89715.55142224378;107726;108849.45575272231;110096.4495177535;84211;84724.15275847162;85880.14119858846;87142.1285787134;87518.56240718755;9891.307608467338;9892.307538472238;9986.650467233612;10023.016329688977;10079.395236285847;49531;50177.74911125421;50193;51281.743591281804;51374;44574.55425445704;45361;67841.66079169573;69022.44951716368;74815.62592187004;13182.472701091849;13352.465901363837;13432.664183395102;13530.661733456742;13583.864161358655;14850.183239921907;15184.544463666107;15544;16162.353505859634;16193.838061619705;14353.784693229401;14739.484118055816;15453.61365965815;15754.448594299145;15888.126153061692;13682.52111176104;14918.925405372904;15001.924990374979;15238.161901095546;15325.693486130438;14227.644308891946;14365.712685746435;14535.127892326494;14541.41834326615;14544.709105818036;10922.18083643714;11532.82700759506;11621.6513504595;11681.941590291994;11721.549479492078;11428.942855286003;12088.576899808464;12135.575254866391;12233.3271670059;12411.379431028232 05:37:26 INFO - PROCESS | 10049 | __end_tp_report 05:37:26 INFO - PROCESS | 10049 | __start_cc_report 05:37:26 INFO - PROCESS | 10049 | _x_x_mozilla_cycle_collect,917 05:37:26 INFO - PROCESS | 10049 | __end_cc_report 05:37:26 INFO - PROCESS | 10049 | __startTimestamp1470141446089__endTimestamp 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | ------- Summary: start ------- 05:37:26 INFO - PROCESS | 10049 | Number of tests: 6 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | [#0] dojo.html Cycles:165 Average:5394.76 Median:5653.43 stddev:625.95 (11.1%) stddev-sans-first:600.29 05:37:26 INFO - PROCESS | 10049 | Values: 3052.1 3061.5 3092.8 3093.1 3107.8 5292.8 5301.3 5318.8 5411.4 5437.6 5359.4 5393.3 5414.4 5437.2 5477.3 4824.1 4896.2 4898.1 4902.4 5044.4 4956.2 4987.7 4990.7 5011.3 5015.8 4776.7 4896.2 4942.8 4968.1 4978.2 4887.6 4892.7 4906.0 4978.9 5025.6 4907.5 4947.1 4948.9 4956.9 4968.9 5271.1 5356.1 5383.3 5441.9 5472.2 5814.9 5876.0 5878.8 5895.5 5898.9 5925.1 5925.9 5926.9 5934.0 5950.3 5263.6 5308.7 5346.7 5353.6 5470.2 5969.9 5977.4 5981.5 5990.7 5996.0 5693.9 5698.5 5703.3 5708.4 5711.3 5655.3 5658.9 5809.7 5819.5 5831.8 5653.4 5719.2 5754.9 5769.5 5771.5 5681.0 5700.5 5736.3 5740.1 5742.7 4421.6 4430.8 4440.0 4445.7 4469.1 3874.5 3896.3 3934.9 3978.2 3979.8 5544.5 5562.9 5562.9 5564.4 5593.8 5827.6 5876.8 5895.3 5906.5 5936.6 5355.1 5402.8 5440.9 5447.2 5530.8 5018.2 5024.9 5027.0 5028.8 5067.3 5964.8 5995.3 6023.3 6027.0 6066.1 5711.0 5756.1 5793.4 5803.2 5812.9 5985.8 6030.5 6030.9 6036.3 6079.3 5685.7 5735.3 5736.9 5740.9 5746.1 5625.3 5725.1 5761.8 5780.5 5830.7 5679.5 5686.7 5690.2 5692.3 5725.6 5618.2 5676.2 5679.1 5681.6 5685.9 5486.8 5573.5 5590.5 5606.6 5652.9 5791.7 5826.2 5838.9 5846.9 5853.8 5663.8 5671.9 5672.0 5673.6 5673.8 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | [#1] ext.html Cycles:180 Average:59531.02 Median:42056.50 stddev:118601.66 (282.0%) stddev-sans-first:118851.77 05:37:26 INFO - PROCESS | 10049 | Values: 578.5 609.0 630.7 631.4 637.1 44078.3 45227.5 45239.8 45333.3 49175.5 46651.8 47121.3 47149.5 47188.3 47206.0 9060.0 9212.3 9214.7 9214.8 9218.4 9042.8 9127.7 9132.7 9136.0 9138.5 9167.8 9200.5 9201.1 9206.6 9209.1 9137.8 9174.3 9178.2 9180.0 9181.1 8951.5 9003.8 9024.6 9025.1 9028.2 43831.6 44099.0 44304.3 44315.0 44366.8 3488.8 3539.3 3594.7 3654.3 3658.6 33937.5 34476.7 34574.8 34660.0 35209.3 4498.6 4546.0 4548.5 4642.4 4673.7 377445.0 378994.0 379483.0 381008.0 381998.0 55951.0 56036.0 56079.4 56080.4 56087.7 36141.0 36917.8 37099.4 38420.8 38477.8 17248.7 17566.8 17600.7 17602.4 17615.9 13373.3 13524.7 13530.4 13533.5 13557.7 19752.6 19774.7 19786.0 19841.2 19910.0 6672.2 6906.9 7079.2 7096.5 7105.5 992.5 1066.4 1098.7 1155.4 1161.2 33021.5 33132.0 33258.3 33262.0 33600.3 1082.6 1129.6 1151.6 1154.8 1186.3 16899.8 17688.3 17725.2 17728.5 17793.9 581423.0 589532.0 590122.0 591548.0 592367.0 59786.0 60260.7 60365.4 60444.0 60508.0 1238.5 1353.4 1374.9 1393.5 1413.1 29931.4 34166.1 34457.8 34471.8 34996.3 51735.0 53154.2 53158.0 53220.7 53292.0 325232.0 326588.0 326785.0 327177.0 329128.0 25024.5 28004.9 28706.0 29106.7 29189.4 47725.0 48576.8 48592.0 49045.8 49600.0 41269.6 41429.8 42398.4 43562.3 44046.8 41748.4 41915.0 42647.0 43433.6 43908.8 31723.7 41286.2 41761.0 42198.0 44365.3 36189.5 37930.2 37977.4 38208.2 38311.0 28573.6 28655.9 28742.6 28997.6 29076.6 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | [#2] jquery.html Cycles:180 Average:28968.00 Median:2437.22 stddev:82444.90 (3382.7%) stddev-sans-first:82648.21 05:37:26 INFO - PROCESS | 10049 | Values: 363.3 364.8 378.4 386.5 404.3 15381.8 17615.2 19168.7 19263.1 19883.1 18225.1 18442.8 18679.7 18731.3 19184.3 5679.9 5773.4 5981.2 5985.1 5988.3 5739.8 5782.7 5783.9 5823.0 5825.6 5571.9 5626.5 5677.4 5698.2 5698.6 5643.4 5661.1 5675.6 5714.2 5778.3 5010.0 5029.2 5073.1 5074.6 5201.8 23236.8 23360.6 23362.8 23489.5 23533.9 2370.6 2408.9 2465.5 2651.6 2820.4 14474.1 14493.3 14609.1 14701.5 15022.2 1922.7 1930.3 1957.4 1989.2 2054.5 76900.0 79060.6 80425.0 81313.2 81767.0 10177.4 10197.1 10285.9 10411.1 10416.7 14047.6 14066.9 14068.0 14068.3 14083.1 7812.3 7879.6 7927.3 7993.4 8015.5 7681.0 7719.0 7784.8 7989.4 7989.9 6342.1 6412.2 6443.6 6510.1 6546.9 1840.7 1890.2 1894.9 1932.5 1948.4 903.2 976.4 979.1 988.5 991.8 18912.3 19926.4 20148.5 20236.4 20490.0 989.5 1015.9 1034.6 1064.8 1077.6 10192.0 11625.7 11674.2 11710.8 11740.3 497629.0 499912.0 501045.0 501716.0 511626.0 75081.6 79363.6 80564.6 80919.0 84096.6 1045.8 1050.7 1053.9 1058.3 1060.9 17285.8 17733.8 18074.7 18172.2 18388.5 39894.4 40125.0 40333.6 40373.4 41140.6 52652.0 53588.0 53724.2 53739.7 54664.5 8277.8 8291.6 8427.7 8585.4 8841.1 13079.0 13297.8 13377.6 13502.3 13604.9 11720.5 11739.8 11761.9 11905.8 12200.0 11510.5 11619.4 11621.2 11684.9 12189.2 11827.2 11857.9 11861.3 11913.2 11962.2 8418.0 8440.2 8449.7 8637.1 8784.7 11730.6 11812.6 11905.2 11943.3 12000.9 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | [#3] mootools.html Cycles:180 Average:5911.51 Median:4353.80 stddev:3434.97 (78.9%) stddev-sans-first:3427.23 05:37:26 INFO - PROCESS | 10049 | Values: 1313.5 1456.9 1525.3 1644.4 1776.0 8579.2 8886.1 8993.6 9253.8 9266.6 9042.5 9176.9 9182.0 9190.9 9197.9 2289.0 2309.0 2319.2 2325.5 2326.9 2352.4 2371.3 2395.3 2403.5 2404.1 2370.1 2381.6 2385.7 2390.5 2399.0 2302.5 2318.7 2324.2 2326.7 2338.9 2281.3 2299.1 2307.9 2308.8 2308.9 8917.1 9011.5 9080.1 9081.9 9082.4 5092.0 5287.3 5310.4 5317.3 5321.1 3403.0 3421.7 3456.9 3496.3 3497.3 1101.6 1113.3 1119.0 1122.3 1122.9 12827.8 12903.4 12995.2 13013.4 13025.7 4316.3 4369.9 4471.7 4506.6 4582.3 10066.3 10077.7 10077.7 10081.5 10085.5 5206.3 5215.6 5215.8 5218.7 5220.5 4281.5 4608.1 4744.2 4780.2 4896.4 3728.3 3789.7 3840.1 3856.6 3894.6 1062.9 1064.8 1094.4 1105.1 1107.9 980.0 985.1 998.4 1001.4 1014.3 6172.4 6232.2 6268.0 6395.2 6513.9 420.1 426.0 437.4 441.4 442.6 4080.8 4282.0 4318.5 4327.1 4337.7 11103.6 11206.9 11219.9 11223.9 11403.4 11091.8 11104.3 11134.8 11149.5 11163.3 7810.7 8126.3 8136.9 8283.3 8520.8 6066.7 6226.3 6320.2 6353.7 6447.1 10098.2 10252.8 10341.9 10345.1 10354.1 10333.1 10644.7 10781.7 10999.4 11048.1 7791.8 7996.8 8035.9 8098.0 8192.5 8824.7 8860.5 8863.6 8865.9 8909.0 7300.7 7304.4 7697.2 7755.0 8025.4 7532.7 7547.8 7573.9 7705.6 7780.3 7009.5 7092.4 7127.3 7135.0 7137.4 5412.5 5451.4 5470.1 5510.9 5554.4 5540.5 5623.5 5646.5 5752.2 5865.1 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | [#4] prototype.html Cycles:180 Average:4405.28 Median:4951.96 stddev:1275.23 (25.8%) stddev-sans-first:1240.74 05:37:26 INFO - PROCESS | 10049 | Values: 284.8 299.3 303.9 312.5 319.2 5049.4 5141.3 5203.1 5246.7 5247.3 5133.5 5180.4 5181.1 5208.7 5238.5 4097.2 4097.4 4101.4 4105.4 4105.8 3923.4 4038.5 4097.4 4102.8 4103.8 4031.4 4031.7 4034.2 4034.8 4036.2 4003.9 4029.7 4033.6 4039.2 4043.7 3459.8 3552.3 3552.6 3565.5 3578.5 5082.2 5083.6 5090.4 5093.2 5105.5 4610.9 4614.7 4616.4 4617.9 4631.7 5296.6 5308.2 5404.7 5420.6 5442.8 3881.2 3882.0 3882.4 3887.0 3899.5 5632.9 5679.4 5681.2 5681.6 5684.1 3803.8 3883.4 3895.2 3915.1 3920.2 3944.2 3944.3 3947.5 3957.5 3961.2 4540.5 4552.0 4552.5 4559.2 4562.3 5309.8 5444.2 5468.7 5482.7 5489.8 1355.5 1378.7 1379.3 1391.4 1393.1 856.0 893.2 894.4 895.1 897.2 4661.8 4685.8 4699.0 4700.6 4741.6 4920.0 4922.4 4938.0 4947.6 4977.3 4408.4 4688.8 4724.7 4731.4 4761.6 2636.5 2643.3 2652.7 2657.6 2660.2 5116.9 5134.6 5158.0 5159.5 5169.9 4692.0 5002.8 5038.5 5048.5 5062.4 5095.2 5097.7 5098.4 5127.5 5138.6 4944.9 4956.4 4956.4 4960.4 4970.7 4702.7 4757.5 4850.6 4899.2 4917.4 5059.9 5108.0 5120.3 5130.6 5131.4 3664.5 3786.8 3786.9 3935.9 3963.5 5562.4 5575.1 5578.4 5584.5 5586.9 5344.5 5375.9 5399.9 5404.4 5420.3 5167.5 5387.1 5402.5 5433.7 5451.2 5357.7 5373.9 5380.2 5388.6 5416.7 5354.9 5430.5 5452.7 5499.3 5505.2 5344.8 5347.6 5354.8 5359.8 5377.7 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - PROCESS | 10049 | [#5] yui.html Cycles:180 Average:21229.33 Median:24516.72 stddev:31230.83 (127.4%) stddev-sans-first:31280.47 05:37:26 INFO - PROCESS | 10049 | Values: 720.1 741.5 768.6 805.0 806.6 15561.8 16622.8 16655.4 16660.3 16677.5 15177.0 15268.6 15321.6 15333.2 15333.5 658.3 780.6 798.6 802.1 812.1 807.3 817.4 817.6 817.7 817.7 866.9 867.8 868.2 868.7 868.9 693.2 838.5 857.0 862.4 866.0 610.2 612.4 612.7 614.0 614.6 14560.8 14649.6 14650.1 14678.1 14684.0 13991.4 14077.2 14149.2 14214.3 14473.5 12734.5 12926.9 13071.7 13120.5 13408.7 4410.4 4458.9 4554.7 4562.7 4573.5 79930.0 80890.8 81378.2 81540.0 81623.0 10595.4 10725.2 10908.2 11213.6 11273.8 18923.7 19016.4 19443.4 19690.1 19754.0 8514.3 8542.0 8585.7 8876.0 8906.9 4620.1 4685.6 4750.0 4752.5 4768.0 3471.2 3537.8 3560.3 3568.4 3580.1 597.6 603.1 632.1 632.8 639.3 577.5 661.8 708.9 713.1 801.6 9339.0 10312.4 10425.0 10567.4 10720.7 654.9 759.8 774.0 780.6 788.9 4677.3 4825.2 5042.3 5061.0 5140.3 129156.0 130638.0 131250.0 131283.0 135317.3 86445.0 89715.6 107726.0 108849.5 110096.4 84211.0 84724.2 85880.1 87142.1 87518.6 9891.3 9892.3 9986.7 10023.0 10079.4 49531.0 50177.7 50193.0 51281.7 51374.0 44574.6 45361.0 67841.7 69022.4 74815.6 13182.5 13352.5 13432.7 13530.7 13583.9 14850.2 15184.5 15544.0 16162.4 16193.8 14353.8 14739.5 15453.6 15754.4 15888.1 13682.5 14918.9 15001.9 15238.2 15325.7 14227.6 14365.7 14535.1 14541.4 14544.7 10922.2 11532.8 11621.7 11681.9 11721.5 11428.9 12088.6 12135.6 12233.3 12411.4 05:37:26 INFO - PROCESS | 10049 | -------- Summary: end -------- 05:37:26 INFO - PROCESS | 10049 | 05:37:26 INFO - TEST-INFO | 10049: exit 0 05:37:26 INFO - TEST-OK | dromaeo_css | took 1113467ms 05:37:26 INFO - TEST-START | kraken 05:37:26 INFO - operating with platform_type : linux_ 05:37:26 INFO - Initialising browser for kraken test... 05:37:26 INFO - TEST-INFO | started process 10237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeU1i_n/profile http://localhost:44387/getInfo.html) 05:37:30 INFO - PROCESS | 10237 | __metrics Screen width/height:1600/1200 05:37:30 INFO - PROCESS | 10237 | colorDepth:24 05:37:30 INFO - PROCESS | 10237 | Browser inner width/height: 1024/697 05:37:30 INFO - PROCESS | 10237 | __metrics 05:37:31 INFO - PROCESS | 10237 | 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:37:31 INFO - PROCESS | 10237 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:32 INFO - PROCESS | 10237 | console.error: PushService: 05:37:32 INFO - PROCESS | 10237 | stateChangeProcessEnqueue: Error transitioning state 05:37:32 INFO - PROCESS | 10237 | UnknownError 05:37:32 INFO - TEST-INFO | 10237: exit 0 05:37:32 INFO - Browser initialized. 05:37:32 INFO - Running cycle 1/1 for kraken test... 05:37:32 INFO - TEST-INFO | started process 10315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeU1i_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:44 INFO - PROCESS | 10315 | RSS: Main: 156041216 05:37:44 INFO - PROCESS | 10315 | 05:37:47 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44387/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:47 INFO - PROCESS | 10315 | RSS: Main: 213356544 05:37:47 INFO - PROCESS | 10315 | 05:37:50 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44387/tests/kraken/driver.html?testName=audio-dft) 05:37:51 INFO - PROCESS | 10315 | RSS: Main: 191123456 05:37:51 INFO - PROCESS | 10315 | 05:37:54 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44387/tests/kraken/driver.html?testName=audio-fft) 05:37:54 INFO - PROCESS | 10315 | RSS: Main: 269152256 05:37:54 INFO - PROCESS | 10315 | 05:37:56 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44387/tests/kraken/driver.html?testName=audio-oscillator) 05:37:57 INFO - PROCESS | 10315 | RSS: Main: 179257344 05:37:57 INFO - PROCESS | 10315 | 05:37:59 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:00 INFO - PROCESS | 10315 | RSS: Main: 184369152 05:38:00 INFO - PROCESS | 10315 | 05:38:03 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44387/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:04 INFO - PROCESS | 10315 | RSS: Main: 218968064 05:38:04 INFO - PROCESS | 10315 | 05:38:07 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44387/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:07 INFO - PROCESS | 10315 | RSS: Main: 219193344 05:38:07 INFO - PROCESS | 10315 | 05:38:10 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44387/tests/kraken/driver.html?testName=json-parse-financial) 05:38:11 INFO - PROCESS | 10315 | RSS: Main: 219025408 05:38:11 INFO - PROCESS | 10315 | 05:38:12 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:13 INFO - PROCESS | 10315 | RSS: Main: 183250944 05:38:13 INFO - PROCESS | 10315 | 05:38:15 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:15 INFO - PROCESS | 10315 | RSS: Main: 188940288 05:38:15 INFO - PROCESS | 10315 | 05:38:17 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:18 INFO - PROCESS | 10315 | RSS: Main: 193994752 05:38:18 INFO - PROCESS | 10315 | 05:38:20 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:21 INFO - PROCESS | 10315 | RSS: Main: 188956672 05:38:21 INFO - PROCESS | 10315 | 05:38:24 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:24 INFO - PROCESS | 10315 | RSS: Main: 191967232 05:38:24 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | Cycle 1(1): loaded http://localhost:44387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44387/tests/kraken/driver.html?testName=ai-astar) 05:38:26 INFO - PROCESS | 10315 | RSS: Main: 242597888 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | __start_tp_report 05:38:26 INFO - PROCESS | 10315 | _x_x_mozilla_page_load 05:38:26 INFO - PROCESS | 10315 | _x_x_mozilla_page_load_details 05:38:26 INFO - PROCESS | 10315 | |i|pagename|runs| 05:38:26 INFO - PROCESS | 10315 | |0;ai-astar;103;111;111;111;112;112;109;111;111;111 05:38:26 INFO - PROCESS | 10315 | |1;audio-beat-detection;145;116;131;188;119;119;146;122;150;122 05:38:26 INFO - PROCESS | 10315 | |2;audio-dft;161;162;161;160;159;159;159;161;160;162 05:38:26 INFO - PROCESS | 10315 | |3;audio-fft;75;74;74;102;75;75;75;76;103;74 05:38:26 INFO - PROCESS | 10315 | |4;audio-oscillator;84;84;133;85;85;85;113;83;84;130 05:38:26 INFO - PROCESS | 10315 | |5;imaging-gaussian-blur;116;117;117;118;117;118;117;116;116;117 05:38:26 INFO - PROCESS | 10315 | |6;imaging-darkroom;146;146;146;146;149;147;145;146;147;147 05:38:26 INFO - PROCESS | 10315 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 05:38:26 INFO - PROCESS | 10315 | |8;json-parse-financial;51;50;51;51;50;51;51;49;50;50 05:38:26 INFO - PROCESS | 10315 | |9;json-stringify-tinderbox;63;65;63;64;64;63;64;64;64;64 05:38:26 INFO - PROCESS | 10315 | |10;stanford-crypto-aes;76;75;75;76;75;76;76;75;75;74 05:38:26 INFO - PROCESS | 10315 | |11;stanford-crypto-ccm;126;128;126;118;118;128;133;118;160;122 05:38:26 INFO - PROCESS | 10315 | |12;stanford-crypto-pbkdf2;159;160;159;159;161;155;159;157;160;155 05:38:26 INFO - PROCESS | 10315 | |13;stanford-crypto-sha256-iterative;63;62;64;63;62;62;62;65;61;60 05:38:26 INFO - PROCESS | 10315 | __end_tp_report 05:38:26 INFO - PROCESS | 10315 | __start_cc_report 05:38:26 INFO - PROCESS | 10315 | _x_x_mozilla_cycle_collect,1653 05:38:26 INFO - PROCESS | 10315 | __end_cc_report 05:38:26 INFO - PROCESS | 10315 | __startTimestamp1470141506815__endTimestamp 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | ------- Summary: start ------- 05:38:26 INFO - PROCESS | 10315 | Number of tests: 14 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 05:38:26 INFO - PROCESS | 10315 | Values: 103.0 111.0 111.0 111.0 112.0 112.0 109.0 111.0 111.0 111.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:138.00 stddev:22.30 (16.2%) stddev-sans-first:23.40 05:38:26 INFO - PROCESS | 10315 | Values: 145.0 116.0 131.0 188.0 119.0 119.0 146.0 122.0 150.0 122.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 05:38:26 INFO - PROCESS | 10315 | Values: 161.0 162.0 161.0 160.0 159.0 159.0 159.0 161.0 160.0 162.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.72 (15.6%) stddev-sans-first:12.27 05:38:26 INFO - PROCESS | 10315 | Values: 75.0 74.0 74.0 102.0 75.0 75.0 75.0 76.0 103.0 74.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:20.48 (24.4%) stddev-sans-first:21.21 05:38:26 INFO - PROCESS | 10315 | Values: 84.0 84.0 133.0 85.0 85.0 85.0 113.0 83.0 84.0 130.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 05:38:26 INFO - PROCESS | 10315 | Values: 116.0 117.0 117.0 118.0 117.0 118.0 117.0 116.0 116.0 117.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:38:26 INFO - PROCESS | 10315 | Values: 146.0 146.0 146.0 146.0 149.0 147.0 145.0 146.0 147.0 147.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:38:26 INFO - PROCESS | 10315 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 05:38:26 INFO - PROCESS | 10315 | Values: 51.0 50.0 51.0 51.0 50.0 51.0 51.0 49.0 50.0 50.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:38:26 INFO - PROCESS | 10315 | Values: 63.0 65.0 63.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.50 stddev:0.67 (0.9%) stddev-sans-first:0.67 05:38:26 INFO - PROCESS | 10315 | Values: 76.0 75.0 75.0 76.0 75.0 76.0 76.0 75.0 75.0 74.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.00 stddev:12.44 (9.8%) stddev-sans-first:13.18 05:38:26 INFO - PROCESS | 10315 | Values: 126.0 128.0 126.0 118.0 118.0 128.0 133.0 118.0 160.0 122.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:2.07 (1.3%) stddev-sans-first:2.18 05:38:26 INFO - PROCESS | 10315 | Values: 159.0 160.0 159.0 159.0 161.0 155.0 159.0 157.0 160.0 155.0 05:38:26 INFO - PROCESS | 10315 | 05:38:26 INFO - PROCESS | 10315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.50 05:38:26 INFO - PROCESS | 10315 | Values: 63.0 62.0 64.0 63.0 62.0 62.0 62.0 65.0 61.0 60.0 05:38:26 INFO - PROCESS | 10315 | -------- Summary: end -------- 05:38:26 INFO - PROCESS | 10315 | 05:38:27 INFO - TEST-INFO | 10315: exit 0 05:38:27 INFO - TEST-OK | kraken | took 60959ms 05:38:27 INFO - SUITE-END | took 1174s 05:38:27 INFO - Completed test suite (00:19:34) 05:38:27 INFO - javascript benchmark 05:38:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.0538633023766, 3061.5407688846685, 3092.7835051546385, 3093.0875391759428, 3107.7979931304462, 5292.841214763564, 5301.257823904656, 5318.840434786957, 5411.431799661038, 5437.564994800421, 5359.38367087785, 5393.298871146755, 5414.377346605142, 5437.157240627709, 5477.3427188737305, 4824.131656301855, 4896.192128298826, 4898.069366820293, 4902.3626928499425, 5044.369453818273, 4956.157453232959, 4987.725675087869, 4990.700557966516, 5011.298418221452, 5015.84952451427, 4776.713397196162, 4896.192128298826, 4942.752862356868, 4968.056069346812, 4978.178600530908, 4887.608991280689, 4892.706437613754, 4905.950940490585, 4978.900421991576, 5025.648204625678, 4907.509249075099, 4947.109520286347, 4948.851534453972, 4956.925646115311, 4968.90062198754, 5271.130263506555, 5356.0894647909945, 5383.327084114486, 5441.945580544223, 5472.206530053159, 5814.854628634275, 5876.0, 5878.823635290948, 5895.498882594985, 5898.911516327258, 5925.081612350093, 5925.881482370329, 5926.8814623707285, 5934.0, 5950.345461999176, 5263.552598029134, 5308.654937429054, 5346.652467589594, 5353.57171426285, 5470.17947307903, 5969.940300597025, 5977.432143946318, 5981.491573216238, 5990.6705131218205, 5995.950708625973, 5693.943060569424, 5698.487136157766, 5703.344115426779, 5708.40061793514, 5711.286089238845, 5655.349634791969, 5658.886822263614, 5809.651420914759, 5819.476247137778, 5831.766729330864, 5653.434656534314, 5719.2279042328755, 5754.88490230193, 5769.509591684669, 5771.538276937835, 5681.0, 5700.458456446631, 5736.311642602831, 5740.0815869460685, 5742.7415766290615, 4421.646268298528, 4430.756308403004, 4440.045390241114, 4445.666575006888, 4469.128519938646, 3874.5156855393075, 3896.298666240104, 3934.940975885364, 3978.1844721831953, 3979.781112038808, 5544.528715059185, 5562.916556251659, 5562.916556251659, 5564.415736347706, 5593.7693707384315, 5827.5920685552455, 5876.7649294028615, 5895.263092113486, 5906.527477801766, 5936.554758393051, 5355.062863998784, 5402.783888644411, 5440.91838622421, 5447.155690867922, 5530.834074977757, 5018.247262910592, 5024.874378140503, 5027.0197311524635, 5028.793089658456, 5067.3412456381175, 5964.761409543657, 5995.280566332068, 6023.3073196582955, 6027.0356742921795, 6066.1204125402455, 5710.971445142748, 5756.07902735577, 5793.420657934173, 5803.245578074823, 5812.854678633068, 5985.790497332572, 6030.547708921761, 6030.939690603038, 6036.3058248302, 6079.270487541523, 5685.687287199078, 5735.283089613798, 5736.885262294814, 5740.913886291793, 5746.051901436216, 5625.268715067015, 5725.08398656213, 5761.769529218952, 5780.450857168562, 5830.679312637845, 5679.460451257124, 5686.687232202268, 5690.203371527907, 5692.288463942007, 5725.570582206435, 5618.2415373924, 5676.20533125371, 5679.148127780866, 5681.602287839977, 5685.886282274414, 5486.835394938158, 5573.470520300565, 5590.468905453975, 5606.607537472338, 5652.943470565242, 5791.652500849962, 5826.242588463472, 5838.912416313674, 5846.883062338815, 5853.824385268449, 5663.830085097454, 5671.914921276267, 5672.035753921926, 5673.631213971079, 5673.8297851064535], "value": 5351.194103502197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.5284992730926, 608.9604175728578, 630.7256343490582, 631.3717850738516, 637.0953246390126, 44078.33882491765, 45227.547724522745, 45239.77380113103, 45333.32000020002, 49175.50824491754, 46651.766741166335, 47121.29318060223, 47149.528504714945, 47188.2921756174, 47206.0, 9060.0, 9212.263018958467, 9214.677486287981, 9214.76963075925, 9218.400803947756, 9042.819143617124, 9127.726168214931, 9132.726018219464, 9136.040715724854, 9138.451692898447, 9167.816643667122, 9200.539973001356, 9201.125893040184, 9206.585703643319, 9209.125133112377, 9137.817243655123, 9174.266058715353, 9178.173964343241, 9179.990201077877, 9181.0818918108, 8951.462912225288, 9003.819923601492, 9024.639014439415, 9025.097490250988, 9028.232600228988, 43831.561684383385, 44099.0, 44304.3354349685, 44315.0, 44366.77816610929, 3488.7906725596545, 3539.2744487380023, 3594.6944509716704, 3654.305681920453, 3658.5609726832686, 33937.49093763596, 34476.65523344785, 34574.82712586446, 34660.0, 35209.295814083576, 4498.595126438603, 4545.977270113662, 4548.522405147478, 4642.419697537808, 4673.696209746356, 377445.0, 378994.0, 379483.0, 381008.0, 381997.9999999972, 55951.0, 56036.0, 56079.43920560742, 56080.43919560752, 56087.71956140275, 36141.0, 36917.815410922776, 37099.443508347395, 38420.807895960344, 38477.80761096177, 17248.655026899392, 17566.824331756776, 17600.735988960176, 17602.38391656286, 17615.911920440572, 13373.331333433289, 13524.661883452993, 13530.391132399065, 13533.52632657872, 13557.728845423037, 19752.60494790096, 19774.703379449318, 19786.0, 19841.20635174577, 19910.0, 6672.232693240242, 6906.896396554056, 7079.194805324712, 7096.50324477292, 7105.502614816914, 992.4888682328607, 1066.4294602387686, 1098.741795678015, 1155.4453862146217, 1161.175565348612, 33021.50467742986, 33132.0, 33258.3348333032, 33262.0, 33600.32799343999, 1082.5723839083519, 1129.5989923577176, 1151.6257216404701, 1154.8440960470398, 1186.347508870118, 16899.831001690072, 17688.251402784135, 17725.202365893565, 17728.493078088508, 17793.911030445022, 581423.0, 589532.0, 590122.0, 591548.0, 592367.0, 59786.0, 60260.69869650711, 60365.396346036854, 60444.0, 60508.0, 1238.4674589926237, 1353.41126609925, 1374.8556401577891, 1393.4844107680224, 1413.130924481457, 29931.401371972002, 34166.14584635404, 34457.82771086128, 34471.82764086164, 34996.300073998886, 51735.0, 53154.20268695895, 53158.0, 53220.73389633027, 53292.0, 325232.0, 326588.0, 326785.0, 327177.0, 329128.0, 25024.499510009333, 28004.85997569999, 28706.0, 29106.7089329104, 29189.41621167607, 47725.0, 48576.75711621419, 48592.0, 49045.75477122592, 49600.0, 41269.58730412657, 41429.79285103676, 42398.36402454027, 43562.34656480092, 44046.77976610096, 41748.3737743928, 41915.0, 42647.0, 43433.565664342954, 43908.78045609751, 31723.682763172073, 41286.1742765149, 41761.0, 42198.0, 44365.33451998287, 36189.457158143174, 37930.24139517139, 37977.4303385455, 38208.23583528258, 38311.04222394463, 28573.571396429485, 28655.856720716263, 28742.568861467513, 28997.565036524047, 29076.56385154182], "value": 20326.161197452016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.3369101389964, 364.7993603518068, 378.42290506976855, 386.4994831692957, 404.3207411548597, 15381.769273460906, 17615.207315670792, 19168.712469312955, 19263.133159007844, 19883.105260263288, 18225.088745562734, 18442.815571844276, 18679.71980420295, 18731.3444029459, 19184.328548500805, 5679.914801277984, 5773.393793651659, 5981.222441082653, 5985.132155837401, 5988.281406231236, 5739.799107031255, 5782.653040817543, 5783.942160578404, 5822.970885145568, 5825.621334613236, 5571.860703482425, 5626.54987600993, 5677.403872593381, 5698.173764804101, 5698.629589076718, 5643.379228284885, 5661.094224924033, 5675.574331925101, 5714.200011998323, 5778.3354914184565, 5009.974950125263, 5029.245613158019, 5073.112205364084, 5074.619403544749, 5201.791928322863, 23236.76763232363, 23360.64959025616, 23362.766372336228, 23489.53020939589, 23533.94097265627, 2370.6444033394955, 2408.903643854244, 2465.5438743832447, 2651.5890037044287, 2820.3795165063652, 14474.131552106906, 14493.347799348949, 14609.123452592772, 14701.485448009375, 15022.248887555688, 1922.7308176855252, 1930.2954421636143, 1957.4421289932443, 1989.184434381911, 2054.496648321156, 76900.0, 79060.60469697672, 80425.0, 81313.18686813115, 81767.0, 10177.389356638625, 10197.13324367437, 10285.897141028643, 10411.11505522039, 10416.687499375032, 14047.648808779863, 14066.929665351812, 14068.0, 14068.296585170701, 14083.084599501, 7812.257835505618, 7879.645415956295, 7927.286544210933, 7993.360531157494, 8015.519068855887, 7681.0, 7718.961405192938, 7784.844303113906, 7989.400794940403, 7989.880151797728, 6342.143810585604, 6412.198475190601, 6443.613383197023, 6510.121133646991, 6546.934530654633, 1840.6744151244736, 1890.1966664167949, 1894.9052547372576, 1932.5361913140746, 1948.366780796247, 903.1735961595198, 976.4287891583504, 979.1285755677453, 988.515627342597, 991.7867658453323, 18912.338068167548, 19926.402207933785, 20148.496287592636, 20236.392908212776, 20490.0, 989.5101924547251, 1015.9034891685278, 1034.6068493972243, 1064.8030114428855, 1077.5635867473686, 10192.0, 11625.6512304631, 11674.241174323643, 11710.76578468426, 11740.295582265091, 497629.0, 499912.0, 501045.0, 501716.0, 511626.0, 75081.6245918767, 79363.60318198372, 80564.59717701492, 80919.0, 84096.57951710203, 1045.816982028142, 1050.7373156710823, 1053.8629978102797, 1058.296233005043, 1060.9416482093404, 17285.827141728423, 17733.822661773218, 18074.728879066563, 18172.182251798964, 18388.540286492946, 39894.40158397568, 40125.0, 40333.596664032986, 40373.39439908345, 41140.58859411367, 52652.0, 53588.0, 53724.194137087194, 53739.73130134324, 54664.453355465936, 8277.83444331122, 8291.58542072906, 8427.662893484192, 8585.399022068395, 8841.115888411108, 13079.01907356933, 13297.80053299182, 13377.598672039854, 13502.257375844423, 13604.86395136036, 11720.472578734149, 11739.765204695688, 11761.88238117608, 11905.821412678644, 12200.0, 11510.539578417105, 11619.36093514831, 11621.186516943733, 11684.88315116838, 12189.207701499374, 11827.231229970024, 11857.940710296394, 11861.288322700666, 11913.16607837443, 11962.162648614514, 8418.0, 8440.15598440151, 8449.747865594789, 8637.093105223861, 8784.736457906272, 11730.589429369931, 11812.645620631394, 11905.166638335233, 11943.343116128697, 12000.879991199976], "value": 9317.012875279519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.474610155938, 1456.934437950292, 1525.2983627531335, 1644.4408900973667, 1776.0498133498581, 8579.227869491744, 8886.066962968893, 8993.59528821203, 9253.76865578361, 9266.629334826599, 9042.457452552835, 9176.908230917688, 9181.95409022954, 9190.908090919089, 9197.862032069525, 2288.9771102288973, 2308.988455057722, 2319.211468100845, 2325.500017496238, 2326.9185578504757, 2352.435415500276, 2371.2530552875874, 2395.2933884504114, 2403.5433267679086, 2404.0504000919627, 2370.063824789207, 2381.583222935988, 2385.71371435428, 2390.486045500217, 2398.95202095958, 2302.458922153293, 2318.7217533895955, 2324.2097686786574, 2326.685897403854, 2338.871362075085, 2281.3384118605586, 2299.1148407862925, 2307.90768369265, 2308.7806658367426, 2308.8845557722047, 8917.108289171096, 9011.504367259799, 9080.137386948229, 9081.909180908173, 9082.40964337316, 5091.974540127276, 5287.312649355559, 5310.389305229909, 5317.335333083364, 5321.148616221425, 3403.0, 3421.726261899042, 3456.861725530976, 3496.318217947501, 3497.318022985519, 1101.6089288302696, 1113.3153110836859, 1118.9776204475945, 1122.3378206857992, 1122.8708698499695, 12827.807582886264, 12903.419346129447, 12995.220286782824, 13013.414396352187, 13025.739485210242, 4316.309390497506, 4369.912601748011, 4471.6646251531265, 4506.639468842484, 4582.312653102062, 10066.295359324777, 10077.69766906994, 10077.748056298651, 10081.546330415149, 10085.546150423248, 5206.271122042917, 5215.608829337815, 5215.7913683453, 5218.66078704883, 5220.451852555503, 4281.464816897887, 4608.101420223024, 4744.217204161275, 4780.1873681474235, 4896.387951506062, 3728.3102626014274, 3789.7157713171623, 3840.0591854995146, 3856.5564960029396, 3894.5910679378826, 1062.8565143705655, 1064.8243039898484, 1094.4035500652165, 1105.0551778229658, 1107.8892110789018, 979.9755006124904, 985.1281615770096, 998.3610489286863, 1001.4241810958728, 1014.3406785589426, 6172.4136207060255, 6232.189815323979, 6268.0, 6395.20059992501, 6513.934860651428, 420.1198489165255, 425.97870106494554, 437.35271797739523, 441.4305545845887, 442.62819231845407, 4080.7959602020373, 4281.957180428218, 4318.481782186158, 4327.091310824699, 4337.696361254745, 11103.555857765761, 11206.943965280285, 11219.887801122048, 11223.943880280709, 11403.372814495116, 11091.778164436666, 11104.333739975627, 11134.777304453866, 11149.498272577754, 11163.330200187853, 7810.6875724971505, 8126.2686358226865, 8136.918630813616, 8283.29591984688, 8520.786980325418, 6066.696665166635, 6226.315105338319, 6320.178376810985, 6353.68231588428, 6447.065175549613, 10098.242631802497, 10252.846207307046, 10341.9482902585, 10345.120664743581, 10354.1198998086, 10333.070023697603, 10644.733881653021, 10781.730456738644, 10999.395033273247, 11048.060914822008, 7791.766247012599, 7996.760097197093, 8035.879461807961, 8098.0, 8192.467489613156, 8824.735257942271, 8860.468371897707, 8863.601137948679, 8865.867011994955, 8909.0, 7300.744473943387, 7304.379127774198, 7697.230276972258, 7755.0, 8025.438219324591, 7532.698692052257, 7547.773566793005, 7573.9242607573215, 7705.6147192641265, 7780.260875216845, 7009.474289428212, 7092.361687448154, 7127.2516385778745, 7134.964325178341, 7137.429005679637, 5412.512873841373, 5451.400345961862, 5470.070088084955, 5510.944890551204, 5554.4445555445745, 5540.501354878081, 5623.522000629992, 5646.520045796154, 5752.194692743103, 5865.149553314831], "value": 4601.234260519895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.7750277280948, 299.28769528522116, 303.9407315573464, 312.4859605948215, 319.16697419734487, 5049.368828896388, 5141.331626888508, 5203.089459344618, 5246.658967167136, 5247.291615631889, 5133.4609865964, 5180.378354597444, 5181.119209734345, 5208.671788693878, 5238.5023422774875, 4097.201045796071, 4097.364908439196, 4101.384792281159, 4105.384192371153, 4105.753654780723, 3923.411488276767, 4038.5355684096266, 4097.405876147956, 4102.79486025699, 4103.835846566149, 4031.3549832026883, 4031.737937034098, 4034.2334956358345, 4034.7780872052026, 4036.1927614477077, 4003.919921601581, 4029.6977726670325, 4033.608405100236, 4039.171969746195, 4043.716939814214, 3459.8443070061658, 3552.3250582389264, 3552.626974167727, 3565.4651802229873, 3578.4970312468827, 5082.23766435034, 5083.6441449098575, 5090.414602320743, 5093.236014597803, 5105.5149760772665, 4610.925083712343, 4614.746188959606, 4616.3537104805355, 4617.907641847178, 4631.698939568917, 5296.612273679806, 5308.230306605559, 5404.675719456806, 5420.593455490854, 5442.829791594826, 3881.243157584272, 3882.0, 3882.3594106972314, 3887.0, 3899.454076429302, 5632.859178520529, 5679.432056794329, 5681.153625071868, 5681.619436435356, 5684.147377893308, 3803.790791506494, 3883.37865941448, 3895.2014836958356, 3915.138669492707, 3920.1963597463023, 3944.2111577684004, 3944.2505923874373, 3947.519680119955, 3957.465742124834, 3961.2473630010204, 4540.523245059221, 4551.954480455153, 4552.544745525421, 4559.224931761609, 4562.270036794097, 5309.761060752276, 5444.156155795858, 5468.699221542774, 5482.671039737628, 5489.807856724996, 1355.4510423278589, 1378.6622277542067, 1379.2552021908057, 1391.4156054457153, 1393.136255521583, 855.9813821552333, 893.1693525021662, 894.4454438248328, 895.1317222294364, 897.2014906733012, 4661.813527458864, 4685.789139488731, 4698.976505117453, 4700.623950083985, 4741.57325840676, 4919.975400123048, 4922.409310882717, 4938.0, 4947.554720075211, 4977.303177555145, 4408.382826404306, 4688.835890743876, 4724.653473759962, 4731.432228132646, 4761.642876784185, 2636.49906517761, 2643.299525625711, 2652.721464246265, 2657.5649149459077, 2660.2418310781723, 5116.923246151311, 5134.614903882224, 5157.974210128926, 5159.458256883048, 5169.948300517022, 4692.0, 5002.774875130628, 5038.496150384932, 5048.5203905628905, 5062.367204099488, 5095.210242412358, 5097.668651537638, 5098.439171691111, 5127.512886275797, 5138.563222126161, 4944.8763780905765, 4956.355673762388, 4956.355673762388, 4960.429550601727, 4970.65205435616, 4702.7162409701, 4757.476677565534, 4850.593327935, 4899.240617704261, 4917.360743103373, 5059.86153115546, 5107.9686508789555, 5120.257562653469, 5130.563902068366, 5131.435542090442, 3664.5419322584676, 3786.7917264550715, 3786.905327366838, 3935.8622448214173, 3963.544192417909, 5562.360328562268, 5575.12880866346, 5578.406041190866, 5584.46947539983, 5586.944130558642, 5344.46555344478, 5375.881988446769, 5399.920015996738, 5404.405515393225, 5420.268263784496, 5167.457416971164, 5387.148189044852, 5402.459754024566, 5433.673979561239, 5451.182322651475, 5357.651467832605, 5373.946260537345, 5380.246765452762, 5388.568914486753, 5416.674999500043, 5354.892902142014, 5430.544092281701, 5452.672839629635, 5499.257600223918, 5505.201745746925, 5344.839654810362, 5347.598930080182, 5354.839354819362, 5359.758810853599, 5377.677339359651], "value": 3995.107660696248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.0926832191441, 741.4883730226147, 768.5926458976744, 804.9637766300518, 806.6208881825542, 15561.766573501392, 16622.75065874013, 16655.417060402888, 16660.250288737006, 16677.49967500977, 15177.0, 15268.618284542892, 15321.616959575987, 15333.156676382794, 15333.463328783495, 658.2528829778188, 780.55898417394, 798.6086817459461, 802.1256830055239, 812.0823469479479, 807.2855522862279, 817.3665409307804, 817.5748610722421, 817.6770175780563, 817.7301490508119, 866.8699695045763, 867.7743786615493, 868.1622234543664, 868.700298397052, 868.9312146060349, 693.1958927643959, 838.4675730910855, 856.9785755356104, 862.4480332587149, 865.9567021648924, 610.1640752169557, 612.3631423319742, 612.6599737145882, 613.9723712432951, 614.6127939398151, 14560.781588276184, 14649.633759156, 14650.120992740469, 14678.119312841263, 14684.0, 13991.440342386293, 14077.15537067769, 14149.221792801392, 14214.289285535786, 14473.493427729978, 12734.490620375174, 12926.935365323114, 13071.673208169872, 13120.47518099275, 13408.664783380396, 4410.404595379615, 4458.885823398007, 4554.658400619934, 4562.680612357136, 4573.451185857685, 79930.0, 80890.78663820047, 81378.18621813825, 81540.0, 81623.0, 10595.417252051211, 10725.195610329256, 10908.23642345044, 11213.607523736793, 11273.830892536618, 18923.716144257847, 19016.429507114808, 19443.4166974991, 19690.113944872515, 19754.0, 8514.276286515715, 8542.017667968263, 8585.699500517452, 8876.0, 8906.86639700405, 4620.0990806793025, 4685.625149987993, 4749.976250118727, 4752.453467851241, 4768.046390721869, 3471.2363280078343, 3537.7523573349617, 3560.3235385276716, 3568.37553428149, 3580.0870777951454, 597.5578072226608, 603.0532064658531, 632.1402892066785, 632.8101569529123, 639.2616527910271, 577.5264283287664, 661.8014595621295, 708.8582283543312, 713.1192976673804, 801.5591424716382, 9338.953305233566, 10312.381257124596, 10425.0, 10567.418791966516, 10720.678379648623, 654.9443297319781, 759.8214419611387, 774.0, 780.6292011294589, 788.873780195166, 4677.345171675968, 4825.179719447632, 5042.268871013683, 5061.0, 5140.254663073908, 129156.0, 130638.0, 131250.0, 131283.0, 135317.3234133823, 86445.0, 89715.55142224378, 107726.0, 108849.45575272231, 110096.4495177535, 84211.0, 84724.15275847162, 85880.14119858846, 87142.1285787134, 87518.56240718755, 9891.307608467338, 9892.307538472238, 9986.650467233612, 10023.016329688977, 10079.395236285847, 49531.0, 50177.74911125421, 50193.0, 51281.743591281804, 51374.0, 44574.55425445704, 45361.0, 67841.66079169573, 69022.44951716368, 74815.62592187004, 13182.472701091849, 13352.465901363837, 13432.664183395102, 13530.661733456742, 13583.864161358655, 14850.183239921907, 15184.544463666107, 15544.0, 16162.353505859634, 16193.838061619705, 14353.784693229401, 14739.484118055816, 15453.61365965815, 15754.448594299145, 15888.126153061692, 13682.52111176104, 14918.925405372904, 15001.924990374979, 15238.161901095546, 15325.693486130438, 14227.644308891946, 14365.712685746435, 14535.127892326494, 14541.41834326615, 14544.709105818036, 10922.18083643714, 11532.82700759506, 11621.6513504595, 11681.941590291994, 11721.549479492078, 11428.942855286003, 12088.576899808464, 12135.575254866391, 12233.3271670059, 12411.379431028232], "value": 7714.85936098145, "unit": "score"}], "name": "dromaeo_css", "value": 7237.585071879343, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 112.0, 112.0, 109.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 131.0, 188.0, 119.0, 119.0, 146.0, 122.0, 150.0, 122.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 159.0, 159.0, 159.0, 161.0, 160.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 102.0, 75.0, 75.0, 75.0, 76.0, 103.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 133.0, 85.0, 85.0, 85.0, 113.0, 83.0, 84.0, 130.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 149.0, 147.0, 145.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 50.0, 51.0, 51.0, 49.0, 50.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 75.0, 76.0, 76.0, 75.0, 75.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 126.0, 118.0, 118.0, 128.0, 133.0, 118.0, 160.0, 122.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 159.0, 161.0, 155.0, 159.0, 157.0, 160.0, 155.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 62.0, 62.0, 62.0, 65.0, 61.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1479.8000000000002, "alertThreshold": 2.0}]} 05:38:28 INFO - Return code: 0 05:38:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:38:28 INFO - # TBPL SUCCESS # 05:38:28 INFO - Running post-action listener: _resource_record_post_action 05:38:28 INFO - [mozharness: 2016-08-02 12:38:28.126904Z] Finished run-tests step (success) 05:38:28 INFO - Running post-run listener: _resource_record_post_run 05:38:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550731776; Read time: 8; Write time: 439388 05:38:28 INFO - TinderboxPrint: CPU usage
13.0% 05:38:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:38:28 INFO - TinderboxPrint: I/O write bytes / time
550,731,776 / 439,388 05:38:28 INFO - TinderboxPrint: CPU idle
8,272.8 (86.9%) 05:38:28 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 05:38:28 INFO - TinderboxPrint: Swap in / out
0 / 0 05:38:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258392064; Read time: 0; Write time: 235772 05:38:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 291278848; Read time: 0; Write time: 203508 05:38:28 INFO - Running post-run listener: _upload_blobber_files 05:38:28 INFO - Blob upload gear active. 05:38:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:28 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 05:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:38:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:38:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:29 INFO - (blobuploader) - INFO - Done attempting. 05:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:33 INFO - (blobuploader) - INFO - Done attempting. 05:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:38:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:34 INFO - (blobuploader) - INFO - Done attempting. 05:38:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:34 INFO - Return code: 0 05:38:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf199e9592d11af9e914a1a36d6410bffe45f8f8b362ab468b14f047aa869c14d5998d4e03c728fd81d446544f813a26ea1d3fb579dea6ca82f13cbcaeb6c932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f057f1669d6428b67c3dc9b8610c6185ac874692915ebf9d271fffbc7a82380a08efdc1565600160981638863077f197b4c43bddff02acb60b63172c69bbc44c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2910ee0774d64c9a49eda761cb4efbbfe48328a82b578fe2f4533916eb0181617b7d96f674de254571801a3a4da313518e8cf639d15230c0ae4b44c754c749d"} 05:38:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:34 INFO - Contents: 05:38:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf199e9592d11af9e914a1a36d6410bffe45f8f8b362ab468b14f047aa869c14d5998d4e03c728fd81d446544f813a26ea1d3fb579dea6ca82f13cbcaeb6c932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f057f1669d6428b67c3dc9b8610c6185ac874692915ebf9d271fffbc7a82380a08efdc1565600160981638863077f197b4c43bddff02acb60b63172c69bbc44c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2910ee0774d64c9a49eda761cb4efbbfe48328a82b578fe2f4533916eb0181617b7d96f674de254571801a3a4da313518e8cf639d15230c0ae4b44c754c749d"} 05:38:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:34 INFO - Copying logs to upload dir... 05:38:34 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.581104 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-02 05:38:34.077298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 05:38:34.080894) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf199e9592d11af9e914a1a36d6410bffe45f8f8b362ab468b14f047aa869c14d5998d4e03c728fd81d446544f813a26ea1d3fb579dea6ca82f13cbcaeb6c932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f057f1669d6428b67c3dc9b8610c6185ac874692915ebf9d271fffbc7a82380a08efdc1565600160981638863077f197b4c43bddff02acb60b63172c69bbc44c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2910ee0774d64c9a49eda761cb4efbbfe48328a82b578fe2f4533916eb0181617b7d96f674de254571801a3a4da313518e8cf639d15230c0ae4b44c754c749d"} build_url:https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/ZfDgyduUT-qtrahZtz9NbQ/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/Fx-Team/sha512/bf199e9592d11af9e914a1a36d6410bffe45f8f8b362ab468b14f047aa869c14d5998d4e03c728fd81d446544f813a26ea1d3fb579dea6ca82f13cbcaeb6c932", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f057f1669d6428b67c3dc9b8610c6185ac874692915ebf9d271fffbc7a82380a08efdc1565600160981638863077f197b4c43bddff02acb60b63172c69bbc44c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2910ee0774d64c9a49eda761cb4efbbfe48328a82b578fe2f4533916eb0181617b7d96f674de254571801a3a4da313518e8cf639d15230c0ae4b44c754c749d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 05:38:34.106883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:38:34.107234) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470139892.714355-1283931654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 05:38:34.192576) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 05:38:34.192908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 05:38:34.193271) ========= ========= Total master_lag: 0.20 =========