builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1469796548.23 results: success (0) buildid: 20160729030203 builduid: 8dfe60aa783f48bdaf56557fa4cb949d revision: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.226903) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.227570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.227846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.242882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.243210) ========= 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=0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 05:49:08-- 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% 221M=0s 2016-07-29 05:49:08 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.437176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.437546) ========= 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=0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016623 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.487101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:08.487493) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 --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=0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 05:49:08,618 truncating revision to first 12 chars 2016-07-29 05:49:08,618 Setting DEBUG logging. 2016-07-29 05:49:08,619 attempt 1/10 2016-07-29 05:49:08,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ea3d51ba1bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 05:49:08,912 unpacking tar archive at: mozilla-central-2ea3d51ba1bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:09.178205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:09.178521) ========= script_repo_revision: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:09.178897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:09.179160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 05:49:09.188473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-29 05:49:09.188774) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:09 INFO - MultiFileLogger online at 20160729 05:49:09 in /builds/slave/test 05:49:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:09 INFO - {'append_to_log': False, 05:49:09 INFO - 'base_work_dir': '/builds/slave/test', 05:49:09 INFO - 'blob_upload_branch': 'Firefox', 05:49:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:09 INFO - 'branch': 'Firefox', 05:49:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:09 INFO - 'config_files': ('talos/linux_config.py',), 05:49:09 INFO - 'default_actions': ('clobber', 05:49:09 INFO - 'read-buildbot-config', 05:49:09 INFO - 'download-and-extract', 05:49:09 INFO - 'populate-webroot', 05:49:09 INFO - 'create-virtualenv', 05:49:09 INFO - 'install', 05:49:09 INFO - 'run-tests'), 05:49:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:09 INFO - 'download_minidump_stackwalk': True, 05:49:09 INFO - 'download_symbols': 'ondemand', 05:49:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:09 INFO - 'installer_path': 'installer.exe', 05:49:09 INFO - 'log_level': 'info', 05:49:09 INFO - 'log_name': 'talos', 05:49:09 INFO - 'log_to_console': True, 05:49:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:09 INFO - 'opt_config_files': (), 05:49:09 INFO - 'pip_index': False, 05:49:09 INFO - 'sps_profile': False, 05:49:09 INFO - 'sps_profile_interval': 0, 05:49:09 INFO - 'suite': 'dromaeojs', 05:49:09 INFO - 'system_bits': '32', 05:49:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:09 INFO - 'title': 'talos-linux64-ix-017', 05:49:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:09 INFO - 'use_talos_json': True, 05:49:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:09 INFO - 'work_dir': 'build'} 05:49:09 INFO - [mozharness: 2016-07-29 12:49:09.420535Z] Running clobber step. 05:49:09 INFO - Running pre-action listener: _resource_record_pre_action 05:49:09 INFO - Running main action method: clobber 05:49:09 INFO - rmtree: /builds/slave/test/build 05:49:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:09 INFO - Running post-action listener: _resource_record_post_action 05:49:09 INFO - [mozharness: 2016-07-29 12:49:09.890389Z] Finished clobber step (success) 05:49:09 INFO - [mozharness: 2016-07-29 12:49:09.890488Z] Running read-buildbot-config step. 05:49:09 INFO - Running pre-action listener: _resource_record_pre_action 05:49:09 INFO - Running main action method: read_buildbot_config 05:49:09 INFO - Using buildbot properties: 05:49:09 INFO - { 05:49:09 INFO - "project": "", 05:49:09 INFO - "product": "firefox", 05:49:09 INFO - "script_repo_revision": "production", 05:49:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:49:09 INFO - "repository": "", 05:49:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:49:09 INFO - "buildid": "20160729030203", 05:49:09 INFO - "stage_platform": "linux64-pgo", 05:49:09 INFO - "basedir": "/builds/slave/test", 05:49:09 INFO - "nightly_build": "True", 05:49:09 INFO - "buildnumber": 812, 05:49:09 INFO - "slavename": "talos-linux64-ix-017", 05:49:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:49:09 INFO - "platform": "ubuntu64_hw", 05:49:09 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:09 INFO - "branch": "mozilla-central", 05:49:09 INFO - "repo_path": "mozilla-central", 05:49:09 INFO - "revision": "2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2", 05:49:09 INFO - "pgo_build": "True", 05:49:09 INFO - "builduid": "8dfe60aa783f48bdaf56557fa4cb949d", 05:49:09 INFO - "slavebuilddir": "test" 05:49:09 INFO - } 05:49:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:49:09 INFO - Running post-action listener: _resource_record_post_action 05:49:09 INFO - [mozharness: 2016-07-29 12:49:09.893002Z] Finished read-buildbot-config step (success) 05:49:09 INFO - [mozharness: 2016-07-29 12:49:09.893091Z] Running download-and-extract step. 05:49:09 INFO - Running pre-action listener: _resource_record_pre_action 05:49:09 INFO - Running main action method: download_and_extract 05:49:09 INFO - mkdir: /builds/slave/test/build/tests 05:49: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')]} 05:49:09 INFO - https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:10 INFO - Downloaded 1361 bytes. 05:49:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:10 INFO - Using the following test package requirements: 05:49:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'jsshell-linux-x86_64.zip'], 05:49:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:10 INFO - https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:11 INFO - Downloaded 24330266 bytes. 05:49:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:12 INFO - Return code: 0 05:49:12 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 05:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:12 INFO - https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:13 INFO - Downloaded 24330266 bytes. 05:49:13 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'] 05:49:13 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 05:49:15 INFO - Return code: 0 05:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:15 INFO - https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:15 INFO - Downloaded 14413725 bytes. 05:49:15 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'] 05:49:15 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 05:49:16 INFO - Return code: 0 05:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:16 INFO - https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHWZW3LwRamMRpunDGT2VQ/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 05:49:17 INFO - Downloaded 61005366 bytes. 05:49:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:17 INFO - mkdir: /builds/slave/test/properties 05:49:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:17 INFO - Contents: 05:49:17 INFO - build_url:https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:17 INFO - Running post-action listener: _resource_record_post_action 05:49:17 INFO - Running post-action listener: set_extra_try_arguments 05:49:17 INFO - [mozharness: 2016-07-29 12:49:17.862408Z] Finished download-and-extract step (success) 05:49:17 INFO - [mozharness: 2016-07-29 12:49:17.862641Z] Running populate-webroot step. 05:49:17 INFO - Running pre-action listener: _resource_record_pre_action 05:49:17 INFO - Running main action method: populate_webroot 05:49:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:17 INFO - '--tppagecycles', 05:49:17 INFO - '7'], 05:49:17 INFO - 'tests': ['tsvgm']}}, 05:49:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['damp', 'tps']}, 05:49:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'tests': ['damp', 'tps']}, 05:49:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['dromaeo_dom']}, 05:49:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['basic_compositor_video']}, 05:49:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['a11yr', 05:49:17 INFO - 'ts_paint', 05:49:17 INFO - 'tpaint', 05:49:17 INFO - 'sessionrestore', 05:49:17 INFO - 'sessionrestore_no_auto_restore', 05:49:17 INFO - 'tabpaint']}, 05:49:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tsvgx', 05:49:17 INFO - 'tsvgr_opacity', 05:49:17 INFO - 'tart', 05:49:17 INFO - 'tscrollx', 05:49:17 INFO - 'cart']}, 05:49:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:17 INFO - 'tsvgr_opacity', 05:49:17 INFO - 'tart', 05:49:17 INFO - 'tscrollx', 05:49:17 INFO - 'cart']}, 05:49:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s'], 05:49:17 INFO - 'tests': ['tp5o']}, 05:49:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'tests': ['tp5o']}, 05:49:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'talos_options': ['--disable-e10s', 05:49:17 INFO - '--xperf_path', 05:49:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:17 INFO - 'tests': ['tp5n']}, 05:49:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:17 INFO - 'talos_options': ['--xperf_path', 05:49:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:17 INFO - 'tests': ['tp5n']}}, 05:49:17 INFO - 'talos.zip': {'path': '', 05:49:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:17 INFO - Running post-action listener: _resource_record_post_action 05:49:17 INFO - [mozharness: 2016-07-29 12:49:17.880232Z] Finished populate-webroot step (success) 05:49:17 INFO - [mozharness: 2016-07-29 12:49:17.880321Z] Running create-virtualenv step. 05:49:17 INFO - Running pre-action listener: _resource_record_pre_action 05:49:17 INFO - Running main action method: create_virtualenv 05:49:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:49:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:17 INFO - Using real prefix '/usr' 05:49:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:20 INFO - Installing pip.................done. 05:49:20 INFO - Return code: 0 05:49:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:20 INFO - Using env: {'DISPLAY': ':0', 05:49:20 INFO - 'HOME': '/home/cltbld', 05:49:20 INFO - 'LANG': 'en_US.UTF-8', 05:49:20 INFO - 'LANGUAGE': 'en_US:en', 05:49:20 INFO - 'LOGNAME': 'cltbld', 05:49:20 INFO - 'MAIL': '/var/mail/cltbld', 05:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:20 INFO - 'MOZ_NO_REMOTE': '1', 05:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:20 INFO - 'NO_EM_RESTART': '1', 05:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:20 INFO - 'PWD': '/builds/slave/test', 05:49:20 INFO - 'SHELL': '/bin/bash', 05:49:20 INFO - 'SHLVL': '1', 05:49:20 INFO - 'TERM': 'linux', 05:49:20 INFO - 'TMOUT': '86400', 05:49:20 INFO - 'USER': 'cltbld', 05:49:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:20 INFO - '_': '/tools/buildbot/bin/python'} 05:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:20 INFO - Cleaning up... 05:49:20 INFO - Return code: 0 05:49:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:20 INFO - Using env: {'DISPLAY': ':0', 05:49:20 INFO - 'HOME': '/home/cltbld', 05:49:20 INFO - 'LANG': 'en_US.UTF-8', 05:49:20 INFO - 'LANGUAGE': 'en_US:en', 05:49:20 INFO - 'LOGNAME': 'cltbld', 05:49:20 INFO - 'MAIL': '/var/mail/cltbld', 05:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:20 INFO - 'MOZ_NO_REMOTE': '1', 05:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:20 INFO - 'NO_EM_RESTART': '1', 05:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:20 INFO - 'PWD': '/builds/slave/test', 05:49:20 INFO - 'SHELL': '/bin/bash', 05:49:20 INFO - 'SHLVL': '1', 05:49:20 INFO - 'TERM': 'linux', 05:49:20 INFO - 'TMOUT': '86400', 05:49:20 INFO - 'USER': 'cltbld', 05:49:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:20 INFO - '_': '/tools/buildbot/bin/python'} 05:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:20 INFO - Downloading/unpacking psutil>=3.1.1 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:22 INFO - Installing collected packages: psutil 05:49:22 INFO - Running setup.py install for psutil 05:49:22 INFO - building 'psutil._psutil_linux' extension 05:49:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:23 INFO - building 'psutil._psutil_posix' extension 05:49:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:49:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:23 INFO - Successfully installed psutil 05:49:23 INFO - Cleaning up... 05:49:23 INFO - Return code: 0 05:49:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:49:23 INFO - Using env: {'DISPLAY': ':0', 05:49:23 INFO - 'HOME': '/home/cltbld', 05:49:23 INFO - 'LANG': 'en_US.UTF-8', 05:49:23 INFO - 'LANGUAGE': 'en_US:en', 05:49:23 INFO - 'LOGNAME': 'cltbld', 05:49:23 INFO - 'MAIL': '/var/mail/cltbld', 05:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:23 INFO - 'MOZ_NO_REMOTE': '1', 05:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:23 INFO - 'NO_EM_RESTART': '1', 05:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:23 INFO - 'PWD': '/builds/slave/test', 05:49:23 INFO - 'SHELL': '/bin/bash', 05:49:23 INFO - 'SHLVL': '1', 05:49:23 INFO - 'TERM': 'linux', 05:49:23 INFO - 'TMOUT': '86400', 05:49:23 INFO - 'USER': 'cltbld', 05:49:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:23 INFO - '_': '/tools/buildbot/bin/python'} 05:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:25 INFO - Installing collected packages: mozsystemmonitor 05:49:25 INFO - Running setup.py install for mozsystemmonitor 05:49:25 INFO - Successfully installed mozsystemmonitor 05:49:25 INFO - Cleaning up... 05:49:25 INFO - Return code: 0 05:49:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:25 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:49:25 INFO - Using env: {'DISPLAY': ':0', 05:49:25 INFO - 'HOME': '/home/cltbld', 05:49:25 INFO - 'LANG': 'en_US.UTF-8', 05:49:25 INFO - 'LANGUAGE': 'en_US:en', 05:49:25 INFO - 'LOGNAME': 'cltbld', 05:49:25 INFO - 'MAIL': '/var/mail/cltbld', 05:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:25 INFO - 'MOZ_NO_REMOTE': '1', 05:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:25 INFO - 'NO_EM_RESTART': '1', 05:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:25 INFO - 'PWD': '/builds/slave/test', 05:49:25 INFO - 'SHELL': '/bin/bash', 05:49:25 INFO - 'SHLVL': '1', 05:49:25 INFO - 'TERM': 'linux', 05:49:25 INFO - 'TMOUT': '86400', 05:49:25 INFO - 'USER': 'cltbld', 05:49:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:25 INFO - '_': '/tools/buildbot/bin/python'} 05:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:28 INFO - warning: no files found matching '*.txt' 05:49:28 INFO - no previously-included directories found matching 'build' 05:49:28 INFO - no previously-included directories found matching 'dist' 05:49:28 INFO - no previously-included directories found matching '.git*' 05:49:28 INFO - Installing collected packages: jsonschema, functools32 05:49:28 INFO - Running setup.py install for functools32 05:49:28 INFO - warning: no files found matching '*.txt' 05:49:28 INFO - no previously-included directories found matching 'build' 05:49:28 INFO - no previously-included directories found matching 'dist' 05:49:28 INFO - no previously-included directories found matching '.git*' 05:49:28 INFO - Successfully installed jsonschema functools32 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:49:28 INFO - Using env: {'DISPLAY': ':0', 05:49:28 INFO - 'HOME': '/home/cltbld', 05:49:28 INFO - 'LANG': 'en_US.UTF-8', 05:49:28 INFO - 'LANGUAGE': 'en_US:en', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MAIL': '/var/mail/cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SHLVL': '1', 05:49:28 INFO - 'TERM': 'linux', 05:49:28 INFO - 'TMOUT': '86400', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - '_': '/tools/buildbot/bin/python'} 05:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:49:28 INFO - Using env: {'DISPLAY': ':0', 05:49:28 INFO - 'HOME': '/home/cltbld', 05:49:28 INFO - 'LANG': 'en_US.UTF-8', 05:49:28 INFO - 'LANGUAGE': 'en_US:en', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MAIL': '/var/mail/cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SHLVL': '1', 05:49:28 INFO - 'TERM': 'linux', 05:49:28 INFO - 'TMOUT': '86400', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - '_': '/tools/buildbot/bin/python'} 05:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:31 INFO - Downloading docopt-0.6.1.tar.gz 05:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:31 INFO - Running setup.py install for blobuploader 05:49:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:31 INFO - Running setup.py install for requests 05:49:31 INFO - Running setup.py install for docopt 05:49:31 INFO - Successfully installed blobuploader requests docopt 05:49:31 INFO - Cleaning up... 05:49:31 INFO - Return code: 0 05:49:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:32 INFO - Using env: {'DISPLAY': ':0', 05:49:32 INFO - 'HOME': '/home/cltbld', 05:49:32 INFO - 'LANG': 'en_US.UTF-8', 05:49:32 INFO - 'LANGUAGE': 'en_US:en', 05:49:32 INFO - 'LOGNAME': 'cltbld', 05:49:32 INFO - 'MAIL': '/var/mail/cltbld', 05:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:32 INFO - 'MOZ_NO_REMOTE': '1', 05:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:32 INFO - 'NO_EM_RESTART': '1', 05:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:32 INFO - 'PWD': '/builds/slave/test', 05:49:32 INFO - 'SHELL': '/bin/bash', 05:49:32 INFO - 'SHLVL': '1', 05:49:32 INFO - 'TERM': 'linux', 05:49:32 INFO - 'TMOUT': '86400', 05:49:32 INFO - 'USER': 'cltbld', 05:49:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:32 INFO - '_': '/tools/buildbot/bin/python'} 05:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:32 INFO - Running setup.py (path:/tmp/pip-XVjPDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:32 INFO - Running setup.py (path:/tmp/pip-6ywdza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:32 INFO - Running setup.py (path:/tmp/pip-uLJBfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:32 INFO - Running setup.py (path:/tmp/pip-WPjRUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:32 INFO - Running setup.py (path:/tmp/pip-gbIIJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:32 INFO - Running setup.py (path:/tmp/pip-sEw51x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:32 INFO - Running setup.py (path:/tmp/pip-gesXkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:32 INFO - Running setup.py (path:/tmp/pip-WipLqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:32 INFO - Running setup.py (path:/tmp/pip-iCUfTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:32 INFO - Running setup.py (path:/tmp/pip-sA6qxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:32 INFO - Running setup.py (path:/tmp/pip-muk674-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:33 INFO - Running setup.py (path:/tmp/pip-pIScqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:33 INFO - Running setup.py (path:/tmp/pip-mPA4CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:33 INFO - Running setup.py (path:/tmp/pip-_25ZPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:33 INFO - Running setup.py (path:/tmp/pip-0ncGTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:33 INFO - Running setup.py (path:/tmp/pip-1JqgYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:33 INFO - Running setup.py (path:/tmp/pip-kM3vUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:33 INFO - Running setup.py install for manifestparser 05:49:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:33 INFO - Running setup.py install for mozcrash 05:49:33 INFO - Running setup.py install for mozdebug 05:49:33 INFO - Running setup.py install for mozdevice 05:49:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:33 INFO - Running setup.py install for mozfile 05:49:33 INFO - Running setup.py install for mozhttpd 05:49:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for mozinfo 05:49:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for mozInstall 05:49:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for mozleak 05:49:34 INFO - Running setup.py install for mozlog 05:49:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for moznetwork 05:49:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for mozprocess 05:49:34 INFO - Running setup.py install for mozprofile 05:49:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for mozrunner 05:49:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:34 INFO - Running setup.py install for mozscreenshot 05:49:35 INFO - Running setup.py install for moztest 05:49:35 INFO - Running setup.py install for mozversion 05:49:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:35 INFO - Cleaning up... 05:49:35 INFO - Return code: 0 05:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:35 INFO - Using env: {'DISPLAY': ':0', 05:49:35 INFO - 'HOME': '/home/cltbld', 05:49:35 INFO - 'LANG': 'en_US.UTF-8', 05:49:35 INFO - 'LANGUAGE': 'en_US:en', 05:49:35 INFO - 'LOGNAME': 'cltbld', 05:49:35 INFO - 'MAIL': '/var/mail/cltbld', 05:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:35 INFO - 'MOZ_NO_REMOTE': '1', 05:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:35 INFO - 'NO_EM_RESTART': '1', 05:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:35 INFO - 'PWD': '/builds/slave/test', 05:49:35 INFO - 'SHELL': '/bin/bash', 05:49:35 INFO - 'SHLVL': '1', 05:49:35 INFO - 'TERM': 'linux', 05:49:35 INFO - 'TMOUT': '86400', 05:49:35 INFO - 'USER': 'cltbld', 05:49:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:35 INFO - '_': '/tools/buildbot/bin/python'} 05:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:35 INFO - Running setup.py (path:/tmp/pip-CUWMrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:35 INFO - Running setup.py (path:/tmp/pip-UAugj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:35 INFO - Running setup.py (path:/tmp/pip-ZGeiPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:35 INFO - Running setup.py (path:/tmp/pip-WZh2nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:35 INFO - Running setup.py (path:/tmp/pip-NSjHbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:35 INFO - Running setup.py (path:/tmp/pip-e5fbua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:35 INFO - Running setup.py (path:/tmp/pip-8cCHEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:35 INFO - Running setup.py (path:/tmp/pip-kzpNe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:36 INFO - Running setup.py (path:/tmp/pip-WQPNd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:36 INFO - Running setup.py (path:/tmp/pip-LSA8Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:36 INFO - Running setup.py (path:/tmp/pip-j3o2pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:36 INFO - Running setup.py (path:/tmp/pip-4EKVkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:36 INFO - Running setup.py (path:/tmp/pip-XucZRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:36 INFO - Running setup.py (path:/tmp/pip-u3_VIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:36 INFO - Running setup.py (path:/tmp/pip-ioy05C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:36 INFO - Running setup.py (path:/tmp/pip-1SYGSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:36 INFO - Running setup.py (path:/tmp/pip-GnxMcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:38 INFO - Downloading blessings-1.6.tar.gz 05:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:38 INFO - Installing collected packages: blessings 05:49:38 INFO - Running setup.py install for blessings 05:49:38 INFO - Successfully installed blessings 05:49:38 INFO - Cleaning up... 05:49:38 INFO - Return code: 0 05:49:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:39 INFO - Reading from file tmpfile_stdout 05:49:39 INFO - Current package versions: 05:49:39 INFO - argparse == 1.2.1 05:49:39 INFO - blessings == 1.6 05:49:39 INFO - blobuploader == 1.2.4 05:49:39 INFO - docopt == 0.6.1 05:49:39 INFO - functools32 == 3.2.3-2 05:49:39 INFO - jsonschema == 2.5.1 05:49:39 INFO - manifestparser == 1.1 05:49:39 INFO - mozInstall == 1.12 05:49:39 INFO - mozcrash == 0.17 05:49:39 INFO - mozdebug == 0.1 05:49:39 INFO - mozdevice == 0.48 05:49:39 INFO - mozfile == 1.2 05:49:39 INFO - mozhttpd == 0.7 05:49:39 INFO - mozinfo == 0.9 05:49:39 INFO - mozleak == 0.1 05:49:39 INFO - mozlog == 3.3 05:49:39 INFO - moznetwork == 0.27 05:49:39 INFO - mozprocess == 0.23 05:49:39 INFO - mozprofile == 0.28 05:49:39 INFO - mozrunner == 6.12 05:49:39 INFO - mozscreenshot == 0.1 05:49:39 INFO - mozsystemmonitor == 0.3 05:49:39 INFO - moztest == 0.7 05:49:39 INFO - mozversion == 1.4 05:49:39 INFO - psutil == 3.1.1 05:49:39 INFO - requests == 1.2.3 05:49:39 INFO - wsgiref == 0.1.2 05:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:39 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 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:39 INFO - Using env: {'DISPLAY': ':0', 05:49:39 INFO - 'HOME': '/home/cltbld', 05:49:39 INFO - 'LANG': 'en_US.UTF-8', 05:49:39 INFO - 'LANGUAGE': 'en_US:en', 05:49:39 INFO - 'LOGNAME': 'cltbld', 05:49:39 INFO - 'MAIL': '/var/mail/cltbld', 05:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:39 INFO - 'MOZ_NO_REMOTE': '1', 05:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:39 INFO - 'NO_EM_RESTART': '1', 05:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:39 INFO - 'PWD': '/builds/slave/test', 05:49:39 INFO - 'SHELL': '/bin/bash', 05:49:39 INFO - 'SHLVL': '1', 05:49:39 INFO - 'TERM': 'linux', 05:49:39 INFO - 'TMOUT': '86400', 05:49:39 INFO - 'USER': 'cltbld', 05:49:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:39 INFO - '_': '/tools/buildbot/bin/python'} 05:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:39 INFO - Cleaning up... 05:49:39 INFO - Return code: 0 05:49:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2976180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, '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': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49: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'] in /builds/slave/test/build 05:49: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 05:49:39 INFO - Using env: {'DISPLAY': ':0', 05:49:39 INFO - 'HOME': '/home/cltbld', 05:49:39 INFO - 'LANG': 'en_US.UTF-8', 05:49:39 INFO - 'LANGUAGE': 'en_US:en', 05:49:39 INFO - 'LOGNAME': 'cltbld', 05:49:39 INFO - 'MAIL': '/var/mail/cltbld', 05:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:39 INFO - 'MOZ_NO_REMOTE': '1', 05:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:39 INFO - 'NO_EM_RESTART': '1', 05:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:39 INFO - 'PWD': '/builds/slave/test', 05:49:39 INFO - 'SHELL': '/bin/bash', 05:49:39 INFO - 'SHLVL': '1', 05:49:39 INFO - 'TERM': 'linux', 05:49:39 INFO - 'TMOUT': '86400', 05:49:39 INFO - 'USER': 'cltbld', 05:49:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:39 INFO - '_': '/tools/buildbot/bin/python'} 05:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:39 INFO - Cleaning up... 05:49:39 INFO - Return code: 0 05:49:39 INFO - Running post-action listener: _resource_record_post_action 05:49:39 INFO - Running post-action listener: _start_resource_monitoring 05:49:39 INFO - Starting resource monitoring. 05:49:39 INFO - [mozharness: 2016-07-29 12:49:39.595199Z] Finished create-virtualenv step (success) 05:49:39 INFO - [mozharness: 2016-07-29 12:49:39.595690Z] Running install step. 05:49:39 INFO - Running pre-action listener: _resource_record_pre_action 05:49:39 INFO - Running main action method: install 05:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:39 INFO - Reading from file tmpfile_stdout 05:49:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:39 INFO - Reading from file tmpfile_stdout 05:49:39 INFO - Output received: 05:49:39 INFO - Usage: mozinstall [options] installer 05:49:39 INFO - Options: 05:49:39 INFO - -h, --help show this help message and exit 05:49:39 INFO - -d DEST, --destination=DEST 05:49:39 INFO - Directory to install application into. [default: 05:49:39 INFO - "/builds/slave/test"] 05:49:39 INFO - --app=APP Application being installed. [default: firefox] 05:49:39 INFO - mkdir: /builds/slave/test/build/application 05:49:39 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'] 05:49:39 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 05:49:57 INFO - Reading from file tmpfile_stdout 05:49:57 INFO - Output received: 05:49:57 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:57 INFO - Running post-action listener: _resource_record_post_action 05:49:57 INFO - [mozharness: 2016-07-29 12:49:57.150840Z] Finished install step (success) 05:49:57 INFO - [mozharness: 2016-07-29 12:49:57.151180Z] Running run-tests step. 05:49:57 INFO - Running pre-action listener: _resource_record_pre_action 05:49:57 INFO - Running main action method: run_tests 05:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:57 INFO - Python 2.7.3 05:49:57 INFO - Return code: 0 05:49:57 INFO - grabbing minidump binary from tooltool 05:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:57 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 0x29743b0>, '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 0x29752b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2975740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:49:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:49:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:49:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:57 INFO - Return code: 0 05:49:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:49:57 INFO - Using env: {'DISPLAY': ':0', 05:49:57 INFO - 'HOME': '/home/cltbld', 05:49:57 INFO - 'LANG': 'en_US.UTF-8', 05:49:57 INFO - 'LANGUAGE': 'en_US:en', 05:49:57 INFO - 'LOGNAME': 'cltbld', 05:49:57 INFO - 'MAIL': '/var/mail/cltbld', 05:49:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:57 INFO - 'MOZ_NO_REMOTE': '1', 05:49:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:57 INFO - 'NO_EM_RESTART': '1', 05:49:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:57 INFO - 'PWD': '/builds/slave/test', 05:49:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:57 INFO - 'SHELL': '/bin/bash', 05:49:57 INFO - 'SHLVL': '1', 05:49:57 INFO - 'TERM': 'linux', 05:49:57 INFO - 'TMOUT': '86400', 05:49:57 INFO - 'USER': 'cltbld', 05:49:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676', 05:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:57 INFO - '_': '/tools/buildbot/bin/python'} 05:49:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:49:57 INFO - mozversion application_buildid: 20160729030203 05:49:57 INFO - mozversion application_changeset: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 05:49:57 INFO - mozversion application_display_name: Nightly 05:49:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:57 INFO - mozversion application_name: Firefox 05:49:57 INFO - mozversion application_remotingname: firefox 05:49:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:57 INFO - mozversion application_vendor: Mozilla 05:49:57 INFO - mozversion application_version: 50.0a1 05:49:57 INFO - mozversion platform_buildid: 20160729030203 05:49:57 INFO - mozversion platform_changeset: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 05:49:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:57 INFO - mozversion platform_version: 50.0a1 05:49:57 INFO - using testdate: 1469796597 05:49:57 INFO - actual date: 1469796597 05:49:57 INFO - starting webserver on 'localhost:47729' 05:49:57 INFO - SUITE-START | Running 2 tests 05:49:57 INFO - TEST-START | dromaeo_css 05:49:57 INFO - operating with platform_type : linux_ 05:49:57 INFO - Initialising browser for dromaeo_css test... 05:49:57 INFO - TEST-INFO | started process 23297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmDIsbI/profile http://localhost:47729/getInfo.html) 05:50:00 INFO - PROCESS | 23297 | JavaScript error: , line 0: uncaught exception: undefined 05:50:01 INFO - PROCESS | 23297 | __metrics Screen width/height:1600/1200 05:50:01 INFO - PROCESS | 23297 | colorDepth:24 05:50:01 INFO - PROCESS | 23297 | Browser inner width/height: 1024/697 05:50:01 INFO - PROCESS | 23297 | __metrics 05:50:01 INFO - PROCESS | 23297 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:50:01 INFO - PROCESS | 23297 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:02 INFO - PROCESS | 23297 | console.error: PushService: 05:50:02 INFO - PROCESS | 23297 | stateChangeProcessEnqueue: Error transitioning state 05:50:02 INFO - PROCESS | 23297 | UnknownError 05:50:02 INFO - TEST-INFO | 23297: exit 0 05:50:02 INFO - Browser initialized. 05:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:02 INFO - TEST-INFO | started process 23375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmDIsbI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:14 INFO - PROCESS | 23375 | RSS: Main: 157896704 05:50:14 INFO - PROCESS | 23375 | 05:51:05 INFO - PROCESS | 23375 | 1469796665404 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:53:14 INFO - PROCESS | 23375 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47729/tests/dromaeo/cssquery-ext.html) 05:53:15 INFO - PROCESS | 23375 | RSS: Main: 259944448 05:53:15 INFO - PROCESS | 23375 | 05:56:17 INFO - PROCESS | 23375 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-ext.html (next: http://localhost:47729/tests/dromaeo/cssquery-jquery.html) 05:56:18 INFO - PROCESS | 23375 | RSS: Main: 246153216 05:56:18 INFO - PROCESS | 23375 | 05:59:20 INFO - PROCESS | 23375 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47729/tests/dromaeo/cssquery-mootools.html) 05:59:20 INFO - PROCESS | 23375 | RSS: Main: 232935424 05:59:20 INFO - PROCESS | 23375 | 06:02:22 INFO - PROCESS | 23375 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47729/tests/dromaeo/cssquery-prototype.html) 06:02:23 INFO - PROCESS | 23375 | RSS: Main: 189841408 06:02:23 INFO - PROCESS | 23375 | 06:05:25 INFO - PROCESS | 23375 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47729/tests/dromaeo/cssquery-yui.html) 06:05:26 INFO - PROCESS | 23375 | RSS: Main: 188723200 06:05:26 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-yui.html (next: http://localhost:47729/tests/dromaeo/cssquery-dojo.html) 06:08:29 INFO - PROCESS | 23375 | RSS: Main: 277139456 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | __start_tp_report 06:08:29 INFO - PROCESS | 23375 | _x_x_mozilla_page_load 06:08:29 INFO - PROCESS | 23375 | _x_x_mozilla_page_load_details 06:08:29 INFO - PROCESS | 23375 | |i|pagename|runs| 06:08:29 INFO - PROCESS | 23375 | |0;dojo.html;3015.155756388212;3021.108772911991;3040.0727778027695;3040.6959304069587;3073.492873675842;5177.456367081459;5189;5242.711650859202;5257;5297.655652382592;5198.6880787152795;5221.1385121455005;5257.947420525794;5287.101192797224;5308.867278318044;4725.818545363659;4765.7140571565815;4780.16347139251;4791.520847915215;4942.728149951751;4862.902741945159;4891.510848915098;4896.55930966213;4906.264060390934;4915.606751459893;4663.48701642819;4725.905481890343;4749.358836557055;4769.689970151963;4822.421309442854;4753.619710423192;4755.476897541268;4757.476677565465;4859.73271470069;4868.95131048692;4737.099951009297;4763.951930575268;4785.784639691222;4795.2087905495555;4824.083424149436;5097.388313402378;5207.114790485626;5248.448912864133;5292.259083728281;5307.787688492455;5641.210230567724;5717.428257174291;5734.139879018139;5736.856578585527;5743.626664266851;5700.971495142539;5707.400722924075;5714.371419143891;5761.798337058225;5763.971180144073;5165.9225111623355;5210.947890521122;5359.08895487768;5368.785248590091;5370.838874833761;5670.631408958405;5714.428557144335;5716.599838011382;5764.654120752768;5779.2775903012125;5499.560035197174;5512.6968016758665;5540.473655002768;5545.833624991256;5549.639273447213;5433.076377015837;5581.10702287632;5621.606487545832;5623.0721930880945;5634.267545219095;5613.158026296007;5645.407232240637;5646.548276137899;5684.658920464785;5702.857428564319;5587.161925711176;5630.8029218977135;5636.408177141423;5637.774489020475;5648.802291919763;4231.61915427613;4312.353147027971;4342.739435633872;4349.217140914602;4393.450818647669;3840.327942610032;3865.16898866745;3866.4200369944733;3881.941770873439;3953.327934251184;5340.732963351817;5343.305370301836;5347.652402593897;5352.0366334060245;5390.353157621111;5531.751071201806;5663.037283661787;5663.830085097454;5666.943330566642;5708.942910570924;5305.469453054741;5341.092014357569;5363.973180134074;5376.542993845489;5431.53831924283;4882.926756098661;4889.682170658896;4893.363862697826;4893.926591101136;4939.87650308738;5688.374278829326;5908.3205431375945;5915.822525324247;5920.5559583031445;5927.585069045212;5585.078462053878;5628.324601047737;5632.662040277596;5653.547716182778;5670.347909990404;5935.0503919372695;5938.257717785277;5938.406159384027;5941.31674857397;5945.851353716192;5374.167004114369;5538.667679939216;5587.916181257203;5590.664560126405;5594;5613.691246981455;5657.8019769307875;5665.49010589049;5708.5147762439;5753;5539.750711218086;5544.085225937675;5552.722363881709;5554.555635549227;5561;5355.303810504765;5536.944630553643;5551.195076713773;5554.888902222014;5592.412796656293;5410.404855465817;5434.266374039454;5438.83683489496;5466.070767969375;5487.6981766003255;5583.274174357308;5595.412481689364;5641.435856414326;5645.096784514458;5650.321961364498;5330.307060082319;5459.372172200247;5467.972660136674;5469.343678758574;5469.699166545878 06:08:29 INFO - PROCESS | 23375 | |1;ext.html;575.8071046199523;594.9762009519619;614.5544480251818;617.5029101573233;634.847636567224;43467.34798978018;44373.11253774923;44470.55529444705;44609;47579;45834.083318333614;46331;46333.53666463334;46360;46379.30431043537;9029.503377314246;9163.633454661838;9171.908280917205;9173.357864949423;9177.587008584629;9009.504477253748;9037.096290370977;9075.27397808177;9083.682071127512;9091.499967501784;9088.545572721338;9121.680741174061;9126.863097053549;9133.041030691782;9135.223506001998;9037.322200834931;9079.273658107335;9079.636814527477;9085.182333590008;9091.272698184162;8990.235829954461;9039.68361107358;9050.456972581665;9053.275737940949;9062.546872656341;43684.56315436837;43982.56017439849;44048.779756101336;44103.558964410266;44106.55893441057;3322.4684050552037;3874.786886721229;3922.1175235572055;3930.508686414198;4020.8994775130564;32748;33501.49747753786;33986.921569411585;34025.14937126567;34053;4170.749755014709;4228.483326287531;4264.168487145008;4389.648828093745;4395.494518130424;354751;357071;357765;358102;358272;57518;57746.4225357741;57765.422345776;57784.4221557779;57801.42198578044;60263.39736602666;60320.983950802285;60388.698056509435;60483;60523;15156.621084472756;15268.618284542976;15272.847271527142;15288.38846446152;15292.770608440882;12544.623661290176;12564.057695672862;12597.87402125967;12608.558700445625;12608.74782504363;12377;15634.68730625381;15781.210939452982;16057.116858572657;16143.192840357935;5638.295213098363;6481.189851268591;6560.540762146604;6675.359321373432;6725.39471447572;906.6464079009191;1022.6114076650825;1100.5817789240039;1131.8981291683788;1188.3939191012646;32948;33224.66775332264;33627.66372336245;33685.494717579255;33762;1120.9327440353443;1131.9603813866474;1132.8753837077916;1156.733951191214;1218.561317925546;17462.738058929128;17537.298508059535;17606.119694015248;17704.986729990058;17822.5544361392;555040;558829;559507;559934;560217;58639.413605863396;58843.41156588379;58912.410875891546;58957;58974.11538826921;1208.4803534480081;1285.7299967007034;1319.4854006937303;1355.457816873239;1404.529482623312;30064.799549739662;34141;34368.48447273343;34600.307993840484;34785.8260708705;50140.49859501358;50588.74705626448;50775;50784.74607626938;50826.745866271915;328080;329195;329625;329711;330531;27489.72510274872;28268.293292667848;28422.43155136927;29773.404531908807;42211.577884220766;46569.76715116403;47972;48857.5114248853;49851;50681;41221.79389103036;41848;41900.37149442822;42152.36771448492;44202;41715.582844172386;41852.790736046125;42025.78987105045;43313.783431082644;43518.12963740771;41315.38026929538;42155.789221053696;43087.56912430836;43336.349954751335;45340.54659453363;34166.487502687974;38050.429243560815;38145;38312.233755325295;39036.80481597574;28685.856570717013;29341.559876602296;29422;29563.85218073896;29582.704172957994 06:08:29 INFO - PROCESS | 23375 | |2;jquery.html;358.98564057437704;373.2013491128983;388.91638297765974;391.3151984027951;407.97144199906;17313.047782371963;19498.512537186576;19511.707324390147;19609.11758970846;19669.606607867834;18688.25246990122;18729.906350468264;19008.28925396714;19119;19229.23083076675;5094.032133894567;5497.147942068976;5688.402717714622;5706.486416222539;5706.77172913083;5544.390117087117;5636.689982050985;5673.404292549285;5705.629134106291;5709.257796486471;5419.780549376378;5485.753141108639;5525.834224973257;5652.63257888238;5678.148277758328;5497.642653227547;5530.972345138249;5539.362973258067;5540.445955404448;5559.916601250944;4827.106985207713;4943.530364615392;4944.60443164546;5036.748162591893;5039.571636410909;23094.76905230943;23212.883935580216;23226.18708345217;23275.53448931029;23362.64956025661;2121.724175857144;2606.530824451598;2679.263202619276;2940.661823890259;3069.9232519186976;10114.494275286206;10240.28318017739;10255.077043066085;10340.069393754524;10425;1858.6840237159581;1890.1494327552518;1913.320771126258;1920.2894928876406;1951.668216403215;82651;83883.5805820973;84403;86215.56892215561;88695.11304886933;10548.630797922036;10816.242862999514;10817.729556760987;10908.836367454494;10949.233553651327;15224.771628425582;15237.314320855367;15249.3900243989;15254.46609368689;15274.770878436831;7531.887021694679;7742.341900938371;7767.495112817649;7905.169957154416;8019.879701804478;7386.926130738624;7416.295451932057;7424.665890034961;7620.276073772982;7630.542167469969;4629.490756016836;4667.743274119956;4700.08348372071;4789.185838407479;4809.855704328876;1916.1664675866043;1949.5905859769323;1980.6830907054803;1991.492169496769;1997.3907958072637;839.9584515201228;975.770693886936;978.1636700621009;984.601236499219;1060.5439660945713;19133.8086619132;19528.51178720515;19584.412467625993;19586.902065489583;19803;979.9074032453763;990.7374545745383;1011.8735158105237;1019.0573719309609;1028.943408112561;10394.688159355232;10756.731081723019;10823.83764243537;10942;10990.505427255792;476020;481160.1013913787;482836;483016;484871;74171.62914185395;79468;79941;93557.5322123385;96333;949.5821838390948;983.3165949665057;996.7508122969258;1006.2151521812998;1014.2393205096178;16965.066921319445;17469.30122795074;17948.19233134538;17981.370652027115;18260.543486412946;44379;44621.77689111534;45237.77381113205;45777.313340300585;45926.54073459223;61574;62156.37843621506;62372.68813655902;62609.68695156677;62884.37115628785;8270.37972152103;8322.334213263046;8361.95819020901;8464.830703385775;8489.87265191035;10762.73093172677;12753.362331883554;12813;12815.487380504675;13525.661858453617;11050.894910508885;11136.109111270916;11371.090312775124;11426.331666269642;11607.825882611936;11037.889621103686;11095.889041109485;11471.541138354372;11496.712582185512;11645.068394528247;11186.440677966231;11225.270357426742;11301.773964520828;11366;11392.943035285101;7291;7717.691292348243;8500.44747091437;8516.105808889977;8699.130086991503;10738.570457181626;10981.3960232188;11527.538898443969;11644.825327619923;11725.530978761095 06:08:29 INFO - PROCESS | 23375 | |3;mootools.html;1451.9854801451988;1465.7654775235962;1594.8644365228954;1728.8271172882721;1785.357271382302;8419;8900.955495222515;8932.285417166628;8941.50821704806;8945.463272203673;7419.703211871532;8277.958610206955;8545.230929216385;8568.143185681429;8680;2277.4420267034557;2308.699869017034;2311.6185829338137;2312.1329501436962;2313.3522613668115;2295.517941232343;2317.783163838981;2350.9647355289685;2352.447174913894;2355.634876594122;2298.2530677529785;2307.896144673494;2316.305108467453;2339.333290012347;2340.32130682102;2222.0667319725753;2227.9554408911895;2228.3983324502374;2234.452559123009;2253.9549209015727;2165.069020321261;2167.100653228908;2171.3703026122407;2173;2173.5870184665023;8778.122187781235;8784.868226976601;8825.823483530357;8877.955610221972;8884.378093533454;4941.20940649498;5067.290579318898;5067.442581316052;5069.239614057884;5076.035553244872;3093.1030001299596;3136.2629782001213;3297.55483009793;3307.96692033079;3317.386283537529;1110.1618278199908;1110.9777804443866;1125.8311253311988;1131.8868113188698;1140.2075557487549;11921.582744603897;11985.101117416229;11987.22083064598;11995.700107497296;12006.339651319175;4371.01652128275;4449.555044495589;4557.316402539579;4558.5897269245925;4611.608013318905;9967.352122112039;9970;9986.35088719231;9995.050470205319;9995.300328977048;5069.264956581275;5069.594432445396;5072.239164125411;5075.187969924868;5075.949240507548;4191.601797829201;4540.364348991144;4619.584237418649;4661.137689527381;4677.929831052537;3821.732478726518;3894.279558281727;3908.081600823804;3993.820278087493;3993.8617494014647;1201.4953719437858;1262.9414055090328;1263.3935710858839;1264.1593340428512;1277.1060257819563;800.5756948817136;918.9724308270762;925.8102089071859;952.4618590496348;955.1308309438516;5452.40023597404;5550.306211723535;5718.7426565804635;5729.684867332254;5735.254416925773;948.743839163422;953.4088864903665;965.5751469353462;967.3857100740939;990.4503000834605;3822.10180607557;3928.3125453045604;4023.3562629979065;4045.514538255369;4053.412255223035;10398.740031499121;11136.944315278372;11164.218504704593;11200.887991120147;11205.383703896201;10440.791184176274;11131.109511239081;11131.220814542905;11132.38771867555;11133.053690436242;7835.529868207926;8250.711225107092;8259.793505162299;8260.339172866155;8272.04871439792;5627.662340259598;5728.627639203439;5753.280839895013;5776.306843178845;5871.647701137946;10067.345622534513;10072.244581656552;10155.441450720282;10187.541560629641;10221.23340749432;10107.69676909694;10251;10354.534045968101;10374.533146008598;10474;6967.268436814062;7679.961600192187;7713.4600577959;7865.056193256846;7926.841463170819;8683.435576687496;8685.305175585812;8749.387542871938;8754.562271886252;8765.211130998241;7233.529820561646;7453.329200371993;7465.402767778456;7480.289372509603;7481.88777168332;7004.964975175091;7235.63821808918;7257.637118144177;7432.665530051268;7468.178500365064;6976.441884649317;6979.232284448605;6986.755463558751;6991.056207411934;7004.719811207495;4677.204875171297;4710.505396933273;4779.187538118597;4838.564529192389;4839.588634966068;4617.538246175355;4688.812447502061;4694.389729335165;4733.83431579893;4866.221404575251 06:08:29 INFO - PROCESS | 23375 | |4;prototype.html;314.8882146837872;316.16217024884054;319.8272932616387;326.27566801700226;331.6087017319562;5090.796368145279;5194.948050519493;5262.973685131574;5283.630145889784;5317.202419637057;5174.404943431507;5207.687538747668;5250.133727934895;5256.921146182801;5277.208418737191;4163.958360416387;4170.687198460112;4178.435911152002;4179.996800767809;4192.161567686459;3993.321135406973;4135.400366946791;4165.354370072643;4184.623383895464;4191.55988621195;4145.419641250227;4146.9792651036705;4147.6474499667565;4150.149219410014;4152.979235103835;4134.958650413488;4152.294110001307;4155.252054630166;4170.186813571355;4173.895652608679;3597.9280414391565;3688.8340024698955;3706.092007458163;3718.163413232001;3718.2377612589353;5083.237514372874;5083.517065878736;5107.61692873036;5122.641415100945;5123.871903202413;4730.692504987165;4775.641826862964;4777.784999675023;4789.353437285957;4792.736399498026;5328.893422131575;5403.621746477748;5443.618946673734;5472.945270547283;5505.201745746885;4019.5578486366476;4033.9915021244688;4048.7975601220114;4050.51393832739;4073.7187175181994;5707.971460142673;5721.456461636138;5729.28383952006;5745.017968800757;5769.192313076214;4002.3596224603925;4139.19285739278;4145.274576949022;4158.209940111369;4165.8541951032175;4182.309918863353;4198.181354635878;4205.831766729358;4213.6207741302815;4218.8523401680795;4760.262159365304;4770.189067858403;4774.427068751772;4779.928301075487;4794.7362895040405;5295.788168473295;5478.506934375846;5509.724513774296;5559.166125081189;5565.721713914288;1365.1263191557412;1415.773476243796;1429.1425144912969;1432.8567143285798;1435.19629007756;991.6529214774915;1003.4430890855499;1022.539857064324;1025.8153532364097;1028.2673694824246;5259.815906443256;5285.894282114413;5288.180332048539;5350.464953504618;5372.140457526855;5598.216249725042;5607.775688972395;5612.35457922336;5618.97190514053;5650.97174514133;5169.234459564115;5264.92102618461;5271.446498117719;5360.65155764874;5364.8122315718765;2631.263366178313;2654.3231475973503;2671.4389978104814;2672.225054734144;2674.251209661259;5198.870028249248;5210.713410762444;5215.269862219292;5245.213218017328;5270.262163297141;4829.27560865873;5079.4412614612365;5153.763096856727;5156.1750119980625;5165.535101840777;5204.992156039828;5213.504717051874;5233.4243233244315;5275.340582427119;5308.230306605597;5000.149974504416;5035.697858128524;5037.823676171316;5073.670211436245;5075.390953085505;4766.404199475066;4920.532549407801;4931.950680493293;4986.476419975996;4999.450060493416;5197.896042079213;5210.088234559013;5225.6603320784025;5229.947700522946;5253.868653283698;3738.570064442515;3778.4899038630533;3788.507494025759;3804.4293355996824;3833.1183827719224;4903.8528844134735;4933.309336692794;4949.28235405857;5417.972910135424;5530.281063461885;5389.784408623768;5432.945670543402;5455.345358556999;5465.890682186414;5469.644473109235;5444.346678398618;5448.782048718007;5473.808416705396;5543.256088236349;5547.8890422192135;5269;5385.542228910586;5425.755840987086;5431.83704488866;5502.614816962774;5466.1527463243265;5502.504774570308;5506.91739623914;5511.669299842022;5527.861803454945;5325.17765584241;5410.918836217538;5420.430854760351;5449.782008719607;5488.396276409512 06:08:29 INFO - PROCESS | 23375 | |5;yui.html;713.8643657705036;740.9407247420204;748.3078152708744;790.1229635105034;799.3684988858802;12491.812622810654;13003.219806811598;13371.665708357272;13394.66513337167;13398.53105141319;12942.547010854621;13011.60965171044;13015.219086854795;13030.153040052413;13052.412641431134;650.4568685147907;776.4603600497657;793.5040599625235;813.0121901889204;815.5432957543765;811.3225456743596;817.6933649881295;820.5527987246935;821.7370441458736;822.6133717152928;867.2195024477988;867.8004059066418;868.4962721621445;870.24723614074;870.4037734152126;680.6052489556046;701.2181417719257;852.0882655558555;856.5289090999956;861.0829466618063;512.9461406552296;591.3436085944599;617.9845503862394;619.7459041792888;621.0745988477137;12822.615321540368;12850.678733031655;12857.871421285854;12861.67845803853;12863.935680321538;13394.531191408254;13566.321683915863;13715.451381944711;13906;13987.580372588736;10788.622398216103;10812.783744325148;11203.103751699844;11286.266392684449;11416.71458213543;4346.8043938022865;4353.455818022747;4407.27821999622;4478.708883922567;4516.390287311204;76418.61790691066;79699.6015019927;80094;82259;82410;10898.509567069343;11066.39134847591;11084.61203857861;11279.210455268052;11289.887101128883;18751.156197971122;18763.34328298503;20808.37574872756;20868.895655521625;20983.475413114793;8155.062167850773;8297.12880147588;8298.751037468886;8325.583720813935;8481.151884811592;4633.258678611473;4651.953480465219;4782.0914026334885;4786.928196077061;4969.478204788517;3235.692609202122;3302.53764472974;3306.173456635841;3307.520409540651;3312.188513814131;589.5048159546002;598.0371601721225;599.4574909706636;600.9729562169713;605.2343785111836;643.7843322486925;673.1652750589234;675.5473832532215;680.0886811672383;690.0994202565699;8964.462132271954;8991.41555798871;9185.908140918638;9253.213476854407;9276.721698348925;666.8966310221923;674.1606699658956;687.6664817563478;711.9501634885612;721.7329588052454;4096.160287141129;4221.261279276115;4222.59885310895;4295.140971805651;4327.7619730914475;68895.3110468899;115820.42089789666;116369.8363016376;121861.39069304596;125794.37102814428;62898.37101629017;65931.67034164799;95371;95605.13184604474;96916.51541742387;55897;56624;57383.843888586525;87969.56015219883;90694.09305906988;8010.959945200237;8058.919410806051;8349.332053435832;8381.203785640355;8382.664693412195;48057.5194248053;51780.48219517907;51802;53503.73248133734;53884;71016;72881.44067033993;75641.62179189069;78442;80133;10443.112335451571;10636.202284828514;10684.09185219265;11008.119350451785;11130.777384452103;12398.504059837505;12404.751904962031;12443;12743.235405875677;13183.868161318263;11291.717707057389;11485.712857178638;11716.765664686829;11755.941220294186;11869.10981676395;9147.496887671243;12809.87190128124;13097.476100955855;13177.934110329386;13230.47078116903;12793.36033198355;12982.545610903573;13474.326283685581;13548.525801596898;13837.79243311331;9908.256880734118;9946.74060480318;10062.899371006197;10116.544755485873;10418.791624167323;9622.951885240529;10031.347962382422;10852.511636976513;10935.28920620157;10942.945285273523 06:08:29 INFO - PROCESS | 23375 | __end_tp_report 06:08:29 INFO - PROCESS | 23375 | __start_cc_report 06:08:29 INFO - PROCESS | 23375 | _x_x_mozilla_cycle_collect,869 06:08:29 INFO - PROCESS | 23375 | __end_cc_report 06:08:29 INFO - PROCESS | 23375 | __startTimestamp1469797709392__endTimestamp 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | ------- Summary: start ------- 06:08:29 INFO - PROCESS | 23375 | Number of tests: 6 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | [#0] dojo.html Cycles:165 Average:5253.21 Median:5459.37 stddev:600.74 (11.0%) stddev-sans-first:576.36 06:08:29 INFO - PROCESS | 23375 | Values: 3015.2 3021.1 3040.1 3040.7 3073.5 5177.5 5189.0 5242.7 5257.0 5297.7 5198.7 5221.1 5257.9 5287.1 5308.9 4725.8 4765.7 4780.2 4791.5 4942.7 4862.9 4891.5 4896.6 4906.3 4915.6 4663.5 4725.9 4749.4 4769.7 4822.4 4753.6 4755.5 4757.5 4859.7 4869.0 4737.1 4764.0 4785.8 4795.2 4824.1 5097.4 5207.1 5248.4 5292.3 5307.8 5641.2 5717.4 5734.1 5736.9 5743.6 5701.0 5707.4 5714.4 5761.8 5764.0 5165.9 5210.9 5359.1 5368.8 5370.8 5670.6 5714.4 5716.6 5764.7 5779.3 5499.6 5512.7 5540.5 5545.8 5549.6 5433.1 5581.1 5621.6 5623.1 5634.3 5613.2 5645.4 5646.5 5684.7 5702.9 5587.2 5630.8 5636.4 5637.8 5648.8 4231.6 4312.4 4342.7 4349.2 4393.5 3840.3 3865.2 3866.4 3881.9 3953.3 5340.7 5343.3 5347.7 5352.0 5390.4 5531.8 5663.0 5663.8 5666.9 5708.9 5305.5 5341.1 5364.0 5376.5 5431.5 4882.9 4889.7 4893.4 4893.9 4939.9 5688.4 5908.3 5915.8 5920.6 5927.6 5585.1 5628.3 5632.7 5653.5 5670.3 5935.1 5938.3 5938.4 5941.3 5945.9 5374.2 5538.7 5587.9 5590.7 5594.0 5613.7 5657.8 5665.5 5708.5 5753.0 5539.8 5544.1 5552.7 5554.6 5561.0 5355.3 5536.9 5551.2 5554.9 5592.4 5410.4 5434.3 5438.8 5466.1 5487.7 5583.3 5595.4 5641.4 5645.1 5650.3 5330.3 5459.4 5468.0 5469.3 5469.7 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | [#1] ext.html Cycles:180 Average:58561.57 Median:23675.87 stddev:113332.52 (478.7%) stddev-sans-first:113566.83 06:08:29 INFO - PROCESS | 23375 | Values: 575.8 595.0 614.6 617.5 634.8 43467.3 44373.1 44470.6 44609.0 47579.0 45834.1 46331.0 46333.5 46360.0 46379.3 9029.5 9163.6 9171.9 9173.4 9177.6 9009.5 9037.1 9075.3 9083.7 9091.5 9088.5 9121.7 9126.9 9133.0 9135.2 9037.3 9079.3 9079.6 9085.2 9091.3 8990.2 9039.7 9050.5 9053.3 9062.5 43684.6 43982.6 44048.8 44103.6 44106.6 3322.5 3874.8 3922.1 3930.5 4020.9 32748.0 33501.5 33986.9 34025.1 34053.0 4170.7 4228.5 4264.2 4389.6 4395.5 354751.0 357071.0 357765.0 358102.0 358272.0 57518.0 57746.4 57765.4 57784.4 57801.4 60263.4 60321.0 60388.7 60483.0 60523.0 15156.6 15268.6 15272.8 15288.4 15292.8 12544.6 12564.1 12597.9 12608.6 12608.7 12377.0 15634.7 15781.2 16057.1 16143.2 5638.3 6481.2 6560.5 6675.4 6725.4 906.6 1022.6 1100.6 1131.9 1188.4 32948.0 33224.7 33627.7 33685.5 33762.0 1120.9 1132.0 1132.9 1156.7 1218.6 17462.7 17537.3 17606.1 17705.0 17822.6 555040.0 558829.0 559507.0 559934.0 560217.0 58639.4 58843.4 58912.4 58957.0 58974.1 1208.5 1285.7 1319.5 1355.5 1404.5 30064.8 34141.0 34368.5 34600.3 34785.8 50140.5 50588.7 50775.0 50784.7 50826.7 328080.0 329195.0 329625.0 329711.0 330531.0 27489.7 28268.3 28422.4 29773.4 42211.6 46569.8 47972.0 48857.5 49851.0 50681.0 41221.8 41848.0 41900.4 42152.4 44202.0 41715.6 41852.8 42025.8 43313.8 43518.1 41315.4 42155.8 43087.6 43336.3 45340.5 34166.5 38050.4 38145.0 38312.2 39036.8 28685.9 29341.6 29422.0 29563.9 29582.7 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | [#2] jquery.html Cycles:180 Average:28781.24 Median:1714.45 stddev:79486.29 (4636.2%) stddev-sans-first:79680.62 06:08:29 INFO - PROCESS | 23375 | Values: 359.0 373.2 388.9 391.3 408.0 17313.0 19498.5 19511.7 19609.1 19669.6 18688.3 18729.9 19008.3 19119.0 19229.2 5094.0 5497.1 5688.4 5706.5 5706.8 5544.4 5636.7 5673.4 5705.6 5709.3 5419.8 5485.8 5525.8 5652.6 5678.1 5497.6 5531.0 5539.4 5540.4 5559.9 4827.1 4943.5 4944.6 5036.7 5039.6 23094.8 23212.9 23226.2 23275.5 23362.6 2121.7 2606.5 2679.3 2940.7 3069.9 10114.5 10240.3 10255.1 10340.1 10425.0 1858.7 1890.1 1913.3 1920.3 1951.7 82651.0 83883.6 84403.0 86215.6 88695.1 10548.6 10816.2 10817.7 10908.8 10949.2 15224.8 15237.3 15249.4 15254.5 15274.8 7531.9 7742.3 7767.5 7905.2 8019.9 7386.9 7416.3 7424.7 7620.3 7630.5 4629.5 4667.7 4700.1 4789.2 4809.9 1916.2 1949.6 1980.7 1991.5 1997.4 840.0 975.8 978.2 984.6 1060.5 19133.8 19528.5 19584.4 19586.9 19803.0 979.9 990.7 1011.9 1019.1 1028.9 10394.7 10756.7 10823.8 10942.0 10990.5 476020.0 481160.1 482836.0 483016.0 484871.0 74171.6 79468.0 79941.0 93557.5 96333.0 949.6 983.3 996.8 1006.2 1014.2 16965.1 17469.3 17948.2 17981.4 18260.5 44379.0 44621.8 45237.8 45777.3 45926.5 61574.0 62156.4 62372.7 62609.7 62884.4 8270.4 8322.3 8362.0 8464.8 8489.9 10762.7 12753.4 12813.0 12815.5 13525.7 11050.9 11136.1 11371.1 11426.3 11607.8 11037.9 11095.9 11471.5 11496.7 11645.1 11186.4 11225.3 11301.8 11366.0 11392.9 7291.0 7717.7 8500.4 8516.1 8699.1 10738.6 10981.4 11527.5 11644.8 11725.5 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | [#3] mootools.html Cycles:180 Average:5694.50 Median:4677.57 stddev:3290.33 (70.3%) stddev-sans-first:3284.11 06:08:29 INFO - PROCESS | 23375 | Values: 1452.0 1465.8 1594.9 1728.8 1785.4 8419.0 8901.0 8932.3 8941.5 8945.5 7419.7 8278.0 8545.2 8568.1 8680.0 2277.4 2308.7 2311.6 2312.1 2313.4 2295.5 2317.8 2351.0 2352.4 2355.6 2298.3 2307.9 2316.3 2339.3 2340.3 2222.1 2228.0 2228.4 2234.5 2254.0 2165.1 2167.1 2171.4 2173.0 2173.6 8778.1 8784.9 8825.8 8878.0 8884.4 4941.2 5067.3 5067.4 5069.2 5076.0 3093.1 3136.3 3297.6 3308.0 3317.4 1110.2 1111.0 1125.8 1131.9 1140.2 11921.6 11985.1 11987.2 11995.7 12006.3 4371.0 4449.6 4557.3 4558.6 4611.6 9967.4 9970.0 9986.4 9995.1 9995.3 5069.3 5069.6 5072.2 5075.2 5075.9 4191.6 4540.4 4619.6 4661.1 4677.9 3821.7 3894.3 3908.1 3993.8 3993.9 1201.5 1262.9 1263.4 1264.2 1277.1 800.6 919.0 925.8 952.5 955.1 5452.4 5550.3 5718.7 5729.7 5735.3 948.7 953.4 965.6 967.4 990.5 3822.1 3928.3 4023.4 4045.5 4053.4 10398.7 11136.9 11164.2 11200.9 11205.4 10440.8 11131.1 11131.2 11132.4 11133.1 7835.5 8250.7 8259.8 8260.3 8272.0 5627.7 5728.6 5753.3 5776.3 5871.6 10067.3 10072.2 10155.4 10187.5 10221.2 10107.7 10251.0 10354.5 10374.5 10474.0 6967.3 7680.0 7713.5 7865.1 7926.8 8683.4 8685.3 8749.4 8754.6 8765.2 7233.5 7453.3 7465.4 7480.3 7481.9 7005.0 7235.6 7257.6 7432.7 7468.2 6976.4 6979.2 6986.8 6991.1 7004.7 4677.2 4710.5 4779.2 4838.6 4839.6 4617.5 4688.8 4694.4 4733.8 4866.2 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | [#4] prototype.html Cycles:180 Average:4527.81 Median:5087.16 stddev:1289.82 (25.4%) stddev-sans-first:1254.07 06:08:29 INFO - PROCESS | 23375 | Values: 314.9 316.2 319.8 326.3 331.6 5090.8 5194.9 5263.0 5283.6 5317.2 5174.4 5207.7 5250.1 5256.9 5277.2 4164.0 4170.7 4178.4 4180.0 4192.2 3993.3 4135.4 4165.4 4184.6 4191.6 4145.4 4147.0 4147.6 4150.1 4153.0 4135.0 4152.3 4155.3 4170.2 4173.9 3597.9 3688.8 3706.1 3718.2 3718.2 5083.2 5083.5 5107.6 5122.6 5123.9 4730.7 4775.6 4777.8 4789.4 4792.7 5328.9 5403.6 5443.6 5472.9 5505.2 4019.6 4034.0 4048.8 4050.5 4073.7 5708.0 5721.5 5729.3 5745.0 5769.2 4002.4 4139.2 4145.3 4158.2 4165.9 4182.3 4198.2 4205.8 4213.6 4218.9 4760.3 4770.2 4774.4 4779.9 4794.7 5295.8 5478.5 5509.7 5559.2 5565.7 1365.1 1415.8 1429.1 1432.9 1435.2 991.7 1003.4 1022.5 1025.8 1028.3 5259.8 5285.9 5288.2 5350.5 5372.1 5598.2 5607.8 5612.4 5619.0 5651.0 5169.2 5264.9 5271.4 5360.7 5364.8 2631.3 2654.3 2671.4 2672.2 2674.3 5198.9 5210.7 5215.3 5245.2 5270.3 4829.3 5079.4 5153.8 5156.2 5165.5 5205.0 5213.5 5233.4 5275.3 5308.2 5000.1 5035.7 5037.8 5073.7 5075.4 4766.4 4920.5 4932.0 4986.5 4999.5 5197.9 5210.1 5225.7 5229.9 5253.9 3738.6 3778.5 3788.5 3804.4 3833.1 4903.9 4933.3 4949.3 5418.0 5530.3 5389.8 5432.9 5455.3 5465.9 5469.6 5444.3 5448.8 5473.8 5543.3 5547.9 5269.0 5385.5 5425.8 5431.8 5502.6 5466.2 5502.5 5506.9 5511.7 5527.9 5325.2 5410.9 5420.4 5449.8 5488.4 06:08:29 INFO - PROCESS | 23375 | 06:08:29 INFO - PROCESS | 23375 | [#5] yui.html Cycles:180 Average:19321.15 Median:2741.21 stddev:28356.79 (1034.5%) stddev-sans-first:28401.92 06:08:29 INFO - PROCESS | 23375 | Values: 713.9 740.9 748.3 790.1 799.4 12491.8 13003.2 13371.7 13394.7 13398.5 12942.5 13011.6 13015.2 13030.2 13052.4 650.5 776.5 793.5 813.0 815.5 811.3 817.7 820.6 821.7 822.6 867.2 867.8 868.5 870.2 870.4 680.6 701.2 852.1 856.5 861.1 512.9 591.3 618.0 619.7 621.1 12822.6 12850.7 12857.9 12861.7 12863.9 13394.5 13566.3 13715.5 13906.0 13987.6 10788.6 10812.8 11203.1 11286.3 11416.7 4346.8 4353.5 4407.3 4478.7 4516.4 76418.6 79699.6 80094.0 82259.0 82410.0 10898.5 11066.4 11084.6 11279.2 11289.9 18751.2 18763.3 20808.4 20868.9 20983.5 8155.1 8297.1 8298.8 8325.6 8481.2 4633.3 4652.0 4782.1 4786.9 4969.5 3235.7 3302.5 3306.2 3307.5 3312.2 589.5 598.0 599.5 601.0 605.2 643.8 673.2 675.5 680.1 690.1 8964.5 8991.4 9185.9 9253.2 9276.7 666.9 674.2 687.7 712.0 721.7 4096.2 4221.3 4222.6 4295.1 4327.8 68895.3 115820.4 116369.8 121861.4 125794.4 62898.4 65931.7 95371.0 95605.1 96916.5 55897.0 56624.0 57383.8 87969.6 90694.1 8011.0 8058.9 8349.3 8381.2 8382.7 48057.5 51780.5 51802.0 53503.7 53884.0 71016.0 72881.4 75641.6 78442.0 80133.0 10443.1 10636.2 10684.1 11008.1 11130.8 12398.5 12404.8 12443.0 12743.2 13183.9 11291.7 11485.7 11716.8 11755.9 11869.1 9147.5 12809.9 13097.5 13177.9 13230.5 12793.4 12982.5 13474.3 13548.5 13837.8 9908.3 9946.7 10062.9 10116.5 10418.8 9623.0 10031.3 10852.5 10935.3 10942.9 06:08:29 INFO - PROCESS | 23375 | -------- Summary: end -------- 06:08:29 INFO - PROCESS | 23375 | 06:08:30 INFO - TEST-INFO | 23375: exit 0 06:08:30 INFO - TEST-OK | dromaeo_css | took 1112751ms 06:08:30 INFO - TEST-START | kraken 06:08:30 INFO - operating with platform_type : linux_ 06:08:30 INFO - Initialising browser for kraken test... 06:08:30 INFO - TEST-INFO | started process 23567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYf4pCq/profile http://localhost:47729/getInfo.html) 06:08:33 INFO - PROCESS | 23567 | JavaScript error: , line 0: uncaught exception: undefined 06:08:34 INFO - PROCESS | 23567 | __metrics Screen width/height:1600/1200 06:08:34 INFO - PROCESS | 23567 | colorDepth:24 06:08:34 INFO - PROCESS | 23567 | Browser inner width/height: 1024/697 06:08:34 INFO - PROCESS | 23567 | __metrics 06:08:34 INFO - PROCESS | 23567 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:08:34 INFO - PROCESS | 23567 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:35 INFO - TEST-INFO | 23567: exit 0 06:08:35 INFO - Browser initialized. 06:08:35 INFO - Running cycle 1/1 for kraken test... 06:08:35 INFO - TEST-INFO | started process 23649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYf4pCq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:47 INFO - PROCESS | 23649 | RSS: Main: 157655040 06:08:47 INFO - PROCESS | 23649 | 06:08:50 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:50 INFO - PROCESS | 23649 | RSS: Main: 214421504 06:08:50 INFO - PROCESS | 23649 | 06:08:53 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-dft) 06:08:54 INFO - PROCESS | 23649 | RSS: Main: 188624896 06:08:54 INFO - PROCESS | 23649 | 06:08:57 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-fft) 06:08:57 INFO - PROCESS | 23649 | RSS: Main: 271781888 06:08:57 INFO - PROCESS | 23649 | 06:09:00 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-oscillator) 06:09:00 INFO - PROCESS | 23649 | RSS: Main: 181071872 06:09:00 INFO - PROCESS | 23649 | 06:09:02 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:03 INFO - PROCESS | 23649 | RSS: Main: 185495552 06:09:03 INFO - PROCESS | 23649 | 06:09:06 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47729/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:07 INFO - PROCESS | 23649 | RSS: Main: 221872128 06:09:07 INFO - PROCESS | 23649 | 06:09:10 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47729/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:11 INFO - PROCESS | 23649 | RSS: Main: 221278208 06:09:11 INFO - PROCESS | 23649 | 06:09:13 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47729/tests/kraken/driver.html?testName=json-parse-financial) 06:09:14 INFO - PROCESS | 23649 | RSS: Main: 220856320 06:09:14 INFO - PROCESS | 23649 | 06:09:15 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:16 INFO - PROCESS | 23649 | RSS: Main: 185159680 06:09:16 INFO - PROCESS | 23649 | 06:09:18 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:18 INFO - PROCESS | 23649 | RSS: Main: 190435328 06:09:18 INFO - PROCESS | 23649 | 06:09:20 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:21 INFO - PROCESS | 23649 | RSS: Main: 195579904 06:09:21 INFO - PROCESS | 23649 | 06:09:24 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:24 INFO - PROCESS | 23649 | RSS: Main: 189505536 06:09:24 INFO - PROCESS | 23649 | 06:09:27 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:27 INFO - PROCESS | 23649 | RSS: Main: 194039808 06:09:27 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47729/tests/kraken/driver.html?testName=ai-astar) 06:09:29 INFO - PROCESS | 23649 | RSS: Main: 245858304 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | __start_tp_report 06:09:29 INFO - PROCESS | 23649 | _x_x_mozilla_page_load 06:09:29 INFO - PROCESS | 23649 | _x_x_mozilla_page_load_details 06:09:29 INFO - PROCESS | 23649 | |i|pagename|runs| 06:09:29 INFO - PROCESS | 23649 | |0;ai-astar;103;111;114;112;112;111;111;112;112;111 06:09:29 INFO - PROCESS | 23649 | |1;audio-beat-detection;148;119;118;177;119;119;141;116;152;117 06:09:29 INFO - PROCESS | 23649 | |2;audio-dft;161;159;161;160;160;159;160;160;161;160 06:09:29 INFO - PROCESS | 23649 | |3;audio-fft;75;76;74;115;77;76;74;75;100;75 06:09:29 INFO - PROCESS | 23649 | |4;audio-oscillator;85;85;122;85;84;84;132;83;84;134 06:09:29 INFO - PROCESS | 23649 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;116;117 06:09:29 INFO - PROCESS | 23649 | |6;imaging-darkroom;145;145;146;145;145;146;146;146;145;145 06:09:29 INFO - PROCESS | 23649 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 06:09:29 INFO - PROCESS | 23649 | |8;json-parse-financial;59;55;54;53;53;54;52;53;53;54 06:09:29 INFO - PROCESS | 23649 | |9;json-stringify-tinderbox;63;64;64;63;64;63;64;65;64;64 06:09:29 INFO - PROCESS | 23649 | |10;stanford-crypto-aes;80;75;76;75;75;76;84;76;75;79 06:09:29 INFO - PROCESS | 23649 | |11;stanford-crypto-ccm;131;120;126;121;119;120;127;120;164;119 06:09:29 INFO - PROCESS | 23649 | |12;stanford-crypto-pbkdf2;156;155;159;160;156;160;156;155;157;159 06:09:29 INFO - PROCESS | 23649 | |13;stanford-crypto-sha256-iterative;65;62;64;64;64;63;63;62;65;62 06:09:29 INFO - PROCESS | 23649 | __end_tp_report 06:09:29 INFO - PROCESS | 23649 | __start_cc_report 06:09:29 INFO - PROCESS | 23649 | _x_x_mozilla_cycle_collect,1713 06:09:29 INFO - PROCESS | 23649 | __end_cc_report 06:09:29 INFO - PROCESS | 23649 | __startTimestamp1469797769902__endTimestamp 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | ------- Summary: start ------- 06:09:29 INFO - PROCESS | 23649 | Number of tests: 14 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.92 (2.6%) stddev-sans-first:0.97 06:09:29 INFO - PROCESS | 23649 | Values: 103.0 111.0 114.0 112.0 112.0 111.0 111.0 112.0 112.0 111.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:130.00 stddev:20.93 (16.1%) stddev-sans-first:21.44 06:09:29 INFO - PROCESS | 23649 | Values: 148.0 119.0 118.0 177.0 119.0 119.0 141.0 116.0 152.0 117.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 06:09:29 INFO - PROCESS | 23649 | Values: 161.0 159.0 161.0 160.0 160.0 159.0 160.0 160.0 161.0 160.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:14.08 (18.8%) stddev-sans-first:14.72 06:09:29 INFO - PROCESS | 23649 | Values: 75.0 76.0 74.0 115.0 77.0 76.0 74.0 75.0 100.0 75.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:84.00 stddev:21.98 (26.2%) stddev-sans-first:22.82 06:09:29 INFO - PROCESS | 23649 | Values: 85.0 85.0 122.0 85.0 84.0 84.0 132.0 83.0 84.0 134.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:09:29 INFO - PROCESS | 23649 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:09:29 INFO - PROCESS | 23649 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:09:29 INFO - PROCESS | 23649 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.94 (3.6%) stddev-sans-first:0.88 06:09:29 INFO - PROCESS | 23649 | Values: 59.0 55.0 54.0 53.0 53.0 54.0 52.0 53.0 53.0 54.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 06:09:29 INFO - PROCESS | 23649 | Values: 63.0 64.0 64.0 63.0 64.0 63.0 64.0 65.0 64.0 64.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:3.00 (3.9%) stddev-sans-first:2.99 06:09:29 INFO - PROCESS | 23649 | Values: 80.0 75.0 76.0 75.0 75.0 76.0 84.0 76.0 75.0 79.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:123.50 stddev:13.73 (11.1%) stddev-sans-first:14.47 06:09:29 INFO - PROCESS | 23649 | Values: 131.0 120.0 126.0 121.0 119.0 120.0 127.0 120.0 164.0 119.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.00 stddev:2.00 (1.3%) stddev-sans-first:2.07 06:09:29 INFO - PROCESS | 23649 | Values: 156.0 155.0 159.0 160.0 156.0 160.0 156.0 155.0 157.0 159.0 06:09:29 INFO - PROCESS | 23649 | 06:09:29 INFO - PROCESS | 23649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.09 06:09:29 INFO - PROCESS | 23649 | Values: 65.0 62.0 64.0 64.0 64.0 63.0 63.0 62.0 65.0 62.0 06:09:29 INFO - PROCESS | 23649 | -------- Summary: end -------- 06:09:29 INFO - PROCESS | 23649 | 06:09:30 INFO - TEST-INFO | 23649: exit 0 06:09:30 INFO - TEST-OK | kraken | took 60729ms 06:09:30 INFO - SUITE-END | took 1173s 06:09:31 INFO - Completed test suite (00:19:33) 06:09:31 INFO - javascript benchmark 06:09:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3015.155756388212, 3021.108772911991, 3040.0727778027695, 3040.6959304069587, 3073.492873675842, 5177.456367081459, 5189.0, 5242.711650859202, 5257.0, 5297.655652382592, 5198.6880787152795, 5221.1385121455005, 5257.947420525794, 5287.101192797224, 5308.867278318044, 4725.818545363659, 4765.7140571565815, 4780.16347139251, 4791.520847915215, 4942.728149951751, 4862.902741945159, 4891.510848915098, 4896.55930966213, 4906.264060390934, 4915.606751459893, 4663.48701642819, 4725.905481890343, 4749.358836557055, 4769.689970151963, 4822.421309442854, 4753.619710423192, 4755.476897541268, 4757.476677565465, 4859.73271470069, 4868.95131048692, 4737.099951009297, 4763.951930575268, 4785.784639691222, 4795.2087905495555, 4824.083424149436, 5097.388313402378, 5207.114790485626, 5248.448912864133, 5292.259083728281, 5307.787688492455, 5641.210230567724, 5717.428257174291, 5734.139879018139, 5736.856578585527, 5743.626664266851, 5700.971495142539, 5707.400722924075, 5714.371419143891, 5761.798337058225, 5763.971180144073, 5165.9225111623355, 5210.947890521122, 5359.08895487768, 5368.785248590091, 5370.838874833761, 5670.631408958405, 5714.428557144335, 5716.599838011382, 5764.654120752768, 5779.2775903012125, 5499.560035197174, 5512.6968016758665, 5540.473655002768, 5545.833624991256, 5549.639273447213, 5433.076377015837, 5581.10702287632, 5621.606487545832, 5623.0721930880945, 5634.267545219095, 5613.158026296007, 5645.407232240637, 5646.548276137899, 5684.658920464785, 5702.857428564319, 5587.161925711176, 5630.8029218977135, 5636.408177141423, 5637.774489020475, 5648.802291919763, 4231.61915427613, 4312.353147027971, 4342.739435633872, 4349.217140914602, 4393.450818647669, 3840.327942610032, 3865.16898866745, 3866.4200369944733, 3881.941770873439, 3953.327934251184, 5340.732963351817, 5343.305370301836, 5347.652402593897, 5352.0366334060245, 5390.353157621111, 5531.751071201806, 5663.037283661787, 5663.830085097454, 5666.943330566642, 5708.942910570924, 5305.469453054741, 5341.092014357569, 5363.973180134074, 5376.542993845489, 5431.53831924283, 4882.926756098661, 4889.682170658896, 4893.363862697826, 4893.926591101136, 4939.87650308738, 5688.374278829326, 5908.3205431375945, 5915.822525324247, 5920.5559583031445, 5927.585069045212, 5585.078462053878, 5628.324601047737, 5632.662040277596, 5653.547716182778, 5670.347909990404, 5935.0503919372695, 5938.257717785277, 5938.406159384027, 5941.31674857397, 5945.851353716192, 5374.167004114369, 5538.667679939216, 5587.916181257203, 5590.664560126405, 5594.0, 5613.691246981455, 5657.8019769307875, 5665.49010589049, 5708.5147762439, 5753.0, 5539.750711218086, 5544.085225937675, 5552.722363881709, 5554.555635549227, 5561.0, 5355.303810504765, 5536.944630553643, 5551.195076713773, 5554.888902222014, 5592.412796656293, 5410.404855465817, 5434.266374039454, 5438.83683489496, 5466.070767969375, 5487.6981766003255, 5583.274174357308, 5595.412481689364, 5641.435856414326, 5645.096784514458, 5650.321961364498, 5330.307060082319, 5459.372172200247, 5467.972660136674, 5469.343678758574, 5469.699166545878], "value": 5212.329364594631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8071046199523, 594.9762009519619, 614.5544480251818, 617.5029101573233, 634.847636567224, 43467.34798978018, 44373.11253774923, 44470.55529444705, 44609.0, 47579.0, 45834.083318333614, 46331.0, 46333.53666463334, 46360.0, 46379.30431043537, 9029.503377314246, 9163.633454661838, 9171.908280917205, 9173.357864949423, 9177.587008584629, 9009.504477253748, 9037.096290370977, 9075.27397808177, 9083.682071127512, 9091.499967501784, 9088.545572721338, 9121.680741174061, 9126.863097053549, 9133.041030691782, 9135.223506001998, 9037.322200834931, 9079.273658107335, 9079.636814527477, 9085.182333590008, 9091.272698184162, 8990.235829954461, 9039.68361107358, 9050.456972581665, 9053.275737940949, 9062.546872656341, 43684.56315436837, 43982.56017439849, 44048.779756101336, 44103.558964410266, 44106.55893441057, 3322.4684050552037, 3874.786886721229, 3922.1175235572055, 3930.508686414198, 4020.8994775130564, 32748.0, 33501.49747753786, 33986.921569411585, 34025.14937126567, 34053.0, 4170.749755014709, 4228.483326287531, 4264.168487145008, 4389.648828093745, 4395.494518130424, 354751.0, 357071.0, 357765.0, 358102.0, 358272.0, 57518.0, 57746.4225357741, 57765.422345776, 57784.4221557779, 57801.42198578044, 60263.39736602666, 60320.983950802285, 60388.698056509435, 60483.0, 60523.0, 15156.621084472756, 15268.618284542976, 15272.847271527142, 15288.38846446152, 15292.770608440882, 12544.623661290176, 12564.057695672862, 12597.87402125967, 12608.558700445625, 12608.74782504363, 12377.0, 15634.68730625381, 15781.210939452982, 16057.116858572657, 16143.192840357935, 5638.295213098363, 6481.189851268591, 6560.540762146604, 6675.359321373432, 6725.39471447572, 906.6464079009191, 1022.6114076650825, 1100.5817789240039, 1131.8981291683788, 1188.3939191012646, 32948.0, 33224.66775332264, 33627.66372336245, 33685.494717579255, 33762.0, 1120.9327440353443, 1131.9603813866474, 1132.8753837077916, 1156.733951191214, 1218.561317925546, 17462.738058929128, 17537.298508059535, 17606.119694015248, 17704.986729990058, 17822.5544361392, 555040.0, 558829.0, 559507.0, 559934.0, 560217.0, 58639.413605863396, 58843.41156588379, 58912.410875891546, 58957.0, 58974.11538826921, 1208.4803534480081, 1285.7299967007034, 1319.4854006937303, 1355.457816873239, 1404.529482623312, 30064.799549739662, 34141.0, 34368.48447273343, 34600.307993840484, 34785.8260708705, 50140.49859501358, 50588.74705626448, 50775.0, 50784.74607626938, 50826.745866271915, 328080.0, 329195.0, 329625.0, 329711.0, 330531.0, 27489.72510274872, 28268.293292667848, 28422.43155136927, 29773.404531908807, 42211.577884220766, 46569.76715116403, 47972.0, 48857.5114248853, 49851.0, 50681.0, 41221.79389103036, 41848.0, 41900.37149442822, 42152.36771448492, 44202.0, 41715.582844172386, 41852.790736046125, 42025.78987105045, 43313.783431082644, 43518.12963740771, 41315.38026929538, 42155.789221053696, 43087.56912430836, 43336.349954751335, 45340.54659453363, 34166.487502687974, 38050.429243560815, 38145.0, 38312.233755325295, 39036.80481597574, 28685.856570717013, 29341.559876602296, 29422.0, 29563.85218073896, 29582.704172957994], "value": 20216.413784061497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.98564057437704, 373.2013491128983, 388.91638297765974, 391.3151984027951, 407.97144199906, 17313.047782371963, 19498.512537186576, 19511.707324390147, 19609.11758970846, 19669.606607867834, 18688.25246990122, 18729.906350468264, 19008.28925396714, 19119.0, 19229.23083076675, 5094.032133894567, 5497.147942068976, 5688.402717714622, 5706.486416222539, 5706.77172913083, 5544.390117087117, 5636.689982050985, 5673.404292549285, 5705.629134106291, 5709.257796486471, 5419.780549376378, 5485.753141108639, 5525.834224973257, 5652.63257888238, 5678.148277758328, 5497.642653227547, 5530.972345138249, 5539.362973258067, 5540.445955404448, 5559.916601250944, 4827.106985207713, 4943.530364615392, 4944.60443164546, 5036.748162591893, 5039.571636410909, 23094.76905230943, 23212.883935580216, 23226.18708345217, 23275.53448931029, 23362.64956025661, 2121.724175857144, 2606.530824451598, 2679.263202619276, 2940.661823890259, 3069.9232519186976, 10114.494275286206, 10240.28318017739, 10255.077043066085, 10340.069393754524, 10425.0, 1858.6840237159581, 1890.1494327552518, 1913.320771126258, 1920.2894928876406, 1951.668216403215, 82651.0, 83883.5805820973, 84403.0, 86215.56892215561, 88695.11304886933, 10548.630797922036, 10816.242862999514, 10817.729556760987, 10908.836367454494, 10949.233553651327, 15224.771628425582, 15237.314320855367, 15249.3900243989, 15254.46609368689, 15274.770878436831, 7531.887021694679, 7742.341900938371, 7767.495112817649, 7905.169957154416, 8019.879701804478, 7386.926130738624, 7416.295451932057, 7424.665890034961, 7620.276073772982, 7630.542167469969, 4629.490756016836, 4667.743274119956, 4700.08348372071, 4789.185838407479, 4809.855704328876, 1916.1664675866043, 1949.5905859769323, 1980.6830907054803, 1991.492169496769, 1997.3907958072637, 839.9584515201228, 975.770693886936, 978.1636700621009, 984.601236499219, 1060.5439660945713, 19133.8086619132, 19528.51178720515, 19584.412467625993, 19586.902065489583, 19803.0, 979.9074032453763, 990.7374545745383, 1011.8735158105237, 1019.0573719309609, 1028.943408112561, 10394.688159355232, 10756.731081723019, 10823.83764243537, 10942.0, 10990.505427255792, 476020.0, 481160.1013913787, 482836.0, 483016.0, 484871.0, 74171.62914185395, 79468.0, 79941.0, 93557.5322123385, 96333.0, 949.5821838390948, 983.3165949665057, 996.7508122969258, 1006.2151521812998, 1014.2393205096178, 16965.066921319445, 17469.30122795074, 17948.19233134538, 17981.370652027115, 18260.543486412946, 44379.0, 44621.77689111534, 45237.77381113205, 45777.313340300585, 45926.54073459223, 61574.0, 62156.37843621506, 62372.68813655902, 62609.68695156677, 62884.37115628785, 8270.37972152103, 8322.334213263046, 8361.95819020901, 8464.830703385775, 8489.87265191035, 10762.73093172677, 12753.362331883554, 12813.0, 12815.487380504675, 13525.661858453617, 11050.894910508885, 11136.109111270916, 11371.090312775124, 11426.331666269642, 11607.825882611936, 11037.889621103686, 11095.889041109485, 11471.541138354372, 11496.712582185512, 11645.068394528247, 11186.440677966231, 11225.270357426742, 11301.773964520828, 11366.0, 11392.943035285101, 7291.0, 7717.691292348243, 8500.44747091437, 8516.105808889977, 8699.130086991503, 10738.570457181626, 10981.3960232188, 11527.538898443969, 11644.825327619923, 11725.530978761095], "value": 9118.509589861755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.9854801451988, 1465.7654775235962, 1594.8644365228954, 1728.8271172882721, 1785.357271382302, 8419.0, 8900.955495222515, 8932.285417166628, 8941.50821704806, 8945.463272203673, 7419.703211871532, 8277.958610206955, 8545.230929216385, 8568.143185681429, 8680.0, 2277.4420267034557, 2308.699869017034, 2311.6185829338137, 2312.1329501436962, 2313.3522613668115, 2295.517941232343, 2317.783163838981, 2350.9647355289685, 2352.447174913894, 2355.634876594122, 2298.2530677529785, 2307.896144673494, 2316.305108467453, 2339.333290012347, 2340.32130682102, 2222.0667319725753, 2227.9554408911895, 2228.3983324502374, 2234.452559123009, 2253.9549209015727, 2165.069020321261, 2167.100653228908, 2171.3703026122407, 2173.0, 2173.5870184665023, 8778.122187781235, 8784.868226976601, 8825.823483530357, 8877.955610221972, 8884.378093533454, 4941.20940649498, 5067.290579318898, 5067.442581316052, 5069.239614057884, 5076.035553244872, 3093.1030001299596, 3136.2629782001213, 3297.55483009793, 3307.96692033079, 3317.386283537529, 1110.1618278199908, 1110.9777804443866, 1125.8311253311988, 1131.8868113188698, 1140.2075557487549, 11921.582744603897, 11985.101117416229, 11987.22083064598, 11995.700107497296, 12006.339651319175, 4371.01652128275, 4449.555044495589, 4557.316402539579, 4558.5897269245925, 4611.608013318905, 9967.352122112039, 9970.0, 9986.35088719231, 9995.050470205319, 9995.300328977048, 5069.264956581275, 5069.594432445396, 5072.239164125411, 5075.187969924868, 5075.949240507548, 4191.601797829201, 4540.364348991144, 4619.584237418649, 4661.137689527381, 4677.929831052537, 3821.732478726518, 3894.279558281727, 3908.081600823804, 3993.820278087493, 3993.8617494014647, 1201.4953719437858, 1262.9414055090328, 1263.3935710858839, 1264.1593340428512, 1277.1060257819563, 800.5756948817136, 918.9724308270762, 925.8102089071859, 952.4618590496348, 955.1308309438516, 5452.40023597404, 5550.306211723535, 5718.7426565804635, 5729.684867332254, 5735.254416925773, 948.743839163422, 953.4088864903665, 965.5751469353462, 967.3857100740939, 990.4503000834605, 3822.10180607557, 3928.3125453045604, 4023.3562629979065, 4045.514538255369, 4053.412255223035, 10398.740031499121, 11136.944315278372, 11164.218504704593, 11200.887991120147, 11205.383703896201, 10440.791184176274, 11131.109511239081, 11131.220814542905, 11132.38771867555, 11133.053690436242, 7835.529868207926, 8250.711225107092, 8259.793505162299, 8260.339172866155, 8272.04871439792, 5627.662340259598, 5728.627639203439, 5753.280839895013, 5776.306843178845, 5871.647701137946, 10067.345622534513, 10072.244581656552, 10155.441450720282, 10187.541560629641, 10221.23340749432, 10107.69676909694, 10251.0, 10354.534045968101, 10374.533146008598, 10474.0, 6967.268436814062, 7679.961600192187, 7713.4600577959, 7865.056193256846, 7926.841463170819, 8683.435576687496, 8685.305175585812, 8749.387542871938, 8754.562271886252, 8765.211130998241, 7233.529820561646, 7453.329200371993, 7465.402767778456, 7480.289372509603, 7481.88777168332, 7004.964975175091, 7235.63821808918, 7257.637118144177, 7432.665530051268, 7468.178500365064, 6976.441884649317, 6979.232284448605, 6986.755463558751, 6991.056207411934, 7004.719811207495, 4677.204875171297, 4710.505396933273, 4779.187538118597, 4838.564529192389, 4839.588634966068, 4617.538246175355, 4688.812447502061, 4694.389729335165, 4733.83431579893, 4866.221404575251], "value": 4544.66671723386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.8882146837872, 316.16217024884054, 319.8272932616387, 326.27566801700226, 331.6087017319562, 5090.796368145279, 5194.948050519493, 5262.973685131574, 5283.630145889784, 5317.202419637057, 5174.404943431507, 5207.687538747668, 5250.133727934895, 5256.921146182801, 5277.208418737191, 4163.958360416387, 4170.687198460112, 4178.435911152002, 4179.996800767809, 4192.161567686459, 3993.321135406973, 4135.400366946791, 4165.354370072643, 4184.623383895464, 4191.55988621195, 4145.419641250227, 4146.9792651036705, 4147.6474499667565, 4150.149219410014, 4152.979235103835, 4134.958650413488, 4152.294110001307, 4155.252054630166, 4170.186813571355, 4173.895652608679, 3597.9280414391565, 3688.8340024698955, 3706.092007458163, 3718.163413232001, 3718.2377612589353, 5083.237514372874, 5083.517065878736, 5107.61692873036, 5122.641415100945, 5123.871903202413, 4730.692504987165, 4775.641826862964, 4777.784999675023, 4789.353437285957, 4792.736399498026, 5328.893422131575, 5403.621746477748, 5443.618946673734, 5472.945270547283, 5505.201745746885, 4019.5578486366476, 4033.9915021244688, 4048.7975601220114, 4050.51393832739, 4073.7187175181994, 5707.971460142673, 5721.456461636138, 5729.28383952006, 5745.017968800757, 5769.192313076214, 4002.3596224603925, 4139.19285739278, 4145.274576949022, 4158.209940111369, 4165.8541951032175, 4182.309918863353, 4198.181354635878, 4205.831766729358, 4213.6207741302815, 4218.8523401680795, 4760.262159365304, 4770.189067858403, 4774.427068751772, 4779.928301075487, 4794.7362895040405, 5295.788168473295, 5478.506934375846, 5509.724513774296, 5559.166125081189, 5565.721713914288, 1365.1263191557412, 1415.773476243796, 1429.1425144912969, 1432.8567143285798, 1435.19629007756, 991.6529214774915, 1003.4430890855499, 1022.539857064324, 1025.8153532364097, 1028.2673694824246, 5259.815906443256, 5285.894282114413, 5288.180332048539, 5350.464953504618, 5372.140457526855, 5598.216249725042, 5607.775688972395, 5612.35457922336, 5618.97190514053, 5650.97174514133, 5169.234459564115, 5264.92102618461, 5271.446498117719, 5360.65155764874, 5364.8122315718765, 2631.263366178313, 2654.3231475973503, 2671.4389978104814, 2672.225054734144, 2674.251209661259, 5198.870028249248, 5210.713410762444, 5215.269862219292, 5245.213218017328, 5270.262163297141, 4829.27560865873, 5079.4412614612365, 5153.763096856727, 5156.1750119980625, 5165.535101840777, 5204.992156039828, 5213.504717051874, 5233.4243233244315, 5275.340582427119, 5308.230306605597, 5000.149974504416, 5035.697858128524, 5037.823676171316, 5073.670211436245, 5075.390953085505, 4766.404199475066, 4920.532549407801, 4931.950680493293, 4986.476419975996, 4999.450060493416, 5197.896042079213, 5210.088234559013, 5225.6603320784025, 5229.947700522946, 5253.868653283698, 3738.570064442515, 3778.4899038630533, 3788.507494025759, 3804.4293355996824, 3833.1183827719224, 4903.8528844134735, 4933.309336692794, 4949.28235405857, 5417.972910135424, 5530.281063461885, 5389.784408623768, 5432.945670543402, 5455.345358556999, 5465.890682186414, 5469.644473109235, 5444.346678398618, 5448.782048718007, 5473.808416705396, 5543.256088236349, 5547.8890422192135, 5269.0, 5385.542228910586, 5425.755840987086, 5431.83704488866, 5502.614816962774, 5466.1527463243265, 5502.504774570308, 5506.91739623914, 5511.669299842022, 5527.861803454945, 5325.17765584241, 5410.918836217538, 5420.430854760351, 5449.782008719607, 5488.396276409512], "value": 4120.928413340572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.8643657705036, 740.9407247420204, 748.3078152708744, 790.1229635105034, 799.3684988858802, 12491.812622810654, 13003.219806811598, 13371.665708357272, 13394.66513337167, 13398.53105141319, 12942.547010854621, 13011.60965171044, 13015.219086854795, 13030.153040052413, 13052.412641431134, 650.4568685147907, 776.4603600497657, 793.5040599625235, 813.0121901889204, 815.5432957543765, 811.3225456743596, 817.6933649881295, 820.5527987246935, 821.7370441458736, 822.6133717152928, 867.2195024477988, 867.8004059066418, 868.4962721621445, 870.24723614074, 870.4037734152126, 680.6052489556046, 701.2181417719257, 852.0882655558555, 856.5289090999956, 861.0829466618063, 512.9461406552296, 591.3436085944599, 617.9845503862394, 619.7459041792888, 621.0745988477137, 12822.615321540368, 12850.678733031655, 12857.871421285854, 12861.67845803853, 12863.935680321538, 13394.531191408254, 13566.321683915863, 13715.451381944711, 13906.0, 13987.580372588736, 10788.622398216103, 10812.783744325148, 11203.103751699844, 11286.266392684449, 11416.71458213543, 4346.8043938022865, 4353.455818022747, 4407.27821999622, 4478.708883922567, 4516.390287311204, 76418.61790691066, 79699.6015019927, 80094.0, 82259.0, 82410.0, 10898.509567069343, 11066.39134847591, 11084.61203857861, 11279.210455268052, 11289.887101128883, 18751.156197971122, 18763.34328298503, 20808.37574872756, 20868.895655521625, 20983.475413114793, 8155.062167850773, 8297.12880147588, 8298.751037468886, 8325.583720813935, 8481.151884811592, 4633.258678611473, 4651.953480465219, 4782.0914026334885, 4786.928196077061, 4969.478204788517, 3235.692609202122, 3302.53764472974, 3306.173456635841, 3307.520409540651, 3312.188513814131, 589.5048159546002, 598.0371601721225, 599.4574909706636, 600.9729562169713, 605.2343785111836, 643.7843322486925, 673.1652750589234, 675.5473832532215, 680.0886811672383, 690.0994202565699, 8964.462132271954, 8991.41555798871, 9185.908140918638, 9253.213476854407, 9276.721698348925, 666.8966310221923, 674.1606699658956, 687.6664817563478, 711.9501634885612, 721.7329588052454, 4096.160287141129, 4221.261279276115, 4222.59885310895, 4295.140971805651, 4327.7619730914475, 68895.3110468899, 115820.42089789666, 116369.8363016376, 121861.39069304596, 125794.37102814428, 62898.37101629017, 65931.67034164799, 95371.0, 95605.13184604474, 96916.51541742387, 55897.0, 56624.0, 57383.843888586525, 87969.56015219883, 90694.09305906988, 8010.959945200237, 8058.919410806051, 8349.332053435832, 8381.203785640355, 8382.664693412195, 48057.5194248053, 51780.48219517907, 51802.0, 53503.73248133734, 53884.0, 71016.0, 72881.44067033993, 75641.62179189069, 78442.0, 80133.0, 10443.112335451571, 10636.202284828514, 10684.09185219265, 11008.119350451785, 11130.777384452103, 12398.504059837505, 12404.751904962031, 12443.0, 12743.235405875677, 13183.868161318263, 11291.717707057389, 11485.712857178638, 11716.765664686829, 11755.941220294186, 11869.10981676395, 9147.496887671243, 12809.87190128124, 13097.476100955855, 13177.934110329386, 13230.47078116903, 12793.36033198355, 12982.545610903573, 13474.326283685581, 13548.525801596898, 13837.79243311331, 9908.256880734118, 9946.74060480318, 10062.899371006197, 10116.544755485873, 10418.791624167323, 9622.951885240529, 10031.347962382422, 10852.511636976513, 10935.28920620157, 10942.945285273523], "value": 7085.966767422144, "unit": "score"}], "name": "dromaeo_css", "value": 7094.6978369428, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 114.0, 112.0, 112.0, 111.0, 111.0, 112.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 118.0, 177.0, 119.0, 119.0, 141.0, 116.0, 152.0, 117.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 160.0, 160.0, 159.0, 160.0, 160.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 115.0, 77.0, 76.0, 74.0, 75.0, 100.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 85.0, 84.0, 84.0, 132.0, 83.0, 84.0, 134.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 54.0, 53.0, 53.0, 54.0, 52.0, 53.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 76.0, 75.0, 75.0, 76.0, 84.0, 76.0, 75.0, 79.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 120.0, 126.0, 121.0, 119.0, 120.0, 127.0, 120.0, 164.0, 119.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 159.0, 160.0, 156.0, 160.0, 156.0, 155.0, 157.0, 159.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 64.0, 64.0, 63.0, 63.0, 62.0, 65.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1482.4, "alertThreshold": 2.0}]} 06:09:31 INFO - Return code: 0 06:09:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:31 INFO - # TBPL SUCCESS # 06:09:31 INFO - Running post-action listener: _resource_record_post_action 06:09:31 INFO - [mozharness: 2016-07-29 13:09:31.193213Z] Finished run-tests step (success) 06:09:31 INFO - Running post-run listener: _resource_record_post_run 06:09:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 570531840; Read time: 12; Write time: 461372 06:09:31 INFO - TinderboxPrint: CPU usage
13.1% 06:09:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:09:31 INFO - TinderboxPrint: I/O write bytes / time
570,531,840 / 461,372 06:09:31 INFO - TinderboxPrint: CPU idle
8,263.1 (86.9%) 06:09:31 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 06:09:31 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:31 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 273154048; Read time: 0; Write time: 284872 06:09:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297377792; Read time: 0; Write time: 176500 06:09:31 INFO - Running post-run listener: _upload_blobber_files 06:09:31 INFO - Blob upload gear active. 06:09:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:32 INFO - (blobuploader) - INFO - Done attempting. 06:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:33 INFO - (blobuploader) - INFO - Done attempting. 06:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:43 INFO - (blobuploader) - INFO - Done attempting. 06:09:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:43 INFO - Return code: 0 06:09:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bd5c0dec17d9c4563376d7d80b7507d58eb72a6e5932ac580b6f280ca84242c76b9e066c607a494919dc91bdf308a689e4862abeaaaa66e3fbd28c3944dfeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd75adc14750b8a376c1b373d82b4096fbddf3b9ed2d69fb43cae72afa68b38dfd12ccaa5f6d3d42caa3a82683c01c650b6bf164038426ba2c019d4adf9bdb1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd175548b229125b2b44d01c5fcc6962881e901cc9394fdcb3981ca62db7b2e6f4ca48a5c3bc1521715e2506aff295b392d7e1aaf12b39b3f014f7834c3372d"} 06:09:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:43 INFO - Contents: 06:09:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bd5c0dec17d9c4563376d7d80b7507d58eb72a6e5932ac580b6f280ca84242c76b9e066c607a494919dc91bdf308a689e4862abeaaaa66e3fbd28c3944dfeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd75adc14750b8a376c1b373d82b4096fbddf3b9ed2d69fb43cae72afa68b38dfd12ccaa5f6d3d42caa3a82683c01c650b6bf164038426ba2c019d4adf9bdb1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd175548b229125b2b44d01c5fcc6962881e901cc9394fdcb3981ca62db7b2e6f4ca48a5c3bc1521715e2506aff295b392d7e1aaf12b39b3f014f7834c3372d"} 06:09:43 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:43 INFO - Copying logs to upload dir... 06:09:43 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.049604 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-29 06:09:43.251666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 06:09:43.254735) ========= 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=0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bd5c0dec17d9c4563376d7d80b7507d58eb72a6e5932ac580b6f280ca84242c76b9e066c607a494919dc91bdf308a689e4862abeaaaa66e3fbd28c3944dfeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd75adc14750b8a376c1b373d82b4096fbddf3b9ed2d69fb43cae72afa68b38dfd12ccaa5f6d3d42caa3a82683c01c650b6bf164038426ba2c019d4adf9bdb1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd175548b229125b2b44d01c5fcc6962881e901cc9394fdcb3981ca62db7b2e6f4ca48a5c3bc1521715e2506aff295b392d7e1aaf12b39b3f014f7834c3372d"} build_url:https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/HHWZW3LwRamMRpunDGT2VQ/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/Firefox/sha512/0bd5c0dec17d9c4563376d7d80b7507d58eb72a6e5932ac580b6f280ca84242c76b9e066c607a494919dc91bdf308a689e4862abeaaaa66e3fbd28c3944dfeb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd75adc14750b8a376c1b373d82b4096fbddf3b9ed2d69fb43cae72afa68b38dfd12ccaa5f6d3d42caa3a82683c01c650b6bf164038426ba2c019d4adf9bdb1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfd175548b229125b2b44d01c5fcc6962881e901cc9394fdcb3981ca62db7b2e6f4ca48a5c3bc1521715e2506aff295b392d7e1aaf12b39b3f014f7834c3372d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 06:09:43.279526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:09:43.279820) ========= 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=0333a256a5e4f052382dd180000001b1-1469796547.271359-1359026676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 06:09:43.363107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 06:09:43.363496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 06:09:43.363832) ========= ========= Total master_lag: 0.17 =========