builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1469805057.25 results: success (0) buildid: 20160729053002 builduid: b206fb9f51eb47b7ac63cbb04b03c1f5 revision: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.249049) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.249540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.249848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.267440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.267722) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 08:10: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-29 08:10:58 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.416508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.416855) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020277 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.477598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:57.477924) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c --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 f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c --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=6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 08:10:58,248 truncating revision to first 12 chars 2016-07-29 08:10:58,248 Setting DEBUG logging. 2016-07-29 08:10:58,248 attempt 1/10 2016-07-29 08:10:58,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5f1c014ca19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 08:10:58,553 unpacking tar archive at: fx-team-f5f1c014ca19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663667 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:58.160963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:58.161327) ========= script_repo_revision: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:58.161835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:58.162142) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 08:10:58.177723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-29 08:10:58.178071) ========= /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=6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:10:59 INFO - MultiFileLogger online at 20160729 08:10:59 in /builds/slave/test 08:10:59 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 08:10:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:59 INFO - {'append_to_log': False, 08:10:59 INFO - 'base_work_dir': '/builds/slave/test', 08:10:59 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:59 INFO - 'branch': 'Fx-Team', 08:10:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:59 INFO - 'config_files': ('talos/linux_config.py',), 08:10:59 INFO - 'default_actions': ('clobber', 08:10:59 INFO - 'read-buildbot-config', 08:10:59 INFO - 'download-and-extract', 08:10:59 INFO - 'populate-webroot', 08:10:59 INFO - 'create-virtualenv', 08:10:59 INFO - 'install', 08:10:59 INFO - 'run-tests'), 08:10:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:59 INFO - 'download_minidump_stackwalk': True, 08:10:59 INFO - 'download_symbols': 'ondemand', 08:10:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:59 INFO - 'installer_path': 'installer.exe', 08:10:59 INFO - 'log_level': 'info', 08:10:59 INFO - 'log_name': 'talos', 08:10:59 INFO - 'log_to_console': True, 08:10:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:10:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:10:59 INFO - 'opt_config_files': (), 08:10:59 INFO - 'pip_index': False, 08:10:59 INFO - 'sps_profile': False, 08:10:59 INFO - 'sps_profile_interval': 0, 08:10:59 INFO - 'suite': 'dromaeojs', 08:10:59 INFO - 'system_bits': '32', 08:10:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:59 INFO - 'title': 'talos-linux64-ix-023', 08:10:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:59 INFO - 'use_talos_json': True, 08:10:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:59 INFO - 'work_dir': 'build'} 08:10:59 INFO - [mozharness: 2016-07-29 15:10:59.041864Z] Running clobber step. 08:10:59 INFO - Running pre-action listener: _resource_record_pre_action 08:10:59 INFO - Running main action method: clobber 08:10:59 INFO - rmtree: /builds/slave/test/build 08:10:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:59 INFO - Running post-action listener: _resource_record_post_action 08:10:59 INFO - [mozharness: 2016-07-29 15:10:59.513740Z] Finished clobber step (success) 08:10:59 INFO - [mozharness: 2016-07-29 15:10:59.513840Z] Running read-buildbot-config step. 08:10:59 INFO - Running pre-action listener: _resource_record_pre_action 08:10:59 INFO - Running main action method: read_buildbot_config 08:10:59 INFO - Using buildbot properties: 08:10:59 INFO - { 08:10:59 INFO - "project": "", 08:10:59 INFO - "product": "firefox", 08:10:59 INFO - "script_repo_revision": "production", 08:10:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:10:59 INFO - "repository": "", 08:10:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:10:59 INFO - "buildid": "20160729053002", 08:10:59 INFO - "pgo_build": "True", 08:10:59 INFO - "basedir": "/builds/slave/test", 08:10:59 INFO - "buildnumber": 1389, 08:10:59 INFO - "slavename": "talos-linux64-ix-023", 08:10:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:10:59 INFO - "platform": "ubuntu64_hw", 08:10:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:10:59 INFO - "branch": "fx-team", 08:10:59 INFO - "repo_path": "integration/fx-team", 08:10:59 INFO - "revision": "f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c", 08:10:59 INFO - "stage_platform": "linux64-pgo", 08:10:59 INFO - "builduid": "b206fb9f51eb47b7ac63cbb04b03c1f5", 08:10:59 INFO - "slavebuilddir": "test" 08:10:59 INFO - } 08:10:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:10:59 INFO - Running post-action listener: _resource_record_post_action 08:10:59 INFO - [mozharness: 2016-07-29 15:10:59.516273Z] Finished read-buildbot-config step (success) 08:10:59 INFO - [mozharness: 2016-07-29 15:10:59.516362Z] Running download-and-extract step. 08:10:59 INFO - Running pre-action listener: _resource_record_pre_action 08:10:59 INFO - Running main action method: download_and_extract 08:10:59 INFO - mkdir: /builds/slave/test/build/tests 08:10: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')]} 08:10:59 INFO - https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:11:01 INFO - Downloaded 1361 bytes. 08:11:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:01 INFO - Using the following test package requirements: 08:11:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'jsshell-linux-x86_64.zip'], 08:11:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:01 INFO - https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:02 INFO - Downloaded 21802412 bytes. 08:11:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:11:03 INFO - Return code: 0 08:11:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:03 INFO - https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:11 INFO - Downloaded 21802412 bytes. 08:11:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:11:12 INFO - Return code: 0 08:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:12 INFO - https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:11:13 INFO - Downloaded 14413725 bytes. 08:11:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:11:13 INFO - Return code: 0 08:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:13 INFO - https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:11:15 INFO - Downloaded 59370135 bytes. 08:11:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:15 INFO - mkdir: /builds/slave/test/properties 08:11:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:15 INFO - Contents: 08:11:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:16 INFO - Running post-action listener: _resource_record_post_action 08:11:16 INFO - Running post-action listener: set_extra_try_arguments 08:11:16 INFO - [mozharness: 2016-07-29 15:11:16.012078Z] Finished download-and-extract step (success) 08:11:16 INFO - [mozharness: 2016-07-29 15:11:16.012311Z] Running populate-webroot step. 08:11:16 INFO - Running pre-action listener: _resource_record_pre_action 08:11:16 INFO - Running main action method: populate_webroot 08:11:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:16 INFO - '--tppagecycles', 08:11:16 INFO - '7'], 08:11:16 INFO - 'tests': ['tsvgm']}}, 08:11:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['damp', 'tps']}, 08:11:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'tests': ['damp', 'tps']}, 08:11:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['dromaeo_dom']}, 08:11:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['basic_compositor_video']}, 08:11:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tsvgx', 08:11:16 INFO - 'tsvgr_opacity', 08:11:16 INFO - 'tart', 08:11:16 INFO - 'tscrollx', 08:11:16 INFO - 'cart']}, 08:11:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:16 INFO - 'tsvgr_opacity', 08:11:16 INFO - 'tart', 08:11:16 INFO - 'tscrollx', 08:11:16 INFO - 'cart']}, 08:11:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tp5o']}, 08:11:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'tests': ['tp5o']}, 08:11:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s', 08:11:16 INFO - '--xperf_path', 08:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:16 INFO - 'tests': ['tp5n']}, 08:11:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:16 INFO - 'talos_options': ['--xperf_path', 08:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:16 INFO - 'tests': ['tp5n']}}, 08:11:16 INFO - 'talos.zip': {'path': '', 08:11:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:16 INFO - Running post-action listener: _resource_record_post_action 08:11:16 INFO - [mozharness: 2016-07-29 15:11:16.031536Z] Finished populate-webroot step (success) 08:11:16 INFO - [mozharness: 2016-07-29 15:11:16.031625Z] Running create-virtualenv step. 08:11:16 INFO - Running pre-action listener: _resource_record_pre_action 08:11:16 INFO - Running main action method: create_virtualenv 08:11:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:16 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 08:11:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:16 INFO - Using real prefix '/usr' 08:11:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:18 INFO - Installing pip.................done. 08:11:18 INFO - Return code: 0 08:11:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:18 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')]} 08:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:18 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')]} 08:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:18 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:18 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 08:11:18 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 08:11:18 INFO - Using env: {'DISPLAY': ':0', 08:11:18 INFO - 'HOME': '/home/cltbld', 08:11:18 INFO - 'LANG': 'en_US.UTF-8', 08:11:18 INFO - 'LANGUAGE': 'en_US:en', 08:11:18 INFO - 'LOGNAME': 'cltbld', 08:11:18 INFO - 'MAIL': '/var/mail/cltbld', 08:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:18 INFO - 'MOZ_NO_REMOTE': '1', 08:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:18 INFO - 'NO_EM_RESTART': '1', 08:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:18 INFO - 'PWD': '/builds/slave/test', 08:11:18 INFO - 'SHELL': '/bin/bash', 08:11:18 INFO - 'SHLVL': '1', 08:11:18 INFO - 'TERM': 'linux', 08:11:18 INFO - 'TMOUT': '86400', 08:11:18 INFO - 'USER': 'cltbld', 08:11:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:18 INFO - '_': '/tools/buildbot/bin/python'} 08:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:18 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 08:11:18 INFO - Cleaning up... 08:11:18 INFO - Return code: 0 08:11:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:18 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')]} 08:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:18 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')]} 08:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:18 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:18 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 08:11:18 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 08:11:18 INFO - Using env: {'DISPLAY': ':0', 08:11:18 INFO - 'HOME': '/home/cltbld', 08:11:18 INFO - 'LANG': 'en_US.UTF-8', 08:11:18 INFO - 'LANGUAGE': 'en_US:en', 08:11:18 INFO - 'LOGNAME': 'cltbld', 08:11:18 INFO - 'MAIL': '/var/mail/cltbld', 08:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:18 INFO - 'MOZ_NO_REMOTE': '1', 08:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:18 INFO - 'NO_EM_RESTART': '1', 08:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:18 INFO - 'PWD': '/builds/slave/test', 08:11:18 INFO - 'SHELL': '/bin/bash', 08:11:18 INFO - 'SHLVL': '1', 08:11:18 INFO - 'TERM': 'linux', 08:11:18 INFO - 'TMOUT': '86400', 08:11:18 INFO - 'USER': 'cltbld', 08:11:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:18 INFO - '_': '/tools/buildbot/bin/python'} 08:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:19 INFO - Downloading/unpacking psutil>=3.1.1 08:11:19 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 08:11:19 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 08:11:19 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 08:11:19 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 08:11:19 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 08:11:19 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 08:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:21 INFO - Installing collected packages: psutil 08:11:21 INFO - Running setup.py install for psutil 08:11:21 INFO - building 'psutil._psutil_linux' extension 08:11:21 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 08:11:21 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 08:11:21 INFO - building 'psutil._psutil_posix' extension 08:11:21 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 08:11:21 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 08:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:21 INFO - Successfully installed psutil 08:11:21 INFO - Cleaning up... 08:11:21 INFO - Return code: 0 08:11:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:21 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')]} 08:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 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')]} 08:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:21 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 08:11:21 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 08:11:21 INFO - Using env: {'DISPLAY': ':0', 08:11:21 INFO - 'HOME': '/home/cltbld', 08:11:21 INFO - 'LANG': 'en_US.UTF-8', 08:11:21 INFO - 'LANGUAGE': 'en_US:en', 08:11:21 INFO - 'LOGNAME': 'cltbld', 08:11:21 INFO - 'MAIL': '/var/mail/cltbld', 08:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:21 INFO - 'MOZ_NO_REMOTE': '1', 08:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:21 INFO - 'NO_EM_RESTART': '1', 08:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:21 INFO - 'PWD': '/builds/slave/test', 08:11:21 INFO - 'SHELL': '/bin/bash', 08:11:21 INFO - 'SHLVL': '1', 08:11:21 INFO - 'TERM': 'linux', 08:11:21 INFO - 'TMOUT': '86400', 08:11:21 INFO - 'USER': 'cltbld', 08:11:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:21 INFO - '_': '/tools/buildbot/bin/python'} 08:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:21 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 08:11:21 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 08:11:21 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 08:11:21 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 08:11:21 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 08:11:21 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 08:11:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:23 INFO - Installing collected packages: mozsystemmonitor 08:11:23 INFO - Running setup.py install for mozsystemmonitor 08:11:23 INFO - Successfully installed mozsystemmonitor 08:11:23 INFO - Cleaning up... 08:11:23 INFO - Return code: 0 08:11:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:23 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')]} 08:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:23 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')]} 08:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:23 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:23 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 08:11:23 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 08:11:23 INFO - Using env: {'DISPLAY': ':0', 08:11:23 INFO - 'HOME': '/home/cltbld', 08:11:23 INFO - 'LANG': 'en_US.UTF-8', 08:11:23 INFO - 'LANGUAGE': 'en_US:en', 08:11:23 INFO - 'LOGNAME': 'cltbld', 08:11:23 INFO - 'MAIL': '/var/mail/cltbld', 08:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:23 INFO - 'MOZ_NO_REMOTE': '1', 08:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:23 INFO - 'NO_EM_RESTART': '1', 08:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:23 INFO - 'PWD': '/builds/slave/test', 08:11:23 INFO - 'SHELL': '/bin/bash', 08:11:23 INFO - 'SHLVL': '1', 08:11:23 INFO - 'TERM': 'linux', 08:11:23 INFO - 'TMOUT': '86400', 08:11:23 INFO - 'USER': 'cltbld', 08:11:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:23 INFO - '_': '/tools/buildbot/bin/python'} 08:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:11: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 08:11: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 08:11: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 08:11: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 08:11: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 08:11: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 08:11:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:26 INFO - warning: no files found matching '*.txt' 08:11:26 INFO - no previously-included directories found matching 'build' 08:11:26 INFO - no previously-included directories found matching 'dist' 08:11:26 INFO - no previously-included directories found matching '.git*' 08:11:26 INFO - Installing collected packages: jsonschema, functools32 08:11:26 INFO - Running setup.py install for functools32 08:11:26 INFO - warning: no files found matching '*.txt' 08:11:26 INFO - no previously-included directories found matching 'build' 08:11:26 INFO - no previously-included directories found matching 'dist' 08:11:26 INFO - no previously-included directories found matching '.git*' 08:11:26 INFO - Successfully installed jsonschema functools32 08:11:26 INFO - Cleaning up... 08:11:26 INFO - Return code: 0 08:11:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:11:26 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')]} 08:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:26 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')]} 08:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:26 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:26 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 08:11:26 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 08:11:26 INFO - Using env: {'DISPLAY': ':0', 08:11:26 INFO - 'HOME': '/home/cltbld', 08:11:26 INFO - 'LANG': 'en_US.UTF-8', 08:11:26 INFO - 'LANGUAGE': 'en_US:en', 08:11:26 INFO - 'LOGNAME': 'cltbld', 08:11:26 INFO - 'MAIL': '/var/mail/cltbld', 08:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:26 INFO - 'MOZ_NO_REMOTE': '1', 08:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:26 INFO - 'NO_EM_RESTART': '1', 08:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:26 INFO - 'PWD': '/builds/slave/test', 08:11:26 INFO - 'SHELL': '/bin/bash', 08:11:26 INFO - 'SHLVL': '1', 08:11:26 INFO - 'TERM': 'linux', 08:11:26 INFO - 'TMOUT': '86400', 08:11:26 INFO - 'USER': 'cltbld', 08:11:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:26 INFO - '_': '/tools/buildbot/bin/python'} 08:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:11:26 INFO - Cleaning up... 08:11:26 INFO - Return code: 0 08:11:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:26 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')]} 08:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:26 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')]} 08:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:26 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:26 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 08:11:26 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 08:11:26 INFO - Using env: {'DISPLAY': ':0', 08:11:26 INFO - 'HOME': '/home/cltbld', 08:11:26 INFO - 'LANG': 'en_US.UTF-8', 08:11:26 INFO - 'LANGUAGE': 'en_US:en', 08:11:26 INFO - 'LOGNAME': 'cltbld', 08:11:26 INFO - 'MAIL': '/var/mail/cltbld', 08:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:26 INFO - 'MOZ_NO_REMOTE': '1', 08:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:26 INFO - 'NO_EM_RESTART': '1', 08:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:26 INFO - 'PWD': '/builds/slave/test', 08:11:26 INFO - 'SHELL': '/bin/bash', 08:11:26 INFO - 'SHLVL': '1', 08:11:26 INFO - 'TERM': 'linux', 08:11:26 INFO - 'TMOUT': '86400', 08:11:26 INFO - 'USER': 'cltbld', 08:11:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:26 INFO - '_': '/tools/buildbot/bin/python'} 08:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:29 INFO - Downloading docopt-0.6.1.tar.gz 08:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:29 INFO - Running setup.py install for blobuploader 08:11:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:29 INFO - Running setup.py install for requests 08:11:30 INFO - Running setup.py install for docopt 08:11:30 INFO - Successfully installed blobuploader requests docopt 08:11:30 INFO - Cleaning up... 08:11:30 INFO - Return code: 0 08:11:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:30 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')]} 08:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:30 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')]} 08:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:30 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:30 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 08:11:30 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 08:11:30 INFO - Using env: {'DISPLAY': ':0', 08:11:30 INFO - 'HOME': '/home/cltbld', 08:11:30 INFO - 'LANG': 'en_US.UTF-8', 08:11:30 INFO - 'LANGUAGE': 'en_US:en', 08:11:30 INFO - 'LOGNAME': 'cltbld', 08:11:30 INFO - 'MAIL': '/var/mail/cltbld', 08:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:30 INFO - 'MOZ_NO_REMOTE': '1', 08:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:30 INFO - 'NO_EM_RESTART': '1', 08:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:30 INFO - 'PWD': '/builds/slave/test', 08:11:30 INFO - 'SHELL': '/bin/bash', 08:11:30 INFO - 'SHLVL': '1', 08:11:30 INFO - 'TERM': 'linux', 08:11:30 INFO - 'TMOUT': '86400', 08:11:30 INFO - 'USER': 'cltbld', 08:11:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:30 INFO - '_': '/tools/buildbot/bin/python'} 08:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:30 INFO - Running setup.py (path:/tmp/pip-HRMHlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:30 INFO - Running setup.py (path:/tmp/pip-FX1BqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:30 INFO - Running setup.py (path:/tmp/pip-CF5KGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:30 INFO - Running setup.py (path:/tmp/pip-epbi1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:30 INFO - Running setup.py (path:/tmp/pip-SzQROD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:30 INFO - Running setup.py (path:/tmp/pip-UwZWIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:30 INFO - Running setup.py (path:/tmp/pip-2Gxk46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:30 INFO - Running setup.py (path:/tmp/pip-d_U3Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:31 INFO - Running setup.py (path:/tmp/pip-mwMzkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:31 INFO - Running setup.py (path:/tmp/pip-OD9qio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:31 INFO - Running setup.py (path:/tmp/pip-IZTk_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:31 INFO - Running setup.py (path:/tmp/pip-zycF1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:31 INFO - Running setup.py (path:/tmp/pip-ybr5SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:31 INFO - Running setup.py (path:/tmp/pip-Clke24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:31 INFO - Running setup.py (path:/tmp/pip-Qhar61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:31 INFO - Running setup.py (path:/tmp/pip-IUH8Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:31 INFO - Running setup.py (path:/tmp/pip-_qZson-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:31 INFO - Running setup.py install for manifestparser 08:11:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Running setup.py install for mozcrash 08:11:31 INFO - Running setup.py install for mozdebug 08:11:31 INFO - Running setup.py install for mozdevice 08:11:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozfile 08:11:32 INFO - Running setup.py install for mozhttpd 08:11:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozinfo 08:11:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozInstall 08:11:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozleak 08:11:32 INFO - Running setup.py install for mozlog 08:11:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for moznetwork 08:11:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozprocess 08:11:32 INFO - Running setup.py install for mozprofile 08:11:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozrunner 08:11:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozscreenshot 08:11:33 INFO - Running setup.py install for moztest 08:11:33 INFO - Running setup.py install for mozversion 08:11:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:33 INFO - Cleaning up... 08:11:33 INFO - Return code: 0 08:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:33 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:33 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 08:11:33 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 08:11:33 INFO - Using env: {'DISPLAY': ':0', 08:11:33 INFO - 'HOME': '/home/cltbld', 08:11:33 INFO - 'LANG': 'en_US.UTF-8', 08:11:33 INFO - 'LANGUAGE': 'en_US:en', 08:11:33 INFO - 'LOGNAME': 'cltbld', 08:11:33 INFO - 'MAIL': '/var/mail/cltbld', 08:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:33 INFO - 'MOZ_NO_REMOTE': '1', 08:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:33 INFO - 'NO_EM_RESTART': '1', 08:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:33 INFO - 'PWD': '/builds/slave/test', 08:11:33 INFO - 'SHELL': '/bin/bash', 08:11:33 INFO - 'SHLVL': '1', 08:11:33 INFO - 'TERM': 'linux', 08:11:33 INFO - 'TMOUT': '86400', 08:11:33 INFO - 'USER': 'cltbld', 08:11:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:33 INFO - '_': '/tools/buildbot/bin/python'} 08:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:33 INFO - Running setup.py (path:/tmp/pip-sRtRYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:33 INFO - Running setup.py (path:/tmp/pip-ozeHCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:33 INFO - Running setup.py (path:/tmp/pip-StUQ8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:33 INFO - Running setup.py (path:/tmp/pip-uuT3pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:33 INFO - Running setup.py (path:/tmp/pip-3LqNyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:34 INFO - Running setup.py (path:/tmp/pip-G_M7LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:34 INFO - Running setup.py (path:/tmp/pip-htjeDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:34 INFO - Running setup.py (path:/tmp/pip-GSxQ4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:34 INFO - Running setup.py (path:/tmp/pip-hvognH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:34 INFO - Running setup.py (path:/tmp/pip-KFqt1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:34 INFO - Running setup.py (path:/tmp/pip-ssaHJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:34 INFO - Running setup.py (path:/tmp/pip-GEGyrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:34 INFO - Running setup.py (path:/tmp/pip-SbiYr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:34 INFO - Running setup.py (path:/tmp/pip-4dKiQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:34 INFO - Running setup.py (path:/tmp/pip-EzoCYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:34 INFO - Running setup.py (path:/tmp/pip-IVBRm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:34 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)) 08:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:34 INFO - Running setup.py (path:/tmp/pip-LopDor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:36 INFO - Downloading blessings-1.6.tar.gz 08:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:36 INFO - Installing collected packages: blessings 08:11:36 INFO - Running setup.py install for blessings 08:11:36 INFO - Successfully installed blessings 08:11:36 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:37 INFO - Reading from file tmpfile_stdout 08:11:37 INFO - Current package versions: 08:11:37 INFO - argparse == 1.2.1 08:11:37 INFO - blessings == 1.6 08:11:37 INFO - blobuploader == 1.2.4 08:11:37 INFO - docopt == 0.6.1 08:11:37 INFO - functools32 == 3.2.3-2 08:11:37 INFO - jsonschema == 2.5.1 08:11:37 INFO - manifestparser == 1.1 08:11:37 INFO - mozInstall == 1.12 08:11:37 INFO - mozcrash == 0.17 08:11:37 INFO - mozdebug == 0.1 08:11:37 INFO - mozdevice == 0.48 08:11:37 INFO - mozfile == 1.2 08:11:37 INFO - mozhttpd == 0.7 08:11:37 INFO - mozinfo == 0.9 08:11:37 INFO - mozleak == 0.1 08:11:37 INFO - mozlog == 3.3 08:11:37 INFO - moznetwork == 0.27 08:11:37 INFO - mozprocess == 0.23 08:11:37 INFO - mozprofile == 0.28 08:11:37 INFO - mozrunner == 6.12 08:11:37 INFO - mozscreenshot == 0.1 08:11:37 INFO - mozsystemmonitor == 0.3 08:11:37 INFO - moztest == 0.7 08:11:37 INFO - mozversion == 1.4 08:11:37 INFO - psutil == 3.1.1 08:11:37 INFO - requests == 1.2.3 08:11:37 INFO - wsgiref == 0.1.2 08:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:37 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')]} 08:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 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')]} 08:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:37 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 08:11:37 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 08:11:37 INFO - Using env: {'DISPLAY': ':0', 08:11:37 INFO - 'HOME': '/home/cltbld', 08:11:37 INFO - 'LANG': 'en_US.UTF-8', 08:11:37 INFO - 'LANGUAGE': 'en_US:en', 08:11:37 INFO - 'LOGNAME': 'cltbld', 08:11:37 INFO - 'MAIL': '/var/mail/cltbld', 08:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:37 INFO - 'MOZ_NO_REMOTE': '1', 08:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:37 INFO - 'NO_EM_RESTART': '1', 08:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:37 INFO - 'PWD': '/builds/slave/test', 08:11:37 INFO - 'SHELL': '/bin/bash', 08:11:37 INFO - 'SHLVL': '1', 08:11:37 INFO - 'TERM': 'linux', 08:11:37 INFO - 'TMOUT': '86400', 08:11:37 INFO - 'USER': 'cltbld', 08:11:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:37 INFO - '_': '/tools/buildbot/bin/python'} 08:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:37 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')]} 08:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 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')]} 08:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 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 0x15e5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, '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': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', '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 08:11:37 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 08:11:37 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 08:11:37 INFO - Using env: {'DISPLAY': ':0', 08:11:37 INFO - 'HOME': '/home/cltbld', 08:11:37 INFO - 'LANG': 'en_US.UTF-8', 08:11:37 INFO - 'LANGUAGE': 'en_US:en', 08:11:37 INFO - 'LOGNAME': 'cltbld', 08:11:37 INFO - 'MAIL': '/var/mail/cltbld', 08:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:37 INFO - 'MOZ_NO_REMOTE': '1', 08:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:37 INFO - 'NO_EM_RESTART': '1', 08:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:37 INFO - 'PWD': '/builds/slave/test', 08:11:37 INFO - 'SHELL': '/bin/bash', 08:11:37 INFO - 'SHLVL': '1', 08:11:37 INFO - 'TERM': 'linux', 08:11:37 INFO - 'TMOUT': '86400', 08:11:37 INFO - 'USER': 'cltbld', 08:11:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:37 INFO - '_': '/tools/buildbot/bin/python'} 08:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:37 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Running post-action listener: _resource_record_post_action 08:11:37 INFO - Running post-action listener: _start_resource_monitoring 08:11:37 INFO - Starting resource monitoring. 08:11:37 INFO - [mozharness: 2016-07-29 15:11:37.707697Z] Finished create-virtualenv step (success) 08:11:37 INFO - [mozharness: 2016-07-29 15:11:37.708143Z] Running install step. 08:11:37 INFO - Running pre-action listener: _resource_record_pre_action 08:11:37 INFO - Running main action method: install 08:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:37 INFO - Reading from file tmpfile_stdout 08:11:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:38 INFO - Reading from file tmpfile_stdout 08:11:38 INFO - Output received: 08:11:38 INFO - Usage: mozinstall [options] installer 08:11:38 INFO - Options: 08:11:38 INFO - -h, --help show this help message and exit 08:11:38 INFO - -d DEST, --destination=DEST 08:11:38 INFO - Directory to install application into. [default: 08:11:38 INFO - "/builds/slave/test"] 08:11:38 INFO - --app=APP Application being installed. [default: firefox] 08:11:38 INFO - mkdir: /builds/slave/test/build/application 08:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:11:54 INFO - Reading from file tmpfile_stdout 08:11:54 INFO - Output received: 08:11:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:11:54 INFO - Running post-action listener: _resource_record_post_action 08:11:54 INFO - [mozharness: 2016-07-29 15:11:54.945052Z] Finished install step (success) 08:11:54 INFO - [mozharness: 2016-07-29 15:11:54.945330Z] Running run-tests step. 08:11:54 INFO - Running pre-action listener: _resource_record_pre_action 08:11:54 INFO - Running main action method: run_tests 08:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:54 INFO - Python 2.7.3 08:11:54 INFO - Return code: 0 08:11:54 INFO - grabbing minidump binary from tooltool 08:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:54 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 0x18a43b0>, '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 0x18a52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:54 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 08:11:54 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 08:11:54 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 08:11:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:55 INFO - Return code: 0 08:11:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:11:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:11:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:55 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/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:11:55 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/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 08:11:55 INFO - Using env: {'DISPLAY': ':0', 08:11:55 INFO - 'HOME': '/home/cltbld', 08:11:55 INFO - 'LANG': 'en_US.UTF-8', 08:11:55 INFO - 'LANGUAGE': 'en_US:en', 08:11:55 INFO - 'LOGNAME': 'cltbld', 08:11:55 INFO - 'MAIL': '/var/mail/cltbld', 08:11:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:55 INFO - 'MOZ_NO_REMOTE': '1', 08:11:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:55 INFO - 'NO_EM_RESTART': '1', 08:11:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:55 INFO - 'PWD': '/builds/slave/test', 08:11:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:55 INFO - 'SHELL': '/bin/bash', 08:11:55 INFO - 'SHLVL': '1', 08:11:55 INFO - 'TERM': 'linux', 08:11:55 INFO - 'TMOUT': '86400', 08:11:55 INFO - 'USER': 'cltbld', 08:11:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981', 08:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:55 INFO - '_': '/tools/buildbot/bin/python'} 08:11:55 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/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:11:55 INFO - mozversion application_buildid: 20160729053002 08:11:55 INFO - mozversion application_changeset: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c 08:11:55 INFO - mozversion application_display_name: Nightly 08:11:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:55 INFO - mozversion application_name: Firefox 08:11:55 INFO - mozversion application_remotingname: firefox 08:11:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:11:55 INFO - mozversion application_vendor: Mozilla 08:11:55 INFO - mozversion application_version: 50.0a1 08:11:55 INFO - mozversion platform_buildid: 20160729053002 08:11:55 INFO - mozversion platform_changeset: f5f1c014ca19fdff1b98ca14b84fd09c48b02e7c 08:11:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:55 INFO - mozversion platform_version: 50.0a1 08:11:55 INFO - using testdate: 1469805115 08:11:55 INFO - actual date: 1469805115 08:11:55 INFO - starting webserver on 'localhost:33927' 08:11:55 INFO - SUITE-START | Running 2 tests 08:11:55 INFO - TEST-START | dromaeo_css 08:11:55 INFO - operating with platform_type : linux_ 08:11:55 INFO - Initialising browser for dromaeo_css test... 08:11:55 INFO - TEST-INFO | started process 31784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8dvft/profile http://localhost:33927/getInfo.html) 08:11:58 INFO - PROCESS | 31784 | __metrics Screen width/height:1600/1200 08:11:58 INFO - PROCESS | 31784 | colorDepth:24 08:11:58 INFO - PROCESS | 31784 | Browser inner width/height: 1024/697 08:11:58 INFO - PROCESS | 31784 | __metrics 08:11:59 INFO - PROCESS | 31784 | 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" 08:11:59 INFO - PROCESS | 31784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:00 INFO - PROCESS | 31784 | console.error: PushService: 08:12:00 INFO - PROCESS | 31784 | stateChangeProcessEnqueue: Error transitioning state 08:12:00 INFO - PROCESS | 31784 | UnknownError 08:12:00 INFO - TEST-INFO | 31784: exit 0 08:12:00 INFO - Browser initialized. 08:12:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:00 INFO - TEST-INFO | started process 31866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK8dvft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:12 INFO - PROCESS | 31866 | RSS: Main: 156069888 08:12:12 INFO - PROCESS | 31866 | 08:13:03 INFO - PROCESS | 31866 | 1469805183235 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] 08:15:12 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33927/tests/dromaeo/cssquery-ext.html) 08:15:13 INFO - PROCESS | 31866 | RSS: Main: 281792512 08:15:13 INFO - PROCESS | 31866 | 08:18:15 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-ext.html (next: http://localhost:33927/tests/dromaeo/cssquery-jquery.html) 08:18:16 INFO - PROCESS | 31866 | RSS: Main: 250507264 08:18:16 INFO - PROCESS | 31866 | 08:21:18 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33927/tests/dromaeo/cssquery-mootools.html) 08:21:18 INFO - PROCESS | 31866 | RSS: Main: 188002304 08:21:18 INFO - PROCESS | 31866 | 08:24:20 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33927/tests/dromaeo/cssquery-prototype.html) 08:24:21 INFO - PROCESS | 31866 | RSS: Main: 245108736 08:24:21 INFO - PROCESS | 31866 | 08:27:24 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33927/tests/dromaeo/cssquery-yui.html) 08:27:24 INFO - PROCESS | 31866 | RSS: Main: 187858944 08:27:24 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-yui.html (next: http://localhost:33927/tests/dromaeo/cssquery-dojo.html) 08:30:27 INFO - PROCESS | 31866 | RSS: Main: 273846272 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | __start_tp_report 08:30:27 INFO - PROCESS | 31866 | _x_x_mozilla_page_load 08:30:27 INFO - PROCESS | 31866 | _x_x_mozilla_page_load_details 08:30:27 INFO - PROCESS | 31866 | |i|pagename|runs| 08:30:27 INFO - PROCESS | 31866 | |0;dojo.html;3021.927215838378;3040.6503252126013;3045.223468015657;3053.938921221575;3074.5849310343096;5240.554552863011;5287.814926477574;5305.4164041955355;5384.030874442598;5448.645838020531;5327.094393953028;5385.892282154355;5388.595855310858;5422.132458806592;5453.127499600065;4813.831515896935;4888.217885138379;4898.926516102261;4910.803567857281;5008.223725322581;4959.975200124012;4978.6017118630425;5024.698518088926;5043.268726034723;5043.394792624872;4803.975980120077;4847.563719265283;4855.208255253208;4925.581325587329;4934.6299027572895;4848.127337079324;4854.466008739036;4855.320255164244;4922.0402021605805;4994.275830004665;4851.369321988154;4900.093482705675;4903.632227582945;4909.435414927258;4941.629377796644;5197.58419326453;5228.111221092423;5382.757775900094;5411.350637923474;5425.891482170335;5726.427357264281;5729.226554415142;5768.653880767168;5771.624844385144;5783.132530120473;5768.596198266123;5775.88448231033;5821.359650438449;5822.359540450547;5826.155207494932;5258.1849813279005;5314.707691077027;5362.946370536245;5375.59683023767;5411.729413529308;5987.79042733511;5987.850303742442;5996.640201587918;5999.700014999233;6004.699765011732;5691.004074287066;5707.143928410688;5739.62692424991;5749.195112684228;5749.568782341341;5569.164625306236;5644.350899646511;5678.886422271531;5680.857978550486;5822.097574875901;5648.491635752802;5714.085746280658;5718.599698021182;5719.113537401709;5761.135829625589;5677.120046392815;5714.942850571441;5717.799877004285;5720.2849643794525;5729.1119876419225;4290.656747460196;4324.2648749712625;4326.4159338489535;4344.695871289043;4381.978090109529;3930.1353702185475;3956.485656864647;3959.40608908666;3962.1481381503113;3962.9009274767786;5351.331083614548;5353.304070470892;5353.732313384316;5355.169948657965;5355.223492593552;5688.345840228427;5745.655260684289;5749.741261643236;5794.101914203306;5855.941440585625;5362.597805164628;5404.486573775485;5411.350637923474;5418.918716219181;5419;4767.046590681877;4950.356453661001;4953.034158339089;4961.355023846877;4993.675411098267;5929.911051334234;5951.404859514014;5997.610155339889;6026.728797204137;6097.939020609826;5785.479306862402;5818.76724930998;5821.970890145607;5825.737841797214;5835.9708201458725;5753.223314852441;6028.939710603014;6029.186059881859;6050.092486127116;6059.182010428536;5557.221988921473;5565.359983601776;5575.135853942646;5617.494425501724;5669.433056694297;5700.600957932905;5712.80005199816;5713.628614140068;5720.713964301685;5722.313322401338;5489.478499542537;5550.47270509301;5559.0827513461445;5563.082091454865;5567.610267281251;5552.305961754781;5574.247476590608;5611.326640802967;5648.181013753065;5698.54411647059;5537.224788529528;5578.63738856973;5592.552595792408;5595.944040559705;5596.188552659923;5560.054790685674;5697.658140511582;5755.424457554211;5760.222369979999;5763.9135412968;5404.459554044564;5449.591280653887;5471.753771080391;5525.668459892419;5575 08:30:27 INFO - PROCESS | 31866 | |1;ext.html;585.4643001653487;632.5003247434527;633.9492840572753;634.8127302445776;642.2934771751073;32589.185270368253;33352.83323583379;33385.49921751176;33405.66594334056;43388;41900.79049604748;46108.3083753744;46119.30821037679;46135.76932115335;46198.30702539464;8994.595243214055;9199.586018629177;9204.447733136;9205.585748641328;9207.12532309433;9024.097590240988;9111.27109831212;9121.224695900857;9122.087791220858;9124.22444092253;9118.726438206832;9159.084091590854;9167.358284920057;9169.495677737721;9170.724878253663;9080;9119.49842758648;9128.680496182602;9128.817423651522;9129.817403651956;9046.683366082221;9121.270298376114;9122.08779122089;9123.406978546373;9124.635014599407;43243;43638;43668.344974825406;43709.34435983463;43723.78138109289;3573.624769399202;3642.5446819147605;3685.5208822853124;3741.2330472253125;3765.3410653135593;34753.478697819555;34764.13089672753;34900.47649285263;35112.82443587791;35115.29769404623;4359.17175736609;4526.637868970474;4583.3125031245245;4622.306654001926;4633.119707255611;334122;335988;336485;336651;337811;59502.70248648729;59983.40016599778;60180;60222.39777602255;60323;64085;64119.67940160269;64134.679326603065;64164;64203.67898160479;15937.20313984296;16157.919210404109;16172.433964811175;16172.595685107966;16180.838191618168;12300.81548776769;12309.32298723561;12310.322932238812;12315.69210769738;12363.505459781687;15304.38782448712;18367.632647347247;18486.168122434523;18523.536911577317;18599.25602975893;6460.418562329319;6543.411093001652;6663.533552651268;6734.158230221223;6892.1729392472225;818.8567000774841;874.2743522875998;945.7682867697458;1052.7631282961272;1088.50473034769;33075.66924330774;33330.500042499385;33624.49563256553;33770;33919;1059.5338051257422;1152.8040233160382;1170.6488053584062;1197.808350663907;1246.8503779546513;17280.654386912192;17593.472195834147;17605.471835844946;17701.291948321923;17737;548108;552444;552628;553211;553252;60822;61096.38903610907;61105.38894610997;61107.694461527404;61158.694206528686;1200.7358381156307;1307.5946456598485;1336.6457888659513;1340.0418700629098;1368.7673095573775;32985.34029319448;34191.4871276936;34616.65383346134;34862.30275394529;35050.9484715459;52151.73924130355;52681.736591316796;52934.205986910994;52977.4702252988;52978.470215297355;411449;412721;412942;414786;415646;27537.17388478349;27946;28227.43545129045;28389.716102839535;28595.714042859305;45679.77160114311;50471;50549.49450505448;50805.23792143047;50877.236841448146;42327.788361057996;42556;42725.14549708926;42963.785181073894;44674.77662611666;42758.358624620036;42891;43363.78318108389;44350.778246108566;44786;41910;42035.369469458594;43427.565724342356;43464;43545.78227108844;35795.64204357923;36465.81767091148;37268.81365593263;38438;38962.415563767136;26761.598576021766;29243.268918277212;29255.268618284714;29268.414631707674;29609.5558566626 08:30:27 INFO - PROCESS | 31866 | |2;jquery.html;364.49153430963787;367.70767240044177;389.90057535328486;390.32084173538044;406.05591998603234;17242;19117.23531058756;19211.807881921177;19278.90360548197;20461.18155273791;18575.628487430244;18686.43940681782;19450.610987780237;19528.804711952875;19866.602667946634;5583.5254003409655;5611.3546942101775;5751.626144300628;5752.367239603661;5760.711964401784;5500.202470641754;5511.889762204753;5613.8596535086745;5616.52259557938;5622.409646987069;5546.500814926656;5590.329160500745;5591.580631452637;5601.663900166003;5637.408072152426;5511.366192887809;5614.578906582023;5649.322081350264;5661.1508273758855;5664.716764161796;4995.150824359867;5055.317532133152;5074.670146440507;5226.5818734501145;5264.9736751315995;13057.086003979724;13193.736125277537;13227.206367617877;13411.329433528383;13438.46246150153;2221.400221940083;2247.438140464884;2252.391854199357;2275.8862056897087;2814.5637426198973;9608.855867161998;10065.446400447972;10293.228007899363;12404.379781010914;13385.933070334586;1746.790385153777;1805.5666640006305;1866.7759868815692;1931.5416860270545;1932.1691672580785;78481.21518784853;80668.19331806665;82349;83655.5817220916;83783.5810820942;10771.6229931952;10784.460776961278;10821.188410869216;10879.075278601249;11547.538098475967;15280.923595382174;15291.464798731991;15293.082415055133;15304.923475382775;15305.311260993281;7493.66278517468;7617.238276172338;7770.106437759617;7784.766457006299;7886.566238856918;7215.891761623579;7301.2333704961275;7304;7510;7528.698852045966;4579.358889755437;4613.5386461354265;4648.209804333272;4651.62786977041;4654.185517534418;1794.443722446046;1820.6085691576375;1851.8425933795509;1903.200655724599;1940.6991916253003;855.8930133733284;974.2108891797667;988.7972965542191;1064.4571268652887;1087.483445363446;18994.62010759777;19570.608587828163;19903;19903.303384381477;20090.39728808138;950.1828427552299;958.7171784323501;972.8589354543551;987.0080569028081;1039.8440233964814;9864.506774661239;10878.238523303293;10935.125189984783;10950.233483656068;11042.116630669527;489974;496116;496435;498216;502198;90581;93605.5319723397;93725.5313723427;94465.5276723612;96199;969.5103972493987;975.6633961283488;980.5587485631637;991.5191132300828;992.2855544008303;16677.83188185528;16774.49676509707;16892.746608801124;17811;17883.463496095137;28859.42281154407;29619;41117.383239252034;41554.792226039885;41814.581854181066;54409.72795135999;56876;57611.71194144002;57763.422365775805;58426;8363.623636936474;8444;8478;8534.359923005675;8576.228139467477;12359.3820308986;13171.73656526845;13339.466421343426;13405.195688258736;13472.259025753678;11514.769704605693;11644.301341919512;11686.123540734308;11841.703957400789;12046.337451440255;11029;11421.31472111676;11540.019098376732;11542.94228528852;11655.650330490098;11114.555417783522;11808.881911181123;11835;11845.348505832262;11950.760984780081;8220.219079187467;8221.506709597443;8311.293540049164;8585.055643879294;8691.043985161501;9464.858027129736;11538.826917596074;11667.941660291644;12066.095042871644;12182.573609923611 08:30:27 INFO - PROCESS | 31866 | |3;mootools.html;1316.5852756381746;1449.9782503262447;1526.1377321813175;1650.6946214950235;1810.502111919222;8794.560271986398;9224.8616270756;9294.535273236328;9308.441493510385;9328.113829186217;9050.411723237985;9137.086291370859;9151.31365147615;9152.908470915288;9265.861012084808;2338.3101984914447;2358.422186564294;2360.468894498741;2364.4443555764383;2365.4677697518005;2369.763023697625;2377.524495100978;2435.9391015224583;2443.987780061097;2445.7554244575576;2322.454223257533;2333.101755824003;2353.1763882641026;2365.775251351119;2367.147826782357;2312.19073324336;2314.7338056123426;2335.089315167086;2341.718993720756;2364.408897775556;2264.535770167112;2269.217120093565;2278.931632051041;2280.749117597063;2283.0297123722517;8851.955740221321;9082;9090;9167.220786233178;9185.586648600829;5150.27896094547;5281.313429254211;5367.329083864517;5376.274202982587;5379.542738867201;3444.105741841977;3468.4103702370658;3542.1144713821545;3545.964540354589;3546.6098729139776;1126.0709914320719;1141.6403832792728;1176.2883455509464;1197.6047904191596;1208.106001558849;12558.623241302776;12862.292573908431;12923.612291631267;12952.028597855104;12959.416826242841;4442.844500442469;4597.931031034537;4678.157931572282;4743.45450273223;4754.643401744883;10649;10699;10736.248462607698;10736.94631526853;10738.731531711614;5265.710385928811;5324.733763311819;5324.840254792362;5325.0148722486465;5345.599080068932;4386.298192289219;4669.766511674403;4804.759762011886;4832.758362081881;4915.311856340115;3919.470871432377;4003.819828107684;4083.3670781028986;4133.8966525836495;4199.853005144805;1307.3985966455348;1322.8081928120369;1328.6611913961879;1331.4075236519657;1336.525533435636;971.577363846729;975.9902400976041;978.3885071830106;986.0681655835167;1009.369144284822;5874.530037596982;5883.235179426732;5963.701814909237;5998.1602575639445;6044.7582096716515;452.7849271596031;457.89190159812665;458.15927772537765;461.04793601213385;469.77450823604863;4072.6538244248977;4136.21411931732;4182.602652747984;4185.142045880587;4191.413202151702;11023.338599684044;11241.775164496828;11297.435128243555;11378.886211137948;11415.828762568568;11258.155638327158;11267.887321126847;11272.66182014541;11279.943600281946;11281.097512199005;8050.108224567222;8367.288780453608;8387.203215694499;8587.184217499453;8607.526586037702;5933.525317974638;6040.486558642565;6082.330943596113;6114.510839132769;6257.624542527463;9708.611655533981;9921.702348929544;10065.949670251603;10071.143952763805;10110.898891010997;9777.804443911224;9860.556274967501;9940.850887236842;9980.451075190935;9989.700308990741;7306.926930730625;7604.961975190088;7682.347000504796;7953.403494738033;8089.110197878346;8583.570821459027;8883.37816352849;8889.688860889837;8891.955540222258;8918.687845925362;7732.420068494998;7748.496347737379;7909.683612655429;8066.23370779775;8218.876716849132;7212.4951253411755;7315.378192853667;7689.692412303669;7703.614819259126;7819.921800782147;7168.390686791473;7271.381932535794;7283.526570772883;7286.380657643947;7287.27127287267;4940.382452193476;4993.350864387751;5028.472010438997;5047.924281135713;5302.098643230583;5326.840194794162;5377.946220537901;5396.109641909041;5404.351477822529;5425.186222066722 08:30:27 INFO - PROCESS | 31866 | |4;prototype.html;303.19652919762615;325.6678188247987;329.4728434504791;334.5483597143856;335.03843967812384;5195.85650681338;5220.347456567929;5278.9208161877605;5315.68105913645;5316.149416093421;5203.739813009353;5261.368635763713;5266.368035835695;5269.973650131754;5279.366476022883;4041.8989525261954;4078.5309689385654;4090.836366545335;4095.283325418055;4102.671786257092;4034.2334956358345;4100.466939297887;4118.135191609766;4159;4171.311733563958;4062.618709638722;4064.796760161995;4077.062275676596;4081.08175660477;4082.6121518455698;4047.6357127858632;4073.165001174767;4078.8980275493054;4091.2431200227757;4091.754494730326;3587.5694916609914;3594.2991116732246;3596.496490491307;3605.5853576838476;3619.7285203609836;4935.333729946447;5103.106956282672;5122.257272695476;5124.256982737519;5217.869553261161;4624.213883639789;4649.88375290617;4653.7440440775745;4662.6269898408045;4668.813247470097;5424.783008679648;5455.945440545584;5457.590680698963;5480.232767412565;5496.032142642968;3699.855123145332;3896.123372241251;3902.843886244547;3917.764934103963;3937.7046721495717;5341.996751218293;5499.862503437446;5585.74864131111;5627.015272327368;5643.351014633328;3968.7817170055923;3984.920301593952;3985.7608543487486;3986.980065099656;4011.919761604752;3867.9226415471535;3992.580779018161;4040.2525532775944;4065.5121385433345;4068.877933661995;4621.95378046222;4628.490866004737;4631.698939568917;4673.135469938073;4709.105269998689;5481.725913704299;5485.670859748428;5495.697736624444;5502.175987688598;5520.392756796749;1361.8706222908809;1373.409433943414;1382.4262930883572;1394.7977543256375;1404.6067101211677;877.5480627476854;898.3486971945288;902.0843843498853;905.2938707807921;912.885889263842;4630.402511133653;4641.721496710208;4646.744429056367;4651.790669419885;4655.301704744315;4888.315635810989;4934.235193545006;4975.328330675385;4981.651284410056;4984.180774017457;4488.192125417456;4612.262038073892;4690.624750019991;4691;4703.811847526061;2617.6466177065854;2623.7113917469064;2646.3516438472698;2646.8808903599383;2662.1214999050653;5146.768395422215;5157.252198431282;5162.909021846158;5169.948300516947;5184.351956005499;4895.31465594817;4965.205567109245;5066;5104.795808167632;5106.974465127651;5086.694798312039;5127.5897928166405;5129.999300272896;5130.307408499954;5148.665336753099;4940.456549779449;4997.9750101249265;5018.0680438030895;5022.347094877642;5039.941612261467;5005.374328208974;5334.626576139788;5368.570514358764;5517.144842549411;5562.110062389998;5775.249217601685;5803.970980145073;5819.15622234782;5820.272465941757;5841.211436456024;3951.9407208892467;4002.219567184371;4002.4196491507987;4002.6197511236387;4003.8798836034966;5395;5583.218349431164;5588.86027849307;5592.468715472024;5597;5483.8080667176455;5486.835394938158;5487.3263654585735;5491.2312276282155;5502.064649009598;5195.68825870449;5434.10337294342;5447.972760136174;5480.890382192413;5485.259489968963;5377.139657654757;5383.0579648562125;5397.325334333208;5415.2689386933835;5444.237806706985;5526.336839579116;5527.309086364205;5535.5848311376;5576.852911628971;5583.441655834384;5280.788768449373;5364.544013758874;5379.784808607612;5405.378381486179;5430.15832545956 08:30:27 INFO - PROCESS | 31866 | |5;yui.html;729.3654520567104;739.7893143756097;750.2347605442445;761.7105499910034;790.9960450197748;15020.24898755062;15678.686426271468;15939.920300398497;16068.116253606047;16126.919365403157;14829.55511334659;14946.775798363005;14948.252587370642;15016.774748378755;15068;791.1218547412368;806.995965020177;811.736185739637;812.1391325195283;812.2080971053235;673.098048614856;796.8924195233657;799.312591171592;802.7631848604647;833.2251006563893;861.3625916821538;863.1886027134505;863.2101627011277;863.7192912303526;863.753830158405;865.5628907401722;865.7402779166256;866.9783255418633;866.9956650216709;867.0592407238186;501.0305059709474;502.1764306537282;507.2188829203023;597.1252115650593;607.875385545962;14381.137131772022;15173.848261517354;15194.392224311014;15197.468088616955;15208.847911520854;14313.928430357886;14548.49080282185;14713;14790.40838366464;14850.1832399218;12402.689932751664;12453.25280483174;12546.247225166428;13670.589882303548;13758.724825503534;4525.954740452619;4557.6581756368405;4628.5371462853445;4684.063187362507;4773.832915847964;75346;75766;76910;79498;80505.19494805035;11565.942170289263;11719.824202636968;11728.296302221894;11995;12283.078769092353;22194.667079993815;22416.215432459787;22452.214172503885;22500;22504.88747556252;7931.28618424333;7938.6427610757655;8020.238077382639;8136.267735903797;8236.794080147924;4479.417675702138;4491.640668746492;4504.2793153096;4537.6143027842345;4562.612177964844;3290.967090329114;3369.2082360645227;3370.4775759756785;3371.3931492331617;3371.460566309379;611.3519669150714;611.8286879673699;623.0716232813076;626.6929204689669;631.7251995382023;655.8983357579583;656.5896314803248;658.8089454058365;660.4353277947382;687.4706476013441;8595.527246001406;8631.98496883416;8839.823203535892;9020.954895225483;9592.232621390272;649.224177108351;657.8388294867788;682.6279677575733;690.4028015766427;704.3414407528977;4510.1656193604285;4803.735794531334;4813.109574728686;4838.225883858566;4894.68184568009;61951;62740.68629656822;101396.98603013875;118295;126270.36864815617;104100;105026;106580.46709766402;106859.46570267099;108830.45584772025;83516.16483835084;85680.57159714286;85747.57126214329;87331.56334218288;87920.56039719889;8833.602487887933;8867.379283450096;9030.548472576476;9150.40522366044;9174;51517.484825152766;51824.481755181965;53067;53902.73048634732;54178.729106354214;68948.31051689418;69675.65162174156;72082.27917720756;77824.61087694525;81035.59482202551;12728.299943502825;13326.600201993568;13454.058215924792;14263;14290.57128286153;13098.476060957455;13490.392932318266;13700.109492882932;14145.080569762933;14864.554063378117;14608.85391146075;14677.92661036688;14739;14806.555803325917;14956.326965286806;14257.358418871383;14857.182854943081;14999.475018374305;15154.469593564614;15660;14478.276086195438;14762.188079655722;14784.186869722269;14987.625309367353;15508.457203997807;10697.893021069689;11063.668089957315;11132.777344452903;11325.263857849213;11500.53997840077;11506.769864602493;11789.882101178879;11809.881901181221;11830.408479575815;12316.384180791103 08:30:27 INFO - PROCESS | 31866 | __end_tp_report 08:30:27 INFO - PROCESS | 31866 | __start_cc_report 08:30:27 INFO - PROCESS | 31866 | _x_x_mozilla_cycle_collect,1066 08:30:27 INFO - PROCESS | 31866 | __end_cc_report 08:30:27 INFO - PROCESS | 31866 | __startTimestamp1469806227821__endTimestamp 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | ------- Summary: start ------- 08:30:27 INFO - PROCESS | 31866 | Number of tests: 6 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | [#0] dojo.html Cycles:165 Average:5339.50 Median:5552.31 stddev:617.85 (11.1%) stddev-sans-first:592.39 08:30:27 INFO - PROCESS | 31866 | Values: 3021.9 3040.7 3045.2 3053.9 3074.6 5240.6 5287.8 5305.4 5384.0 5448.6 5327.1 5385.9 5388.6 5422.1 5453.1 4813.8 4888.2 4898.9 4910.8 5008.2 4960.0 4978.6 5024.7 5043.3 5043.4 4804.0 4847.6 4855.2 4925.6 4934.6 4848.1 4854.5 4855.3 4922.0 4994.3 4851.4 4900.1 4903.6 4909.4 4941.6 5197.6 5228.1 5382.8 5411.4 5425.9 5726.4 5729.2 5768.7 5771.6 5783.1 5768.6 5775.9 5821.4 5822.4 5826.2 5258.2 5314.7 5362.9 5375.6 5411.7 5987.8 5987.9 5996.6 5999.7 6004.7 5691.0 5707.1 5739.6 5749.2 5749.6 5569.2 5644.4 5678.9 5680.9 5822.1 5648.5 5714.1 5718.6 5719.1 5761.1 5677.1 5714.9 5717.8 5720.3 5729.1 4290.7 4324.3 4326.4 4344.7 4382.0 3930.1 3956.5 3959.4 3962.1 3962.9 5351.3 5353.3 5353.7 5355.2 5355.2 5688.3 5745.7 5749.7 5794.1 5855.9 5362.6 5404.5 5411.4 5418.9 5419.0 4767.0 4950.4 4953.0 4961.4 4993.7 5929.9 5951.4 5997.6 6026.7 6097.9 5785.5 5818.8 5822.0 5825.7 5836.0 5753.2 6028.9 6029.2 6050.1 6059.2 5557.2 5565.4 5575.1 5617.5 5669.4 5700.6 5712.8 5713.6 5720.7 5722.3 5489.5 5550.5 5559.1 5563.1 5567.6 5552.3 5574.2 5611.3 5648.2 5698.5 5537.2 5578.6 5592.6 5595.9 5596.2 5560.1 5697.7 5755.4 5760.2 5763.9 5404.5 5449.6 5471.8 5525.7 5575.0 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | [#1] ext.html Cycles:180 Average:60239.47 Median:43303.39 stddev:117423.95 (271.2%) stddev-sans-first:117667.94 08:30:27 INFO - PROCESS | 31866 | Values: 585.5 632.5 633.9 634.8 642.3 32589.2 33352.8 33385.5 33405.7 43388.0 41900.8 46108.3 46119.3 46135.8 46198.3 8994.6 9199.6 9204.4 9205.6 9207.1 9024.1 9111.3 9121.2 9122.1 9124.2 9118.7 9159.1 9167.4 9169.5 9170.7 9080.0 9119.5 9128.7 9128.8 9129.8 9046.7 9121.3 9122.1 9123.4 9124.6 43243.0 43638.0 43668.3 43709.3 43723.8 3573.6 3642.5 3685.5 3741.2 3765.3 34753.5 34764.1 34900.5 35112.8 35115.3 4359.2 4526.6 4583.3 4622.3 4633.1 334122.0 335988.0 336485.0 336651.0 337811.0 59502.7 59983.4 60180.0 60222.4 60323.0 64085.0 64119.7 64134.7 64164.0 64203.7 15937.2 16157.9 16172.4 16172.6 16180.8 12300.8 12309.3 12310.3 12315.7 12363.5 15304.4 18367.6 18486.2 18523.5 18599.3 6460.4 6543.4 6663.5 6734.2 6892.2 818.9 874.3 945.8 1052.8 1088.5 33075.7 33330.5 33624.5 33770.0 33919.0 1059.5 1152.8 1170.6 1197.8 1246.9 17280.7 17593.5 17605.5 17701.3 17737.0 548108.0 552444.0 552628.0 553211.0 553252.0 60822.0 61096.4 61105.4 61107.7 61158.7 1200.7 1307.6 1336.6 1340.0 1368.8 32985.3 34191.5 34616.7 34862.3 35050.9 52151.7 52681.7 52934.2 52977.5 52978.5 411449.0 412721.0 412942.0 414786.0 415646.0 27537.2 27946.0 28227.4 28389.7 28595.7 45679.8 50471.0 50549.5 50805.2 50877.2 42327.8 42556.0 42725.1 42963.8 44674.8 42758.4 42891.0 43363.8 44350.8 44786.0 41910.0 42035.4 43427.6 43464.0 43545.8 35795.6 36465.8 37268.8 38438.0 38962.4 26761.6 29243.3 29255.3 29268.4 29609.6 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | [#2] jquery.html Cycles:180 Average:28759.52 Median:398.19 stddev:81927.34 (20575.0%) stddev-sans-first:82129.42 08:30:27 INFO - PROCESS | 31866 | Values: 364.5 367.7 389.9 390.3 406.1 17242.0 19117.2 19211.8 19278.9 20461.2 18575.6 18686.4 19450.6 19528.8 19866.6 5583.5 5611.4 5751.6 5752.4 5760.7 5500.2 5511.9 5613.9 5616.5 5622.4 5546.5 5590.3 5591.6 5601.7 5637.4 5511.4 5614.6 5649.3 5661.2 5664.7 4995.2 5055.3 5074.7 5226.6 5265.0 13057.1 13193.7 13227.2 13411.3 13438.5 2221.4 2247.4 2252.4 2275.9 2814.6 9608.9 10065.4 10293.2 12404.4 13385.9 1746.8 1805.6 1866.8 1931.5 1932.2 78481.2 80668.2 82349.0 83655.6 83783.6 10771.6 10784.5 10821.2 10879.1 11547.5 15280.9 15291.5 15293.1 15304.9 15305.3 7493.7 7617.2 7770.1 7784.8 7886.6 7215.9 7301.2 7304.0 7510.0 7528.7 4579.4 4613.5 4648.2 4651.6 4654.2 1794.4 1820.6 1851.8 1903.2 1940.7 855.9 974.2 988.8 1064.5 1087.5 18994.6 19570.6 19903.0 19903.3 20090.4 950.2 958.7 972.9 987.0 1039.8 9864.5 10878.2 10935.1 10950.2 11042.1 489974.0 496116.0 496435.0 498216.0 502198.0 90581.0 93605.5 93725.5 94465.5 96199.0 969.5 975.7 980.6 991.5 992.3 16677.8 16774.5 16892.7 17811.0 17883.5 28859.4 29619.0 41117.4 41554.8 41814.6 54409.7 56876.0 57611.7 57763.4 58426.0 8363.6 8444.0 8478.0 8534.4 8576.2 12359.4 13171.7 13339.5 13405.2 13472.3 11514.8 11644.3 11686.1 11841.7 12046.3 11029.0 11421.3 11540.0 11542.9 11655.7 11114.6 11808.9 11835.0 11845.3 11950.8 8220.2 8221.5 8311.3 8585.1 8691.0 9464.9 11538.8 11667.9 12066.1 12182.6 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | [#3] mootools.html Cycles:180 Average:5903.99 Median:4779.70 stddev:3411.56 (71.4%) stddev-sans-first:3403.71 08:30:27 INFO - PROCESS | 31866 | Values: 1316.6 1450.0 1526.1 1650.7 1810.5 8794.6 9224.9 9294.5 9308.4 9328.1 9050.4 9137.1 9151.3 9152.9 9265.9 2338.3 2358.4 2360.5 2364.4 2365.5 2369.8 2377.5 2435.9 2444.0 2445.8 2322.5 2333.1 2353.2 2365.8 2367.1 2312.2 2314.7 2335.1 2341.7 2364.4 2264.5 2269.2 2278.9 2280.7 2283.0 8852.0 9082.0 9090.0 9167.2 9185.6 5150.3 5281.3 5367.3 5376.3 5379.5 3444.1 3468.4 3542.1 3546.0 3546.6 1126.1 1141.6 1176.3 1197.6 1208.1 12558.6 12862.3 12923.6 12952.0 12959.4 4442.8 4597.9 4678.2 4743.5 4754.6 10649.0 10699.0 10736.2 10736.9 10738.7 5265.7 5324.7 5324.8 5325.0 5345.6 4386.3 4669.8 4804.8 4832.8 4915.3 3919.5 4003.8 4083.4 4133.9 4199.9 1307.4 1322.8 1328.7 1331.4 1336.5 971.6 976.0 978.4 986.1 1009.4 5874.5 5883.2 5963.7 5998.2 6044.8 452.8 457.9 458.2 461.0 469.8 4072.7 4136.2 4182.6 4185.1 4191.4 11023.3 11241.8 11297.4 11378.9 11415.8 11258.2 11267.9 11272.7 11279.9 11281.1 8050.1 8367.3 8387.2 8587.2 8607.5 5933.5 6040.5 6082.3 6114.5 6257.6 9708.6 9921.7 10065.9 10071.1 10110.9 9777.8 9860.6 9940.9 9980.5 9989.7 7306.9 7605.0 7682.3 7953.4 8089.1 8583.6 8883.4 8889.7 8892.0 8918.7 7732.4 7748.5 7909.7 8066.2 8218.9 7212.5 7315.4 7689.7 7703.6 7819.9 7168.4 7271.4 7283.5 7286.4 7287.3 4940.4 4993.4 5028.5 5047.9 5302.1 5326.8 5377.9 5396.1 5404.4 5425.2 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | [#4] prototype.html Cycles:180 Average:4471.73 Median:5011.72 stddev:1300.32 (25.9%) stddev-sans-first:1265.77 08:30:27 INFO - PROCESS | 31866 | Values: 303.2 325.7 329.5 334.5 335.0 5195.9 5220.3 5278.9 5315.7 5316.1 5203.7 5261.4 5266.4 5270.0 5279.4 4041.9 4078.5 4090.8 4095.3 4102.7 4034.2 4100.5 4118.1 4159.0 4171.3 4062.6 4064.8 4077.1 4081.1 4082.6 4047.6 4073.2 4078.9 4091.2 4091.8 3587.6 3594.3 3596.5 3605.6 3619.7 4935.3 5103.1 5122.3 5124.3 5217.9 4624.2 4649.9 4653.7 4662.6 4668.8 5424.8 5455.9 5457.6 5480.2 5496.0 3699.9 3896.1 3902.8 3917.8 3937.7 5342.0 5499.9 5585.7 5627.0 5643.4 3968.8 3984.9 3985.8 3987.0 4011.9 3867.9 3992.6 4040.3 4065.5 4068.9 4622.0 4628.5 4631.7 4673.1 4709.1 5481.7 5485.7 5495.7 5502.2 5520.4 1361.9 1373.4 1382.4 1394.8 1404.6 877.5 898.3 902.1 905.3 912.9 4630.4 4641.7 4646.7 4651.8 4655.3 4888.3 4934.2 4975.3 4981.7 4984.2 4488.2 4612.3 4690.6 4691.0 4703.8 2617.6 2623.7 2646.4 2646.9 2662.1 5146.8 5157.3 5162.9 5169.9 5184.4 4895.3 4965.2 5066.0 5104.8 5107.0 5086.7 5127.6 5130.0 5130.3 5148.7 4940.5 4998.0 5018.1 5022.3 5039.9 5005.4 5334.6 5368.6 5517.1 5562.1 5775.2 5804.0 5819.2 5820.3 5841.2 3951.9 4002.2 4002.4 4002.6 4003.9 5395.0 5583.2 5588.9 5592.5 5597.0 5483.8 5486.8 5487.3 5491.2 5502.1 5195.7 5434.1 5448.0 5480.9 5485.3 5377.1 5383.1 5397.3 5415.3 5444.2 5526.3 5527.3 5535.6 5576.9 5583.4 5280.8 5364.5 5379.8 5405.4 5430.2 08:30:27 INFO - PROCESS | 31866 | 08:30:27 INFO - PROCESS | 31866 | [#5] yui.html Cycles:180 Average:20652.05 Median:4595.57 stddev:29235.35 (636.2%) stddev-sans-first:29279.09 08:30:27 INFO - PROCESS | 31866 | Values: 729.4 739.8 750.2 761.7 791.0 15020.2 15678.7 15939.9 16068.1 16126.9 14829.6 14946.8 14948.3 15016.8 15068.0 791.1 807.0 811.7 812.1 812.2 673.1 796.9 799.3 802.8 833.2 861.4 863.2 863.2 863.7 863.8 865.6 865.7 867.0 867.0 867.1 501.0 502.2 507.2 597.1 607.9 14381.1 15173.8 15194.4 15197.5 15208.8 14313.9 14548.5 14713.0 14790.4 14850.2 12402.7 12453.3 12546.2 13670.6 13758.7 4526.0 4557.7 4628.5 4684.1 4773.8 75346.0 75766.0 76910.0 79498.0 80505.2 11565.9 11719.8 11728.3 11995.0 12283.1 22194.7 22416.2 22452.2 22500.0 22504.9 7931.3 7938.6 8020.2 8136.3 8236.8 4479.4 4491.6 4504.3 4537.6 4562.6 3291.0 3369.2 3370.5 3371.4 3371.5 611.4 611.8 623.1 626.7 631.7 655.9 656.6 658.8 660.4 687.5 8595.5 8632.0 8839.8 9021.0 9592.2 649.2 657.8 682.6 690.4 704.3 4510.2 4803.7 4813.1 4838.2 4894.7 61951.0 62740.7 101397.0 118295.0 126270.4 104100.0 105026.0 106580.5 106859.5 108830.5 83516.2 85680.6 85747.6 87331.6 87920.6 8833.6 8867.4 9030.5 9150.4 9174.0 51517.5 51824.5 53067.0 53902.7 54178.7 68948.3 69675.7 72082.3 77824.6 81035.6 12728.3 13326.6 13454.1 14263.0 14290.6 13098.5 13490.4 13700.1 14145.1 14864.6 14608.9 14677.9 14739.0 14806.6 14956.3 14257.4 14857.2 14999.5 15154.5 15660.0 14478.3 14762.2 14784.2 14987.6 15508.5 10697.9 11063.7 11132.8 11325.3 11500.5 11506.8 11789.9 11809.9 11830.4 12316.4 08:30:27 INFO - PROCESS | 31866 | -------- Summary: end -------- 08:30:27 INFO - PROCESS | 31866 | 08:30:28 INFO - TEST-INFO | 31866: exit 0 08:30:28 INFO - TEST-OK | dromaeo_css | took 1113410ms 08:30:28 INFO - TEST-START | kraken 08:30:28 INFO - operating with platform_type : linux_ 08:30:28 INFO - Initialising browser for kraken test... 08:30:28 INFO - TEST-INFO | started process 32055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0YW4Do/profile http://localhost:33927/getInfo.html) 08:30:32 INFO - PROCESS | 32055 | __metrics Screen width/height:1600/1200 08:30:32 INFO - PROCESS | 32055 | colorDepth:24 08:30:32 INFO - PROCESS | 32055 | Browser inner width/height: 1024/697 08:30:32 INFO - PROCESS | 32055 | __metrics 08:30:33 INFO - PROCESS | 32055 | 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" 08:30:33 INFO - PROCESS | 32055 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:33 INFO - PROCESS | 32055 | console.error: PushService: 08:30:33 INFO - PROCESS | 32055 | stateChangeProcessEnqueue: Error transitioning state 08:30:33 INFO - PROCESS | 32055 | UnknownError 08:30:34 INFO - TEST-INFO | 32055: exit 0 08:30:34 INFO - Browser initialized. 08:30:34 INFO - Running cycle 1/1 for kraken test... 08:30:34 INFO - TEST-INFO | started process 32135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0YW4Do/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:45 INFO - PROCESS | 32135 | RSS: Main: 155787264 08:30:45 INFO - PROCESS | 32135 | 08:30:48 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:49 INFO - PROCESS | 32135 | RSS: Main: 212398080 08:30:49 INFO - PROCESS | 32135 | 08:30:51 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-dft) 08:30:52 INFO - PROCESS | 32135 | RSS: Main: 190550016 08:30:52 INFO - PROCESS | 32135 | 08:30:55 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-fft) 08:30:56 INFO - PROCESS | 32135 | RSS: Main: 269565952 08:30:56 INFO - PROCESS | 32135 | 08:30:58 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-oscillator) 08:30:58 INFO - PROCESS | 32135 | RSS: Main: 179167232 08:30:58 INFO - PROCESS | 32135 | 08:31:00 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:01 INFO - PROCESS | 32135 | RSS: Main: 184025088 08:31:01 INFO - PROCESS | 32135 | 08:31:04 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33927/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:05 INFO - PROCESS | 32135 | RSS: Main: 218599424 08:31:05 INFO - PROCESS | 32135 | 08:31:08 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33927/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:09 INFO - PROCESS | 32135 | RSS: Main: 219807744 08:31:09 INFO - PROCESS | 32135 | 08:31:11 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33927/tests/kraken/driver.html?testName=json-parse-financial) 08:31:12 INFO - PROCESS | 32135 | RSS: Main: 219348992 08:31:12 INFO - PROCESS | 32135 | 08:31:14 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:14 INFO - PROCESS | 32135 | RSS: Main: 183435264 08:31:14 INFO - PROCESS | 32135 | 08:31:16 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:17 INFO - PROCESS | 32135 | RSS: Main: 187875328 08:31:17 INFO - PROCESS | 32135 | 08:31:18 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:19 INFO - PROCESS | 32135 | RSS: Main: 193904640 08:31:19 INFO - PROCESS | 32135 | 08:31:22 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:22 INFO - PROCESS | 32135 | RSS: Main: 189419520 08:31:22 INFO - PROCESS | 32135 | 08:31:25 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:26 INFO - PROCESS | 32135 | RSS: Main: 192102400 08:31:26 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33927/tests/kraken/driver.html?testName=ai-astar) 08:31:27 INFO - PROCESS | 32135 | RSS: Main: 242884608 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | __start_tp_report 08:31:27 INFO - PROCESS | 32135 | _x_x_mozilla_page_load 08:31:27 INFO - PROCESS | 32135 | _x_x_mozilla_page_load_details 08:31:27 INFO - PROCESS | 32135 | |i|pagename|runs| 08:31:27 INFO - PROCESS | 32135 | |0;ai-astar;106;112;111;110;112;113;113;111;111;113 08:31:27 INFO - PROCESS | 32135 | |1;audio-beat-detection;143;116;119;171;119;118;145;118;162;120 08:31:27 INFO - PROCESS | 32135 | |2;audio-dft;161;161;160;161;159;161;162;162;161;161 08:31:27 INFO - PROCESS | 32135 | |3;audio-fft;73;74;74;102;76;75;75;73;105;74 08:31:27 INFO - PROCESS | 32135 | |4;audio-oscillator;84;84;118;83;85;85;120;84;86;126 08:31:27 INFO - PROCESS | 32135 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;117;117;119 08:31:27 INFO - PROCESS | 32135 | |6;imaging-darkroom;146;146;147;146;146;147;146;146;145;146 08:31:27 INFO - PROCESS | 32135 | |7;imaging-desaturate;95;95;94;95;94;95;94;95;95;95 08:31:27 INFO - PROCESS | 32135 | |8;json-parse-financial;53;52;53;51;51;52;54;57;51;50 08:31:27 INFO - PROCESS | 32135 | |9;json-stringify-tinderbox;62;62;62;62;62;61;61;62;62;62 08:31:27 INFO - PROCESS | 32135 | |10;stanford-crypto-aes;84;79;76;78;76;74;75;75;75;83 08:31:27 INFO - PROCESS | 32135 | |11;stanford-crypto-ccm;133;119;118;121;122;118;119;126;155;121 08:31:27 INFO - PROCESS | 32135 | |12;stanford-crypto-pbkdf2;157;159;161;159;160;158;158;157;160;155 08:31:27 INFO - PROCESS | 32135 | |13;stanford-crypto-sha256-iterative;64;62;64;61;62;61;66;62;62;68 08:31:27 INFO - PROCESS | 32135 | __end_tp_report 08:31:27 INFO - PROCESS | 32135 | __start_cc_report 08:31:27 INFO - PROCESS | 32135 | _x_x_mozilla_cycle_collect,1650 08:31:27 INFO - PROCESS | 32135 | __end_cc_report 08:31:27 INFO - PROCESS | 32135 | __startTimestamp1469806287952__endTimestamp 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | ------- Summary: start ------- 08:31:27 INFO - PROCESS | 32135 | Number of tests: 14 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.10 (1.9%) stddev-sans-first:1.09 08:31:27 INFO - PROCESS | 32135 | Values: 106.0 112.0 111.0 110.0 112.0 113.0 113.0 111.0 111.0 113.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:131.50 stddev:20.63 (15.7%) stddev-sans-first:21.56 08:31:27 INFO - PROCESS | 32135 | Values: 143.0 116.0 119.0 171.0 119.0 118.0 145.0 118.0 162.0 120.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 08:31:27 INFO - PROCESS | 32135 | Values: 161.0 161.0 160.0 161.0 159.0 161.0 162.0 162.0 161.0 161.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.00 stddev:12.39 (16.7%) stddev-sans-first:12.87 08:31:27 INFO - PROCESS | 32135 | Values: 73.0 74.0 74.0 102.0 76.0 75.0 75.0 73.0 105.0 74.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:17.95 (21.4%) stddev-sans-first:18.55 08:31:27 INFO - PROCESS | 32135 | Values: 84.0 84.0 118.0 83.0 85.0 85.0 120.0 84.0 86.0 126.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 08:31:27 INFO - PROCESS | 32135 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 119.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:31:27 INFO - PROCESS | 32135 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:31:27 INFO - PROCESS | 32135 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:2.01 (3.8%) stddev-sans-first:2.12 08:31:27 INFO - PROCESS | 32135 | Values: 53.0 52.0 53.0 51.0 51.0 52.0 54.0 57.0 51.0 50.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:31:27 INFO - PROCESS | 32135 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 62.0 62.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:3.50 (4.6%) stddev-sans-first:2.82 08:31:27 INFO - PROCESS | 32135 | Values: 84.0 79.0 76.0 78.0 76.0 74.0 75.0 75.0 75.0 83.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:121.50 stddev:11.43 (9.4%) stddev-sans-first:11.77 08:31:27 INFO - PROCESS | 32135 | Values: 133.0 119.0 118.0 121.0 122.0 118.0 119.0 126.0 155.0 121.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:1.78 (1.1%) stddev-sans-first:1.81 08:31:27 INFO - PROCESS | 32135 | Values: 157.0 159.0 161.0 159.0 160.0 158.0 158.0 157.0 160.0 155.0 08:31:27 INFO - PROCESS | 32135 | 08:31:27 INFO - PROCESS | 32135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.30 (3.7%) stddev-sans-first:2.42 08:31:27 INFO - PROCESS | 32135 | Values: 64.0 62.0 64.0 61.0 62.0 61.0 66.0 62.0 62.0 68.0 08:31:27 INFO - PROCESS | 32135 | -------- Summary: end -------- 08:31:27 INFO - PROCESS | 32135 | 08:31:28 INFO - TEST-INFO | 32135: exit 0 08:31:28 INFO - TEST-OK | kraken | took 60358ms 08:31:28 INFO - SUITE-END | took 1173s 08:31:29 INFO - Completed test suite (00:19:33) 08:31:29 INFO - javascript benchmark 08:31:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.927215838378, 3040.6503252126013, 3045.223468015657, 3053.938921221575, 3074.5849310343096, 5240.554552863011, 5287.814926477574, 5305.4164041955355, 5384.030874442598, 5448.645838020531, 5327.094393953028, 5385.892282154355, 5388.595855310858, 5422.132458806592, 5453.127499600065, 4813.831515896935, 4888.217885138379, 4898.926516102261, 4910.803567857281, 5008.223725322581, 4959.975200124012, 4978.6017118630425, 5024.698518088926, 5043.268726034723, 5043.394792624872, 4803.975980120077, 4847.563719265283, 4855.208255253208, 4925.581325587329, 4934.6299027572895, 4848.127337079324, 4854.466008739036, 4855.320255164244, 4922.0402021605805, 4994.275830004665, 4851.369321988154, 4900.093482705675, 4903.632227582945, 4909.435414927258, 4941.629377796644, 5197.58419326453, 5228.111221092423, 5382.757775900094, 5411.350637923474, 5425.891482170335, 5726.427357264281, 5729.226554415142, 5768.653880767168, 5771.624844385144, 5783.132530120473, 5768.596198266123, 5775.88448231033, 5821.359650438449, 5822.359540450547, 5826.155207494932, 5258.1849813279005, 5314.707691077027, 5362.946370536245, 5375.59683023767, 5411.729413529308, 5987.79042733511, 5987.850303742442, 5996.640201587918, 5999.700014999233, 6004.699765011732, 5691.004074287066, 5707.143928410688, 5739.62692424991, 5749.195112684228, 5749.568782341341, 5569.164625306236, 5644.350899646511, 5678.886422271531, 5680.857978550486, 5822.097574875901, 5648.491635752802, 5714.085746280658, 5718.599698021182, 5719.113537401709, 5761.135829625589, 5677.120046392815, 5714.942850571441, 5717.799877004285, 5720.2849643794525, 5729.1119876419225, 4290.656747460196, 4324.2648749712625, 4326.4159338489535, 4344.695871289043, 4381.978090109529, 3930.1353702185475, 3956.485656864647, 3959.40608908666, 3962.1481381503113, 3962.9009274767786, 5351.331083614548, 5353.304070470892, 5353.732313384316, 5355.169948657965, 5355.223492593552, 5688.345840228427, 5745.655260684289, 5749.741261643236, 5794.101914203306, 5855.941440585625, 5362.597805164628, 5404.486573775485, 5411.350637923474, 5418.918716219181, 5419.0, 4767.046590681877, 4950.356453661001, 4953.034158339089, 4961.355023846877, 4993.675411098267, 5929.911051334234, 5951.404859514014, 5997.610155339889, 6026.728797204137, 6097.939020609826, 5785.479306862402, 5818.76724930998, 5821.970890145607, 5825.737841797214, 5835.9708201458725, 5753.223314852441, 6028.939710603014, 6029.186059881859, 6050.092486127116, 6059.182010428536, 5557.221988921473, 5565.359983601776, 5575.135853942646, 5617.494425501724, 5669.433056694297, 5700.600957932905, 5712.80005199816, 5713.628614140068, 5720.713964301685, 5722.313322401338, 5489.478499542537, 5550.47270509301, 5559.0827513461445, 5563.082091454865, 5567.610267281251, 5552.305961754781, 5574.247476590608, 5611.326640802967, 5648.181013753065, 5698.54411647059, 5537.224788529528, 5578.63738856973, 5592.552595792408, 5595.944040559705, 5596.188552659923, 5560.054790685674, 5697.658140511582, 5755.424457554211, 5760.222369979999, 5763.9135412968, 5404.459554044564, 5449.591280653887, 5471.753771080391, 5525.668459892419, 5575.0], "value": 5296.758837461357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.4643001653487, 632.5003247434527, 633.9492840572753, 634.8127302445776, 642.2934771751073, 32589.185270368253, 33352.83323583379, 33385.49921751176, 33405.66594334056, 43388.0, 41900.79049604748, 46108.3083753744, 46119.30821037679, 46135.76932115335, 46198.30702539464, 8994.595243214055, 9199.586018629177, 9204.447733136, 9205.585748641328, 9207.12532309433, 9024.097590240988, 9111.27109831212, 9121.224695900857, 9122.087791220858, 9124.22444092253, 9118.726438206832, 9159.084091590854, 9167.358284920057, 9169.495677737721, 9170.724878253663, 9080.0, 9119.49842758648, 9128.680496182602, 9128.817423651522, 9129.817403651956, 9046.683366082221, 9121.270298376114, 9122.08779122089, 9123.406978546373, 9124.635014599407, 43243.0, 43638.0, 43668.344974825406, 43709.34435983463, 43723.78138109289, 3573.624769399202, 3642.5446819147605, 3685.5208822853124, 3741.2330472253125, 3765.3410653135593, 34753.478697819555, 34764.13089672753, 34900.47649285263, 35112.82443587791, 35115.29769404623, 4359.17175736609, 4526.637868970474, 4583.3125031245245, 4622.306654001926, 4633.119707255611, 334122.0, 335988.0, 336485.0, 336651.0, 337811.0, 59502.70248648729, 59983.40016599778, 60180.0, 60222.39777602255, 60323.0, 64085.0, 64119.67940160269, 64134.679326603065, 64164.0, 64203.67898160479, 15937.20313984296, 16157.919210404109, 16172.433964811175, 16172.595685107966, 16180.838191618168, 12300.81548776769, 12309.32298723561, 12310.322932238812, 12315.69210769738, 12363.505459781687, 15304.38782448712, 18367.632647347247, 18486.168122434523, 18523.536911577317, 18599.25602975893, 6460.418562329319, 6543.411093001652, 6663.533552651268, 6734.158230221223, 6892.1729392472225, 818.8567000774841, 874.2743522875998, 945.7682867697458, 1052.7631282961272, 1088.50473034769, 33075.66924330774, 33330.500042499385, 33624.49563256553, 33770.0, 33919.0, 1059.5338051257422, 1152.8040233160382, 1170.6488053584062, 1197.808350663907, 1246.8503779546513, 17280.654386912192, 17593.472195834147, 17605.471835844946, 17701.291948321923, 17737.0, 548108.0, 552444.0, 552628.0, 553211.0, 553252.0, 60822.0, 61096.38903610907, 61105.38894610997, 61107.694461527404, 61158.694206528686, 1200.7358381156307, 1307.5946456598485, 1336.6457888659513, 1340.0418700629098, 1368.7673095573775, 32985.34029319448, 34191.4871276936, 34616.65383346134, 34862.30275394529, 35050.9484715459, 52151.73924130355, 52681.736591316796, 52934.205986910994, 52977.4702252988, 52978.470215297355, 411449.0, 412721.0, 412942.0, 414786.0, 415646.0, 27537.17388478349, 27946.0, 28227.43545129045, 28389.716102839535, 28595.714042859305, 45679.77160114311, 50471.0, 50549.49450505448, 50805.23792143047, 50877.236841448146, 42327.788361057996, 42556.0, 42725.14549708926, 42963.785181073894, 44674.77662611666, 42758.358624620036, 42891.0, 43363.78318108389, 44350.778246108566, 44786.0, 41910.0, 42035.369469458594, 43427.565724342356, 43464.0, 43545.78227108844, 35795.64204357923, 36465.81767091148, 37268.81365593263, 38438.0, 38962.415563767136, 26761.598576021766, 29243.268918277212, 29255.268618284714, 29268.414631707674, 29609.5558566626], "value": 20360.378010063396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.49153430963787, 367.70767240044177, 389.90057535328486, 390.32084173538044, 406.05591998603234, 17242.0, 19117.23531058756, 19211.807881921177, 19278.90360548197, 20461.18155273791, 18575.628487430244, 18686.43940681782, 19450.610987780237, 19528.804711952875, 19866.602667946634, 5583.5254003409655, 5611.3546942101775, 5751.626144300628, 5752.367239603661, 5760.711964401784, 5500.202470641754, 5511.889762204753, 5613.8596535086745, 5616.52259557938, 5622.409646987069, 5546.500814926656, 5590.329160500745, 5591.580631452637, 5601.663900166003, 5637.408072152426, 5511.366192887809, 5614.578906582023, 5649.322081350264, 5661.1508273758855, 5664.716764161796, 4995.150824359867, 5055.317532133152, 5074.670146440507, 5226.5818734501145, 5264.9736751315995, 13057.086003979724, 13193.736125277537, 13227.206367617877, 13411.329433528383, 13438.46246150153, 2221.400221940083, 2247.438140464884, 2252.391854199357, 2275.8862056897087, 2814.5637426198973, 9608.855867161998, 10065.446400447972, 10293.228007899363, 12404.379781010914, 13385.933070334586, 1746.790385153777, 1805.5666640006305, 1866.7759868815692, 1931.5416860270545, 1932.1691672580785, 78481.21518784853, 80668.19331806665, 82349.0, 83655.5817220916, 83783.5810820942, 10771.6229931952, 10784.460776961278, 10821.188410869216, 10879.075278601249, 11547.538098475967, 15280.923595382174, 15291.464798731991, 15293.082415055133, 15304.923475382775, 15305.311260993281, 7493.66278517468, 7617.238276172338, 7770.106437759617, 7784.766457006299, 7886.566238856918, 7215.891761623579, 7301.2333704961275, 7304.0, 7510.0, 7528.698852045966, 4579.358889755437, 4613.5386461354265, 4648.209804333272, 4651.62786977041, 4654.185517534418, 1794.443722446046, 1820.6085691576375, 1851.8425933795509, 1903.200655724599, 1940.6991916253003, 855.8930133733284, 974.2108891797667, 988.7972965542191, 1064.4571268652887, 1087.483445363446, 18994.62010759777, 19570.608587828163, 19903.0, 19903.303384381477, 20090.39728808138, 950.1828427552299, 958.7171784323501, 972.8589354543551, 987.0080569028081, 1039.8440233964814, 9864.506774661239, 10878.238523303293, 10935.125189984783, 10950.233483656068, 11042.116630669527, 489974.0, 496116.0, 496435.0, 498216.0, 502198.0, 90581.0, 93605.5319723397, 93725.5313723427, 94465.5276723612, 96199.0, 969.5103972493987, 975.6633961283488, 980.5587485631637, 991.5191132300828, 992.2855544008303, 16677.83188185528, 16774.49676509707, 16892.746608801124, 17811.0, 17883.463496095137, 28859.42281154407, 29619.0, 41117.383239252034, 41554.792226039885, 41814.581854181066, 54409.72795135999, 56876.0, 57611.71194144002, 57763.422365775805, 58426.0, 8363.623636936474, 8444.0, 8478.0, 8534.359923005675, 8576.228139467477, 12359.3820308986, 13171.73656526845, 13339.466421343426, 13405.195688258736, 13472.259025753678, 11514.769704605693, 11644.301341919512, 11686.123540734308, 11841.703957400789, 12046.337451440255, 11029.0, 11421.31472111676, 11540.019098376732, 11542.94228528852, 11655.650330490098, 11114.555417783522, 11808.881911181123, 11835.0, 11845.348505832262, 11950.760984780081, 8220.219079187467, 8221.506709597443, 8311.293540049164, 8585.055643879294, 8691.043985161501, 9464.858027129736, 11538.826917596074, 11667.941660291644, 12066.095042871644, 12182.573609923611], "value": 8942.628716744988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.5852756381746, 1449.9782503262447, 1526.1377321813175, 1650.6946214950235, 1810.502111919222, 8794.560271986398, 9224.8616270756, 9294.535273236328, 9308.441493510385, 9328.113829186217, 9050.411723237985, 9137.086291370859, 9151.31365147615, 9152.908470915288, 9265.861012084808, 2338.3101984914447, 2358.422186564294, 2360.468894498741, 2364.4443555764383, 2365.4677697518005, 2369.763023697625, 2377.524495100978, 2435.9391015224583, 2443.987780061097, 2445.7554244575576, 2322.454223257533, 2333.101755824003, 2353.1763882641026, 2365.775251351119, 2367.147826782357, 2312.19073324336, 2314.7338056123426, 2335.089315167086, 2341.718993720756, 2364.408897775556, 2264.535770167112, 2269.217120093565, 2278.931632051041, 2280.749117597063, 2283.0297123722517, 8851.955740221321, 9082.0, 9090.0, 9167.220786233178, 9185.586648600829, 5150.27896094547, 5281.313429254211, 5367.329083864517, 5376.274202982587, 5379.542738867201, 3444.105741841977, 3468.4103702370658, 3542.1144713821545, 3545.964540354589, 3546.6098729139776, 1126.0709914320719, 1141.6403832792728, 1176.2883455509464, 1197.6047904191596, 1208.106001558849, 12558.623241302776, 12862.292573908431, 12923.612291631267, 12952.028597855104, 12959.416826242841, 4442.844500442469, 4597.931031034537, 4678.157931572282, 4743.45450273223, 4754.643401744883, 10649.0, 10699.0, 10736.248462607698, 10736.94631526853, 10738.731531711614, 5265.710385928811, 5324.733763311819, 5324.840254792362, 5325.0148722486465, 5345.599080068932, 4386.298192289219, 4669.766511674403, 4804.759762011886, 4832.758362081881, 4915.311856340115, 3919.470871432377, 4003.819828107684, 4083.3670781028986, 4133.8966525836495, 4199.853005144805, 1307.3985966455348, 1322.8081928120369, 1328.6611913961879, 1331.4075236519657, 1336.525533435636, 971.577363846729, 975.9902400976041, 978.3885071830106, 986.0681655835167, 1009.369144284822, 5874.530037596982, 5883.235179426732, 5963.701814909237, 5998.1602575639445, 6044.7582096716515, 452.7849271596031, 457.89190159812665, 458.15927772537765, 461.04793601213385, 469.77450823604863, 4072.6538244248977, 4136.21411931732, 4182.602652747984, 4185.142045880587, 4191.413202151702, 11023.338599684044, 11241.775164496828, 11297.435128243555, 11378.886211137948, 11415.828762568568, 11258.155638327158, 11267.887321126847, 11272.66182014541, 11279.943600281946, 11281.097512199005, 8050.108224567222, 8367.288780453608, 8387.203215694499, 8587.184217499453, 8607.526586037702, 5933.525317974638, 6040.486558642565, 6082.330943596113, 6114.510839132769, 6257.624542527463, 9708.611655533981, 9921.702348929544, 10065.949670251603, 10071.143952763805, 10110.898891010997, 9777.804443911224, 9860.556274967501, 9940.850887236842, 9980.451075190935, 9989.700308990741, 7306.926930730625, 7604.961975190088, 7682.347000504796, 7953.403494738033, 8089.110197878346, 8583.570821459027, 8883.37816352849, 8889.688860889837, 8891.955540222258, 8918.687845925362, 7732.420068494998, 7748.496347737379, 7909.683612655429, 8066.23370779775, 8218.876716849132, 7212.4951253411755, 7315.378192853667, 7689.692412303669, 7703.614819259126, 7819.921800782147, 7168.390686791473, 7271.381932535794, 7283.526570772883, 7286.380657643947, 7287.27127287267, 4940.382452193476, 4993.350864387751, 5028.472010438997, 5047.924281135713, 5302.098643230583, 5326.840194794162, 5377.946220537901, 5396.109641909041, 5404.351477822529, 5425.186222066722], "value": 4631.60051361298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.19652919762615, 325.6678188247987, 329.4728434504791, 334.5483597143856, 335.03843967812384, 5195.85650681338, 5220.347456567929, 5278.9208161877605, 5315.68105913645, 5316.149416093421, 5203.739813009353, 5261.368635763713, 5266.368035835695, 5269.973650131754, 5279.366476022883, 4041.8989525261954, 4078.5309689385654, 4090.836366545335, 4095.283325418055, 4102.671786257092, 4034.2334956358345, 4100.466939297887, 4118.135191609766, 4159.0, 4171.311733563958, 4062.618709638722, 4064.796760161995, 4077.062275676596, 4081.08175660477, 4082.6121518455698, 4047.6357127858632, 4073.165001174767, 4078.8980275493054, 4091.2431200227757, 4091.754494730326, 3587.5694916609914, 3594.2991116732246, 3596.496490491307, 3605.5853576838476, 3619.7285203609836, 4935.333729946447, 5103.106956282672, 5122.257272695476, 5124.256982737519, 5217.869553261161, 4624.213883639789, 4649.88375290617, 4653.7440440775745, 4662.6269898408045, 4668.813247470097, 5424.783008679648, 5455.945440545584, 5457.590680698963, 5480.232767412565, 5496.032142642968, 3699.855123145332, 3896.123372241251, 3902.843886244547, 3917.764934103963, 3937.7046721495717, 5341.996751218293, 5499.862503437446, 5585.74864131111, 5627.015272327368, 5643.351014633328, 3968.7817170055923, 3984.920301593952, 3985.7608543487486, 3986.980065099656, 4011.919761604752, 3867.9226415471535, 3992.580779018161, 4040.2525532775944, 4065.5121385433345, 4068.877933661995, 4621.95378046222, 4628.490866004737, 4631.698939568917, 4673.135469938073, 4709.105269998689, 5481.725913704299, 5485.670859748428, 5495.697736624444, 5502.175987688598, 5520.392756796749, 1361.8706222908809, 1373.409433943414, 1382.4262930883572, 1394.7977543256375, 1404.6067101211677, 877.5480627476854, 898.3486971945288, 902.0843843498853, 905.2938707807921, 912.885889263842, 4630.402511133653, 4641.721496710208, 4646.744429056367, 4651.790669419885, 4655.301704744315, 4888.315635810989, 4934.235193545006, 4975.328330675385, 4981.651284410056, 4984.180774017457, 4488.192125417456, 4612.262038073892, 4690.624750019991, 4691.0, 4703.811847526061, 2617.6466177065854, 2623.7113917469064, 2646.3516438472698, 2646.8808903599383, 2662.1214999050653, 5146.768395422215, 5157.252198431282, 5162.909021846158, 5169.948300516947, 5184.351956005499, 4895.31465594817, 4965.205567109245, 5066.0, 5104.795808167632, 5106.974465127651, 5086.694798312039, 5127.5897928166405, 5129.999300272896, 5130.307408499954, 5148.665336753099, 4940.456549779449, 4997.9750101249265, 5018.0680438030895, 5022.347094877642, 5039.941612261467, 5005.374328208974, 5334.626576139788, 5368.570514358764, 5517.144842549411, 5562.110062389998, 5775.249217601685, 5803.970980145073, 5819.15622234782, 5820.272465941757, 5841.211436456024, 3951.9407208892467, 4002.219567184371, 4002.4196491507987, 4002.6197511236387, 4003.8798836034966, 5395.0, 5583.218349431164, 5588.86027849307, 5592.468715472024, 5597.0, 5483.8080667176455, 5486.835394938158, 5487.3263654585735, 5491.2312276282155, 5502.064649009598, 5195.68825870449, 5434.10337294342, 5447.972760136174, 5480.890382192413, 5485.259489968963, 5377.139657654757, 5383.0579648562125, 5397.325334333208, 5415.2689386933835, 5444.237806706985, 5526.336839579116, 5527.309086364205, 5535.5848311376, 5576.852911628971, 5583.441655834384, 5280.788768449373, 5364.544013758874, 5379.784808607612, 5405.378381486179, 5430.15832545956], "value": 4058.204981045293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.3654520567104, 739.7893143756097, 750.2347605442445, 761.7105499910034, 790.9960450197748, 15020.24898755062, 15678.686426271468, 15939.920300398497, 16068.116253606047, 16126.919365403157, 14829.55511334659, 14946.775798363005, 14948.252587370642, 15016.774748378755, 15068.0, 791.1218547412368, 806.995965020177, 811.736185739637, 812.1391325195283, 812.2080971053235, 673.098048614856, 796.8924195233657, 799.312591171592, 802.7631848604647, 833.2251006563893, 861.3625916821538, 863.1886027134505, 863.2101627011277, 863.7192912303526, 863.753830158405, 865.5628907401722, 865.7402779166256, 866.9783255418633, 866.9956650216709, 867.0592407238186, 501.0305059709474, 502.1764306537282, 507.2188829203023, 597.1252115650593, 607.875385545962, 14381.137131772022, 15173.848261517354, 15194.392224311014, 15197.468088616955, 15208.847911520854, 14313.928430357886, 14548.49080282185, 14713.0, 14790.40838366464, 14850.1832399218, 12402.689932751664, 12453.25280483174, 12546.247225166428, 13670.589882303548, 13758.724825503534, 4525.954740452619, 4557.6581756368405, 4628.5371462853445, 4684.063187362507, 4773.832915847964, 75346.0, 75766.0, 76910.0, 79498.0, 80505.19494805035, 11565.942170289263, 11719.824202636968, 11728.296302221894, 11995.0, 12283.078769092353, 22194.667079993815, 22416.215432459787, 22452.214172503885, 22500.0, 22504.88747556252, 7931.28618424333, 7938.6427610757655, 8020.238077382639, 8136.267735903797, 8236.794080147924, 4479.417675702138, 4491.640668746492, 4504.2793153096, 4537.6143027842345, 4562.612177964844, 3290.967090329114, 3369.2082360645227, 3370.4775759756785, 3371.3931492331617, 3371.460566309379, 611.3519669150714, 611.8286879673699, 623.0716232813076, 626.6929204689669, 631.7251995382023, 655.8983357579583, 656.5896314803248, 658.8089454058365, 660.4353277947382, 687.4706476013441, 8595.527246001406, 8631.98496883416, 8839.823203535892, 9020.954895225483, 9592.232621390272, 649.224177108351, 657.8388294867788, 682.6279677575733, 690.4028015766427, 704.3414407528977, 4510.1656193604285, 4803.735794531334, 4813.109574728686, 4838.225883858566, 4894.68184568009, 61951.0, 62740.68629656822, 101396.98603013875, 118295.0, 126270.36864815617, 104100.0, 105026.0, 106580.46709766402, 106859.46570267099, 108830.45584772025, 83516.16483835084, 85680.57159714286, 85747.57126214329, 87331.56334218288, 87920.56039719889, 8833.602487887933, 8867.379283450096, 9030.548472576476, 9150.40522366044, 9174.0, 51517.484825152766, 51824.481755181965, 53067.0, 53902.73048634732, 54178.729106354214, 68948.31051689418, 69675.65162174156, 72082.27917720756, 77824.61087694525, 81035.59482202551, 12728.299943502825, 13326.600201993568, 13454.058215924792, 14263.0, 14290.57128286153, 13098.476060957455, 13490.392932318266, 13700.109492882932, 14145.080569762933, 14864.554063378117, 14608.85391146075, 14677.92661036688, 14739.0, 14806.555803325917, 14956.326965286806, 14257.358418871383, 14857.182854943081, 14999.475018374305, 15154.469593564614, 15660.0, 14478.276086195438, 14762.188079655722, 14784.186869722269, 14987.625309367353, 15508.457203997807, 10697.893021069689, 11063.668089957315, 11132.777344452903, 11325.263857849213, 11500.53997840077, 11506.769864602493, 11789.882101178879, 11809.881901181221, 11830.408479575815, 12316.384180791103], "value": 7574.5084563652845, "unit": "score"}], "name": "dromaeo_css", "value": 7182.70443828048, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 111.0, 110.0, 112.0, 113.0, 113.0, 111.0, 111.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 119.0, 171.0, 119.0, 118.0, 145.0, 118.0, 162.0, 120.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 159.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 102.0, 76.0, 75.0, 75.0, 73.0, 105.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 83.0, 85.0, 85.0, 120.0, 84.0, 86.0, 126.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 51.0, 52.0, 54.0, 57.0, 51.0, 50.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 76.0, 78.0, 76.0, 74.0, 75.0, 75.0, 75.0, 83.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 119.0, 118.0, 121.0, 122.0, 118.0, 119.0, 126.0, 155.0, 121.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 161.0, 159.0, 160.0, 158.0, 158.0, 157.0, 160.0, 155.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 61.0, 62.0, 61.0, 66.0, 62.0, 62.0, 68.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1477.5000000000002, "alertThreshold": 2.0}]} 08:31:29 INFO - Return code: 0 08:31:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:29 INFO - # TBPL SUCCESS # 08:31:29 INFO - Running post-action listener: _resource_record_post_action 08:31:29 INFO - [mozharness: 2016-07-29 15:31:29.234182Z] Finished run-tests step (success) 08:31:29 INFO - Running post-run listener: _resource_record_post_run 08:31:29 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552873984; Read time: 16; Write time: 403120 08:31:29 INFO - TinderboxPrint: CPU usage
13.0% 08:31:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:31:29 INFO - TinderboxPrint: I/O write bytes / time
552,873,984 / 403,120 08:31:29 INFO - TinderboxPrint: CPU idle
8,268.7 (87.0%) 08:31:29 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%) 08:31:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247668736; Read time: 0; Write time: 213784 08:31:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 293412864; Read time: 0; Write time: 188008 08:31:29 INFO - Running post-run listener: _upload_blobber_files 08:31:29 INFO - Blob upload gear active. 08:31:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:29 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 08:31:29 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'] 08:31:29 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 08:31:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:31:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:31 INFO - (blobuploader) - INFO - Done attempting. 08:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:31 INFO - (blobuploader) - INFO - Done attempting. 08:31:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:38 INFO - (blobuploader) - INFO - Done attempting. 08:31:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:38 INFO - Return code: 0 08:31:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/279432c22e89b31cce6b3c797269117edaeb8dc20bccb94d2a95a95a0e75716bdb8b3dfd03ccc2b4608e2b124d092a85d131a308a344504b69327d198c7cf055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec12b527aaa8072d0c1d273808dd5a34bdba2679785c852ba9e06ace68168150069b348244818dfc74b8a3c5733297b458a233faca4273fe044c57d696101e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06aad0e24713ecccac947defa5d81f294cec087ebfba054a8d618159ada2de41d5192ce46e8237f0694d00f6d271c6034efdcad5cb47fd3026714cc9c6c0bec"} 08:31:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:38 INFO - Contents: 08:31:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/279432c22e89b31cce6b3c797269117edaeb8dc20bccb94d2a95a95a0e75716bdb8b3dfd03ccc2b4608e2b124d092a85d131a308a344504b69327d198c7cf055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec12b527aaa8072d0c1d273808dd5a34bdba2679785c852ba9e06ace68168150069b348244818dfc74b8a3c5733297b458a233faca4273fe044c57d696101e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06aad0e24713ecccac947defa5d81f294cec087ebfba054a8d618159ada2de41d5192ce46e8237f0694d00f6d271c6034efdcad5cb47fd3026714cc9c6c0bec"} 08:31:38 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:38 INFO - Copying logs to upload dir... 08:31:38 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.735836 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-29 08:31:37.923741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 08:31:37.927831) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981 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/279432c22e89b31cce6b3c797269117edaeb8dc20bccb94d2a95a95a0e75716bdb8b3dfd03ccc2b4608e2b124d092a85d131a308a344504b69327d198c7cf055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec12b527aaa8072d0c1d273808dd5a34bdba2679785c852ba9e06ace68168150069b348244818dfc74b8a3c5733297b458a233faca4273fe044c57d696101e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06aad0e24713ecccac947defa5d81f294cec087ebfba054a8d618159ada2de41d5192ce46e8237f0694d00f6d271c6034efdcad5cb47fd3026714cc9c6c0bec"} build_url:https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/Dqe1HOH6TgaehvjTl9k7qg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/279432c22e89b31cce6b3c797269117edaeb8dc20bccb94d2a95a95a0e75716bdb8b3dfd03ccc2b4608e2b124d092a85d131a308a344504b69327d198c7cf055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec12b527aaa8072d0c1d273808dd5a34bdba2679785c852ba9e06ace68168150069b348244818dfc74b8a3c5733297b458a233faca4273fe044c57d696101e44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d06aad0e24713ecccac947defa5d81f294cec087ebfba054a8d618159ada2de41d5192ce46e8237f0694d00f6d271c6034efdcad5cb47fd3026714cc9c6c0bec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 08:31:37.955148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:31:37.955571) ========= 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=6d15e502d8e29d5d2676d664000001c3-1469803595.953088-253603981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 08:31:38.036621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 08:31:38.036934) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 08:31:38.037240) ========= ========= Total master_lag: 0.18 =========