builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1469441040.5 results: success (0) buildid: 20160725013328 builduid: 096f27c520f04927842adfd14bd16917 revision: 3b35d43491f5d0af16f35ea9d15aa9a451d5248f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.504789) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.505325) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.505623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.523908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.524400) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 03:04:01-- 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% 227M=0s 2016-07-25 03:04:01 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131877 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.705160) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.705495) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021289 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.746585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:00.746942) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3b35d43491f5d0af16f35ea9d15aa9a451d5248f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3b35d43491f5d0af16f35ea9d15aa9a451d5248f --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=8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 03:04:01,376 truncating revision to first 12 chars 2016-07-25 03:04:01,376 Setting DEBUG logging. 2016-07-25 03:04:01,376 attempt 1/10 2016-07-25 03:04:01,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3b35d43491f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 03:04:01,743 unpacking tar archive at: autoland-3b35d43491f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.722532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:01.490402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:01.490835) ========= script_repo_revision: 3b35d43491f5d0af16f35ea9d15aa9a451d5248f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:01.491327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:01.491611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 03:04:01.505564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-07-25 03:04:01.506065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:02 INFO - MultiFileLogger online at 20160725 03:04:02 in /builds/slave/test 03:04:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:04:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:02 INFO - {'append_to_log': False, 03:04:02 INFO - 'base_work_dir': '/builds/slave/test', 03:04:02 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:04:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:02 INFO - 'branch': 'Autoland-Non-PGO', 03:04:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:02 INFO - 'config_files': ('talos/linux_config.py',), 03:04:02 INFO - 'default_actions': ('clobber', 03:04:02 INFO - 'read-buildbot-config', 03:04:02 INFO - 'download-and-extract', 03:04:02 INFO - 'populate-webroot', 03:04:02 INFO - 'create-virtualenv', 03:04:02 INFO - 'install', 03:04:02 INFO - 'run-tests'), 03:04:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:02 INFO - 'download_minidump_stackwalk': True, 03:04:02 INFO - 'download_symbols': 'ondemand', 03:04:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:02 INFO - 'installer_path': 'installer.exe', 03:04:02 INFO - 'log_level': 'info', 03:04:02 INFO - 'log_name': 'talos', 03:04:02 INFO - 'log_to_console': True, 03:04:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:02 INFO - 'opt_config_files': (), 03:04:02 INFO - 'pip_index': False, 03:04:02 INFO - 'sps_profile': False, 03:04:02 INFO - 'sps_profile_interval': 0, 03:04:02 INFO - 'suite': 'dromaeojs', 03:04:02 INFO - 'system_bits': '32', 03:04:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:02 INFO - 'title': 'talos-linux64-ix-041', 03:04:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:02 INFO - 'use_talos_json': True, 03:04:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:02 INFO - 'work_dir': 'build'} 03:04:02 INFO - [mozharness: 2016-07-25 10:04:02.221740Z] Running clobber step. 03:04:02 INFO - Running pre-action listener: _resource_record_pre_action 03:04:02 INFO - Running main action method: clobber 03:04:02 INFO - rmtree: /builds/slave/test/build 03:04:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:03 INFO - Running post-action listener: _resource_record_post_action 03:04:03 INFO - [mozharness: 2016-07-25 10:04:03.205151Z] Finished clobber step (success) 03:04:03 INFO - [mozharness: 2016-07-25 10:04:03.205252Z] Running read-buildbot-config step. 03:04:03 INFO - Running pre-action listener: _resource_record_pre_action 03:04:03 INFO - Running main action method: read_buildbot_config 03:04:03 INFO - Using buildbot properties: 03:04:03 INFO - { 03:04:03 INFO - "project": "", 03:04:03 INFO - "product": "firefox", 03:04:03 INFO - "script_repo_revision": "production", 03:04:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:04:03 INFO - "repository": "", 03:04:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:04:03 INFO - "buildid": "20160725013328", 03:04:03 INFO - "pgo_build": "False", 03:04:03 INFO - "basedir": "/builds/slave/test", 03:04:03 INFO - "buildnumber": 97, 03:04:03 INFO - "slavename": "talos-linux64-ix-041", 03:04:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:04:03 INFO - "platform": "ubuntu64_hw", 03:04:03 INFO - "scheduler": "tests-autoland-linux64-talos", 03:04:03 INFO - "branch": "autoland", 03:04:03 INFO - "repo_path": "integration/autoland", 03:04:03 INFO - "revision": "3b35d43491f5d0af16f35ea9d15aa9a451d5248f", 03:04:03 INFO - "stage_platform": "linux64", 03:04:03 INFO - "builduid": "096f27c520f04927842adfd14bd16917", 03:04:03 INFO - "slavebuilddir": "test" 03:04:03 INFO - } 03:04:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:04:03 INFO - Running post-action listener: _resource_record_post_action 03:04:03 INFO - [mozharness: 2016-07-25 10:04:03.207686Z] Finished read-buildbot-config step (success) 03:04:03 INFO - [mozharness: 2016-07-25 10:04:03.207776Z] Running download-and-extract step. 03:04:03 INFO - Running pre-action listener: _resource_record_pre_action 03:04:03 INFO - Running main action method: download_and_extract 03:04:03 INFO - mkdir: /builds/slave/test/build/tests 03:04: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')]} 03:04:03 INFO - https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:04 INFO - Downloaded 1361 bytes. 03:04:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:04 INFO - Using the following test package requirements: 03:04:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:04:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:04:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'jsshell-linux-x86_64.zip'], 03:04:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:04:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:04:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:04:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:04:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:04:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:04 INFO - https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:06 INFO - Downloaded 22737746 bytes. 03:04:06 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'] 03:04:06 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 03:04:07 INFO - Return code: 0 03:04:07 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 03:04:07 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')]} 03:04:07 INFO - https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:26 INFO - Downloaded 22737746 bytes. 03:04:26 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'] 03:04:26 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 03:04:27 INFO - Return code: 0 03:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:27 INFO - https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:28 INFO - Downloaded 14403248 bytes. 03:04:28 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'] 03:04:28 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 03:04:29 INFO - Return code: 0 03:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:29 INFO - https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dEgnc1oqRx-ubudIE3wGnw/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 03:04:30 INFO - Downloaded 57159914 bytes. 03:04:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:30 INFO - mkdir: /builds/slave/test/properties 03:04:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:04:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:04:30 INFO - Contents: 03:04:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:31 INFO - Running post-action listener: _resource_record_post_action 03:04:31 INFO - Running post-action listener: set_extra_try_arguments 03:04:31 INFO - [mozharness: 2016-07-25 10:04:31.192136Z] Finished download-and-extract step (success) 03:04:31 INFO - [mozharness: 2016-07-25 10:04:31.192369Z] Running populate-webroot step. 03:04:31 INFO - Running pre-action listener: _resource_record_pre_action 03:04:31 INFO - Running main action method: populate_webroot 03:04:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:04:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:04:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:04:31 INFO - '--tppagecycles', 03:04:31 INFO - '7'], 03:04:31 INFO - 'tests': ['tsvgm']}}, 03:04:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:04:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:04:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:04:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:04:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['damp', 'tps']}, 03:04:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'tests': ['damp', 'tps']}, 03:04:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['dromaeo_dom']}, 03:04:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['basic_compositor_video']}, 03:04:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:04:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['a11yr', 03:04:31 INFO - 'ts_paint', 03:04:31 INFO - 'tpaint', 03:04:31 INFO - 'sessionrestore', 03:04:31 INFO - 'sessionrestore_no_auto_restore', 03:04:31 INFO - 'tabpaint']}, 03:04:31 INFO - 'other-e10s': {'tests': ['a11yr', 03:04:31 INFO - 'ts_paint', 03:04:31 INFO - 'tpaint', 03:04:31 INFO - 'sessionrestore', 03:04:31 INFO - 'sessionrestore_no_auto_restore', 03:04:31 INFO - 'tabpaint']}, 03:04:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:04:31 INFO - 'ts_paint', 03:04:31 INFO - 'tpaint', 03:04:31 INFO - 'sessionrestore', 03:04:31 INFO - 'sessionrestore_no_auto_restore', 03:04:31 INFO - 'tabpaint']}, 03:04:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:04:31 INFO - 'ts_paint', 03:04:31 INFO - 'tpaint', 03:04:31 INFO - 'sessionrestore', 03:04:31 INFO - 'sessionrestore_no_auto_restore', 03:04:31 INFO - 'tabpaint']}, 03:04:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['a11yr', 03:04:31 INFO - 'ts_paint', 03:04:31 INFO - 'tpaint', 03:04:31 INFO - 'sessionrestore', 03:04:31 INFO - 'sessionrestore_no_auto_restore', 03:04:31 INFO - 'tabpaint']}, 03:04:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['a11yr', 03:04:31 INFO - 'ts_paint', 03:04:31 INFO - 'tpaint', 03:04:31 INFO - 'sessionrestore', 03:04:31 INFO - 'sessionrestore_no_auto_restore', 03:04:31 INFO - 'tabpaint']}, 03:04:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['tsvgx', 03:04:31 INFO - 'tsvgr_opacity', 03:04:31 INFO - 'tart', 03:04:31 INFO - 'tscrollx', 03:04:31 INFO - 'cart']}, 03:04:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:04:31 INFO - 'tsvgr_opacity', 03:04:31 INFO - 'tart', 03:04:31 INFO - 'tscrollx', 03:04:31 INFO - 'cart']}, 03:04:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'talos_options': ['--disable-e10s'], 03:04:31 INFO - 'tests': ['tp5o']}, 03:04:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'tests': ['tp5o']}, 03:04:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'talos_options': ['--disable-e10s', 03:04:31 INFO - '--xperf_path', 03:04:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:31 INFO - 'tests': ['tp5n']}, 03:04:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:31 INFO - 'talos_options': ['--xperf_path', 03:04:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:31 INFO - 'tests': ['tp5n']}}, 03:04:31 INFO - 'talos.zip': {'path': '', 03:04:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:04:31 INFO - Running post-action listener: _resource_record_post_action 03:04:31 INFO - [mozharness: 2016-07-25 10:04:31.208681Z] Finished populate-webroot step (success) 03:04:31 INFO - [mozharness: 2016-07-25 10:04:31.208770Z] Running create-virtualenv step. 03:04:31 INFO - Running pre-action listener: _resource_record_pre_action 03:04:31 INFO - Running main action method: create_virtualenv 03:04:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:04:31 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 03:04:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:04:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:04:31 INFO - Using real prefix '/usr' 03:04:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:04:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:04:33 INFO - Installing pip.................done. 03:04:33 INFO - Return code: 0 03:04:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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')]} 03:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:33 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:33 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 03:04:33 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 03:04:33 INFO - Using env: {'DISPLAY': ':0', 03:04:33 INFO - 'HOME': '/home/cltbld', 03:04:33 INFO - 'LANG': 'en_US.UTF-8', 03:04:33 INFO - 'LANGUAGE': 'en_US:en', 03:04:33 INFO - 'LOGNAME': 'cltbld', 03:04:33 INFO - 'MAIL': '/var/mail/cltbld', 03:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:33 INFO - 'MOZ_NO_REMOTE': '1', 03:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:33 INFO - 'NO_EM_RESTART': '1', 03:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:33 INFO - 'PWD': '/builds/slave/test', 03:04:33 INFO - 'SHELL': '/bin/bash', 03:04:33 INFO - 'SHLVL': '1', 03:04:33 INFO - 'TERM': 'linux', 03:04:33 INFO - 'TMOUT': '86400', 03:04:33 INFO - 'USER': 'cltbld', 03:04:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:33 INFO - '_': '/tools/buildbot/bin/python'} 03:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:33 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 03:04:33 INFO - Cleaning up... 03:04:33 INFO - Return code: 0 03:04:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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')]} 03:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:33 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:33 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 03:04:33 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 03:04:33 INFO - Using env: {'DISPLAY': ':0', 03:04:33 INFO - 'HOME': '/home/cltbld', 03:04:33 INFO - 'LANG': 'en_US.UTF-8', 03:04:33 INFO - 'LANGUAGE': 'en_US:en', 03:04:33 INFO - 'LOGNAME': 'cltbld', 03:04:33 INFO - 'MAIL': '/var/mail/cltbld', 03:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:33 INFO - 'MOZ_NO_REMOTE': '1', 03:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:34 INFO - 'NO_EM_RESTART': '1', 03:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:34 INFO - 'PWD': '/builds/slave/test', 03:04:34 INFO - 'SHELL': '/bin/bash', 03:04:34 INFO - 'SHLVL': '1', 03:04:34 INFO - 'TERM': 'linux', 03:04:34 INFO - 'TMOUT': '86400', 03:04:34 INFO - 'USER': 'cltbld', 03:04:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:34 INFO - '_': '/tools/buildbot/bin/python'} 03:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:34 INFO - Downloading/unpacking psutil>=3.1.1 03:04: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 03:04: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 03:04: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 03:04: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 03:04: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 03:04: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 03:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:04:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:36 INFO - Installing collected packages: psutil 03:04:36 INFO - Running setup.py install for psutil 03:04:36 INFO - building 'psutil._psutil_linux' extension 03:04:36 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 03:04:36 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 03:04:36 INFO - building 'psutil._psutil_posix' extension 03:04:36 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 03:04:36 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 03:04:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:36 INFO - Successfully installed psutil 03:04:36 INFO - Cleaning up... 03:04:37 INFO - Return code: 0 03:04:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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')]} 03:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:04: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 mozsystemmonitor==0.3 03:04:37 INFO - Using env: {'DISPLAY': ':0', 03:04:37 INFO - 'HOME': '/home/cltbld', 03:04:37 INFO - 'LANG': 'en_US.UTF-8', 03:04:37 INFO - 'LANGUAGE': 'en_US:en', 03:04:37 INFO - 'LOGNAME': 'cltbld', 03:04:37 INFO - 'MAIL': '/var/mail/cltbld', 03:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:37 INFO - 'MOZ_NO_REMOTE': '1', 03:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:37 INFO - 'NO_EM_RESTART': '1', 03:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:37 INFO - 'PWD': '/builds/slave/test', 03:04:37 INFO - 'SHELL': '/bin/bash', 03:04:37 INFO - 'SHLVL': '1', 03:04:37 INFO - 'TERM': 'linux', 03:04:37 INFO - 'TMOUT': '86400', 03:04:37 INFO - 'USER': 'cltbld', 03:04:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:37 INFO - '_': '/tools/buildbot/bin/python'} 03:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:04:37 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 03:04:37 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 03:04:37 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 03:04:37 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 03:04:37 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 03:04:37 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 03:04:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:04:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:04:39 INFO - Installing collected packages: mozsystemmonitor 03:04:39 INFO - Running setup.py install for mozsystemmonitor 03:04:39 INFO - Successfully installed mozsystemmonitor 03:04:39 INFO - Cleaning up... 03:04:39 INFO - Return code: 0 03:04:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:39 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:39 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 03:04:39 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 03:04:39 INFO - Using env: {'DISPLAY': ':0', 03:04:39 INFO - 'HOME': '/home/cltbld', 03:04:39 INFO - 'LANG': 'en_US.UTF-8', 03:04:39 INFO - 'LANGUAGE': 'en_US:en', 03:04:39 INFO - 'LOGNAME': 'cltbld', 03:04:39 INFO - 'MAIL': '/var/mail/cltbld', 03:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:39 INFO - 'MOZ_NO_REMOTE': '1', 03:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:39 INFO - 'NO_EM_RESTART': '1', 03:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:39 INFO - 'PWD': '/builds/slave/test', 03:04:39 INFO - 'SHELL': '/bin/bash', 03:04:39 INFO - 'SHLVL': '1', 03:04:39 INFO - 'TERM': 'linux', 03:04:39 INFO - 'TMOUT': '86400', 03:04:39 INFO - 'USER': 'cltbld', 03:04:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:39 INFO - '_': '/tools/buildbot/bin/python'} 03:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:04:39 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 03:04:39 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 03:04:39 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 03:04:39 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 03:04:39 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 03:04:39 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 03:04:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:04:41 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 03:04:41 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 03:04:41 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 03:04:41 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 03:04:41 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 03:04:41 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 03:04:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:41 INFO - warning: no files found matching '*.txt' 03:04:41 INFO - no previously-included directories found matching 'build' 03:04:41 INFO - no previously-included directories found matching 'dist' 03:04:41 INFO - no previously-included directories found matching '.git*' 03:04:41 INFO - Installing collected packages: jsonschema, functools32 03:04:41 INFO - Running setup.py install for functools32 03:04:42 INFO - warning: no files found matching '*.txt' 03:04:42 INFO - no previously-included directories found matching 'build' 03:04:42 INFO - no previously-included directories found matching 'dist' 03:04:42 INFO - no previously-included directories found matching '.git*' 03:04:42 INFO - Successfully installed jsonschema functools32 03:04:42 INFO - Cleaning up... 03:04:42 INFO - Return code: 0 03:04:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:42 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:42 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 03:04:42 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 03:04:42 INFO - Using env: {'DISPLAY': ':0', 03:04:42 INFO - 'HOME': '/home/cltbld', 03:04:42 INFO - 'LANG': 'en_US.UTF-8', 03:04:42 INFO - 'LANGUAGE': 'en_US:en', 03:04:42 INFO - 'LOGNAME': 'cltbld', 03:04:42 INFO - 'MAIL': '/var/mail/cltbld', 03:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:42 INFO - 'MOZ_NO_REMOTE': '1', 03:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:42 INFO - 'NO_EM_RESTART': '1', 03:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:42 INFO - 'PWD': '/builds/slave/test', 03:04:42 INFO - 'SHELL': '/bin/bash', 03:04:42 INFO - 'SHLVL': '1', 03:04:42 INFO - 'TERM': 'linux', 03:04:42 INFO - 'TMOUT': '86400', 03:04:42 INFO - 'USER': 'cltbld', 03:04:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:42 INFO - '_': '/tools/buildbot/bin/python'} 03:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:04:42 INFO - Cleaning up... 03:04:42 INFO - Return code: 0 03:04:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:42 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:42 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 03:04:42 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 03:04:42 INFO - Using env: {'DISPLAY': ':0', 03:04:42 INFO - 'HOME': '/home/cltbld', 03:04:42 INFO - 'LANG': 'en_US.UTF-8', 03:04:42 INFO - 'LANGUAGE': 'en_US:en', 03:04:42 INFO - 'LOGNAME': 'cltbld', 03:04:42 INFO - 'MAIL': '/var/mail/cltbld', 03:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:42 INFO - 'MOZ_NO_REMOTE': '1', 03:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:42 INFO - 'NO_EM_RESTART': '1', 03:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:42 INFO - 'PWD': '/builds/slave/test', 03:04:42 INFO - 'SHELL': '/bin/bash', 03:04:42 INFO - 'SHLVL': '1', 03:04:42 INFO - 'TERM': 'linux', 03:04:42 INFO - 'TMOUT': '86400', 03:04:42 INFO - 'USER': 'cltbld', 03:04:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:42 INFO - '_': '/tools/buildbot/bin/python'} 03:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:04:42 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 03:04:42 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 03:04:42 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 03:04:42 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 03:04:42 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 03:04:42 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 03:04:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:04:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:45 INFO - Downloading docopt-0.6.1.tar.gz 03:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:04:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:04:45 INFO - Running setup.py install for blobuploader 03:04:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:04:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:04:45 INFO - Running setup.py install for requests 03:04:45 INFO - Running setup.py install for docopt 03:04:45 INFO - Successfully installed blobuploader requests docopt 03:04:45 INFO - Cleaning up... 03:04:45 INFO - Return code: 0 03:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:45 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')]} 03:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:45 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')]} 03:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:45 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:45 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 03:04:45 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 03:04:45 INFO - Using env: {'DISPLAY': ':0', 03:04:45 INFO - 'HOME': '/home/cltbld', 03:04:45 INFO - 'LANG': 'en_US.UTF-8', 03:04:45 INFO - 'LANGUAGE': 'en_US:en', 03:04:45 INFO - 'LOGNAME': 'cltbld', 03:04:45 INFO - 'MAIL': '/var/mail/cltbld', 03:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:45 INFO - 'MOZ_NO_REMOTE': '1', 03:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:45 INFO - 'NO_EM_RESTART': '1', 03:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:45 INFO - 'PWD': '/builds/slave/test', 03:04:45 INFO - 'SHELL': '/bin/bash', 03:04:45 INFO - 'SHLVL': '1', 03:04:45 INFO - 'TERM': 'linux', 03:04:45 INFO - 'TMOUT': '86400', 03:04:45 INFO - 'USER': 'cltbld', 03:04:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:45 INFO - '_': '/tools/buildbot/bin/python'} 03:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:45 INFO - Running setup.py (path:/tmp/pip-N0peDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:46 INFO - Running setup.py (path:/tmp/pip-Xhe1WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:46 INFO - Running setup.py (path:/tmp/pip-E1WeFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:46 INFO - Running setup.py (path:/tmp/pip-lSzdb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:46 INFO - Running setup.py (path:/tmp/pip-EkkJvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:46 INFO - Running setup.py (path:/tmp/pip-0BqcRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:46 INFO - Running setup.py (path:/tmp/pip-xrXmfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:46 INFO - Running setup.py (path:/tmp/pip-DanHBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:46 INFO - Running setup.py (path:/tmp/pip-zdQmLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:46 INFO - Running setup.py (path:/tmp/pip-4esfpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:46 INFO - Running setup.py (path:/tmp/pip-mSiR4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:46 INFO - Running setup.py (path:/tmp/pip-UZE6h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:46 INFO - Running setup.py (path:/tmp/pip-ZBKQas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:46 INFO - Running setup.py (path:/tmp/pip-tfRp9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:46 INFO - Running setup.py (path:/tmp/pip-TWvAv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:47 INFO - Running setup.py (path:/tmp/pip-_8CI1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:47 INFO - Running setup.py (path:/tmp/pip-Eo2SP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:47 INFO - Running setup.py install for manifestparser 03:04:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Running setup.py install for mozcrash 03:04:47 INFO - Running setup.py install for mozdebug 03:04:47 INFO - Running setup.py install for mozdevice 03:04:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Running setup.py install for mozfile 03:04:47 INFO - Running setup.py install for mozhttpd 03:04:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Running setup.py install for mozinfo 03:04:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Running setup.py install for mozInstall 03:04:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:47 INFO - Running setup.py install for mozleak 03:04:48 INFO - Running setup.py install for mozlog 03:04:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Running setup.py install for moznetwork 03:04:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Running setup.py install for mozprocess 03:04:48 INFO - Running setup.py install for mozprofile 03:04:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Running setup.py install for mozrunner 03:04:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Running setup.py install for mozscreenshot 03:04:48 INFO - Running setup.py install for moztest 03:04:48 INFO - Running setup.py install for mozversion 03:04:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:48 INFO - Cleaning up... 03:04:48 INFO - Return code: 0 03:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:48 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')]} 03:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:48 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')]} 03:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:48 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:48 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 03:04:48 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 03:04:48 INFO - Using env: {'DISPLAY': ':0', 03:04:48 INFO - 'HOME': '/home/cltbld', 03:04:48 INFO - 'LANG': 'en_US.UTF-8', 03:04:48 INFO - 'LANGUAGE': 'en_US:en', 03:04:48 INFO - 'LOGNAME': 'cltbld', 03:04:48 INFO - 'MAIL': '/var/mail/cltbld', 03:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:48 INFO - 'MOZ_NO_REMOTE': '1', 03:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:48 INFO - 'NO_EM_RESTART': '1', 03:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:48 INFO - 'PWD': '/builds/slave/test', 03:04:48 INFO - 'SHELL': '/bin/bash', 03:04:48 INFO - 'SHLVL': '1', 03:04:48 INFO - 'TERM': 'linux', 03:04:48 INFO - 'TMOUT': '86400', 03:04:48 INFO - 'USER': 'cltbld', 03:04:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:48 INFO - '_': '/tools/buildbot/bin/python'} 03:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:49 INFO - Running setup.py (path:/tmp/pip-5nuJp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:49 INFO - Running setup.py (path:/tmp/pip-IejyS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:49 INFO - Running setup.py (path:/tmp/pip-vS2K2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:49 INFO - Running setup.py (path:/tmp/pip-vdUQhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:49 INFO - Running setup.py (path:/tmp/pip-jstGYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:49 INFO - Running setup.py (path:/tmp/pip-vOT9VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:49 INFO - Running setup.py (path:/tmp/pip-evCyf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:49 INFO - Running setup.py (path:/tmp/pip-rhW4D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:49 INFO - Running setup.py (path:/tmp/pip-Lp1M9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:49 INFO - Running setup.py (path:/tmp/pip-n0VbeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:49 INFO - Running setup.py (path:/tmp/pip-50yxT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:49 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)) 03:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:49 INFO - Running setup.py (path:/tmp/pip-SUkEwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:50 INFO - Running setup.py (path:/tmp/pip-hQJkom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:50 INFO - Running setup.py (path:/tmp/pip-yjKUEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:50 INFO - Running setup.py (path:/tmp/pip-3bxS74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:50 INFO - Running setup.py (path:/tmp/pip-9pL8dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:50 INFO - Running setup.py (path:/tmp/pip-lcpyja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:50 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)) 03:04:50 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)) 03:04:50 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)) 03:04:50 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)) 03:04:50 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)) 03:04:50 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)) 03:04:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:50 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 03:04:50 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 03:04:50 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 03:04:50 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 03:04:50 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 03:04:50 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 03:04:52 INFO - Downloading blessings-1.6.tar.gz 03:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:52 INFO - Installing collected packages: blessings 03:04:52 INFO - Running setup.py install for blessings 03:04:52 INFO - Successfully installed blessings 03:04:52 INFO - Cleaning up... 03:04:52 INFO - Return code: 0 03:04:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:52 INFO - Reading from file tmpfile_stdout 03:04:52 INFO - Current package versions: 03:04:52 INFO - argparse == 1.2.1 03:04:52 INFO - blessings == 1.6 03:04:52 INFO - blobuploader == 1.2.4 03:04:52 INFO - docopt == 0.6.1 03:04:52 INFO - functools32 == 3.2.3-2 03:04:52 INFO - jsonschema == 2.5.1 03:04:52 INFO - manifestparser == 1.1 03:04:52 INFO - mozInstall == 1.12 03:04:52 INFO - mozcrash == 0.17 03:04:52 INFO - mozdebug == 0.1 03:04:52 INFO - mozdevice == 0.48 03:04:52 INFO - mozfile == 1.2 03:04:52 INFO - mozhttpd == 0.7 03:04:52 INFO - mozinfo == 0.9 03:04:52 INFO - mozleak == 0.1 03:04:52 INFO - mozlog == 3.3 03:04:52 INFO - moznetwork == 0.27 03:04:52 INFO - mozprocess == 0.23 03:04:52 INFO - mozprofile == 0.28 03:04:52 INFO - mozrunner == 6.12 03:04:52 INFO - mozscreenshot == 0.1 03:04:52 INFO - mozsystemmonitor == 0.3 03:04:52 INFO - moztest == 0.7 03:04:52 INFO - mozversion == 1.4 03:04:52 INFO - psutil == 3.1.1 03:04:52 INFO - requests == 1.2.3 03:04:52 INFO - wsgiref == 0.1.2 03:04:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:52 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')]} 03:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:52 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')]} 03:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:52 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:52 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 03:04:52 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 03:04:52 INFO - Using env: {'DISPLAY': ':0', 03:04:52 INFO - 'HOME': '/home/cltbld', 03:04:52 INFO - 'LANG': 'en_US.UTF-8', 03:04:52 INFO - 'LANGUAGE': 'en_US:en', 03:04:52 INFO - 'LOGNAME': 'cltbld', 03:04:52 INFO - 'MAIL': '/var/mail/cltbld', 03:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:52 INFO - 'MOZ_NO_REMOTE': '1', 03:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:52 INFO - 'NO_EM_RESTART': '1', 03:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:52 INFO - 'PWD': '/builds/slave/test', 03:04:52 INFO - 'SHELL': '/bin/bash', 03:04:52 INFO - 'SHLVL': '1', 03:04:52 INFO - 'TERM': 'linux', 03:04:52 INFO - 'TMOUT': '86400', 03:04:52 INFO - 'USER': 'cltbld', 03:04:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:52 INFO - '_': '/tools/buildbot/bin/python'} 03:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 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)) 03:04:52 INFO - Cleaning up... 03:04:52 INFO - Return code: 0 03:04:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:04:52 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')]} 03:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:52 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')]} 03:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:52 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 0xf80030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', '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 03:04:52 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 03:04:52 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 03:04:52 INFO - Using env: {'DISPLAY': ':0', 03:04:52 INFO - 'HOME': '/home/cltbld', 03:04:52 INFO - 'LANG': 'en_US.UTF-8', 03:04:52 INFO - 'LANGUAGE': 'en_US:en', 03:04:52 INFO - 'LOGNAME': 'cltbld', 03:04:52 INFO - 'MAIL': '/var/mail/cltbld', 03:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:52 INFO - 'MOZ_NO_REMOTE': '1', 03:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:52 INFO - 'NO_EM_RESTART': '1', 03:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:52 INFO - 'PWD': '/builds/slave/test', 03:04:52 INFO - 'SHELL': '/bin/bash', 03:04:52 INFO - 'SHLVL': '1', 03:04:52 INFO - 'TERM': 'linux', 03:04:52 INFO - 'TMOUT': '86400', 03:04:52 INFO - 'USER': 'cltbld', 03:04:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:52 INFO - '_': '/tools/buildbot/bin/python'} 03:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:04:53 INFO - Cleaning up... 03:04:53 INFO - Return code: 0 03:04:53 INFO - Running post-action listener: _resource_record_post_action 03:04:53 INFO - Running post-action listener: _start_resource_monitoring 03:04:53 INFO - Starting resource monitoring. 03:04:53 INFO - [mozharness: 2016-07-25 10:04:53.221484Z] Finished create-virtualenv step (success) 03:04:53 INFO - [mozharness: 2016-07-25 10:04:53.221963Z] Running install step. 03:04:53 INFO - Running pre-action listener: _resource_record_pre_action 03:04:53 INFO - Running main action method: install 03:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:53 INFO - Reading from file tmpfile_stdout 03:04:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:04:53 INFO - Reading from file tmpfile_stdout 03:04:53 INFO - Output received: 03:04:53 INFO - Usage: mozinstall [options] installer 03:04:53 INFO - Options: 03:04:53 INFO - -h, --help show this help message and exit 03:04:53 INFO - -d DEST, --destination=DEST 03:04:53 INFO - Directory to install application into. [default: 03:04:53 INFO - "/builds/slave/test"] 03:04:53 INFO - --app=APP Application being installed. [default: firefox] 03:04:53 INFO - mkdir: /builds/slave/test/build/application 03:04:53 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'] 03:04:53 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 03:05:09 INFO - Reading from file tmpfile_stdout 03:05:09 INFO - Output received: 03:05:09 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:09 INFO - Running post-action listener: _resource_record_post_action 03:05:09 INFO - [mozharness: 2016-07-25 10:05:09.905251Z] Finished install step (success) 03:05:09 INFO - [mozharness: 2016-07-25 10:05:09.905532Z] Running run-tests step. 03:05:09 INFO - Running pre-action listener: _resource_record_pre_action 03:05:09 INFO - Running main action method: run_tests 03:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:09 INFO - Python 2.7.3 03:05:09 INFO - Return code: 0 03:05:09 INFO - grabbing minidump binary from tooltool 03:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:09 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 0x123f3b0>, '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 0x12402b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1240740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:09 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 03:05:09 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 03:05:09 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 03:05:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:09 INFO - Return code: 0 03:05:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 03:05:09 INFO - Using env: {'DISPLAY': ':0', 03:05:09 INFO - 'HOME': '/home/cltbld', 03:05:09 INFO - 'LANG': 'en_US.UTF-8', 03:05:09 INFO - 'LANGUAGE': 'en_US:en', 03:05:09 INFO - 'LOGNAME': 'cltbld', 03:05:09 INFO - 'MAIL': '/var/mail/cltbld', 03:05:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:09 INFO - 'MOZ_NO_REMOTE': '1', 03:05:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:09 INFO - 'NO_EM_RESTART': '1', 03:05:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:09 INFO - 'PWD': '/builds/slave/test', 03:05:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:09 INFO - 'SHELL': '/bin/bash', 03:05:09 INFO - 'SHLVL': '1', 03:05:09 INFO - 'TERM': 'linux', 03:05:09 INFO - 'TMOUT': '86400', 03:05:09 INFO - 'USER': 'cltbld', 03:05:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273', 03:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:09 INFO - '_': '/tools/buildbot/bin/python'} 03:05:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:05:10 INFO - mozversion application_buildid: 20160725013328 03:05:10 INFO - mozversion application_changeset: 3b35d43491f5d0af16f35ea9d15aa9a451d5248f 03:05:10 INFO - mozversion application_display_name: Nightly 03:05:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:10 INFO - mozversion application_name: Firefox 03:05:10 INFO - mozversion application_remotingname: firefox 03:05:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:05:10 INFO - mozversion application_vendor: Mozilla 03:05:10 INFO - mozversion application_version: 50.0a1 03:05:10 INFO - mozversion platform_buildid: 20160725013328 03:05:10 INFO - mozversion platform_changeset: 3b35d43491f5d0af16f35ea9d15aa9a451d5248f 03:05:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:05:10 INFO - mozversion platform_version: 50.0a1 03:05:10 INFO - using testdate: 1469441110 03:05:10 INFO - actual date: 1469441110 03:05:10 INFO - starting webserver on 'localhost:34379' 03:05:10 INFO - SUITE-START | Running 2 tests 03:05:10 INFO - TEST-START | dromaeo_css 03:05:10 INFO - operating with platform_type : linux_ 03:05:10 INFO - Initialising browser for dromaeo_css test... 03:05:10 INFO - TEST-INFO | started process 15010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4IxpTz/profile http://localhost:34379/getInfo.html) 03:05:13 INFO - PROCESS | 15010 | JavaScript error: , line 0: uncaught exception: undefined 03:05:14 INFO - PROCESS | 15010 | __metrics Screen width/height:1600/1200 03:05:14 INFO - PROCESS | 15010 | colorDepth:24 03:05:14 INFO - PROCESS | 15010 | Browser inner width/height: 1024/697 03:05:14 INFO - PROCESS | 15010 | __metrics 03:05:15 INFO - PROCESS | 15010 | 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" 03:05:15 INFO - PROCESS | 15010 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:05:16 INFO - TEST-INFO | 15010: exit 0 03:05:16 INFO - Browser initialized. 03:05:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:05:16 INFO - TEST-INFO | started process 15089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4IxpTz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:28 INFO - PROCESS | 15089 | RSS: Main: 158982144 03:05:28 INFO - PROCESS | 15089 | 03:06:19 INFO - PROCESS | 15089 | 1469441179395 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] 03:08:33 INFO - PROCESS | 15089 | Cycle 1(1): loaded http://localhost:34379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34379/tests/dromaeo/cssquery-ext.html) 03:08:34 INFO - PROCESS | 15089 | RSS: Main: 229064704 03:08:34 INFO - PROCESS | 15089 | 03:11:37 INFO - PROCESS | 15089 | Cycle 1(1): loaded http://localhost:34379/tests/dromaeo/cssquery-ext.html (next: http://localhost:34379/tests/dromaeo/cssquery-jquery.html) 03:11:37 INFO - PROCESS | 15089 | RSS: Main: 244436992 03:11:37 INFO - PROCESS | 15089 | 03:14:40 INFO - PROCESS | 15089 | Cycle 1(1): loaded http://localhost:34379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34379/tests/dromaeo/cssquery-mootools.html) 03:14:40 INFO - PROCESS | 15089 | RSS: Main: 183713792 03:14:40 INFO - PROCESS | 15089 | 03:17:42 INFO - PROCESS | 15089 | Cycle 1(1): loaded http://localhost:34379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34379/tests/dromaeo/cssquery-prototype.html) 03:17:43 INFO - PROCESS | 15089 | RSS: Main: 189259776 03:17:43 INFO - PROCESS | 15089 | 03:20:46 INFO - PROCESS | 15089 | Cycle 1(1): loaded http://localhost:34379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34379/tests/dromaeo/cssquery-yui.html) 03:20:47 INFO - PROCESS | 15089 | RSS: Main: 185786368 03:20:47 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | Cycle 1(1): loaded http://localhost:34379/tests/dromaeo/cssquery-yui.html (next: http://localhost:34379/tests/dromaeo/cssquery-dojo.html) 03:23:50 INFO - PROCESS | 15089 | RSS: Main: 274898944 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | __start_tp_report 03:23:50 INFO - PROCESS | 15089 | _x_x_mozilla_page_load 03:23:50 INFO - PROCESS | 15089 | _x_x_mozilla_page_load_details 03:23:50 INFO - PROCESS | 15089 | |i|pagename|runs| 03:23:50 INFO - PROCESS | 15089 | |0;dojo.html;2598.870056497175;2632.7104018557943;2663;2667.226504313749;2673.9598906016413;4766.165920963835;4815.325854380385;4871.8538443846655;4913.484084171159;4925.95074049259;4764.499727528611;4828.299896515004;4848.272759086139;4885.682430642006;4924.384451943507;4417.315316125998;4424.9557504424865;4480.260756975112;4484.9551504485025;4485.416895803557;4498.145352383053;4498.280275155976;4532.728036317815;4552.97723511382;4579.4504659440745;4585.220512512864;4608.5852273295395;4610.031893302394;4619.653525985547;4629.143608432434;4353.73877567347;4407.140607581523;4416.1167766446515;4448.043670610834;4536.228841096989;4358.978205108986;4406.339049142623;4423.093265880487;4474.53017433168;4479.664025198123;4747.976260118712;4823.975880120612;4827.444843842968;4894.681845680019;4912.582430493412;5195.454477279869;5205.063088644042;5212.713300768456;5254.8160814371695;5261.894762104775;5038.622103342227;5172.534471897509;5229.084910140748;5230.267762513251;5290.444503327134;4875.24433712775;4882.609391248691;4919.827806026772;4921.040397122527;4924.3352147460355;5381.78472861089;5383.7846486140115;5384.165454354581;5388.245645609618;5391.865203369947;4962.354893863775;5065;5127.769250383742;5132.640715149903;5194.402643696023;5260.237265596467;5262.421133675292;5265.6840589564745;5281.894362112736;5314.415414304423;5173.0688476074665;5184.662996905189;5185.922211166836;5187.325647665854;5238.738063096906;4956.132676781549;5014.974925125424;5035.672681275705;5085.567726743194;5093;4395.120975804788;4405.493368262627;4408.9118217636105;4440.489343725449;4450.888727781831;3821.8662346817728;3844.7693138411787;3853.7687738735767;3878.030492376906;3888.125171836314;4377.562243775597;4466.798994045275;4468.396766436489;4475.552444755498;4487.147441986012;5267;5281.287026251483;5286.894262114736;5299.072662284085;5299.178627312773;4523.457185137804;4526.479454862667;4529.846345947108;4531.161735079021;4577.5880170784785;4514.255147900625;4588.3805686231935;4604.815807367735;4613.100445413179;4750.334953106568;4829.879253018703;4837.153498137882;4852.490488498657;4886.804527818847;4896.387951506062;5183.11886979222;5199.168133098686;5207.947920520898;5211.062008838446;5219.608529360237;4721.2918062289555;4757.215059515142;4771.928421073756;4816.590589799766;4882.998985208095;5087.592992560661;5087.720175390389;5104.3619547556555;5116.6418350716585;5131.974340128425;5209.166533354645;5249.658772179796;5257.369115706139;5291.894162116659;5322.148456246982;5103.489651034867;5104.591632669451;5108.106081435808;5113.8721531962;5161.0968080585;4947.628927830499;5007.37407824022;5107.744612769272;5110.872228194176;5125.308083408841;4981.178105612534;5024;5043.823466178666;5091.439941606346;5098.209777484496;4964.032013757427;4990.900181996267;5004.39947206323;5021.799128034838;5208.817691380784;4999.600031997359;5003.724795136302;5008.198688209869;5017.347744793154;5018.849434516825 03:23:50 INFO - PROCESS | 15089 | |1;ext.html;564.8983183027053;576.2221001647775;587.5652017507047;589.7523040323064;590.0176206615985;29162.270943226402;39350.60649393509;40147.59852401475;40186.196276074465;40350.7982460088;40442;40770;40770.79614601923;40786;40928.38607420884;7581.279778421042;7675.692972281102;7715.845683086335;7719.652615632282;7722.382209423261;7697.576633285167;7701.9614901925415;7793.76618701437;7801.726939557117;7804.76585702427;7785.065792104955;7801.336886364666;7814.0623125224765;7820.530768153901;7823.256790604912;7772.961135194344;7789;7797.298243158086;7808.960955195216;7812.804679882992;7685.385169186452;7755.108162561265;7755.72854950074;7761.844763104763;7770.145284018753;38910;39276.21447571032;39283.41074883879;39298;39333.40999885004;2976.2113040044405;2999.3251518408183;3026.636803583584;3099.5505651680605;3118.8128712277335;29372;29590.852045739848;29706;29971.850140749375;30829.383412331852;3266.852991615383;3468.1329667583104;3483.1814523586936;3524.9823750881337;3581.0510214793103;162626;164869;165880;165940;166048.99999999878;31943.201419964687;32981.50527742086;33092.83453582765;55240;55827;33455;33650.64445488792;33928.83035584806;33931.83034084814;33933.32133357319;14015.299235038206;14151.504697335544;14155.079919805179;14167.85832141686;14180.290985450893;11749.588764393206;11842;11842.230255033395;11847.289162650268;11847.407629618485;7779.72770953014;7882.487638303492;7937.682492700343;7971.804229365525;8001.8799718004275;3084;3129.6087989001376;3135.6707545707827;3148.7323577495713;3175.0474857542645;878.3544095090103;898.9280857531381;905.8414777413926;917.2249449215402;976.1897624971399;27939.30151746182;28225.858870705924;28586.28534286618;28657.942468258792;28807.279818004718;774.7714424244862;929.2983797233046;1007.9697609071593;1015.1472762879217;1018.251585084962;14367;15011.549653510412;15062.774058389134;15447.845521544865;15479.613009674847;403683;405733;406532;406695;406832;49451;49471.25793113106;49648;49818.75090624524;50024;1084.159776173472;1165.6328256599145;1178.6581891251442;1196.9281843089443;1207.0705556721275;28009.43981120407;29053.418931621673;29151.562726559543;29180.416391672472;29551;42343;42933;42987.14025719531;43012;43084;284974;287569;287597;287825;289036;24704.752952470244;25788.61317080283;25818.354541135872;26530.071447499246;26642.600360994988;41464;41702.58297416987;42197.367039493816;42628.78685606552;43121.137577248905;35939.28121437609;37176.25647487089;37783.81108094552;40621.390679139244;41844;36038.8198059008;36097;36313.273734524635;36620.45069324016;36699.816500918394;34889.302213956085;35413.29173416569;35622.643773562966;36700.63299366972;37081.81459092795;31118.222044448165;33003.66996330006;34023.48964765481;34128;34328.48507272443;25584.360390990376;25759.742402575735;26150.215493535223;26175.345616359744;26633.334166645214 03:23:50 INFO - PROCESS | 15089 | |2;jquery.html;344.24781851654154;364.8960046386779;373.83551237455515;374.4888227569367;390.1533671931908;12709.555165569207;16110.35558577657;16481;17892;18075.638487230248;17742.82257177431;18052.81947180531;18154.183061762218;18176.18207180677;18296.359627413043;4856.514348565151;5168.043911876296;5193.298904647881;5197.610179236553;5204.037253108168;3639.144800971783;5117.590592752571;5204.8809505956215;5207.297014902996;5769;6040.275166979968;6044.24446944132;6060.151578778975;6071.362506936753;6149.661768602725;5801.158831969341;6018.638881667114;6046.879062418749;6050.45545900871;6051.273847138327;5281.9207711884355;5292.655977361459;5299.33758280215;5299.814506492255;5308.6549374290935;20049.79950200494;20787.792122078736;20859.269925552533;20898.791012089987;21280.893595531925;1845.4002449204063;1916.7220752990877;2142.0146732503067;2494.2143224884285;2501;13184.934075329658;13478.191308521422;13713.725725485434;13780.655483612889;14114.92942535291;1665.4095338951392;1722.5951901303183;1732.5928406824387;1759.6568669109529;1761.2718424469483;43251.56748432507;64552.67723661352;66760.66619666919;68878.3112168877;73003.26996730072;9982.301238913351;10116.54475548602;10120.797584048278;10160.847587286196;10370.118539924191;14128.86969042474;14166.575002749934;14207.147571145557;14208.431662733376;14222.288885555681;7264.527805692613;7375.500944423897;7487.775366739006;7514.323710866049;7610.035584702023;7384.409247260313;7441.627918604048;7506.474546781782;7549.924500755032;7621.923780762232;4266.701330906807;4373.906523369158;4400.141972315432;4485.147821913826;4527.320901864681;1647.8928869623676;1766.2140347545476;1790.9373171938919;1796.8796819752818;1811.2845426056633;653.8986457099157;792.9841403171904;831.6590198018783;832.4713806732768;858.1289990659485;16567.17164141788;16669.16654167287;16748.330066797436;16785.07682077473;17569.121543922753;828.0127693535443;851.2679095977454;854.3165467625998;865.3726048614704;876.3296078499952;9253.306002049872;9492.184979475856;9693.660721874701;9715.46564938921;9749.07383798538;380191;382063;385975;386895;387264;73808;75176.62411687906;75451.24548754552;76113;80402.59798700969;837.6063250272363;905.3526728389234;913.9040400757958;929.2287401456774;938.3150300280697;11459.48432320531;14759.188244646648;15531.45639902598;15764.211789410254;16687.249073791467;35899.28201436009;36856.44715329219;37264.627353726115;37293.6270637301;37566.2486750258;50786.746066269436;51067.489325106275;51355.486445136565;51571;51861.22208166805;7384.446166537424;7571.924280757122;7575.0909890813455;7857.135715071223;8141.9185808141165;11496.54013839437;11501.712457188638;11741.41292935367;11846.822297665369;11980.64058078259;9580.281478888972;9619.807603847745;10067.395956242648;10267.075963163352;10563.894361056598;4900.436449808318;9057.411268267806;9403.764905877408;9981.550830212513;10496.47517624131;10297.124744396511;10581.36511809294;10632;10767.246292759432;11075.944620276847;6686.465082793267;6761.256261811295;6856.9314306856295;7030.578165310098;7861.803454913673;8409.579521024047;10322.329048611817;10521.105706014769;10675;10868.347899125762 03:23:50 INFO - PROCESS | 15089 | |3;mootools.html;1390.624531376528;1411.6118067531427;1470.7426200414925;1684.2168391697874;1715.6911755883937;7515.549067055974;8116.066652334984;8129.943107396038;8136.349092072634;8144.6742130314715;6845.452363810896;7076.256993015723;7469.253074692528;7760.262775036363;7919.366450683946;2208.856424332417;2238.7089678341795;2238.9776102238934;2240.5518896220738;2242.955140897181;2165.935021949344;2196.187410658059;2224.132588290568;2227.220472834503;2228.9108435662556;1840.319081939684;2089.3105275259127;2158.0504577985716;2179.640359340715;2197.0223250653466;2208.536207396449;2208.9889550552143;2226.1206823304865;2227.3874684461903;2227.7326720793526;2209.4476380904775;2215.1471683401846;2216.7783221677864;2217.7116974793175;2220.0675716199235;8048;8090.838183236302;8096.838063238761;8100.473469224482;8106.837863242702;4537.727736335831;4663.183942810028;4664.253719404879;4665.626749860037;4690.01509682967;2834.2489240351324;3018.5170372740477;3029.1972627253795;3033.0445909538425;3033.2568520712566;840.7099550655014;861.7845538615346;868.3096937934357;875.4309698695835;879.3317079019927;10936.234463587552;10965.342079475256;10967.670969870916;10990.285631433931;11000.394978276192;4091.263572556909;4252.192083504125;4385.057212699285;4390.407295015196;4401.097774956126;9176.770580735401;9214.262858971266;9219.21636660878;9223.907760922304;9230.907690923004;4775.42694876617;4788.497207793202;4791.305260737174;4796.184648609745;4799.088173247072;4245.299525578307;4373.693841431133;4387.561243875651;4396.846110386121;4400.44994375703;3354.2452948086975;3414.129397003748;3498.3877821381666;3499.2476617527354;3510.736694747904;1007.9294449388473;1014.3102690170607;1035.2649618770606;1039.5166247694858;1080.778440419712;660.6498555765452;694.2571448550104;735.2904447208363;815.9265666089962;829.8921140251729;5013.197888337849;5153.7165455900285;5160.7935682573025;5285.7621407036;5422.61723260566;440.37246923135046;452.72610070907285;453.17974466216253;453.99773001135446;603.8707616756693;3438;3657.9817100914856;3699.5560532736245;3827.483289755903;3839.6544311012144;9517.191038761644;9952.950235248778;9960.452175130438;9979.60081596728;9984.850227246598;9830.655927042519;9880.950595246977;9909.950450247703;9914.157296629723;9918.15695665862;6938.653067346612;7261.128664560287;7279;7296.270372962661;7444.664990075459;5570.58220633446;5617.719114044363;5659.603827732184;5704.743286552032;5793.8551536211935;8650.140219852761;8834.337424693302;8857.335699822668;8889.422187557788;9004.054574269607;9109.863352049591;9245.075492450702;9292.442453452815;9295.6281748732;9379.484128373006;6891.138607674041;7069.6111713856235;7069.858602827811;7069.929300706927;7075.398591119607;7548.358389536951;7562.810929726801;7604.695812167452;7613.200613935457;7639.04511936008;6888.483363747639;6893.241743408322;6935.89596156048;6961.6519174042105;6983.371496565131;6736.595804251565;6907.792766217021;6909.965450172717;6932.688029038806;6941.132358455193;5934.495567876606;6005.7297421617;6012.669303188191;6015.819525414245;6020.1270815730595;4769.30845027476;4842.080004799077;4872.366592342973;4889.731064791471;4898.730569818694;4451.643868490578;4467;4564.269716845289;4617.722936623813;4708.811647534198 03:23:50 INFO - PROCESS | 15089 | |4;prototype.html;291.3691857129314;298.57453129290764;300.228412978645;314.0609577363683;314.625595541306;4869.9269510957365;4957.1325018121815;4962.578180854623;4967.627427942905;5020.364308737914;4679.15775160471;4809.807607695688;4829.0100529391475;4829.1307564638355;4926.359573255471;3769.944415563633;3812.866549670762;3825.139343647671;3875.2249550090096;3906.335922893115;3886.378179491282;3897.064704470921;3920.1179734559637;3926.175503144343;3927.3323534999117;3667.211549516853;3811.313963486571;3884.844606215748;3894.3963685628773;3906.5507466641275;3818;3823.254465379252;3831.214601006801;3833.9233215335817;3840.327942610032;3364.7308215342714;3371.9157021074425;3379.4423920053164;3405.7445691572984;3412.266362732;4812.398450193726;4827.686200396963;4844.66087373884;4850.75746212688;4886.218205087204;4154.109880004591;4367.6069153776;4390.05613793036;4409.625181859546;4416.712913660634;5124.948750512522;5144.4083930348115;5144.942023190716;5160.483951604847;5177;3697.5193224880595;3709.8516059357594;3711.1278849470355;3714.4056950888;3718.8140592970512;5158.40678321994;5378.731063446851;5429.131338985783;5501.312335958005;5520.558355331564;3689.5203623529305;3709.925801483955;3710.6845918097265;3737.3085979093953;3744.307303148926;3788.791616461066;3801.163743976321;3805.6955443564448;3809.3524100902914;3810.8856734298015;4211.7472951622385;4320.827166913351;4365.367021781887;4366.8908277292685;4390.407295015196;5131.281620573122;5134;5138.897222055538;5142.1772516397195;5149.742512874416;1282.179405180685;1298.6558561981083;1301.8437787465564;1306.8303868038242;1310.2269660900115;837.8437755896823;876.7632739160391;887.4231749362966;899.3030401438806;905.4748246017294;4487.842925497657;4493;4493.281075028045;4503.864884053418;4513.526079761577;5228.581713462914;5235.60732945023;5284.833218380446;5313.335833020872;5346.866328341823;4304.78476076195;4473.709208901411;4481.170983368087;4539.546045395434;4555.339475775994;2783.997760806108;2796.1891051595217;2805.424887897976;2818.7456581821302;2826.703196164373;4873.780679869415;4885.926711099336;4906.1659517881335;4911.803527858917;4954;5191.247269146028;5363.712708949902;5394.163904594794;5411.161270003156;5439.5104440600535;4903.289023091632;4906.2640603909695;4913.508649135058;4918.508149185053;4930.235813448921;5264.236685680631;5286.20706893969;5299.152135658276;5307.346326836581;5313.449544218719;4916.55750982399;5010.749462526932;5110.361204849394;5116.820911268088;5120.769565369493;4876.902461950812;4877.804887804448;4882.536159064884;4918.360613120271;4934.7285899275885;3730.1980074283074;3747.7938713371027;3754.155315054091;3756.267527832156;3793.3740932745786;5051.646384753179;5255.9211611825085;5288.788448462173;5313.362396512443;5340.519353258225;5176.637635365489;5184.922226166686;5187.974060129675;5206.245094461357;5223;5261.921071184011;5262.552683021833;5264.131418315935;5264.710440925633;5282.392524859691;4862.79055823155;4892.192788189909;5114.777690055242;5122.487751224848;5126.53861152498;5087.64386492942;5195.870103247449;5244.947550524446;5251.684898906078;5267.3152490176035;5128.8717782054255;5141.691498510101;5142.382914050338;5143.3056537368475;5156.329677141947 03:23:50 INFO - PROCESS | 15089 | |5;yui.html;679.1985457160548;705.8517711280631;718.3606590134777;718.6083584446477;751.4439314906969;12531.373431328431;13584.320783960811;13584.592462226125;13592.116512426697;13606.387712552922;13120.278384688838;13191.14257573257;13233.867661323384;13253.867461325384;13264.535741249058;624.1605041219552;649.4122818848949;754.2871985973258;759.3355813663045;781.5779479081318;777.1645481107804;794.6185830801219;794.7417089445925;794.972175973841;795.5505139596139;841.4530555139147;847.2501835875264;847.8897743293394;848.2959143910571;848.4866655673321;648.5557393185636;784.3372350363933;825.2407784837964;837.7319257837495;838.0948575538404;601.3235110500686;601.6750954484573;601.7653115285042;608.3399511529996;609.1745684597396;13386.799198012037;13450.663733406645;13459.528916487974;13475.66310842227;13484.325783710776;12267.202631828903;12578.119531632788;12668.493260269579;12792.393280198143;12996.545120920722;11669.824952625717;11778.293302401884;11909;11961;12465.626031219077;3967.861124860616;4004.8798536043964;4085.9795701021303;4103.322951712964;4119.608637179464;56678;56683.716581416826;56826.14760778592;56969.14546281809;56988.715056424866;9703.417794932328;9993.10062094415;10323.587056517656;10355.637552685619;10524.631637892637;18180.909095454703;18352.357667481574;18379.54051148732;18457.723134153;18490;6761.628110453972;6826.078479405217;6957.199922009034;7024.613646249505;7050.541714788523;3574.7855128692363;3587.9282414352087;3608.332458495187;3609.8375573099274;3620.981895090508;2674.064077572873;2750.4636595864013;2755.517784387764;3272.9509057364157;3439.4840773884116;600.2107228993859;600.7236671131328;610.6458254212635;611.2939554814196;613.1722175063628;502.7687263858593;559.0970582509218;600.8497875531117;626.602107661629;650.7429565321671;8083.353331733447;8196.098429172785;8360.958195209107;8650.567471626393;8652.264557512555;432.44214962697765;464.628297362109;531.3331768630421;636.1825054804553;642.210081599635;3788.913297314407;4017.678585713136;4105.2405305018665;4415.779211039435;4564.680472366902;92714.07285927054;96643;98590;102199.48900255452;102373.48813256035;84800.57599712085;85664;87113;87287.56356218306;88875.55562222148;59369;61221;62455;71288.28711713024;79346.20653793387;8024.638891249791;8487;8700.781890535456;8745.387822852339;8943.150400711922;41685.58314416817;42196.789016054725;42204.57795422006;42379;43204;62786.686066569375;63509.364906352195;64013.67993160005;64054;65909.34090659033;10499.265051446326;10755;10902.945485272523;11092.445377731243;11260.099192064452;12904.354782260662;13035.087543871838;13132.671683207996;13480.865191348354;13613.251271180181;11976;12142.878571214174;12145.271283723005;12511.374431278582;12602.11785175029;12277.754444910874;12407.93796031014;12625.87374126247;12972.675683107998;13121.606351809462;12261.69345766363;12371.566995155126;12406.503739850305;13162.021296190296;13314.800277996032;9234.722958311262;9479.146876781122;9517.476538790155;9573.473458959545;9772.755681108029;7714.652840622073;8402;8555.101714319906;8706.47761134334;8908.420952638058 03:23:50 INFO - PROCESS | 15089 | __end_tp_report 03:23:50 INFO - PROCESS | 15089 | __start_cc_report 03:23:50 INFO - PROCESS | 15089 | _x_x_mozilla_cycle_collect,897 03:23:50 INFO - PROCESS | 15089 | __end_cc_report 03:23:50 INFO - PROCESS | 15089 | __startTimestamp1469442230443__endTimestamp 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | ------- Summary: start ------- 03:23:50 INFO - PROCESS | 15089 | Number of tests: 6 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | [#0] dojo.html Cycles:165 Average:4807.38 Median:4924.34 stddev:515.64 (10.5%) stddev-sans-first:487.25 03:23:50 INFO - PROCESS | 15089 | Values: 2598.9 2632.7 2663.0 2667.2 2674.0 4766.2 4815.3 4871.9 4913.5 4926.0 4764.5 4828.3 4848.3 4885.7 4924.4 4417.3 4425.0 4480.3 4485.0 4485.4 4498.1 4498.3 4532.7 4553.0 4579.5 4585.2 4608.6 4610.0 4619.7 4629.1 4353.7 4407.1 4416.1 4448.0 4536.2 4359.0 4406.3 4423.1 4474.5 4479.7 4748.0 4824.0 4827.4 4894.7 4912.6 5195.5 5205.1 5212.7 5254.8 5261.9 5038.6 5172.5 5229.1 5230.3 5290.4 4875.2 4882.6 4919.8 4921.0 4924.3 5381.8 5383.8 5384.2 5388.2 5391.9 4962.4 5065.0 5127.8 5132.6 5194.4 5260.2 5262.4 5265.7 5281.9 5314.4 5173.1 5184.7 5185.9 5187.3 5238.7 4956.1 5015.0 5035.7 5085.6 5093.0 4395.1 4405.5 4408.9 4440.5 4450.9 3821.9 3844.8 3853.8 3878.0 3888.1 4377.6 4466.8 4468.4 4475.6 4487.1 5267.0 5281.3 5286.9 5299.1 5299.2 4523.5 4526.5 4529.8 4531.2 4577.6 4514.3 4588.4 4604.8 4613.1 4750.3 4829.9 4837.2 4852.5 4886.8 4896.4 5183.1 5199.2 5207.9 5211.1 5219.6 4721.3 4757.2 4771.9 4816.6 4883.0 5087.6 5087.7 5104.4 5116.6 5132.0 5209.2 5249.7 5257.4 5291.9 5322.1 5103.5 5104.6 5108.1 5113.9 5161.1 4947.6 5007.4 5107.7 5110.9 5125.3 4981.2 5024.0 5043.8 5091.4 5098.2 4964.0 4990.9 5004.4 5021.8 5208.8 4999.6 5003.7 5008.2 5017.3 5018.8 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | [#1] ext.html Cycles:180 Average:43642.00 Median:35989.05 stddev:80131.93 (222.7%) stddev-sans-first:80291.45 03:23:50 INFO - PROCESS | 15089 | Values: 564.9 576.2 587.6 589.8 590.0 29162.3 39350.6 40147.6 40186.2 40350.8 40442.0 40770.0 40770.8 40786.0 40928.4 7581.3 7675.7 7715.8 7719.7 7722.4 7697.6 7702.0 7793.8 7801.7 7804.8 7785.1 7801.3 7814.1 7820.5 7823.3 7773.0 7789.0 7797.3 7809.0 7812.8 7685.4 7755.1 7755.7 7761.8 7770.1 38910.0 39276.2 39283.4 39298.0 39333.4 2976.2 2999.3 3026.6 3099.6 3118.8 29372.0 29590.9 29706.0 29971.9 30829.4 3266.9 3468.1 3483.2 3525.0 3581.1 162626.0 164869.0 165880.0 165940.0 166049.0 31943.2 32981.5 33092.8 55240.0 55827.0 33455.0 33650.6 33928.8 33931.8 33933.3 14015.3 14151.5 14155.1 14167.9 14180.3 11749.6 11842.0 11842.2 11847.3 11847.4 7779.7 7882.5 7937.7 7971.8 8001.9 3084.0 3129.6 3135.7 3148.7 3175.0 878.4 898.9 905.8 917.2 976.2 27939.3 28225.9 28586.3 28657.9 28807.3 774.8 929.3 1008.0 1015.1 1018.3 14367.0 15011.5 15062.8 15447.8 15479.6 403683.0 405733.0 406532.0 406695.0 406832.0 49451.0 49471.3 49648.0 49818.8 50024.0 1084.2 1165.6 1178.7 1196.9 1207.1 28009.4 29053.4 29151.6 29180.4 29551.0 42343.0 42933.0 42987.1 43012.0 43084.0 284974.0 287569.0 287597.0 287825.0 289036.0 24704.8 25788.6 25818.4 26530.1 26642.6 41464.0 41702.6 42197.4 42628.8 43121.1 35939.3 37176.3 37783.8 40621.4 41844.0 36038.8 36097.0 36313.3 36620.5 36699.8 34889.3 35413.3 35622.6 36700.6 37081.8 31118.2 33003.7 34023.5 34128.0 34328.5 25584.4 25759.7 26150.2 26175.3 26633.3 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | [#2] jquery.html Cycles:180 Average:24115.63 Median:4387.02 stddev:63395.77 (1445.1%) stddev-sans-first:63548.49 03:23:50 INFO - PROCESS | 15089 | Values: 344.2 364.9 373.8 374.5 390.2 12709.6 16110.4 16481.0 17892.0 18075.6 17742.8 18052.8 18154.2 18176.2 18296.4 4856.5 5168.0 5193.3 5197.6 5204.0 3639.1 5117.6 5204.9 5207.3 5769.0 6040.3 6044.2 6060.2 6071.4 6149.7 5801.2 6018.6 6046.9 6050.5 6051.3 5281.9 5292.7 5299.3 5299.8 5308.7 20049.8 20787.8 20859.3 20898.8 21280.9 1845.4 1916.7 2142.0 2494.2 2501.0 13184.9 13478.2 13713.7 13780.7 14114.9 1665.4 1722.6 1732.6 1759.7 1761.3 43251.6 64552.7 66760.7 68878.3 73003.3 9982.3 10116.5 10120.8 10160.8 10370.1 14128.9 14166.6 14207.1 14208.4 14222.3 7264.5 7375.5 7487.8 7514.3 7610.0 7384.4 7441.6 7506.5 7549.9 7621.9 4266.7 4373.9 4400.1 4485.1 4527.3 1647.9 1766.2 1790.9 1796.9 1811.3 653.9 793.0 831.7 832.5 858.1 16567.2 16669.2 16748.3 16785.1 17569.1 828.0 851.3 854.3 865.4 876.3 9253.3 9492.2 9693.7 9715.5 9749.1 380191.0 382063.0 385975.0 386895.0 387264.0 73808.0 75176.6 75451.2 76113.0 80402.6 837.6 905.4 913.9 929.2 938.3 11459.5 14759.2 15531.5 15764.2 16687.2 35899.3 36856.4 37264.6 37293.6 37566.2 50786.7 51067.5 51355.5 51571.0 51861.2 7384.4 7571.9 7575.1 7857.1 8141.9 11496.5 11501.7 11741.4 11846.8 11980.6 9580.3 9619.8 10067.4 10267.1 10563.9 4900.4 9057.4 9403.8 9981.6 10496.5 10297.1 10581.4 10632.0 10767.2 11075.9 6686.5 6761.3 6856.9 7030.6 7861.8 8409.6 10322.3 10521.1 10675.0 10868.3 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | [#3] mootools.html Cycles:180 Average:5206.39 Median:5157.26 stddev:2962.85 (57.5%) stddev-sans-first:2957.28 03:23:50 INFO - PROCESS | 15089 | Values: 1390.6 1411.6 1470.7 1684.2 1715.7 7515.5 8116.1 8129.9 8136.3 8144.7 6845.5 7076.3 7469.3 7760.3 7919.4 2208.9 2238.7 2239.0 2240.6 2243.0 2165.9 2196.2 2224.1 2227.2 2228.9 1840.3 2089.3 2158.1 2179.6 2197.0 2208.5 2209.0 2226.1 2227.4 2227.7 2209.4 2215.1 2216.8 2217.7 2220.1 8048.0 8090.8 8096.8 8100.5 8106.8 4537.7 4663.2 4664.3 4665.6 4690.0 2834.2 3018.5 3029.2 3033.0 3033.3 840.7 861.8 868.3 875.4 879.3 10936.2 10965.3 10967.7 10990.3 11000.4 4091.3 4252.2 4385.1 4390.4 4401.1 9176.8 9214.3 9219.2 9223.9 9230.9 4775.4 4788.5 4791.3 4796.2 4799.1 4245.3 4373.7 4387.6 4396.8 4400.4 3354.2 3414.1 3498.4 3499.2 3510.7 1007.9 1014.3 1035.3 1039.5 1080.8 660.6 694.3 735.3 815.9 829.9 5013.2 5153.7 5160.8 5285.8 5422.6 440.4 452.7 453.2 454.0 603.9 3438.0 3658.0 3699.6 3827.5 3839.7 9517.2 9953.0 9960.5 9979.6 9984.9 9830.7 9881.0 9910.0 9914.2 9918.2 6938.7 7261.1 7279.0 7296.3 7444.7 5570.6 5617.7 5659.6 5704.7 5793.9 8650.1 8834.3 8857.3 8889.4 9004.1 9109.9 9245.1 9292.4 9295.6 9379.5 6891.1 7069.6 7069.9 7069.9 7075.4 7548.4 7562.8 7604.7 7613.2 7639.0 6888.5 6893.2 6935.9 6961.7 6983.4 6736.6 6907.8 6910.0 6932.7 6941.1 5934.5 6005.7 6012.7 6015.8 6020.1 4769.3 4842.1 4872.4 4889.7 4898.7 4451.6 4467.0 4564.3 4617.7 4708.8 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | [#4] prototype.html Cycles:180 Average:4272.94 Median:4875.34 stddev:1239.28 (25.4%) stddev-sans-first:1206.19 03:23:50 INFO - PROCESS | 15089 | Values: 291.4 298.6 300.2 314.1 314.6 4869.9 4957.1 4962.6 4967.6 5020.4 4679.2 4809.8 4829.0 4829.1 4926.4 3769.9 3812.9 3825.1 3875.2 3906.3 3886.4 3897.1 3920.1 3926.2 3927.3 3667.2 3811.3 3884.8 3894.4 3906.6 3818.0 3823.3 3831.2 3833.9 3840.3 3364.7 3371.9 3379.4 3405.7 3412.3 4812.4 4827.7 4844.7 4850.8 4886.2 4154.1 4367.6 4390.1 4409.6 4416.7 5124.9 5144.4 5144.9 5160.5 5177.0 3697.5 3709.9 3711.1 3714.4 3718.8 5158.4 5378.7 5429.1 5501.3 5520.6 3689.5 3709.9 3710.7 3737.3 3744.3 3788.8 3801.2 3805.7 3809.4 3810.9 4211.7 4320.8 4365.4 4366.9 4390.4 5131.3 5134.0 5138.9 5142.2 5149.7 1282.2 1298.7 1301.8 1306.8 1310.2 837.8 876.8 887.4 899.3 905.5 4487.8 4493.0 4493.3 4503.9 4513.5 5228.6 5235.6 5284.8 5313.3 5346.9 4304.8 4473.7 4481.2 4539.5 4555.3 2784.0 2796.2 2805.4 2818.7 2826.7 4873.8 4885.9 4906.2 4911.8 4954.0 5191.2 5363.7 5394.2 5411.2 5439.5 4903.3 4906.3 4913.5 4918.5 4930.2 5264.2 5286.2 5299.2 5307.3 5313.4 4916.6 5010.7 5110.4 5116.8 5120.8 4876.9 4877.8 4882.5 4918.4 4934.7 3730.2 3747.8 3754.2 3756.3 3793.4 5051.6 5255.9 5288.8 5313.4 5340.5 5176.6 5184.9 5188.0 5206.2 5223.0 5261.9 5262.6 5264.1 5264.7 5282.4 4862.8 4892.2 5114.8 5122.5 5126.5 5087.6 5195.9 5244.9 5251.7 5267.3 5128.9 5141.7 5142.4 5143.3 5156.3 03:23:50 INFO - PROCESS | 15089 | 03:23:50 INFO - PROCESS | 15089 | [#5] yui.html Cycles:180 Average:17585.78 Median:56680.86 stddev:24906.36 (43.9%) stddev-sans-first:24943.88 03:23:50 INFO - PROCESS | 15089 | Values: 679.2 705.9 718.4 718.6 751.4 12531.4 13584.3 13584.6 13592.1 13606.4 13120.3 13191.1 13233.9 13253.9 13264.5 624.2 649.4 754.3 759.3 781.6 777.2 794.6 794.7 795.0 795.6 841.5 847.3 847.9 848.3 848.5 648.6 784.3 825.2 837.7 838.1 601.3 601.7 601.8 608.3 609.2 13386.8 13450.7 13459.5 13475.7 13484.3 12267.2 12578.1 12668.5 12792.4 12996.5 11669.8 11778.3 11909.0 11961.0 12465.6 3967.9 4004.9 4086.0 4103.3 4119.6 56678.0 56683.7 56826.1 56969.1 56988.7 9703.4 9993.1 10323.6 10355.6 10524.6 18180.9 18352.4 18379.5 18457.7 18490.0 6761.6 6826.1 6957.2 7024.6 7050.5 3574.8 3587.9 3608.3 3609.8 3621.0 2674.1 2750.5 2755.5 3273.0 3439.5 600.2 600.7 610.6 611.3 613.2 502.8 559.1 600.8 626.6 650.7 8083.4 8196.1 8361.0 8650.6 8652.3 432.4 464.6 531.3 636.2 642.2 3788.9 4017.7 4105.2 4415.8 4564.7 92714.1 96643.0 98590.0 102199.5 102373.5 84800.6 85664.0 87113.0 87287.6 88875.6 59369.0 61221.0 62455.0 71288.3 79346.2 8024.6 8487.0 8700.8 8745.4 8943.2 41685.6 42196.8 42204.6 42379.0 43204.0 62786.7 63509.4 64013.7 64054.0 65909.3 10499.3 10755.0 10902.9 11092.4 11260.1 12904.4 13035.1 13132.7 13480.9 13613.3 11976.0 12142.9 12145.3 12511.4 12602.1 12277.8 12407.9 12625.9 12972.7 13121.6 12261.7 12371.6 12406.5 13162.0 13314.8 9234.7 9479.1 9517.5 9573.5 9772.8 7714.7 8402.0 8555.1 8706.5 8908.4 03:23:50 INFO - PROCESS | 15089 | -------- Summary: end -------- 03:23:50 INFO - PROCESS | 15089 | 03:23:51 INFO - TEST-INFO | 15089: exit 0 03:23:51 INFO - TEST-OK | dromaeo_css | took 1121049ms 03:23:51 INFO - TEST-START | kraken 03:23:51 INFO - operating with platform_type : linux_ 03:23:51 INFO - Initialising browser for kraken test... 03:23:51 INFO - TEST-INFO | started process 15278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdPDSa/profile http://localhost:34379/getInfo.html) 03:23:54 INFO - PROCESS | 15278 | JavaScript error: , line 0: uncaught exception: undefined 03:23:55 INFO - PROCESS | 15278 | __metrics Screen width/height:1600/1200 03:23:55 INFO - PROCESS | 15278 | colorDepth:24 03:23:55 INFO - PROCESS | 15278 | Browser inner width/height: 1024/697 03:23:55 INFO - PROCESS | 15278 | __metrics 03:23:56 INFO - PROCESS | 15278 | 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" 03:23:56 INFO - PROCESS | 15278 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:23:57 INFO - TEST-INFO | 15278: exit 0 03:23:57 INFO - Browser initialized. 03:23:57 INFO - Running cycle 1/1 for kraken test... 03:23:57 INFO - TEST-INFO | started process 15357 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdPDSa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:09 INFO - PROCESS | 15357 | RSS: Main: 159121408 03:24:09 INFO - PROCESS | 15357 | 03:24:12 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34379/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:12 INFO - PROCESS | 15357 | RSS: Main: 215281664 03:24:12 INFO - PROCESS | 15357 | 03:24:15 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34379/tests/kraken/driver.html?testName=audio-dft) 03:24:16 INFO - PROCESS | 15357 | RSS: Main: 193781760 03:24:16 INFO - PROCESS | 15357 | 03:24:19 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34379/tests/kraken/driver.html?testName=audio-fft) 03:24:20 INFO - PROCESS | 15357 | RSS: Main: 272961536 03:24:20 INFO - PROCESS | 15357 | 03:24:22 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34379/tests/kraken/driver.html?testName=audio-oscillator) 03:24:22 INFO - PROCESS | 15357 | RSS: Main: 182063104 03:24:22 INFO - PROCESS | 15357 | 03:24:25 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:25 INFO - PROCESS | 15357 | RSS: Main: 186351616 03:24:25 INFO - PROCESS | 15357 | 03:24:28 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34379/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:29 INFO - PROCESS | 15357 | RSS: Main: 222203904 03:24:29 INFO - PROCESS | 15357 | 03:24:33 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34379/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:33 INFO - PROCESS | 15357 | RSS: Main: 216547328 03:24:33 INFO - PROCESS | 15357 | 03:24:36 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34379/tests/kraken/driver.html?testName=json-parse-financial) 03:24:37 INFO - PROCESS | 15357 | RSS: Main: 219951104 03:24:37 INFO - PROCESS | 15357 | 03:24:38 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:39 INFO - PROCESS | 15357 | RSS: Main: 184774656 03:24:39 INFO - PROCESS | 15357 | 03:24:41 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:42 INFO - PROCESS | 15357 | RSS: Main: 191565824 03:24:42 INFO - PROCESS | 15357 | 03:24:44 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:44 INFO - PROCESS | 15357 | RSS: Main: 195588096 03:24:44 INFO - PROCESS | 15357 | 03:24:47 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:48 INFO - PROCESS | 15357 | RSS: Main: 190730240 03:24:48 INFO - PROCESS | 15357 | 03:24:51 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:51 INFO - PROCESS | 15357 | RSS: Main: 193691648 03:24:51 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | Cycle 1(1): loaded http://localhost:34379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34379/tests/kraken/driver.html?testName=ai-astar) 03:24:53 INFO - PROCESS | 15357 | RSS: Main: 244187136 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | __start_tp_report 03:24:53 INFO - PROCESS | 15357 | _x_x_mozilla_page_load 03:24:53 INFO - PROCESS | 15357 | _x_x_mozilla_page_load_details 03:24:53 INFO - PROCESS | 15357 | |i|pagename|runs| 03:24:53 INFO - PROCESS | 15357 | |0;ai-astar;104;114;112;113;114;112;112;113;114;113 03:24:53 INFO - PROCESS | 15357 | |1;audio-beat-detection;155;122;126;176;121;125;151;128;162;120 03:24:53 INFO - PROCESS | 15357 | |2;audio-dft;162;160;160;161;161;161;158;162;161;162 03:24:53 INFO - PROCESS | 15357 | |3;audio-fft;78;76;76;126;76;78;74;75;107;77 03:24:53 INFO - PROCESS | 15357 | |4;audio-oscillator;85;86;120;84;84;85;123;84;84;126 03:24:53 INFO - PROCESS | 15357 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 03:24:53 INFO - PROCESS | 15357 | |6;imaging-darkroom;147;146;146;146;147;146;147;146;146;146 03:24:53 INFO - PROCESS | 15357 | |7;imaging-desaturate;95;95;96;96;95;94;95;95;95;95 03:24:53 INFO - PROCESS | 15357 | |8;json-parse-financial;62;62;62;63;62;64;64;63;63;62 03:24:53 INFO - PROCESS | 15357 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;66;65;66 03:24:53 INFO - PROCESS | 15357 | |10;stanford-crypto-aes;78;78;78;79;88;80;80;80;80;85 03:24:53 INFO - PROCESS | 15357 | |11;stanford-crypto-ccm;146;134;144;144;130;133;136;130;189;129 03:24:53 INFO - PROCESS | 15357 | |12;stanford-crypto-pbkdf2;167;175;163;163;170;162;163;162;166;161 03:24:53 INFO - PROCESS | 15357 | |13;stanford-crypto-sha256-iterative;67;65;67;66;65;66;65;71;65;66 03:24:53 INFO - PROCESS | 15357 | __end_tp_report 03:24:53 INFO - PROCESS | 15357 | __start_cc_report 03:24:53 INFO - PROCESS | 15357 | _x_x_mozilla_cycle_collect,1927 03:24:53 INFO - PROCESS | 15357 | __end_cc_report 03:24:53 INFO - PROCESS | 15357 | __startTimestamp1469442293728__endTimestamp 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | ------- Summary: start ------- 03:24:53 INFO - PROCESS | 15357 | Number of tests: 14 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.96 (2.6%) stddev-sans-first:0.87 03:24:53 INFO - PROCESS | 15357 | Values: 104.0 114.0 112.0 113.0 114.0 112.0 112.0 113.0 114.0 113.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:139.50 stddev:20.43 (14.6%) stddev-sans-first:20.79 03:24:53 INFO - PROCESS | 15357 | Values: 155.0 122.0 126.0 176.0 121.0 125.0 151.0 128.0 162.0 120.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 03:24:53 INFO - PROCESS | 15357 | Values: 162.0 160.0 160.0 161.0 161.0 161.0 158.0 162.0 161.0 162.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:17.59 (23.2%) stddev-sans-first:18.51 03:24:53 INFO - PROCESS | 15357 | Values: 78.0 76.0 76.0 126.0 76.0 78.0 74.0 75.0 107.0 77.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.00 stddev:18.63 (22.2%) stddev-sans-first:19.32 03:24:53 INFO - PROCESS | 15357 | Values: 85.0 86.0 120.0 84.0 84.0 85.0 123.0 84.0 84.0 126.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:24:53 INFO - PROCESS | 15357 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 03:24:53 INFO - PROCESS | 15357 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:24:53 INFO - PROCESS | 15357 | Values: 95.0 95.0 96.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 03:24:53 INFO - PROCESS | 15357 | Values: 62.0 62.0 62.0 63.0 62.0 64.0 64.0 63.0 63.0 62.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 03:24:53 INFO - PROCESS | 15357 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:3.31 (4.1%) stddev-sans-first:3.37 03:24:53 INFO - PROCESS | 15357 | Values: 78.0 78.0 78.0 79.0 88.0 80.0 80.0 80.0 80.0 85.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:140.00 stddev:17.85 (12.8%) stddev-sans-first:18.86 03:24:53 INFO - PROCESS | 15357 | Values: 146.0 134.0 144.0 144.0 130.0 133.0 136.0 130.0 189.0 129.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:164.50 stddev:4.42 (2.7%) stddev-sans-first:4.64 03:24:53 INFO - PROCESS | 15357 | Values: 167.0 175.0 163.0 163.0 170.0 162.0 163.0 162.0 166.0 161.0 03:24:53 INFO - PROCESS | 15357 | 03:24:53 INFO - PROCESS | 15357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.92 03:24:53 INFO - PROCESS | 15357 | Values: 67.0 65.0 67.0 66.0 65.0 66.0 65.0 71.0 65.0 66.0 03:24:53 INFO - PROCESS | 15357 | -------- Summary: end -------- 03:24:53 INFO - PROCESS | 15357 | 03:24:54 INFO - TEST-INFO | 15357: exit 0 03:24:54 INFO - TEST-OK | kraken | took 63587ms 03:24:54 INFO - SUITE-END | took 1184s 03:24:54 INFO - Completed test suite (00:19:44) 03:24:54 INFO - javascript benchmark 03:24:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.870056497175, 2632.7104018557943, 2663.0, 2667.226504313749, 2673.9598906016413, 4766.165920963835, 4815.325854380385, 4871.8538443846655, 4913.484084171159, 4925.95074049259, 4764.499727528611, 4828.299896515004, 4848.272759086139, 4885.682430642006, 4924.384451943507, 4417.315316125998, 4424.9557504424865, 4480.260756975112, 4484.9551504485025, 4485.416895803557, 4498.145352383053, 4498.280275155976, 4532.728036317815, 4552.97723511382, 4579.4504659440745, 4585.220512512864, 4608.5852273295395, 4610.031893302394, 4619.653525985547, 4629.143608432434, 4353.73877567347, 4407.140607581523, 4416.1167766446515, 4448.043670610834, 4536.228841096989, 4358.978205108986, 4406.339049142623, 4423.093265880487, 4474.53017433168, 4479.664025198123, 4747.976260118712, 4823.975880120612, 4827.444843842968, 4894.681845680019, 4912.582430493412, 5195.454477279869, 5205.063088644042, 5212.713300768456, 5254.8160814371695, 5261.894762104775, 5038.622103342227, 5172.534471897509, 5229.084910140748, 5230.267762513251, 5290.444503327134, 4875.24433712775, 4882.609391248691, 4919.827806026772, 4921.040397122527, 4924.3352147460355, 5381.78472861089, 5383.7846486140115, 5384.165454354581, 5388.245645609618, 5391.865203369947, 4962.354893863775, 5065.0, 5127.769250383742, 5132.640715149903, 5194.402643696023, 5260.237265596467, 5262.421133675292, 5265.6840589564745, 5281.894362112736, 5314.415414304423, 5173.0688476074665, 5184.662996905189, 5185.922211166836, 5187.325647665854, 5238.738063096906, 4956.132676781549, 5014.974925125424, 5035.672681275705, 5085.567726743194, 5093.0, 4395.120975804788, 4405.493368262627, 4408.9118217636105, 4440.489343725449, 4450.888727781831, 3821.8662346817728, 3844.7693138411787, 3853.7687738735767, 3878.030492376906, 3888.125171836314, 4377.562243775597, 4466.798994045275, 4468.396766436489, 4475.552444755498, 4487.147441986012, 5267.0, 5281.287026251483, 5286.894262114736, 5299.072662284085, 5299.178627312773, 4523.457185137804, 4526.479454862667, 4529.846345947108, 4531.161735079021, 4577.5880170784785, 4514.255147900625, 4588.3805686231935, 4604.815807367735, 4613.100445413179, 4750.334953106568, 4829.879253018703, 4837.153498137882, 4852.490488498657, 4886.804527818847, 4896.387951506062, 5183.11886979222, 5199.168133098686, 5207.947920520898, 5211.062008838446, 5219.608529360237, 4721.2918062289555, 4757.215059515142, 4771.928421073756, 4816.590589799766, 4882.998985208095, 5087.592992560661, 5087.720175390389, 5104.3619547556555, 5116.6418350716585, 5131.974340128425, 5209.166533354645, 5249.658772179796, 5257.369115706139, 5291.894162116659, 5322.148456246982, 5103.489651034867, 5104.591632669451, 5108.106081435808, 5113.8721531962, 5161.0968080585, 4947.628927830499, 5007.37407824022, 5107.744612769272, 5110.872228194176, 5125.308083408841, 4981.178105612534, 5024.0, 5043.823466178666, 5091.439941606346, 5098.209777484496, 4964.032013757427, 4990.900181996267, 5004.39947206323, 5021.799128034838, 5208.817691380784, 4999.600031997359, 5003.724795136302, 5008.198688209869, 5017.347744793154, 5018.849434516825], "value": 4773.26446435782, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8983183027053, 576.2221001647775, 587.5652017507047, 589.7523040323064, 590.0176206615985, 29162.270943226402, 39350.60649393509, 40147.59852401475, 40186.196276074465, 40350.7982460088, 40442.0, 40770.0, 40770.79614601923, 40786.0, 40928.38607420884, 7581.279778421042, 7675.692972281102, 7715.845683086335, 7719.652615632282, 7722.382209423261, 7697.576633285167, 7701.9614901925415, 7793.76618701437, 7801.726939557117, 7804.76585702427, 7785.065792104955, 7801.336886364666, 7814.0623125224765, 7820.530768153901, 7823.256790604912, 7772.961135194344, 7789.0, 7797.298243158086, 7808.960955195216, 7812.804679882992, 7685.385169186452, 7755.108162561265, 7755.72854950074, 7761.844763104763, 7770.145284018753, 38910.0, 39276.21447571032, 39283.41074883879, 39298.0, 39333.40999885004, 2976.2113040044405, 2999.3251518408183, 3026.636803583584, 3099.5505651680605, 3118.8128712277335, 29372.0, 29590.852045739848, 29706.0, 29971.850140749375, 30829.383412331852, 3266.852991615383, 3468.1329667583104, 3483.1814523586936, 3524.9823750881337, 3581.0510214793103, 162626.0, 164869.0, 165880.0, 165940.0, 166048.99999999878, 31943.201419964687, 32981.50527742086, 33092.83453582765, 55240.0, 55827.0, 33455.0, 33650.64445488792, 33928.83035584806, 33931.83034084814, 33933.32133357319, 14015.299235038206, 14151.504697335544, 14155.079919805179, 14167.85832141686, 14180.290985450893, 11749.588764393206, 11842.0, 11842.230255033395, 11847.289162650268, 11847.407629618485, 7779.72770953014, 7882.487638303492, 7937.682492700343, 7971.804229365525, 8001.8799718004275, 3084.0, 3129.6087989001376, 3135.6707545707827, 3148.7323577495713, 3175.0474857542645, 878.3544095090103, 898.9280857531381, 905.8414777413926, 917.2249449215402, 976.1897624971399, 27939.30151746182, 28225.858870705924, 28586.28534286618, 28657.942468258792, 28807.279818004718, 774.7714424244862, 929.2983797233046, 1007.9697609071593, 1015.1472762879217, 1018.251585084962, 14367.0, 15011.549653510412, 15062.774058389134, 15447.845521544865, 15479.613009674847, 403683.0, 405733.0, 406532.0, 406695.0, 406832.0, 49451.0, 49471.25793113106, 49648.0, 49818.75090624524, 50024.0, 1084.159776173472, 1165.6328256599145, 1178.6581891251442, 1196.9281843089443, 1207.0705556721275, 28009.43981120407, 29053.418931621673, 29151.562726559543, 29180.416391672472, 29551.0, 42343.0, 42933.0, 42987.14025719531, 43012.0, 43084.0, 284974.0, 287569.0, 287597.0, 287825.0, 289036.0, 24704.752952470244, 25788.61317080283, 25818.354541135872, 26530.071447499246, 26642.600360994988, 41464.0, 41702.58297416987, 42197.367039493816, 42628.78685606552, 43121.137577248905, 35939.28121437609, 37176.25647487089, 37783.81108094552, 40621.390679139244, 41844.0, 36038.8198059008, 36097.0, 36313.273734524635, 36620.45069324016, 36699.816500918394, 34889.302213956085, 35413.29173416569, 35622.643773562966, 36700.63299366972, 37081.81459092795, 31118.222044448165, 33003.66996330006, 34023.48964765481, 34128.0, 34328.48507272443, 25584.360390990376, 25759.742402575735, 26150.215493535223, 26175.345616359744, 26633.334166645214], "value": 16319.934600862978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.24781851654154, 364.8960046386779, 373.83551237455515, 374.4888227569367, 390.1533671931908, 12709.555165569207, 16110.35558577657, 16481.0, 17892.0, 18075.638487230248, 17742.82257177431, 18052.81947180531, 18154.183061762218, 18176.18207180677, 18296.359627413043, 4856.514348565151, 5168.043911876296, 5193.298904647881, 5197.610179236553, 5204.037253108168, 3639.144800971783, 5117.590592752571, 5204.8809505956215, 5207.297014902996, 5769.0, 6040.275166979968, 6044.24446944132, 6060.151578778975, 6071.362506936753, 6149.661768602725, 5801.158831969341, 6018.638881667114, 6046.879062418749, 6050.45545900871, 6051.273847138327, 5281.9207711884355, 5292.655977361459, 5299.33758280215, 5299.814506492255, 5308.6549374290935, 20049.79950200494, 20787.792122078736, 20859.269925552533, 20898.791012089987, 21280.893595531925, 1845.4002449204063, 1916.7220752990877, 2142.0146732503067, 2494.2143224884285, 2501.0, 13184.934075329658, 13478.191308521422, 13713.725725485434, 13780.655483612889, 14114.92942535291, 1665.4095338951392, 1722.5951901303183, 1732.5928406824387, 1759.6568669109529, 1761.2718424469483, 43251.56748432507, 64552.67723661352, 66760.66619666919, 68878.3112168877, 73003.26996730072, 9982.301238913351, 10116.54475548602, 10120.797584048278, 10160.847587286196, 10370.118539924191, 14128.86969042474, 14166.575002749934, 14207.147571145557, 14208.431662733376, 14222.288885555681, 7264.527805692613, 7375.500944423897, 7487.775366739006, 7514.323710866049, 7610.035584702023, 7384.409247260313, 7441.627918604048, 7506.474546781782, 7549.924500755032, 7621.923780762232, 4266.701330906807, 4373.906523369158, 4400.141972315432, 4485.147821913826, 4527.320901864681, 1647.8928869623676, 1766.2140347545476, 1790.9373171938919, 1796.8796819752818, 1811.2845426056633, 653.8986457099157, 792.9841403171904, 831.6590198018783, 832.4713806732768, 858.1289990659485, 16567.17164141788, 16669.16654167287, 16748.330066797436, 16785.07682077473, 17569.121543922753, 828.0127693535443, 851.2679095977454, 854.3165467625998, 865.3726048614704, 876.3296078499952, 9253.306002049872, 9492.184979475856, 9693.660721874701, 9715.46564938921, 9749.07383798538, 380191.0, 382063.0, 385975.0, 386895.0, 387264.0, 73808.0, 75176.62411687906, 75451.24548754552, 76113.0, 80402.59798700969, 837.6063250272363, 905.3526728389234, 913.9040400757958, 929.2287401456774, 938.3150300280697, 11459.48432320531, 14759.188244646648, 15531.45639902598, 15764.211789410254, 16687.249073791467, 35899.28201436009, 36856.44715329219, 37264.627353726115, 37293.6270637301, 37566.2486750258, 50786.746066269436, 51067.489325106275, 51355.486445136565, 51571.0, 51861.22208166805, 7384.446166537424, 7571.924280757122, 7575.0909890813455, 7857.135715071223, 8141.9185808141165, 11496.54013839437, 11501.712457188638, 11741.41292935367, 11846.822297665369, 11980.64058078259, 9580.281478888972, 9619.807603847745, 10067.395956242648, 10267.075963163352, 10563.894361056598, 4900.436449808318, 9057.411268267806, 9403.764905877408, 9981.550830212513, 10496.47517624131, 10297.124744396511, 10581.36511809294, 10632.0, 10767.246292759432, 11075.944620276847, 6686.465082793267, 6761.256261811295, 6856.9314306856295, 7030.578165310098, 7861.803454913673, 8409.579521024047, 10322.329048611817, 10521.105706014769, 10675.0, 10868.347899125762], "value": 8282.01662505584, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.624531376528, 1411.6118067531427, 1470.7426200414925, 1684.2168391697874, 1715.6911755883937, 7515.549067055974, 8116.066652334984, 8129.943107396038, 8136.349092072634, 8144.6742130314715, 6845.452363810896, 7076.256993015723, 7469.253074692528, 7760.262775036363, 7919.366450683946, 2208.856424332417, 2238.7089678341795, 2238.9776102238934, 2240.5518896220738, 2242.955140897181, 2165.935021949344, 2196.187410658059, 2224.132588290568, 2227.220472834503, 2228.9108435662556, 1840.319081939684, 2089.3105275259127, 2158.0504577985716, 2179.640359340715, 2197.0223250653466, 2208.536207396449, 2208.9889550552143, 2226.1206823304865, 2227.3874684461903, 2227.7326720793526, 2209.4476380904775, 2215.1471683401846, 2216.7783221677864, 2217.7116974793175, 2220.0675716199235, 8048.0, 8090.838183236302, 8096.838063238761, 8100.473469224482, 8106.837863242702, 4537.727736335831, 4663.183942810028, 4664.253719404879, 4665.626749860037, 4690.01509682967, 2834.2489240351324, 3018.5170372740477, 3029.1972627253795, 3033.0445909538425, 3033.2568520712566, 840.7099550655014, 861.7845538615346, 868.3096937934357, 875.4309698695835, 879.3317079019927, 10936.234463587552, 10965.342079475256, 10967.670969870916, 10990.285631433931, 11000.394978276192, 4091.263572556909, 4252.192083504125, 4385.057212699285, 4390.407295015196, 4401.097774956126, 9176.770580735401, 9214.262858971266, 9219.21636660878, 9223.907760922304, 9230.907690923004, 4775.42694876617, 4788.497207793202, 4791.305260737174, 4796.184648609745, 4799.088173247072, 4245.299525578307, 4373.693841431133, 4387.561243875651, 4396.846110386121, 4400.44994375703, 3354.2452948086975, 3414.129397003748, 3498.3877821381666, 3499.2476617527354, 3510.736694747904, 1007.9294449388473, 1014.3102690170607, 1035.2649618770606, 1039.5166247694858, 1080.778440419712, 660.6498555765452, 694.2571448550104, 735.2904447208363, 815.9265666089962, 829.8921140251729, 5013.197888337849, 5153.7165455900285, 5160.7935682573025, 5285.7621407036, 5422.61723260566, 440.37246923135046, 452.72610070907285, 453.17974466216253, 453.99773001135446, 603.8707616756693, 3438.0, 3657.9817100914856, 3699.5560532736245, 3827.483289755903, 3839.6544311012144, 9517.191038761644, 9952.950235248778, 9960.452175130438, 9979.60081596728, 9984.850227246598, 9830.655927042519, 9880.950595246977, 9909.950450247703, 9914.157296629723, 9918.15695665862, 6938.653067346612, 7261.128664560287, 7279.0, 7296.270372962661, 7444.664990075459, 5570.58220633446, 5617.719114044363, 5659.603827732184, 5704.743286552032, 5793.8551536211935, 8650.140219852761, 8834.337424693302, 8857.335699822668, 8889.422187557788, 9004.054574269607, 9109.863352049591, 9245.075492450702, 9292.442453452815, 9295.6281748732, 9379.484128373006, 6891.138607674041, 7069.6111713856235, 7069.858602827811, 7069.929300706927, 7075.398591119607, 7548.358389536951, 7562.810929726801, 7604.695812167452, 7613.200613935457, 7639.04511936008, 6888.483363747639, 6893.241743408322, 6935.89596156048, 6961.6519174042105, 6983.371496565131, 6736.595804251565, 6907.792766217021, 6909.965450172717, 6932.688029038806, 6941.132358455193, 5934.495567876606, 6005.7297421617, 6012.669303188191, 6015.819525414245, 6020.1270815730595, 4769.30845027476, 4842.080004799077, 4872.366592342973, 4889.731064791471, 4898.730569818694, 4451.643868490578, 4467.0, 4564.269716845289, 4617.722936623813, 4708.811647534198], "value": 4098.114686167338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.3691857129314, 298.57453129290764, 300.228412978645, 314.0609577363683, 314.625595541306, 4869.9269510957365, 4957.1325018121815, 4962.578180854623, 4967.627427942905, 5020.364308737914, 4679.15775160471, 4809.807607695688, 4829.0100529391475, 4829.1307564638355, 4926.359573255471, 3769.944415563633, 3812.866549670762, 3825.139343647671, 3875.2249550090096, 3906.335922893115, 3886.378179491282, 3897.064704470921, 3920.1179734559637, 3926.175503144343, 3927.3323534999117, 3667.211549516853, 3811.313963486571, 3884.844606215748, 3894.3963685628773, 3906.5507466641275, 3818.0, 3823.254465379252, 3831.214601006801, 3833.9233215335817, 3840.327942610032, 3364.7308215342714, 3371.9157021074425, 3379.4423920053164, 3405.7445691572984, 3412.266362732, 4812.398450193726, 4827.686200396963, 4844.66087373884, 4850.75746212688, 4886.218205087204, 4154.109880004591, 4367.6069153776, 4390.05613793036, 4409.625181859546, 4416.712913660634, 5124.948750512522, 5144.4083930348115, 5144.942023190716, 5160.483951604847, 5177.0, 3697.5193224880595, 3709.8516059357594, 3711.1278849470355, 3714.4056950888, 3718.8140592970512, 5158.40678321994, 5378.731063446851, 5429.131338985783, 5501.312335958005, 5520.558355331564, 3689.5203623529305, 3709.925801483955, 3710.6845918097265, 3737.3085979093953, 3744.307303148926, 3788.791616461066, 3801.163743976321, 3805.6955443564448, 3809.3524100902914, 3810.8856734298015, 4211.7472951622385, 4320.827166913351, 4365.367021781887, 4366.8908277292685, 4390.407295015196, 5131.281620573122, 5134.0, 5138.897222055538, 5142.1772516397195, 5149.742512874416, 1282.179405180685, 1298.6558561981083, 1301.8437787465564, 1306.8303868038242, 1310.2269660900115, 837.8437755896823, 876.7632739160391, 887.4231749362966, 899.3030401438806, 905.4748246017294, 4487.842925497657, 4493.0, 4493.281075028045, 4503.864884053418, 4513.526079761577, 5228.581713462914, 5235.60732945023, 5284.833218380446, 5313.335833020872, 5346.866328341823, 4304.78476076195, 4473.709208901411, 4481.170983368087, 4539.546045395434, 4555.339475775994, 2783.997760806108, 2796.1891051595217, 2805.424887897976, 2818.7456581821302, 2826.703196164373, 4873.780679869415, 4885.926711099336, 4906.1659517881335, 4911.803527858917, 4954.0, 5191.247269146028, 5363.712708949902, 5394.163904594794, 5411.161270003156, 5439.5104440600535, 4903.289023091632, 4906.2640603909695, 4913.508649135058, 4918.508149185053, 4930.235813448921, 5264.236685680631, 5286.20706893969, 5299.152135658276, 5307.346326836581, 5313.449544218719, 4916.55750982399, 5010.749462526932, 5110.361204849394, 5116.820911268088, 5120.769565369493, 4876.902461950812, 4877.804887804448, 4882.536159064884, 4918.360613120271, 4934.7285899275885, 3730.1980074283074, 3747.7938713371027, 3754.155315054091, 3756.267527832156, 3793.3740932745786, 5051.646384753179, 5255.9211611825085, 5288.788448462173, 5313.362396512443, 5340.519353258225, 5176.637635365489, 5184.922226166686, 5187.974060129675, 5206.245094461357, 5223.0, 5261.921071184011, 5262.552683021833, 5264.131418315935, 5264.710440925633, 5282.392524859691, 4862.79055823155, 4892.192788189909, 5114.777690055242, 5122.487751224848, 5126.53861152498, 5087.64386492942, 5195.870103247449, 5244.947550524446, 5251.684898906078, 5267.3152490176035, 5128.8717782054255, 5141.691498510101, 5142.382914050338, 5143.3056537368475, 5156.329677141947], "value": 3878.759631649726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1985457160548, 705.8517711280631, 718.3606590134777, 718.6083584446477, 751.4439314906969, 12531.373431328431, 13584.320783960811, 13584.592462226125, 13592.116512426697, 13606.387712552922, 13120.278384688838, 13191.14257573257, 13233.867661323384, 13253.867461325384, 13264.535741249058, 624.1605041219552, 649.4122818848949, 754.2871985973258, 759.3355813663045, 781.5779479081318, 777.1645481107804, 794.6185830801219, 794.7417089445925, 794.972175973841, 795.5505139596139, 841.4530555139147, 847.2501835875264, 847.8897743293394, 848.2959143910571, 848.4866655673321, 648.5557393185636, 784.3372350363933, 825.2407784837964, 837.7319257837495, 838.0948575538404, 601.3235110500686, 601.6750954484573, 601.7653115285042, 608.3399511529996, 609.1745684597396, 13386.799198012037, 13450.663733406645, 13459.528916487974, 13475.66310842227, 13484.325783710776, 12267.202631828903, 12578.119531632788, 12668.493260269579, 12792.393280198143, 12996.545120920722, 11669.824952625717, 11778.293302401884, 11909.0, 11961.0, 12465.626031219077, 3967.861124860616, 4004.8798536043964, 4085.9795701021303, 4103.322951712964, 4119.608637179464, 56678.0, 56683.716581416826, 56826.14760778592, 56969.14546281809, 56988.715056424866, 9703.417794932328, 9993.10062094415, 10323.587056517656, 10355.637552685619, 10524.631637892637, 18180.909095454703, 18352.357667481574, 18379.54051148732, 18457.723134153, 18490.0, 6761.628110453972, 6826.078479405217, 6957.199922009034, 7024.613646249505, 7050.541714788523, 3574.7855128692363, 3587.9282414352087, 3608.332458495187, 3609.8375573099274, 3620.981895090508, 2674.064077572873, 2750.4636595864013, 2755.517784387764, 3272.9509057364157, 3439.4840773884116, 600.2107228993859, 600.7236671131328, 610.6458254212635, 611.2939554814196, 613.1722175063628, 502.7687263858593, 559.0970582509218, 600.8497875531117, 626.602107661629, 650.7429565321671, 8083.353331733447, 8196.098429172785, 8360.958195209107, 8650.567471626393, 8652.264557512555, 432.44214962697765, 464.628297362109, 531.3331768630421, 636.1825054804553, 642.210081599635, 3788.913297314407, 4017.678585713136, 4105.2405305018665, 4415.779211039435, 4564.680472366902, 92714.07285927054, 96643.0, 98590.0, 102199.48900255452, 102373.48813256035, 84800.57599712085, 85664.0, 87113.0, 87287.56356218306, 88875.55562222148, 59369.0, 61221.0, 62455.0, 71288.28711713024, 79346.20653793387, 8024.638891249791, 8487.0, 8700.781890535456, 8745.387822852339, 8943.150400711922, 41685.58314416817, 42196.789016054725, 42204.57795422006, 42379.0, 43204.0, 62786.686066569375, 63509.364906352195, 64013.67993160005, 64054.0, 65909.34090659033, 10499.265051446326, 10755.0, 10902.945485272523, 11092.445377731243, 11260.099192064452, 12904.354782260662, 13035.087543871838, 13132.671683207996, 13480.865191348354, 13613.251271180181, 11976.0, 12142.878571214174, 12145.271283723005, 12511.374431278582, 12602.11785175029, 12277.754444910874, 12407.93796031014, 12625.87374126247, 12972.675683107998, 13121.606351809462, 12261.69345766363, 12371.566995155126, 12406.503739850305, 13162.021296190296, 13314.800277996032, 9234.722958311262, 9479.146876781122, 9517.476538790155, 9573.473458959545, 9772.755681108029, 7714.652840622073, 8402.0, 8555.101714319906, 8706.47761134334, 8908.420952638058], "value": 6637.396225146379, "unit": "score"}], "name": "dromaeo_css", "value": 6389.963663315568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 113.0, 114.0, 112.0, 112.0, 113.0, 114.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 126.0, 176.0, 121.0, 125.0, 151.0, 128.0, 162.0, 120.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 161.0, 161.0, 158.0, 162.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 126.0, 76.0, 78.0, 74.0, 75.0, 107.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 120.0, 84.0, 84.0, 85.0, 123.0, 84.0, 84.0, 126.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 64.0, 64.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 79.0, 88.0, 80.0, 80.0, 80.0, 80.0, 85.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 134.0, 144.0, 144.0, 130.0, 133.0, 136.0, 130.0, 189.0, 129.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 175.0, 163.0, 163.0, 170.0, 162.0, 163.0, 162.0, 166.0, 161.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 71.0, 65.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1532.3, "alertThreshold": 2.0}]} 03:24:54 INFO - Return code: 0 03:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:55 INFO - # TBPL SUCCESS # 03:24:55 INFO - Running post-action listener: _resource_record_post_action 03:24:55 INFO - [mozharness: 2016-07-25 10:24:55.044605Z] Finished run-tests step (success) 03:24:55 INFO - Running post-run listener: _resource_record_post_run 03:24:55 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 16384; Write bytes: 536080384; Read time: 248; Write time: 388616 03:24:55 INFO - TinderboxPrint: CPU usage
13.0% 03:24:55 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 248 03:24:55 INFO - TinderboxPrint: I/O write bytes / time
536,080,384 / 388,616 03:24:55 INFO - TinderboxPrint: CPU idle
8,341.4 (87.0%) 03:24:55 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 03:24:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:24:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 247095296; Read time: 152; Write time: 228576 03:24:55 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288985088; Read time: 84; Write time: 160040 03:24:55 INFO - Running post-run listener: _upload_blobber_files 03:24:55 INFO - Blob upload gear active. 03:24:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24:55 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 03:24:55 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:24:55 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:20 INFO - (blobuploader) - INFO - Done attempting. 03:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:21 INFO - (blobuploader) - INFO - Done attempting. 03:25:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:25:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:25:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:22 INFO - (blobuploader) - INFO - Done attempting. 03:25:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:25:22 INFO - Return code: 0 03:25:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:25:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:25:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c403a67759ac4156ee16a03280e981128e7f176e62906b64edf12ca6af941b5b90dd6a2a1cfd913eba55c0995224d714fc81e3830cdcbe10036fc36bac66061a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/711a4328b35c771c7f5cb089ed12354b65321d76e13e50b579fca45f68c10ce22bee1bd7138178fe1cef077ea41172dac0409eb9deb34c2d2f7b47062f4d60c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9ce3113d96df08ab6832873d865c2392df79ef27d840255c42949eae7345fa0b944e6eb8b226c2b7574aeccf2d61b65c8ef4495b1ebb01a8433501ae372e4de"} 03:25:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:25:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:25:22 INFO - Contents: 03:25:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c403a67759ac4156ee16a03280e981128e7f176e62906b64edf12ca6af941b5b90dd6a2a1cfd913eba55c0995224d714fc81e3830cdcbe10036fc36bac66061a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/711a4328b35c771c7f5cb089ed12354b65321d76e13e50b579fca45f68c10ce22bee1bd7138178fe1cef077ea41172dac0409eb9deb34c2d2f7b47062f4d60c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9ce3113d96df08ab6832873d865c2392df79ef27d840255c42949eae7345fa0b944e6eb8b226c2b7574aeccf2d61b65c8ef4495b1ebb01a8433501ae372e4de"} 03:25:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:25:22 INFO - Copying logs to upload dir... 03:25:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:25:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.999935 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-07-25 03:25:21.523546) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 03:25:21.526733) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c403a67759ac4156ee16a03280e981128e7f176e62906b64edf12ca6af941b5b90dd6a2a1cfd913eba55c0995224d714fc81e3830cdcbe10036fc36bac66061a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/711a4328b35c771c7f5cb089ed12354b65321d76e13e50b579fca45f68c10ce22bee1bd7138178fe1cef077ea41172dac0409eb9deb34c2d2f7b47062f4d60c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9ce3113d96df08ab6832873d865c2392df79ef27d840255c42949eae7345fa0b944e6eb8b226c2b7574aeccf2d61b65c8ef4495b1ebb01a8433501ae372e4de"} build_url:https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/dEgnc1oqRx-ubudIE3wGnw/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/Autoland-Non-PGO/sha512/c403a67759ac4156ee16a03280e981128e7f176e62906b64edf12ca6af941b5b90dd6a2a1cfd913eba55c0995224d714fc81e3830cdcbe10036fc36bac66061a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/711a4328b35c771c7f5cb089ed12354b65321d76e13e50b579fca45f68c10ce22bee1bd7138178fe1cef077ea41172dac0409eb9deb34c2d2f7b47062f4d60c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e9ce3113d96df08ab6832873d865c2392df79ef27d840255c42949eae7345fa0b944e6eb8b226c2b7574aeccf2d61b65c8ef4495b1ebb01a8433501ae372e4de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 03:25:21.553879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:25:21.554382) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469435800.113386-684818273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 03:25:21.638365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 03:25:21.638827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 03:25:21.639301) ========= ========= Total master_lag: 0.20 =========