builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1469623677.96 results: success (0) buildid: 20160727030230 builduid: e5f7364f127949aa9939d4dd970c5ae9 revision: 78dd94ba93c77d0bba45f8e4525947629a305a41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:57.965004) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:57.966029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:57.966655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:58.048216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:58.048546) ========= 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=745a4373a2a16df560f216e000000264-1469623402.652399-1316382342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 05:47:58-- 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% 113M=0s 2016-07-27 05:47:58 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:58.133454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:58.134050) ========= 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=745a4373a2a16df560f216e000000264-1469623402.652399-1316382342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016437 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:58.186778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 05:47:58.187182) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78dd94ba93c77d0bba45f8e4525947629a305a41 --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 78dd94ba93c77d0bba45f8e4525947629a305a41 --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=745a4373a2a16df560f216e000000264-1469623402.652399-1316382342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 05:47:58,423 truncating revision to first 12 chars 2016-07-27 05:47:58,423 Setting DEBUG logging. 2016-07-27 05:47:58,424 attempt 1/10 2016-07-27 05:47:58,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78dd94ba93c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 05:47:59,211 unpacking tar archive at: mozilla-central-78dd94ba93c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 05:47:59.340981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:59.341453) ========= script_repo_revision: 78dd94ba93c77d0bba45f8e4525947629a305a41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:59.342024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:59.342330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 05:47:59.356184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-27 05:47:59.356538) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1469623402.652399-1316382342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:59 INFO - MultiFileLogger online at 20160727 05:47:59 in /builds/slave/test 05:47:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:47:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:59 INFO - {'append_to_log': False, 05:47:59 INFO - 'base_work_dir': '/builds/slave/test', 05:47:59 INFO - 'blob_upload_branch': 'Firefox', 05:47:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:59 INFO - 'branch': 'Firefox', 05:47:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:59 INFO - 'config_files': ('talos/linux_config.py',), 05:47:59 INFO - 'default_actions': ('clobber', 05:47:59 INFO - 'read-buildbot-config', 05:47:59 INFO - 'download-and-extract', 05:47:59 INFO - 'populate-webroot', 05:47:59 INFO - 'create-virtualenv', 05:47:59 INFO - 'install', 05:47:59 INFO - 'run-tests'), 05:47:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:59 INFO - 'download_minidump_stackwalk': True, 05:47:59 INFO - 'download_symbols': 'ondemand', 05:47:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:59 INFO - 'installer_path': 'installer.exe', 05:47:59 INFO - 'log_level': 'info', 05:47:59 INFO - 'log_name': 'talos', 05:47:59 INFO - 'log_to_console': True, 05:47:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:59 INFO - 'opt_config_files': (), 05:47:59 INFO - 'pip_index': False, 05:47:59 INFO - 'sps_profile': False, 05:47:59 INFO - 'sps_profile_interval': 0, 05:47:59 INFO - 'suite': 'dromaeojs-e10s', 05:47:59 INFO - 'system_bits': '32', 05:47:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:59 INFO - 'title': 'talos-linux64-ix-032', 05:47:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:59 INFO - 'use_talos_json': True, 05:47:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:59 INFO - 'work_dir': 'build'} 05:47:59 INFO - [mozharness: 2016-07-27 12:47:59.685772Z] Running clobber step. 05:47:59 INFO - Running pre-action listener: _resource_record_pre_action 05:47:59 INFO - Running main action method: clobber 05:47:59 INFO - rmtree: /builds/slave/test/build 05:47:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:00 INFO - Running post-action listener: _resource_record_post_action 05:48:00 INFO - [mozharness: 2016-07-27 12:48:00.158291Z] Finished clobber step (success) 05:48:00 INFO - [mozharness: 2016-07-27 12:48:00.158396Z] Running read-buildbot-config step. 05:48:00 INFO - Running pre-action listener: _resource_record_pre_action 05:48:00 INFO - Running main action method: read_buildbot_config 05:48:00 INFO - Using buildbot properties: 05:48:00 INFO - { 05:48:00 INFO - "project": "", 05:48:00 INFO - "product": "firefox", 05:48:00 INFO - "script_repo_revision": "production", 05:48:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:48:00 INFO - "repository": "", 05:48:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:48:00 INFO - "buildid": "20160727030230", 05:48:00 INFO - "stage_platform": "linux64-pgo", 05:48:00 INFO - "basedir": "/builds/slave/test", 05:48:00 INFO - "nightly_build": "True", 05:48:00 INFO - "buildnumber": 19, 05:48:00 INFO - "slavename": "talos-linux64-ix-032", 05:48:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:48:00 INFO - "platform": "ubuntu64_hw", 05:48:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:48:00 INFO - "branch": "mozilla-central", 05:48:00 INFO - "repo_path": "mozilla-central", 05:48:00 INFO - "revision": "78dd94ba93c77d0bba45f8e4525947629a305a41", 05:48:00 INFO - "pgo_build": "True", 05:48:00 INFO - "builduid": "e5f7364f127949aa9939d4dd970c5ae9", 05:48:00 INFO - "slavebuilddir": "test" 05:48:00 INFO - } 05:48:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:48:00 INFO - Running post-action listener: _resource_record_post_action 05:48:00 INFO - [mozharness: 2016-07-27 12:48:00.160914Z] Finished read-buildbot-config step (success) 05:48:00 INFO - [mozharness: 2016-07-27 12:48:00.161003Z] Running download-and-extract step. 05:48:00 INFO - Running pre-action listener: _resource_record_pre_action 05:48:00 INFO - Running main action method: download_and_extract 05:48:00 INFO - mkdir: /builds/slave/test/build/tests 05:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:00 INFO - https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:01 INFO - Downloaded 1361 bytes. 05:48:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:48:01 INFO - Using the following test package requirements: 05:48:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:48:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:48:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'jsshell-linux-x86_64.zip'], 05:48:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:48:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:48:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:48:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:48:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:48:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:01 INFO - https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:03 INFO - Downloaded 24315281 bytes. 05:48:03 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:48:03 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:48:04 INFO - Return code: 0 05:48:04 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:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:04 INFO - https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:06 INFO - Downloaded 24315281 bytes. 05:48:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:48:08 INFO - Return code: 0 05:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:08 INFO - https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:09 INFO - Downloaded 14413725 bytes. 05:48:09 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:48:09 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:48:10 INFO - Return code: 0 05:48: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:48:10 INFO - https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M8w7e4OtSQmr-6yYjysGAQ/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:48:16 INFO - Downloaded 60932273 bytes. 05:48:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:16 INFO - mkdir: /builds/slave/test/properties 05:48:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:16 INFO - Contents: 05:48:16 INFO - build_url:https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:16 INFO - Running post-action listener: _resource_record_post_action 05:48:16 INFO - Running post-action listener: set_extra_try_arguments 05:48:16 INFO - [mozharness: 2016-07-27 12:48:16.776108Z] Finished download-and-extract step (success) 05:48:16 INFO - [mozharness: 2016-07-27 12:48:16.776346Z] Running populate-webroot step. 05:48:16 INFO - Running pre-action listener: _resource_record_pre_action 05:48:16 INFO - Running main action method: populate_webroot 05:48:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:16 INFO - '--tppagecycles', 05:48:16 INFO - '7'], 05:48:16 INFO - 'tests': ['tsvgm']}}, 05:48:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['damp', 'tps']}, 05:48:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'tests': ['damp', 'tps']}, 05:48:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['dromaeo_dom']}, 05:48:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['basic_compositor_video']}, 05:48:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:48:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['a11yr', 05:48:16 INFO - 'ts_paint', 05:48:16 INFO - 'tpaint', 05:48:16 INFO - 'sessionrestore', 05:48:16 INFO - 'sessionrestore_no_auto_restore', 05:48:16 INFO - 'tabpaint']}, 05:48:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:16 INFO - 'ts_paint', 05:48:16 INFO - 'tpaint', 05:48:16 INFO - 'sessionrestore', 05:48:16 INFO - 'sessionrestore_no_auto_restore', 05:48:16 INFO - 'tabpaint']}, 05:48:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:16 INFO - 'ts_paint', 05:48:16 INFO - 'tpaint', 05:48:16 INFO - 'sessionrestore', 05:48:16 INFO - 'sessionrestore_no_auto_restore', 05:48:16 INFO - 'tabpaint']}, 05:48:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:16 INFO - 'ts_paint', 05:48:16 INFO - 'tpaint', 05:48:16 INFO - 'sessionrestore', 05:48:16 INFO - 'sessionrestore_no_auto_restore', 05:48:16 INFO - 'tabpaint']}, 05:48:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['a11yr', 05:48:16 INFO - 'ts_paint', 05:48:16 INFO - 'tpaint', 05:48:16 INFO - 'sessionrestore', 05:48:16 INFO - 'sessionrestore_no_auto_restore', 05:48:16 INFO - 'tabpaint']}, 05:48:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['a11yr', 05:48:16 INFO - 'ts_paint', 05:48:16 INFO - 'tpaint', 05:48:16 INFO - 'sessionrestore', 05:48:16 INFO - 'sessionrestore_no_auto_restore', 05:48:16 INFO - 'tabpaint']}, 05:48:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['tsvgx', 05:48:16 INFO - 'tsvgr_opacity', 05:48:16 INFO - 'tart', 05:48:16 INFO - 'tscrollx', 05:48:16 INFO - 'cart']}, 05:48:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:16 INFO - 'tsvgr_opacity', 05:48:16 INFO - 'tart', 05:48:16 INFO - 'tscrollx', 05:48:16 INFO - 'cart']}, 05:48:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'talos_options': ['--disable-e10s'], 05:48:16 INFO - 'tests': ['tp5o']}, 05:48:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'tests': ['tp5o']}, 05:48:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'talos_options': ['--disable-e10s', 05:48:16 INFO - '--xperf_path', 05:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:16 INFO - 'tests': ['tp5n']}, 05:48:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:16 INFO - 'talos_options': ['--xperf_path', 05:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:16 INFO - 'tests': ['tp5n']}}, 05:48:16 INFO - 'talos.zip': {'path': '', 05:48:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:16 INFO - Running post-action listener: _resource_record_post_action 05:48:16 INFO - [mozharness: 2016-07-27 12:48:16.795508Z] Finished populate-webroot step (success) 05:48:16 INFO - [mozharness: 2016-07-27 12:48:16.795598Z] Running create-virtualenv step. 05:48:16 INFO - Running pre-action listener: _resource_record_pre_action 05:48:16 INFO - Running main action method: create_virtualenv 05:48:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:48:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:16 INFO - Using real prefix '/usr' 05:48:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:19 INFO - Installing pip.................done. 05:48:19 INFO - Return code: 0 05:48:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:48:19 INFO - Using env: {'DISPLAY': ':0', 05:48:19 INFO - 'HOME': '/home/cltbld', 05:48:19 INFO - 'LANG': 'en_US.UTF-8', 05:48:19 INFO - 'LANGUAGE': 'en_US:en', 05:48:19 INFO - 'LOGNAME': 'cltbld', 05:48:19 INFO - 'MAIL': '/var/mail/cltbld', 05:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:19 INFO - 'MOZ_NO_REMOTE': '1', 05:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:19 INFO - 'NO_EM_RESTART': '1', 05:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:19 INFO - 'PWD': '/builds/slave/test', 05:48:19 INFO - 'SHELL': '/bin/bash', 05:48:19 INFO - 'SHLVL': '1', 05:48:19 INFO - 'TERM': 'linux', 05:48:19 INFO - 'TMOUT': '86400', 05:48:19 INFO - 'USER': 'cltbld', 05:48:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:19 INFO - '_': '/tools/buildbot/bin/python'} 05:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:19 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:48:19 INFO - Cleaning up... 05:48:19 INFO - Return code: 0 05:48:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:48:19 INFO - Using env: {'DISPLAY': ':0', 05:48:19 INFO - 'HOME': '/home/cltbld', 05:48:19 INFO - 'LANG': 'en_US.UTF-8', 05:48:19 INFO - 'LANGUAGE': 'en_US:en', 05:48:19 INFO - 'LOGNAME': 'cltbld', 05:48:19 INFO - 'MAIL': '/var/mail/cltbld', 05:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:19 INFO - 'MOZ_NO_REMOTE': '1', 05:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:19 INFO - 'NO_EM_RESTART': '1', 05:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:19 INFO - 'PWD': '/builds/slave/test', 05:48:19 INFO - 'SHELL': '/bin/bash', 05:48:19 INFO - 'SHLVL': '1', 05:48:19 INFO - 'TERM': 'linux', 05:48:19 INFO - 'TMOUT': '86400', 05:48:19 INFO - 'USER': 'cltbld', 05:48:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:19 INFO - '_': '/tools/buildbot/bin/python'} 05:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:19 INFO - Downloading/unpacking psutil>=3.1.1 05:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:21 INFO - Installing collected packages: psutil 05:48:21 INFO - Running setup.py install for psutil 05:48:21 INFO - building 'psutil._psutil_linux' extension 05:48:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:48:22 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:48:22 INFO - building 'psutil._psutil_posix' extension 05:48:22 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:48:22 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:48:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:22 INFO - Successfully installed psutil 05:48:22 INFO - Cleaning up... 05:48:22 INFO - Return code: 0 05:48:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:48:22 INFO - Using env: {'DISPLAY': ':0', 05:48:22 INFO - 'HOME': '/home/cltbld', 05:48:22 INFO - 'LANG': 'en_US.UTF-8', 05:48:22 INFO - 'LANGUAGE': 'en_US:en', 05:48:22 INFO - 'LOGNAME': 'cltbld', 05:48:22 INFO - 'MAIL': '/var/mail/cltbld', 05:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:22 INFO - 'MOZ_NO_REMOTE': '1', 05:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:22 INFO - 'NO_EM_RESTART': '1', 05:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:22 INFO - 'PWD': '/builds/slave/test', 05:48:22 INFO - 'SHELL': '/bin/bash', 05:48:22 INFO - 'SHLVL': '1', 05:48:22 INFO - 'TERM': 'linux', 05:48:22 INFO - 'TMOUT': '86400', 05:48:22 INFO - 'USER': 'cltbld', 05:48:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:22 INFO - '_': '/tools/buildbot/bin/python'} 05:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:24 INFO - Installing collected packages: mozsystemmonitor 05:48:24 INFO - Running setup.py install for mozsystemmonitor 05:48:24 INFO - Successfully installed mozsystemmonitor 05:48:24 INFO - Cleaning up... 05:48:24 INFO - Return code: 0 05:48:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:48:24 INFO - Using env: {'DISPLAY': ':0', 05:48:24 INFO - 'HOME': '/home/cltbld', 05:48:24 INFO - 'LANG': 'en_US.UTF-8', 05:48:24 INFO - 'LANGUAGE': 'en_US:en', 05:48:24 INFO - 'LOGNAME': 'cltbld', 05:48:24 INFO - 'MAIL': '/var/mail/cltbld', 05:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:24 INFO - 'MOZ_NO_REMOTE': '1', 05:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:24 INFO - 'NO_EM_RESTART': '1', 05:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:24 INFO - 'PWD': '/builds/slave/test', 05:48:24 INFO - 'SHELL': '/bin/bash', 05:48:24 INFO - 'SHLVL': '1', 05:48:24 INFO - 'TERM': 'linux', 05:48:24 INFO - 'TMOUT': '86400', 05:48:24 INFO - 'USER': 'cltbld', 05:48:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:24 INFO - '_': '/tools/buildbot/bin/python'} 05:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:24 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:27 INFO - warning: no files found matching '*.txt' 05:48:27 INFO - no previously-included directories found matching 'build' 05:48:27 INFO - no previously-included directories found matching 'dist' 05:48:27 INFO - no previously-included directories found matching '.git*' 05:48:27 INFO - Installing collected packages: jsonschema, functools32 05:48:27 INFO - Running setup.py install for functools32 05:48:27 INFO - warning: no files found matching '*.txt' 05:48:27 INFO - no previously-included directories found matching 'build' 05:48:27 INFO - no previously-included directories found matching 'dist' 05:48:27 INFO - no previously-included directories found matching '.git*' 05:48:27 INFO - Successfully installed jsonschema functools32 05:48:27 INFO - Cleaning up... 05:48:27 INFO - Return code: 0 05:48:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:48:27 INFO - Using env: {'DISPLAY': ':0', 05:48:27 INFO - 'HOME': '/home/cltbld', 05:48:27 INFO - 'LANG': 'en_US.UTF-8', 05:48:27 INFO - 'LANGUAGE': 'en_US:en', 05:48:27 INFO - 'LOGNAME': 'cltbld', 05:48:27 INFO - 'MAIL': '/var/mail/cltbld', 05:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:27 INFO - 'MOZ_NO_REMOTE': '1', 05:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:27 INFO - 'NO_EM_RESTART': '1', 05:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:27 INFO - 'PWD': '/builds/slave/test', 05:48:27 INFO - 'SHELL': '/bin/bash', 05:48:27 INFO - 'SHLVL': '1', 05:48:27 INFO - 'TERM': 'linux', 05:48:27 INFO - 'TMOUT': '86400', 05:48:27 INFO - 'USER': 'cltbld', 05:48:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:27 INFO - '_': '/tools/buildbot/bin/python'} 05:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:48:27 INFO - Cleaning up... 05:48:27 INFO - Return code: 0 05:48:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:48:27 INFO - Using env: {'DISPLAY': ':0', 05:48:27 INFO - 'HOME': '/home/cltbld', 05:48:27 INFO - 'LANG': 'en_US.UTF-8', 05:48:27 INFO - 'LANGUAGE': 'en_US:en', 05:48:27 INFO - 'LOGNAME': 'cltbld', 05:48:27 INFO - 'MAIL': '/var/mail/cltbld', 05:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:27 INFO - 'MOZ_NO_REMOTE': '1', 05:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:27 INFO - 'NO_EM_RESTART': '1', 05:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:27 INFO - 'PWD': '/builds/slave/test', 05:48:27 INFO - 'SHELL': '/bin/bash', 05:48:27 INFO - 'SHLVL': '1', 05:48:27 INFO - 'TERM': 'linux', 05:48:27 INFO - 'TMOUT': '86400', 05:48:27 INFO - 'USER': 'cltbld', 05:48:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:27 INFO - '_': '/tools/buildbot/bin/python'} 05:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:48: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:48: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:48: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:48: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:48: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:48: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:48:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48: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:48: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:48: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:48: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:48: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:48: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:48:30 INFO - Downloading docopt-0.6.1.tar.gz 05:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:30 INFO - Running setup.py install for blobuploader 05:48:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:30 INFO - Running setup.py install for requests 05:48:30 INFO - Running setup.py install for docopt 05:48:30 INFO - Successfully installed blobuploader requests docopt 05:48:30 INFO - Cleaning up... 05:48:30 INFO - Return code: 0 05:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:30 INFO - Using env: {'DISPLAY': ':0', 05:48:30 INFO - 'HOME': '/home/cltbld', 05:48:30 INFO - 'LANG': 'en_US.UTF-8', 05:48:30 INFO - 'LANGUAGE': 'en_US:en', 05:48:30 INFO - 'LOGNAME': 'cltbld', 05:48:30 INFO - 'MAIL': '/var/mail/cltbld', 05:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:30 INFO - 'MOZ_NO_REMOTE': '1', 05:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:30 INFO - 'NO_EM_RESTART': '1', 05:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:30 INFO - 'PWD': '/builds/slave/test', 05:48:30 INFO - 'SHELL': '/bin/bash', 05:48:30 INFO - 'SHLVL': '1', 05:48:30 INFO - 'TERM': 'linux', 05:48:30 INFO - 'TMOUT': '86400', 05:48:30 INFO - 'USER': 'cltbld', 05:48:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:30 INFO - '_': '/tools/buildbot/bin/python'} 05:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:31 INFO - Running setup.py (path:/tmp/pip-K9Gun7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:31 INFO - Running setup.py (path:/tmp/pip-OUfkDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:31 INFO - Running setup.py (path:/tmp/pip-MvfA4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:31 INFO - Running setup.py (path:/tmp/pip-w0FzF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:31 INFO - Running setup.py (path:/tmp/pip-rnKTiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:31 INFO - Running setup.py (path:/tmp/pip-_zEG5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:31 INFO - Running setup.py (path:/tmp/pip-Vw7oQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:31 INFO - Running setup.py (path:/tmp/pip-8iON_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:31 INFO - Running setup.py (path:/tmp/pip-hntPqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:31 INFO - Running setup.py (path:/tmp/pip-CYz8Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:31 INFO - Running setup.py (path:/tmp/pip-3_DyPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:31 INFO - Running setup.py (path:/tmp/pip-EYRIDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:32 INFO - Running setup.py (path:/tmp/pip-FNoyX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:32 INFO - Running setup.py (path:/tmp/pip-3ZpDh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:32 INFO - Running setup.py (path:/tmp/pip-lWnWA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:32 INFO - Running setup.py (path:/tmp/pip-3A4Icy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:32 INFO - Running setup.py (path:/tmp/pip-TjSO5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:32 INFO - Running setup.py install for manifestparser 05:48:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:32 INFO - Running setup.py install for mozcrash 05:48:32 INFO - Running setup.py install for mozdebug 05:48:32 INFO - Running setup.py install for mozdevice 05:48:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:32 INFO - Running setup.py install for mozfile 05:48:32 INFO - Running setup.py install for mozhttpd 05:48:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for mozinfo 05:48:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for mozInstall 05:48:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for mozleak 05:48:33 INFO - Running setup.py install for mozlog 05:48:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for moznetwork 05:48:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for mozprocess 05:48:33 INFO - Running setup.py install for mozprofile 05:48:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for mozrunner 05:48:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:33 INFO - Running setup.py install for mozscreenshot 05:48:33 INFO - Running setup.py install for moztest 05:48:34 INFO - Running setup.py install for mozversion 05:48:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:34 INFO - Cleaning up... 05:48:34 INFO - Return code: 0 05:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:34 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:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:34 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:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:34 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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:34 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:48:34 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:48:34 INFO - Using env: {'DISPLAY': ':0', 05:48:34 INFO - 'HOME': '/home/cltbld', 05:48:34 INFO - 'LANG': 'en_US.UTF-8', 05:48:34 INFO - 'LANGUAGE': 'en_US:en', 05:48:34 INFO - 'LOGNAME': 'cltbld', 05:48:34 INFO - 'MAIL': '/var/mail/cltbld', 05:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:34 INFO - 'MOZ_NO_REMOTE': '1', 05:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:34 INFO - 'NO_EM_RESTART': '1', 05:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:34 INFO - 'PWD': '/builds/slave/test', 05:48:34 INFO - 'SHELL': '/bin/bash', 05:48:34 INFO - 'SHLVL': '1', 05:48:34 INFO - 'TERM': 'linux', 05:48:34 INFO - 'TMOUT': '86400', 05:48:34 INFO - 'USER': 'cltbld', 05:48:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:34 INFO - '_': '/tools/buildbot/bin/python'} 05:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:34 INFO - Running setup.py (path:/tmp/pip-a0fI24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:34 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:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:34 INFO - Running setup.py (path:/tmp/pip-vG48RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:34 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:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:34 INFO - Running setup.py (path:/tmp/pip-VLjRza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:34 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:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:34 INFO - Running setup.py (path:/tmp/pip-XyS_XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:34 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:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:34 INFO - Running setup.py (path:/tmp/pip-w6enKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:34 INFO - Running setup.py (path:/tmp/pip-uTDyf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:34 INFO - Running setup.py (path:/tmp/pip-XkCos4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:34 INFO - Running setup.py (path:/tmp/pip-XZ2C49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:35 INFO - Running setup.py (path:/tmp/pip-j22tMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:35 INFO - Running setup.py (path:/tmp/pip-4BY_0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:35 INFO - Running setup.py (path:/tmp/pip-4moWVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:35 INFO - Running setup.py (path:/tmp/pip-0FqV6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:35 INFO - Running setup.py (path:/tmp/pip-RbuqCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:35 INFO - Running setup.py (path:/tmp/pip-fV6hDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:35 INFO - Running setup.py (path:/tmp/pip-kqwDhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:35 INFO - Running setup.py (path:/tmp/pip-zOfJ7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:35 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:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:35 INFO - Running setup.py (path:/tmp/pip-HGbId2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:35 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:48:35 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:48:35 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:48:35 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:48:35 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:48:35 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:48:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:37 INFO - Downloading blessings-1.6.tar.gz 05:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:38 INFO - Installing collected packages: blessings 05:48:38 INFO - Running setup.py install for blessings 05:48:38 INFO - Successfully installed blessings 05:48:38 INFO - Cleaning up... 05:48:39 INFO - Return code: 0 05:48:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:41 INFO - Reading from file tmpfile_stdout 05:48:41 INFO - Current package versions: 05:48:41 INFO - argparse == 1.2.1 05:48:41 INFO - blessings == 1.6 05:48:41 INFO - blobuploader == 1.2.4 05:48:41 INFO - docopt == 0.6.1 05:48:41 INFO - functools32 == 3.2.3-2 05:48:41 INFO - jsonschema == 2.5.1 05:48:41 INFO - manifestparser == 1.1 05:48:41 INFO - mozInstall == 1.12 05:48:41 INFO - mozcrash == 0.17 05:48:41 INFO - mozdebug == 0.1 05:48:41 INFO - mozdevice == 0.48 05:48:41 INFO - mozfile == 1.2 05:48:41 INFO - mozhttpd == 0.7 05:48:41 INFO - mozinfo == 0.9 05:48:41 INFO - mozleak == 0.1 05:48:41 INFO - mozlog == 3.3 05:48:41 INFO - moznetwork == 0.27 05:48:41 INFO - mozprocess == 0.23 05:48:41 INFO - mozprofile == 0.28 05:48:41 INFO - mozrunner == 6.12 05:48:41 INFO - mozscreenshot == 0.1 05:48:41 INFO - mozsystemmonitor == 0.3 05:48:41 INFO - moztest == 0.7 05:48:41 INFO - mozversion == 1.4 05:48:41 INFO - psutil == 3.1.1 05:48:41 INFO - requests == 1.2.3 05:48:41 INFO - wsgiref == 0.1.2 05:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:41 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:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 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:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:41 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:48:41 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:48:41 INFO - Using env: {'DISPLAY': ':0', 05:48:41 INFO - 'HOME': '/home/cltbld', 05:48:41 INFO - 'LANG': 'en_US.UTF-8', 05:48:41 INFO - 'LANGUAGE': 'en_US:en', 05:48:41 INFO - 'LOGNAME': 'cltbld', 05:48:41 INFO - 'MAIL': '/var/mail/cltbld', 05:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:41 INFO - 'MOZ_NO_REMOTE': '1', 05:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:41 INFO - 'NO_EM_RESTART': '1', 05:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:41 INFO - 'PWD': '/builds/slave/test', 05:48:41 INFO - 'SHELL': '/bin/bash', 05:48:41 INFO - 'SHLVL': '1', 05:48:41 INFO - 'TERM': 'linux', 05:48:41 INFO - 'TMOUT': '86400', 05:48:41 INFO - 'USER': 'cltbld', 05:48:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:41 INFO - '_': '/tools/buildbot/bin/python'} 05:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 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:48:41 INFO - Cleaning up... 05:48:41 INFO - Return code: 0 05:48:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:41 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:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 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:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 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 0x16ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, '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': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', '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:48:41 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:48:41 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:48:41 INFO - Using env: {'DISPLAY': ':0', 05:48:41 INFO - 'HOME': '/home/cltbld', 05:48:41 INFO - 'LANG': 'en_US.UTF-8', 05:48:41 INFO - 'LANGUAGE': 'en_US:en', 05:48:41 INFO - 'LOGNAME': 'cltbld', 05:48:41 INFO - 'MAIL': '/var/mail/cltbld', 05:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:41 INFO - 'MOZ_NO_REMOTE': '1', 05:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:41 INFO - 'NO_EM_RESTART': '1', 05:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:41 INFO - 'PWD': '/builds/slave/test', 05:48:41 INFO - 'SHELL': '/bin/bash', 05:48:41 INFO - 'SHLVL': '1', 05:48:41 INFO - 'TERM': 'linux', 05:48:41 INFO - 'TMOUT': '86400', 05:48:41 INFO - 'USER': 'cltbld', 05:48:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:41 INFO - '_': '/tools/buildbot/bin/python'} 05:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:41 INFO - Cleaning up... 05:48:41 INFO - Return code: 0 05:48:41 INFO - Running post-action listener: _resource_record_post_action 05:48:41 INFO - Running post-action listener: _start_resource_monitoring 05:48:41 INFO - Starting resource monitoring. 05:48:41 INFO - [mozharness: 2016-07-27 12:48:41.509715Z] Finished create-virtualenv step (success) 05:48:41 INFO - [mozharness: 2016-07-27 12:48:41.510152Z] Running install step. 05:48:41 INFO - Running pre-action listener: _resource_record_pre_action 05:48:41 INFO - Running main action method: install 05:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:41 INFO - Reading from file tmpfile_stdout 05:48:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:41 INFO - Reading from file tmpfile_stdout 05:48:41 INFO - Output received: 05:48:41 INFO - Usage: mozinstall [options] installer 05:48:41 INFO - Options: 05:48:41 INFO - -h, --help show this help message and exit 05:48:41 INFO - -d DEST, --destination=DEST 05:48:41 INFO - Directory to install application into. [default: 05:48:41 INFO - "/builds/slave/test"] 05:48:41 INFO - --app=APP Application being installed. [default: firefox] 05:48:41 INFO - mkdir: /builds/slave/test/build/application 05:48:41 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:48:41 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:48:59 INFO - Reading from file tmpfile_stdout 05:48:59 INFO - Output received: 05:48:59 INFO - /builds/slave/test/build/application/firefox/firefox 05:48:59 INFO - Running post-action listener: _resource_record_post_action 05:48:59 INFO - [mozharness: 2016-07-27 12:48:59.040832Z] Finished install step (success) 05:48:59 INFO - [mozharness: 2016-07-27 12:48:59.041083Z] Running run-tests step. 05:48:59 INFO - Running pre-action listener: _resource_record_pre_action 05:48:59 INFO - Running main action method: run_tests 05:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:59 INFO - Python 2.7.3 05:48:59 INFO - Return code: 0 05:48:59 INFO - grabbing minidump binary from tooltool 05:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:59 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 0x196c3b0>, '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 0x196d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:59 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:48:59 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:48:59 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:48:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:59 INFO - Return code: 0 05:48:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:48:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:48:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:48:59 INFO - Using env: {'DISPLAY': ':0', 05:48:59 INFO - 'HOME': '/home/cltbld', 05:48:59 INFO - 'LANG': 'en_US.UTF-8', 05:48:59 INFO - 'LANGUAGE': 'en_US:en', 05:48:59 INFO - 'LOGNAME': 'cltbld', 05:48:59 INFO - 'MAIL': '/var/mail/cltbld', 05:48:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:59 INFO - 'MOZ_NO_REMOTE': '1', 05:48:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:59 INFO - 'NO_EM_RESTART': '1', 05:48:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:59 INFO - 'PWD': '/builds/slave/test', 05:48:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:59 INFO - 'SHELL': '/bin/bash', 05:48:59 INFO - 'SHLVL': '1', 05:48:59 INFO - 'TERM': 'linux', 05:48:59 INFO - 'TMOUT': '86400', 05:48:59 INFO - 'USER': 'cltbld', 05:48:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469623402.652399-1316382342', 05:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:59 INFO - '_': '/tools/buildbot/bin/python'} 05:48:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:48:59 INFO - mozversion application_buildid: 20160727030230 05:48:59 INFO - mozversion application_changeset: 78dd94ba93c77d0bba45f8e4525947629a305a41 05:48:59 INFO - mozversion application_display_name: Nightly 05:48:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:59 INFO - mozversion application_name: Firefox 05:48:59 INFO - mozversion application_remotingname: firefox 05:48:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:59 INFO - mozversion application_vendor: Mozilla 05:48:59 INFO - mozversion application_version: 50.0a1 05:48:59 INFO - mozversion platform_buildid: 20160727030230 05:48:59 INFO - mozversion platform_changeset: 78dd94ba93c77d0bba45f8e4525947629a305a41 05:48:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:59 INFO - mozversion platform_version: 50.0a1 05:48:59 INFO - using testdate: 1469623739 05:48:59 INFO - actual date: 1469623739 05:48:59 INFO - starting webserver on 'localhost:41073' 05:48:59 INFO - SUITE-START | Running 2 tests 05:48:59 INFO - TEST-START | dromaeo_css 05:48:59 INFO - operating with platform_type : linux_ 05:48:59 INFO - Initialising browser for dromaeo_css test... 05:48:59 INFO - TEST-INFO | started process 19133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkhu75c/profile http://localhost:41073/getInfo.html) 05:49:03 INFO - PROCESS | 19133 | JavaScript error: , line 0: uncaught exception: undefined 05:49:04 INFO - PROCESS | 19133 | __metrics Screen width/height:1600/1200 05:49:04 INFO - PROCESS | 19133 | colorDepth:24 05:49:04 INFO - PROCESS | 19133 | Browser inner width/height: 1024/697 05:49:04 INFO - PROCESS | 19133 | __metrics 05:49:05 ERROR - PROCESS | 19133 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:49:06 INFO - TEST-INFO | 19133: exit 0 05:49:06 INFO - Browser initialized. 05:49:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:06 INFO - TEST-INFO | started process 19256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkhu75c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:18 INFO - PROCESS | 19256 | RSS: Main: 164753408 05:49:18 INFO - PROCESS | 19256 | 05:50:07 INFO - PROCESS | 19256 | 1469623807834 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:52:16 INFO - PROCESS | 19256 | Cycle 1(1): loaded http://localhost:41073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41073/tests/dromaeo/cssquery-ext.html) 05:52:17 INFO - PROCESS | 19256 | RSS: Main: 169795584 05:52:17 INFO - PROCESS | 19256 | 05:55:19 INFO - PROCESS | 19256 | Cycle 1(1): loaded http://localhost:41073/tests/dromaeo/cssquery-ext.html (next: http://localhost:41073/tests/dromaeo/cssquery-jquery.html) 05:55:20 INFO - PROCESS | 19256 | RSS: Main: 166739968 05:55:20 INFO - PROCESS | 19256 | 05:58:22 INFO - PROCESS | 19256 | Cycle 1(1): loaded http://localhost:41073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41073/tests/dromaeo/cssquery-mootools.html) 05:58:22 INFO - PROCESS | 19256 | RSS: Main: 170831872 05:58:22 INFO - PROCESS | 19256 | 06:01:24 INFO - PROCESS | 19256 | Cycle 1(1): loaded http://localhost:41073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41073/tests/dromaeo/cssquery-prototype.html) 06:01:25 INFO - PROCESS | 19256 | RSS: Main: 165322752 06:01:25 INFO - PROCESS | 19256 | 06:04:27 INFO - PROCESS | 19256 | Cycle 1(1): loaded http://localhost:41073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41073/tests/dromaeo/cssquery-yui.html) 06:04:28 INFO - PROCESS | 19256 | RSS: Main: 167763968 06:04:28 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | Cycle 1(1): loaded http://localhost:41073/tests/dromaeo/cssquery-yui.html (next: http://localhost:41073/tests/dromaeo/cssquery-dojo.html) 06:07:31 INFO - PROCESS | 19256 | RSS: Main: 170639360 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | __start_tp_report 06:07:31 INFO - PROCESS | 19256 | _x_x_mozilla_page_load 06:07:31 INFO - PROCESS | 19256 | _x_x_mozilla_page_load_details 06:07:31 INFO - PROCESS | 19256 | |i|pagename|runs| 06:07:31 INFO - PROCESS | 19256 | |0;dojo.html;3141.2461009357753;3158.1473002289395;3174.9998750393625;3179.0303957293045;3182.2362632968093;5383.569314454844;5490.094134467813;5539.058360078786;5551.306086739158;5568.1647752837;5413.133898576229;5473.06957817171;5524.475174858392;5567.8886422271535;5572.832815015546;4950.356453661028;4995.150824359867;5025.321581586494;5043.117454445476;5051.5453609175165;5057.822976195834;5061.493850614946;5167.844964651048;5171.793128274864;5176.741162941857;5058.822941197041;5077.746112694351;5110.28456016158;5118.513741194581;5141.845744627667;5010.574101201402;5035.622328325354;5037.395512538482;5089.389273287192;5147.279380886679;5030.094582975063;5033.697978121288;5038.370203724535;5054.444011158769;5110.029094472038;5358.678479291255;5554.888902221974;5585.078462053756;5601.327840659147;5611.186377975211;5848.239728835267;5914.585978981473;5919.704014799286;5978.611390259619;5987.311459182206;6048.758049678007;6050.485708714765;6056.757729690807;6061.636301821861;6061.818145455643;5437.728113594305;5644.209810626516;5644.463775941238;5651.547876169897;5665.291838520185;5914.76340946366;5935.73289201987;6004.249468816398;6039.365866584033;6087.391260873966;5759.280089988752;5766.654000759968;5776.191333213354;5776.220210271644;5783.421657834267;5676.460736230051;5883.7058147092475;5886.587938844325;5892.852678683067;5895.29256489224;5746.454086861741;5838.065909454467;5857.7949771757785;5886.705664716747;5960.284765828128;5895.233619629421;5972.372900845436;5981.641101533922;5993.160957465958;6046.062860256668;4531.4109165808895;4536.909261814745;4537.909241815145;4538.773061346919;4568.634509239253;3989.8005099744896;4024.8390064397095;4032.890954987402;4060.9796951015055;4086.0806318578084;5730.885382292414;5736.885262294731;5755.165501002331;5775.104858746817;5803.0134877071;6061.909071363933;6063.090536419572;6070.180525628984;6070.362611925772;6074.149619053336;5614.606977511535;5667.914981275284;5698.914516282176;5744.770209191669;5753.194552762617;5154.407243167008;5155.639105262596;5157.922631160535;5199.298094757235;5212.009718153538;6117.938820611737;6198.783042593487;6209.65846878417;6211.627302361872;6223.253209614784;5886.529077673861;5923.111533270044;5956;6033.879322413615;6055.364186760326;6117.296510901303;6152.692365381624;6170.444659980444;6190.50475961913;6197.194364732736;5877.941220587911;5882.705864706833;5884;5893.469587737124;5951.404859514188;5810.331811841524;5818.156367326798;5845.41545845412;5978.8206353809455;5980;5745.569082318926;5747.48272655463;5754.683492407958;5783.624064435799;5799.797007104731;5734.942650573607;5740.167675687086;5743.253377060955;5743.483086522233;5750.108733146369;5607;5625.578081643975;5626.071698169756;5685.090385538294;5685.77256909719;5810.389909059488;5812.157237200498;5829.650220986754;5832.950068987623;5858.882822343615;5689.203511508475;5695.857603559778;5717.828465146053;5719.2279042328755;5719.914201287067 06:07:31 INFO - PROCESS | 19256 | |1;ext.html;543.5930927181574;590.1943846649324;601.4212691684329;610.3621715307505;646.2664875366457;40542.59457405425;44249;44414.11171776566;44561;44655;43779.34330985038;44202.778986105106;44237.557624423745;44397;44462.555374446245;8797.428167169146;8816.735497935073;8875.822483550324;8974.50640214788;9025.548722563879;8984.371094023421;8987.415817971843;9000.324975626821;9064.365494415393;9066.093390660948;9055.456672599632;9131.086891310882;9151.130642588943;9164.175224229817;9195.72412827613;9033.503157326344;9094.86357704635;9139.588718507683;9158.40470369424;9169.128932751379;8901.109889011112;8904.643814247422;8915.73252802417;8932.910670893272;8971.865422018675;41696.583034169875;41845.58154418478;42021.36967945483;42241.57758422438;42331.36502952458;3540.7875527468436;3762.416825392041;3796.6962642988497;4058.040103685579;4072.104785371546;33351.83324083364;33444.83277583597;33696.83151584226;33932.49101263483;34157.31685366303;4377.781110944472;4433.091216300651;4495.617872480843;4535.433070866142;4595.149897269016;228206;230834.9999999983;231144;231860;232333;59996.40003599908;60197.59209631653;60247.69876150679;60439;60477.09284360738;35605;36798.44802327967;36846.815765921;62921.68539157275;63372.68313658402;14018.649533761738;14037.71924561503;14040.438382464587;14056.43774249039;14166.220857852917;10357.274990750726;10379.11777498921;10414.062734353945;10431.37411755297;10462.895371046192;19547.51131221731;19556.94652061513;19845.30541431043;19891.403257902286;19947.700784488243;6989;7053.224145344008;7073.61095139762;7086.291370862872;7502.062242219723;1011.6509804117568;1043.9791204175874;1090.0571006079683;1196.3778835005921;1212.5513559982862;33846;33934.66065339315;34065.91224935448;34280;34577.30845383078;1058.1323314881722;1085.7177133945074;1109.678193323943;1187.8158885372782;1199.6572407883518;17186.828131718772;17352.219150138273;17520.474554115324;17541.47375578709;17585.944843309186;566871;571028;572285;572831;575045;60495.69752151211;60763;61053.38946610566;61335.693321533996;61445.38554614486;1300.5773123734823;1343.9932800335935;1358.6127953533394;1374.587623712882;1384.3562743324403;31569.526457102704;32256.677433225366;32931.67068329286;33274;33587.328253435284;52505;53232.467675322754;53290.20064698955;53481;53483.46516534941;451131;451803;453387;453531;453673;28559.857200713865;29225.56161657534;29338.266543336587;30672.539911901786;30796.23009424782;49393.75303123461;50186.24720629267;50674;51448.74275628598;51727.22409163941;42149.36775948302;42374.576254238294;43339.34990975201;43379.34930976101;44717.329240060775;41395.58604413917;42289.57710422979;42873.78563107289;43660;43683.56316436795;41729.58270417379;42217.36673949955;43261;43296.78351608348;43542.78228608837;36376.63623363733;38502.42246366363;38718.225635487695;39396.6814480053;39527.60472395354;28378;29064;29310.706892930797;29346.559801602565;30670.233244169074 06:07:31 INFO - PROCESS | 19256 | |2;jquery.html;380.42935596605076;387.7227782135772;391.620128475379;396.2570180910792;415.6446238466111;13838.723225535483;18779.812201877976;19347;20333.898330508346;20335.67818091823;19045.7143142853;19258.614827703437;19500.804991950077;19520.804791952076;19695.31066412676;5748.5975981681195;5882.911756323659;5901.144334071557;5921.940780592204;5936.40635936405;5778.768849246025;5790.826275211751;5914.083317085859;5921.8815623687715;5926.288845338566;5735.08238681811;5820.476157145856;5845.152452894327;5867.823965281027;5886.793962211324;5818.359980402152;5850.619709718854;5861.062230043215;5863.677497737623;5881.441263080001;5086.949130508685;5229.11105112128;5237.188235823453;5253.842384728426;5260.842174734764;22714.318570442912;23147.421314467105;23346.299611011527;23445;23718;2137.187868609934;2277.87471689057;2311.3874823171705;2424.5393375258645;2457.3242358351417;10267;10470.16238700902;10631.574737010511;10647;13708.52020179289;1921.1162865082078;1987.6620974434381;2014.8791072535548;2052.7434070741156;2053.5071582820165;78561.21438785596;81879;83424;84084.57957710234;84973;10529;10706.625268115735;10800.841675954656;10958.506867190996;11041;14900.329485173193;14982.775258371134;14995.250237488082;15017.549473515593;15089.396424142911;7293.70825166998;7344.706211751577;7503.137139229058;7534.095908491016;7655.043119610049;6904.654767261617;6956.443484521226;7119.679614417364;7152.964235178895;7388.482806203514;4422.535633758409;4725.1730947084125;4820.493848145964;4853.150698627796;4868.610511159099;1933.729277901095;1939.9612007759765;1955.951101222481;1998.4204580671442;2023.271622216001;993.6820217530321;1005.7385079879137;1020.6529779874878;1024.9641262555774;1046.49768111307;19619;19999.500012499804;20120.19519219244;20157.29449469291;20253.898730506255;1015.2436434855932;1016.2784423059562;1024.861643678094;1027.1936529824052;1036.79782442423;10419.843702344471;10962.342259464458;11202.831957520644;11243.212975091828;11243.60647377338;477048;480542.19457805675;481300;495050;499789;93772.53113734524;95899.52050239705;96308;96866.5156674212;98172.50913745529;979.9804003919882;996.8386829343733;997.2271489595621;1008.4201584089031;1011.2870426349554;16568.420105296256;16752.832471675614;17638.82361176423;17708.203130858885;18002.279908804026;41237.79381103075;41857.372139417326;42114.789426053896;42333.57666423296;42947.78526107349;58567.4143258579;58874;59088;60082.39917600768;61100.08349874844;8168.7957801055445;8279.13069127757;8448.704295349633;8502.74491765248;9020.909790902007;12458.688532786753;13269.469221231042;13346.466141354236;13588.86411135876;13869.237191954539;11843.763124737628;11906;11964;12025.63923082309;12105.878941210827;11497.885021149681;11785.116116291483;11857;11928.642140735792;12080.21478603888;12126.151169418055;12277.386130693609;12289.56986505468;12291.56979505713;12350.258984460961;7369.44729145327;7618.542887426772;7625.542467451971;8126.593670316579;8655.134486551295;8682.956585217285;11225.382603956861;11428.542858285575;11535.480903359537;11581.594644187413 06:07:31 INFO - PROCESS | 19256 | |3;mootools.html;1492.224043497381;1509.019137560586;1665.475375256794;1752.0976697001054;1818.0364406864358;7827.530348179113;8490.490570565771;8690.348223883218;9045.592948317326;9059.592318345674;8819.073997230294;8883.067277935821;8889.777755556115;8912.24245939096;8919.286457083434;2349.2952114365708;2378.1914149189274;2403.4472071423584;2406.2179791567723;2408.337707130536;2364.7517010713887;2367.7040369953756;2421.8546887186735;2429.514097180562;2439.878006099697;2366.95266094678;2384.7376788553247;2389.844660097097;2429.3197904586746;2431.161249368965;2323.337848713117;2339.4619237575284;2357.398863289867;2363.7990770784504;2367.3963139399516;2311.791938725523;2313.6182529882717;2314.409825494488;2337.6960995070704;2366.9289921302216;8833.924027853449;8883.111688831064;8901.287896968292;8933.508657023862;8939.865902011476;5189.455107213764;5199.064168449678;5241.633085684004;5284.445133260991;5289;3276.770626056177;3345.8159801210923;3368.1916340078205;3368.8147151906637;3392.23674673199;1100.4442756408043;1135.267752299762;1142.7543078238136;1159.4144956796847;1178.6640807369945;12097.879021209763;12154.392280385946;12177.51289948401;12238.326892020936;12244.755104897853;4332.545082766327;4547.681662283675;4651.093036857848;4687.484376718558;4696.342512048316;10225.43760093202;10326.535305911251;10346.430946297874;10359.792804143875;10364;5139.049275883974;5149.356330458692;5163.896722065538;5165.276861239429;5170.405403378584;4151.709380343407;4721.858344249678;4769.880752981203;4846.854594362175;4872.9512704873205;3807.638274363931;3923.8822835314986;3969.206158768258;4029.1538776857187;4055.9391609125887;1271.4596296574105;1274.2800317820402;1275.8724127587168;1279.6480967733949;1294.4692676002794;988.1650005745134;995.2386424385351;1014.1886490807325;1018.1294992781213;1019.1031891935198;6106.267247930276;6148.047052706837;6190.81427557174;6219.378062193744;6273;461.21823509151665;472.5912086045546;474.7673639916416;477.4723930057237;1051.4112097225577;4147.605977432139;4322.6325762309925;4385.539518350591;4403.9559604404185;4419.7127186733405;10741.355518668905;11116.444177791078;11133.220674552866;11140.944295278472;11164.60923867677;11011.28426652265;11017.11863050954;11036.172287078502;11037.558497660004;11046.613368532062;7804.297613214724;8097.514149151069;8104.797380065545;8243.752687419386;8415.663373465115;6095.1771510845465;6189;6199.132121503083;6268.182227154074;6348.968255158695;9993.350432221881;10041.648542300984;10208.744781380228;10219.7445063874;10313.845292320771;10390.376577405379;10473.528691209067;10597.576096956343;10604.257701961098;10605.681829545127;7210.2789721027475;7620.31417172435;7749.65126569317;7778.611069446391;7857.646405911862;8722.91277087221;8792.912070879465;8813.867791983253;8821.691240806798;8826.91173088261;7505.211952744883;7661.425393095652;7698.769036928901;7815.882761758465;7984.481008734414;7640.617969101411;7643.350315223268;7692.115406728298;7808.726694565663;7854.72508462201;6968;7178.5692858428665;7181.245969173162;7183.461240406886;7199.460040496879;5184.948150518447;5233.764480598458;5281.9471805281455;5293.602979776455;5488.368837583729;5376.408595054619;5401.783928642967;5434.212039254365;5460.453954604508;5506.760978779743 06:07:31 INFO - PROCESS | 19256 | |4;prototype.html;326.36847699701065;335.34272825262485;339.0726363396111;339.53822800990633;345.58357179598585;5431.447219806684;5553.750081246343;5588.161775733642;5667.206591077247;5713.6000479966415;5550.77796888124;5589.245451863997;5598.272224610805;5620.522255608268;5653.830385088454;4389.934150987738;4402.36165755966;4418.5802348776815;4432.6232270256905;4439.80125366151;4123;4317.2228998780365;4336;4438.578335058164;4442.267025940716;4290.4422425084695;4295.892602684927;4298.828046878121;4303.332983387564;4303.526612072669;4254.680898932593;4278;4290.806913688892;4327.7186982846015;4344.261475549164;3716;3728.539449939354;3789.5831458539537;3793.867214647474;3798.753081049723;5394.6493477924205;5401.812266032263;5409.459054094598;5418.729063546807;5434.266374039533;4934.358533390672;4948.604111671058;4948.901021979576;4960.305557221992;4960.454350021495;5600.327960644708;5725.914111288334;5797;5811.186433899257;5822.563307751893;4108.239975604522;4117.691173161995;4125.66994640428;4136.793160341971;4158.438610787565;6037.516998640098;6077.908831367533;6087.878242435171;6128.601640893327;6157.384261573851;4159.604837540429;4224.5353011168745;4278.55075217104;4281.715485354382;4285.435815927164;4298.9570104298555;4332;4338.392625032498;4343.67422443318;4361.934570981438;4943.72809495474;4978.1288274552535;4985.376827896513;4988.55103040728;5003.49965003504;5797.304323481209;5921.911171332347;5941.286695815115;5946.554008449383;5953.196318497034;1466.9779953300708;1471.6541612721003;1472.3068471257925;1473.506375364265;1475.3287254299269;898.2544488074882;941.712777602824;953.7663272498144;954.4941181173989;957.1577012229194;4975.9847261859;5005.4744251853035;5030.84907452777;5035.471275516018;5071.4532067718965;5279.838435544174;5326.189095707478;5355.143177091647;5371.6239863209985;5447.319085114361;4897.730624815669;5053.84838454847;5061.861081256688;5074.873128171826;5145.588352931756;2825.27955371379;2862.5849251858363;2871.8276903385445;2887.768978481716;2907.9418411632073;5491.117163489121;5563.610547261653;5568.665880047129;5576.888462230814;5591.27313449249;5240.082985477527;5294.470552944752;5458.635341164709;5499.900019995936;5552.333719953632;5523.867607140526;5555.2222688823595;5587.664740115606;5593.552515798727;5599.440055994368;5312.335958005249;5344.412114667306;5397.892042159214;5406.0809662356705;5678.517326027334;6050.245428825591;6082.422169893853;6097.146399503984;6101.7559297627595;6141.324454310112;6266.530010249158;6299.6535190564955;6342.936570634419;6364.93635063662;6387.297397286202;4026.2350153470748;4121.1345617420675;4212.831486740496;4250.958515163805;4270.145970805789;6073.210482637229;6076.179715738319;6095.3904609538695;6104.481119104748;6105.504151482915;5738.684372359393;5791.333996590446;5951.196588460502;5967.224260846062;6001.609895356788;5847.38602446737;5894.145348924468;5924.733386997682;5926.67403292823;5967.194428752063;5822.243108395882;5823.330317013598;5902.6458412495385;5914.970425147847;5921.259842519685;5800.361960184461;5820.214271073351;5941.31674857397;5943.970280148572;5947.732352044082;5754.5684073695475;5811.883762324645;5819.70901454934;5837.562182836389;5858.209141765807 06:07:31 INFO - PROCESS | 19256 | |5;yui.html;684.4866350237322;769.3456083602887;775.976720698379;799.0451410564374;800.4313820550994;15521.379144834207;16687.916560417212;16791.412300569482;16797.916010419947;16826.747598785998;13890.583282501515;13914.51299204528;13942.442302307922;13958.302084895766;14053.367598458068;648.8832010238156;805.7663277649475;824.0605709491185;824.1511243419287;824.3075816314295;795.5226863881683;809.0493669937829;818.6193420059672;823.8105235795771;824.0358780227118;869.0874581689233;869.9608517616722;870.5473153959937;871.3029576338904;873.3231745397304;857.3741168946704;861.7156338408311;863.9395242333039;866.9739907802776;868.5223127280002;626.2829060725444;628.4249911331126;628.5631486117151;628.6196850905228;632.3771085480797;14564.92717536416;14578.198199099046;14659.120452772868;14695;14719.337629806685;15199;15379.615509612237;15384.307706153138;15440.764738820868;15447.691046179014;12575.434105465276;12601.684957876034;12803.359832008362;12818.679533011657;12911.289879056649;3910.7262491625597;3958.188571342868;3982.681385489183;4023.879283621496;4173.39485774564;79481;79568;79920.60039699764;79989;80123.59938200272;11945.462454189583;11958.521659133712;12434.440450179764;12664.556740514037;12734.172278801849;23081.42296442569;23098.19156329554;23172.420689482897;23188.65217021746;23487;8501.829963400698;8627.180417860292;8637.740867773977;8697.086805885418;8829.64681412749;4764.237721964469;4811.206150985118;4852.320675105488;5039.949600504021;5064.139096353629;3499.842507087187;3580.4987301777774;3598.208394153282;3618.9638103619154;3623.07611559056;515.939329187557;623.5853157650112;625.978090766821;628.1802248066226;630.5649102119523;656.4485831901226;691.9204291506542;727.1492353945896;731.2468157797371;740.3632875726871;9185.954070229605;9346.803501177217;10265.178785697126;10516.789664206673;10798.94600527008;707.4658632732358;723.8877973914052;732.5824280160364;757.3411132314922;766.096006712074;4950.232713929347;5056.418511871108;5102.107131252016;5112.488751124858;5126.436092029874;110902.44548777204;111306;113143.43428282806;115899.42050289694;115992.42003789927;97170.51414742881;97783.51108244414;98476;98658;98701;86245.56877215573;89767.55116224378;89852;90011;91396.5430172845;9541.284403669892;9558.56986435598;9559.23526117895;9611.996026615607;9663.178629816544;52243;53326.20010699765;53440.46559534355;53733.73133134309;54719.17921231264;67066.66466667636;70102;70514.64742676253;72390.91413628694;73363.63318183375;13789.862101378858;13868.098573592684;13871.79192312096;13880.236586987812;14353.712925741636;15013.324400401789;15185;15219.239038048274;15960.441384551485;16070.357185712908;14659.780103298672;14933.402663893323;15192.46826361072;15227.086374817547;15541.378344866078;12138.453769580567;13713.588592342247;14050.437982480586;14232.35954382076;14513.129212247299;13255.469781209029;14563.92718036403;14722.337494812973;14852.257387130385;14897.553073407815;11019.559217631526;11641.06871450265;11683.591074312359;11981.64055078349;12749.93625031869;11062.723431914266;11899;12009.339486328336;12286.754264914473;12954.222746635232 06:07:31 INFO - PROCESS | 19256 | __end_tp_report 06:07:31 INFO - PROCESS | 19256 | __start_cc_report 06:07:31 INFO - PROCESS | 19256 | _x_x_mozilla_cycle_collect,352 06:07:31 INFO - PROCESS | 19256 | __end_cc_report 06:07:31 INFO - PROCESS | 19256 | __startTimestamp1469624851431__endTimestamp 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | ------- Summary: start ------- 06:07:31 INFO - PROCESS | 19256 | Number of tests: 6 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | [#0] dojo.html Cycles:165 Average:5521.73 Median:5740.17 stddev:631.23 (11.0%) stddev-sans-first:604.92 06:07:31 INFO - PROCESS | 19256 | Values: 3141.2 3158.1 3175.0 3179.0 3182.2 5383.6 5490.1 5539.1 5551.3 5568.2 5413.1 5473.1 5524.5 5567.9 5572.8 4950.4 4995.2 5025.3 5043.1 5051.5 5057.8 5061.5 5167.8 5171.8 5176.7 5058.8 5077.7 5110.3 5118.5 5141.8 5010.6 5035.6 5037.4 5089.4 5147.3 5030.1 5033.7 5038.4 5054.4 5110.0 5358.7 5554.9 5585.1 5601.3 5611.2 5848.2 5914.6 5919.7 5978.6 5987.3 6048.8 6050.5 6056.8 6061.6 6061.8 5437.7 5644.2 5644.5 5651.5 5665.3 5914.8 5935.7 6004.2 6039.4 6087.4 5759.3 5766.7 5776.2 5776.2 5783.4 5676.5 5883.7 5886.6 5892.9 5895.3 5746.5 5838.1 5857.8 5886.7 5960.3 5895.2 5972.4 5981.6 5993.2 6046.1 4531.4 4536.9 4537.9 4538.8 4568.6 3989.8 4024.8 4032.9 4061.0 4086.1 5730.9 5736.9 5755.2 5775.1 5803.0 6061.9 6063.1 6070.2 6070.4 6074.1 5614.6 5667.9 5698.9 5744.8 5753.2 5154.4 5155.6 5157.9 5199.3 5212.0 6117.9 6198.8 6209.7 6211.6 6223.3 5886.5 5923.1 5956.0 6033.9 6055.4 6117.3 6152.7 6170.4 6190.5 6197.2 5877.9 5882.7 5884.0 5893.5 5951.4 5810.3 5818.2 5845.4 5978.8 5980.0 5745.6 5747.5 5754.7 5783.6 5799.8 5734.9 5740.2 5743.3 5743.5 5750.1 5607.0 5625.6 5626.1 5685.1 5685.8 5810.4 5812.2 5829.7 5833.0 5858.9 5689.2 5695.9 5717.8 5719.2 5719.9 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | [#1] ext.html Cycles:180 Average:58632.73 Median:43067.39 stddev:117664.34 (273.2%) stddev-sans-first:117913.59 06:07:31 INFO - PROCESS | 19256 | Values: 543.6 590.2 601.4 610.4 646.3 40542.6 44249.0 44414.1 44561.0 44655.0 43779.3 44202.8 44237.6 44397.0 44462.6 8797.4 8816.7 8875.8 8974.5 9025.5 8984.4 8987.4 9000.3 9064.4 9066.1 9055.5 9131.1 9151.1 9164.2 9195.7 9033.5 9094.9 9139.6 9158.4 9169.1 8901.1 8904.6 8915.7 8932.9 8971.9 41696.6 41845.6 42021.4 42241.6 42331.4 3540.8 3762.4 3796.7 4058.0 4072.1 33351.8 33444.8 33696.8 33932.5 34157.3 4377.8 4433.1 4495.6 4535.4 4595.1 228206.0 230835.0 231144.0 231860.0 232333.0 59996.4 60197.6 60247.7 60439.0 60477.1 35605.0 36798.4 36846.8 62921.7 63372.7 14018.6 14037.7 14040.4 14056.4 14166.2 10357.3 10379.1 10414.1 10431.4 10462.9 19547.5 19556.9 19845.3 19891.4 19947.7 6989.0 7053.2 7073.6 7086.3 7502.1 1011.7 1044.0 1090.1 1196.4 1212.6 33846.0 33934.7 34065.9 34280.0 34577.3 1058.1 1085.7 1109.7 1187.8 1199.7 17186.8 17352.2 17520.5 17541.5 17585.9 566871.0 571028.0 572285.0 572831.0 575045.0 60495.7 60763.0 61053.4 61335.7 61445.4 1300.6 1344.0 1358.6 1374.6 1384.4 31569.5 32256.7 32931.7 33274.0 33587.3 52505.0 53232.5 53290.2 53481.0 53483.5 451131.0 451803.0 453387.0 453531.0 453673.0 28559.9 29225.6 29338.3 30672.5 30796.2 49393.8 50186.2 50674.0 51448.7 51727.2 42149.4 42374.6 43339.3 43379.3 44717.3 41395.6 42289.6 42873.8 43660.0 43683.6 41729.6 42217.4 43261.0 43296.8 43542.8 36376.6 38502.4 38718.2 39396.7 39527.6 28378.0 29064.0 29310.7 29346.6 30670.2 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | [#2] jquery.html Cycles:180 Average:29111.67 Median:23395.65 stddev:80436.46 (343.8%) stddev-sans-first:80633.18 06:07:31 INFO - PROCESS | 19256 | Values: 380.4 387.7 391.6 396.3 415.6 13838.7 18779.8 19347.0 20333.9 20335.7 19045.7 19258.6 19500.8 19520.8 19695.3 5748.6 5882.9 5901.1 5921.9 5936.4 5778.8 5790.8 5914.1 5921.9 5926.3 5735.1 5820.5 5845.2 5867.8 5886.8 5818.4 5850.6 5861.1 5863.7 5881.4 5086.9 5229.1 5237.2 5253.8 5260.8 22714.3 23147.4 23346.3 23445.0 23718.0 2137.2 2277.9 2311.4 2424.5 2457.3 10267.0 10470.2 10631.6 10647.0 13708.5 1921.1 1987.7 2014.9 2052.7 2053.5 78561.2 81879.0 83424.0 84084.6 84973.0 10529.0 10706.6 10800.8 10958.5 11041.0 14900.3 14982.8 14995.3 15017.5 15089.4 7293.7 7344.7 7503.1 7534.1 7655.0 6904.7 6956.4 7119.7 7153.0 7388.5 4422.5 4725.2 4820.5 4853.2 4868.6 1933.7 1940.0 1956.0 1998.4 2023.3 993.7 1005.7 1020.7 1025.0 1046.5 19619.0 19999.5 20120.2 20157.3 20253.9 1015.2 1016.3 1024.9 1027.2 1036.8 10419.8 10962.3 11202.8 11243.2 11243.6 477048.0 480542.2 481300.0 495050.0 499789.0 93772.5 95899.5 96308.0 96866.5 98172.5 980.0 996.8 997.2 1008.4 1011.3 16568.4 16752.8 17638.8 17708.2 18002.3 41237.8 41857.4 42114.8 42333.6 42947.8 58567.4 58874.0 59088.0 60082.4 61100.1 8168.8 8279.1 8448.7 8502.7 9020.9 12458.7 13269.5 13346.5 13588.9 13869.2 11843.8 11906.0 11964.0 12025.6 12105.9 11497.9 11785.1 11857.0 11928.6 12080.2 12126.2 12277.4 12289.6 12291.6 12350.3 7369.4 7618.5 7625.5 8126.6 8655.1 8683.0 11225.4 11428.5 11535.5 11581.6 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | [#3] mootools.html Cycles:180 Average:5856.72 Median:2504.45 stddev:3326.52 (132.8%) stddev-sans-first:3319.68 06:07:31 INFO - PROCESS | 19256 | Values: 1492.2 1509.0 1665.5 1752.1 1818.0 7827.5 8490.5 8690.3 9045.6 9059.6 8819.1 8883.1 8889.8 8912.2 8919.3 2349.3 2378.2 2403.4 2406.2 2408.3 2364.8 2367.7 2421.9 2429.5 2439.9 2367.0 2384.7 2389.8 2429.3 2431.2 2323.3 2339.5 2357.4 2363.8 2367.4 2311.8 2313.6 2314.4 2337.7 2366.9 8833.9 8883.1 8901.3 8933.5 8939.9 5189.5 5199.1 5241.6 5284.4 5289.0 3276.8 3345.8 3368.2 3368.8 3392.2 1100.4 1135.3 1142.8 1159.4 1178.7 12097.9 12154.4 12177.5 12238.3 12244.8 4332.5 4547.7 4651.1 4687.5 4696.3 10225.4 10326.5 10346.4 10359.8 10364.0 5139.0 5149.4 5163.9 5165.3 5170.4 4151.7 4721.9 4769.9 4846.9 4873.0 3807.6 3923.9 3969.2 4029.2 4055.9 1271.5 1274.3 1275.9 1279.6 1294.5 988.2 995.2 1014.2 1018.1 1019.1 6106.3 6148.0 6190.8 6219.4 6273.0 461.2 472.6 474.8 477.5 1051.4 4147.6 4322.6 4385.5 4404.0 4419.7 10741.4 11116.4 11133.2 11140.9 11164.6 11011.3 11017.1 11036.2 11037.6 11046.6 7804.3 8097.5 8104.8 8243.8 8415.7 6095.2 6189.0 6199.1 6268.2 6349.0 9993.4 10041.6 10208.7 10219.7 10313.8 10390.4 10473.5 10597.6 10604.3 10605.7 7210.3 7620.3 7749.7 7778.6 7857.6 8722.9 8792.9 8813.9 8821.7 8826.9 7505.2 7661.4 7698.8 7815.9 7984.5 7640.6 7643.4 7692.1 7808.7 7854.7 6968.0 7178.6 7181.2 7183.5 7199.5 5184.9 5233.8 5281.9 5293.6 5488.4 5376.4 5401.8 5434.2 5460.5 5506.8 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | [#4] prototype.html Cycles:180 Average:4811.48 Median:5403.95 stddev:1422.09 (26.3%) stddev-sans-first:1385.66 06:07:31 INFO - PROCESS | 19256 | Values: 326.4 335.3 339.1 339.5 345.6 5431.4 5553.8 5588.2 5667.2 5713.6 5550.8 5589.2 5598.3 5620.5 5653.8 4389.9 4402.4 4418.6 4432.6 4439.8 4123.0 4317.2 4336.0 4438.6 4442.3 4290.4 4295.9 4298.8 4303.3 4303.5 4254.7 4278.0 4290.8 4327.7 4344.3 3716.0 3728.5 3789.6 3793.9 3798.8 5394.6 5401.8 5409.5 5418.7 5434.3 4934.4 4948.6 4948.9 4960.3 4960.5 5600.3 5725.9 5797.0 5811.2 5822.6 4108.2 4117.7 4125.7 4136.8 4158.4 6037.5 6077.9 6087.9 6128.6 6157.4 4159.6 4224.5 4278.6 4281.7 4285.4 4299.0 4332.0 4338.4 4343.7 4361.9 4943.7 4978.1 4985.4 4988.6 5003.5 5797.3 5921.9 5941.3 5946.6 5953.2 1467.0 1471.7 1472.3 1473.5 1475.3 898.3 941.7 953.8 954.5 957.2 4976.0 5005.5 5030.8 5035.5 5071.5 5279.8 5326.2 5355.1 5371.6 5447.3 4897.7 5053.8 5061.9 5074.9 5145.6 2825.3 2862.6 2871.8 2887.8 2907.9 5491.1 5563.6 5568.7 5576.9 5591.3 5240.1 5294.5 5458.6 5499.9 5552.3 5523.9 5555.2 5587.7 5593.6 5599.4 5312.3 5344.4 5397.9 5406.1 5678.5 6050.2 6082.4 6097.1 6101.8 6141.3 6266.5 6299.7 6342.9 6364.9 6387.3 4026.2 4121.1 4212.8 4251.0 4270.1 6073.2 6076.2 6095.4 6104.5 6105.5 5738.7 5791.3 5951.2 5967.2 6001.6 5847.4 5894.1 5924.7 5926.7 5967.2 5822.2 5823.3 5902.6 5915.0 5921.3 5800.4 5820.2 5941.3 5944.0 5947.7 5754.6 5811.9 5819.7 5837.6 5858.2 06:07:31 INFO - PROCESS | 19256 | 06:07:31 INFO - PROCESS | 19256 | [#5] yui.html Cycles:180 Average:21196.13 Median:4901.28 stddev:29919.36 (610.4%) stddev-sans-first:29963.65 06:07:31 INFO - PROCESS | 19256 | Values: 684.5 769.3 776.0 799.0 800.4 15521.4 16687.9 16791.4 16797.9 16826.7 13890.6 13914.5 13942.4 13958.3 14053.4 648.9 805.8 824.1 824.2 824.3 795.5 809.0 818.6 823.8 824.0 869.1 870.0 870.5 871.3 873.3 857.4 861.7 863.9 867.0 868.5 626.3 628.4 628.6 628.6 632.4 14564.9 14578.2 14659.1 14695.0 14719.3 15199.0 15379.6 15384.3 15440.8 15447.7 12575.4 12601.7 12803.4 12818.7 12911.3 3910.7 3958.2 3982.7 4023.9 4173.4 79481.0 79568.0 79920.6 79989.0 80123.6 11945.5 11958.5 12434.4 12664.6 12734.2 23081.4 23098.2 23172.4 23188.7 23487.0 8501.8 8627.2 8637.7 8697.1 8829.6 4764.2 4811.2 4852.3 5039.9 5064.1 3499.8 3580.5 3598.2 3619.0 3623.1 515.9 623.6 626.0 628.2 630.6 656.4 691.9 727.1 731.2 740.4 9186.0 9346.8 10265.2 10516.8 10798.9 707.5 723.9 732.6 757.3 766.1 4950.2 5056.4 5102.1 5112.5 5126.4 110902.4 111306.0 113143.4 115899.4 115992.4 97170.5 97783.5 98476.0 98658.0 98701.0 86245.6 89767.6 89852.0 90011.0 91396.5 9541.3 9558.6 9559.2 9612.0 9663.2 52243.0 53326.2 53440.5 53733.7 54719.2 67066.7 70102.0 70514.6 72390.9 73363.6 13789.9 13868.1 13871.8 13880.2 14353.7 15013.3 15185.0 15219.2 15960.4 16070.4 14659.8 14933.4 15192.5 15227.1 15541.4 12138.5 13713.6 14050.4 14232.4 14513.1 13255.5 14563.9 14722.3 14852.3 14897.6 11019.6 11641.1 11683.6 11981.6 12749.9 11062.7 11899.0 12009.3 12286.8 12954.2 06:07:31 INFO - PROCESS | 19256 | -------- Summary: end -------- 06:07:31 INFO - PROCESS | 19256 | 06:07:32 INFO - TEST-INFO | 19256: exit 0 06:07:32 INFO - TEST-OK | dromaeo_css | took 1112909ms 06:07:32 INFO - TEST-START | kraken 06:07:32 INFO - operating with platform_type : linux_ 06:07:32 INFO - Initialising browser for kraken test... 06:07:32 INFO - TEST-INFO | started process 19502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2aPrYI/profile http://localhost:41073/getInfo.html) 06:07:35 INFO - PROCESS | 19502 | JavaScript error: , line 0: uncaught exception: undefined 06:07:37 INFO - PROCESS | 19502 | __metrics Screen width/height:1600/1200 06:07:37 INFO - PROCESS | 19502 | colorDepth:24 06:07:37 INFO - PROCESS | 19502 | Browser inner width/height: 1024/697 06:07:37 INFO - PROCESS | 19502 | __metrics 06:07:38 ERROR - PROCESS | 19502 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:07:38 INFO - TEST-INFO | 19502: exit 0 06:07:38 INFO - Browser initialized. 06:07:38 INFO - Running cycle 1/1 for kraken test... 06:07:39 INFO - TEST-INFO | started process 19621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2aPrYI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:50 INFO - PROCESS | 19621 | RSS: Main: 164466688 06:07:50 INFO - PROCESS | 19621 | 06:07:53 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41073/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:54 INFO - PROCESS | 19621 | RSS: Main: 170070016 06:07:54 INFO - PROCESS | 19621 | 06:07:56 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41073/tests/kraken/driver.html?testName=audio-dft) 06:07:57 INFO - PROCESS | 19621 | RSS: Main: 168919040 06:07:57 INFO - PROCESS | 19621 | 06:08:00 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41073/tests/kraken/driver.html?testName=audio-fft) 06:08:00 INFO - PROCESS | 19621 | RSS: Main: 165269504 06:08:00 INFO - PROCESS | 19621 | 06:08:03 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41073/tests/kraken/driver.html?testName=audio-oscillator) 06:08:03 INFO - PROCESS | 19621 | RSS: Main: 166100992 06:08:03 INFO - PROCESS | 19621 | 06:08:05 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:06 INFO - PROCESS | 19621 | RSS: Main: 166293504 06:08:06 INFO - PROCESS | 19621 | 06:08:09 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41073/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:10 INFO - PROCESS | 19621 | RSS: Main: 165818368 06:08:10 INFO - PROCESS | 19621 | 06:08:13 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41073/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:14 INFO - PROCESS | 19621 | RSS: Main: 167174144 06:08:14 INFO - PROCESS | 19621 | 06:08:17 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41073/tests/kraken/driver.html?testName=json-parse-financial) 06:08:17 INFO - PROCESS | 19621 | RSS: Main: 167333888 06:08:17 INFO - PROCESS | 19621 | 06:08:19 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:19 INFO - PROCESS | 19621 | RSS: Main: 166801408 06:08:19 INFO - PROCESS | 19621 | 06:08:21 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:22 INFO - PROCESS | 19621 | RSS: Main: 167092224 06:08:22 INFO - PROCESS | 19621 | 06:08:24 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:25 INFO - PROCESS | 19621 | RSS: Main: 167493632 06:08:25 INFO - PROCESS | 19621 | 06:08:27 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:28 INFO - PROCESS | 19621 | RSS: Main: 167874560 06:08:28 INFO - PROCESS | 19621 | 06:08:31 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:31 INFO - PROCESS | 19621 | RSS: Main: 168230912 06:08:31 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | Cycle 1(1): loaded http://localhost:41073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41073/tests/kraken/driver.html?testName=ai-astar) 06:08:33 INFO - PROCESS | 19621 | RSS: Main: 168742912 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | __start_tp_report 06:08:33 INFO - PROCESS | 19621 | _x_x_mozilla_page_load 06:08:33 INFO - PROCESS | 19621 | _x_x_mozilla_page_load_details 06:08:33 INFO - PROCESS | 19621 | |i|pagename|runs| 06:08:33 INFO - PROCESS | 19621 | |0;ai-astar;101;112;105;112;111;114;113;113;112;111 06:08:33 INFO - PROCESS | 19621 | |1;audio-beat-detection;156;117;147;188;121;146;148;118;182;118 06:08:33 INFO - PROCESS | 19621 | |2;audio-dft;163;163;166;163;164;164;172;165;164;163 06:08:33 INFO - PROCESS | 19621 | |3;audio-fft;76;75;76;155;77;77;77;75;161;78 06:08:33 INFO - PROCESS | 19621 | |4;audio-oscillator;83;86;143;83;83;84;142;85;85;142 06:08:33 INFO - PROCESS | 19621 | |5;imaging-gaussian-blur;118;118;117;119;117;118;117;118;118;118 06:08:33 INFO - PROCESS | 19621 | |6;imaging-darkroom;147;148;148;147;148;149;148;148;148;148 06:08:33 INFO - PROCESS | 19621 | |7;imaging-desaturate;97;96;96;96;96;97;95;97;96;96 06:08:33 INFO - PROCESS | 19621 | |8;json-parse-financial;53;54;55;53;56;56;55;59;55;54 06:08:33 INFO - PROCESS | 19621 | |9;json-stringify-tinderbox;62;64;63;64;63;63;64;65;63;65 06:08:33 INFO - PROCESS | 19621 | |10;stanford-crypto-aes;76;79;79;78;87;79;83;79;80;77 06:08:33 INFO - PROCESS | 19621 | |11;stanford-crypto-ccm;124;134;129;127;122;132;121;129;162;137 06:08:33 INFO - PROCESS | 19621 | |12;stanford-crypto-pbkdf2;158;158;164;159;162;160;163;160;172;157 06:08:33 INFO - PROCESS | 19621 | |13;stanford-crypto-sha256-iterative;68;64;65;68;67;65;63;64;65;63 06:08:33 INFO - PROCESS | 19621 | __end_tp_report 06:08:33 INFO - PROCESS | 19621 | __start_cc_report 06:08:33 INFO - PROCESS | 19621 | _x_x_mozilla_cycle_collect,887 06:08:33 INFO - PROCESS | 19621 | __end_cc_report 06:08:33 INFO - PROCESS | 19621 | __startTimestamp1469624913614__endTimestamp 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | ------- Summary: start ------- 06:08:33 INFO - PROCESS | 19621 | Number of tests: 14 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:2.60 06:08:33 INFO - PROCESS | 19621 | Values: 101.0 112.0 105.0 112.0 111.0 114.0 113.0 113.0 112.0 111.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:147.50 stddev:26.17 (17.7%) stddev-sans-first:27.40 06:08:33 INFO - PROCESS | 19621 | Values: 156.0 117.0 147.0 188.0 121.0 146.0 148.0 118.0 182.0 118.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.75 (1.7%) stddev-sans-first:2.85 06:08:33 INFO - PROCESS | 19621 | Values: 163.0 163.0 166.0 163.0 164.0 164.0 172.0 165.0 164.0 163.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.50 stddev:34.46 (45.0%) stddev-sans-first:36.01 06:08:33 INFO - PROCESS | 19621 | Values: 76.0 75.0 76.0 155.0 77.0 77.0 77.0 75.0 161.0 78.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:83.50 stddev:28.13 (33.7%) stddev-sans-first:29.02 06:08:33 INFO - PROCESS | 19621 | Values: 83.0 86.0 143.0 83.0 83.0 84.0 142.0 85.0 85.0 142.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:08:33 INFO - PROCESS | 19621 | Values: 118.0 118.0 117.0 119.0 117.0 118.0 117.0 118.0 118.0 118.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 06:08:33 INFO - PROCESS | 19621 | Values: 147.0 148.0 148.0 147.0 148.0 149.0 148.0 148.0 148.0 148.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:08:33 INFO - PROCESS | 19621 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 95.0 97.0 96.0 96.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.76 (3.2%) stddev-sans-first:1.72 06:08:33 INFO - PROCESS | 19621 | Values: 53.0 54.0 55.0 53.0 56.0 56.0 55.0 59.0 55.0 54.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 06:08:33 INFO - PROCESS | 19621 | Values: 62.0 64.0 63.0 64.0 63.0 63.0 64.0 65.0 63.0 65.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:3.16 (4.0%) stddev-sans-first:3.06 06:08:33 INFO - PROCESS | 19621 | Values: 76.0 79.0 79.0 78.0 87.0 79.0 83.0 79.0 80.0 77.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:130.50 stddev:11.81 (9.1%) stddev-sans-first:12.20 06:08:33 INFO - PROCESS | 19621 | Values: 124.0 134.0 129.0 127.0 122.0 132.0 121.0 129.0 162.0 137.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:4.40 (2.7%) stddev-sans-first:4.50 06:08:33 INFO - PROCESS | 19621 | Values: 158.0 158.0 164.0 159.0 162.0 160.0 163.0 160.0 172.0 157.0 06:08:33 INFO - PROCESS | 19621 | 06:08:33 INFO - PROCESS | 19621 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.87 (2.9%) stddev-sans-first:1.69 06:08:33 INFO - PROCESS | 19621 | Values: 68.0 64.0 65.0 68.0 67.0 65.0 63.0 64.0 65.0 63.0 06:08:33 INFO - PROCESS | 19621 | -------- Summary: end -------- 06:08:33 INFO - PROCESS | 19621 | 06:08:34 INFO - TEST-INFO | 19621: exit 0 06:08:34 INFO - TEST-OK | kraken | took 62469ms 06:08:34 INFO - SUITE-END | took 1175s 06:08:34 INFO - Completed test suite (00:19:35) 06:08:34 INFO - javascript benchmark 06:08:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7368.061223832002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.2461009357753, 3158.1473002289395, 3174.9998750393625, 3179.0303957293045, 3182.2362632968093, 5383.569314454844, 5490.094134467813, 5539.058360078786, 5551.306086739158, 5568.1647752837, 5413.133898576229, 5473.06957817171, 5524.475174858392, 5567.8886422271535, 5572.832815015546, 4950.356453661028, 4995.150824359867, 5025.321581586494, 5043.117454445476, 5051.5453609175165, 5057.822976195834, 5061.493850614946, 5167.844964651048, 5171.793128274864, 5176.741162941857, 5058.822941197041, 5077.746112694351, 5110.28456016158, 5118.513741194581, 5141.845744627667, 5010.574101201402, 5035.622328325354, 5037.395512538482, 5089.389273287192, 5147.279380886679, 5030.094582975063, 5033.697978121288, 5038.370203724535, 5054.444011158769, 5110.029094472038, 5358.678479291255, 5554.888902221974, 5585.078462053756, 5601.327840659147, 5611.186377975211, 5848.239728835267, 5914.585978981473, 5919.704014799286, 5978.611390259619, 5987.311459182206, 6048.758049678007, 6050.485708714765, 6056.757729690807, 6061.636301821861, 6061.818145455643, 5437.728113594305, 5644.209810626516, 5644.463775941238, 5651.547876169897, 5665.291838520185, 5914.76340946366, 5935.73289201987, 6004.249468816398, 6039.365866584033, 6087.391260873966, 5759.280089988752, 5766.654000759968, 5776.191333213354, 5776.220210271644, 5783.421657834267, 5676.460736230051, 5883.7058147092475, 5886.587938844325, 5892.852678683067, 5895.29256489224, 5746.454086861741, 5838.065909454467, 5857.7949771757785, 5886.705664716747, 5960.284765828128, 5895.233619629421, 5972.372900845436, 5981.641101533922, 5993.160957465958, 6046.062860256668, 4531.4109165808895, 4536.909261814745, 4537.909241815145, 4538.773061346919, 4568.634509239253, 3989.8005099744896, 4024.8390064397095, 4032.890954987402, 4060.9796951015055, 4086.0806318578084, 5730.885382292414, 5736.885262294731, 5755.165501002331, 5775.104858746817, 5803.0134877071, 6061.909071363933, 6063.090536419572, 6070.180525628984, 6070.362611925772, 6074.149619053336, 5614.606977511535, 5667.914981275284, 5698.914516282176, 5744.770209191669, 5753.194552762617, 5154.407243167008, 5155.639105262596, 5157.922631160535, 5199.298094757235, 5212.009718153538, 6117.938820611737, 6198.783042593487, 6209.65846878417, 6211.627302361872, 6223.253209614784, 5886.529077673861, 5923.111533270044, 5956.0, 6033.879322413615, 6055.364186760326, 6117.296510901303, 6152.692365381624, 6170.444659980444, 6190.50475961913, 6197.194364732736, 5877.941220587911, 5882.705864706833, 5884.0, 5893.469587737124, 5951.404859514188, 5810.331811841524, 5818.156367326798, 5845.41545845412, 5978.8206353809455, 5980.0, 5745.569082318926, 5747.48272655463, 5754.683492407958, 5783.624064435799, 5799.797007104731, 5734.942650573607, 5740.167675687086, 5743.253377060955, 5743.483086522233, 5750.108733146369, 5607.0, 5625.578081643975, 5626.071698169756, 5685.090385538294, 5685.77256909719, 5810.389909059488, 5812.157237200498, 5829.650220986754, 5832.950068987623, 5858.882822343615, 5689.203511508475, 5695.857603559778, 5717.828465146053, 5719.2279042328755, 5719.914201287067], "value": 5478.38205535359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.5930927181574, 590.1943846649324, 601.4212691684329, 610.3621715307505, 646.2664875366457, 40542.59457405425, 44249.0, 44414.11171776566, 44561.0, 44655.0, 43779.34330985038, 44202.778986105106, 44237.557624423745, 44397.0, 44462.555374446245, 8797.428167169146, 8816.735497935073, 8875.822483550324, 8974.50640214788, 9025.548722563879, 8984.371094023421, 8987.415817971843, 9000.324975626821, 9064.365494415393, 9066.093390660948, 9055.456672599632, 9131.086891310882, 9151.130642588943, 9164.175224229817, 9195.72412827613, 9033.503157326344, 9094.86357704635, 9139.588718507683, 9158.40470369424, 9169.128932751379, 8901.109889011112, 8904.643814247422, 8915.73252802417, 8932.910670893272, 8971.865422018675, 41696.583034169875, 41845.58154418478, 42021.36967945483, 42241.57758422438, 42331.36502952458, 3540.7875527468436, 3762.416825392041, 3796.6962642988497, 4058.040103685579, 4072.104785371546, 33351.83324083364, 33444.83277583597, 33696.83151584226, 33932.49101263483, 34157.31685366303, 4377.781110944472, 4433.091216300651, 4495.617872480843, 4535.433070866142, 4595.149897269016, 228206.0, 230834.9999999983, 231144.0, 231860.0, 232333.0, 59996.40003599908, 60197.59209631653, 60247.69876150679, 60439.0, 60477.09284360738, 35605.0, 36798.44802327967, 36846.815765921, 62921.68539157275, 63372.68313658402, 14018.649533761738, 14037.71924561503, 14040.438382464587, 14056.43774249039, 14166.220857852917, 10357.274990750726, 10379.11777498921, 10414.062734353945, 10431.37411755297, 10462.895371046192, 19547.51131221731, 19556.94652061513, 19845.30541431043, 19891.403257902286, 19947.700784488243, 6989.0, 7053.224145344008, 7073.61095139762, 7086.291370862872, 7502.062242219723, 1011.6509804117568, 1043.9791204175874, 1090.0571006079683, 1196.3778835005921, 1212.5513559982862, 33846.0, 33934.66065339315, 34065.91224935448, 34280.0, 34577.30845383078, 1058.1323314881722, 1085.7177133945074, 1109.678193323943, 1187.8158885372782, 1199.6572407883518, 17186.828131718772, 17352.219150138273, 17520.474554115324, 17541.47375578709, 17585.944843309186, 566871.0, 571028.0, 572285.0, 572831.0, 575045.0, 60495.69752151211, 60763.0, 61053.38946610566, 61335.693321533996, 61445.38554614486, 1300.5773123734823, 1343.9932800335935, 1358.6127953533394, 1374.587623712882, 1384.3562743324403, 31569.526457102704, 32256.677433225366, 32931.67068329286, 33274.0, 33587.328253435284, 52505.0, 53232.467675322754, 53290.20064698955, 53481.0, 53483.46516534941, 451131.0, 451803.0, 453387.0, 453531.0, 453673.0, 28559.857200713865, 29225.56161657534, 29338.266543336587, 30672.539911901786, 30796.23009424782, 49393.75303123461, 50186.24720629267, 50674.0, 51448.74275628598, 51727.22409163941, 42149.36775948302, 42374.576254238294, 43339.34990975201, 43379.34930976101, 44717.329240060775, 41395.58604413917, 42289.57710422979, 42873.78563107289, 43660.0, 43683.56316436795, 41729.58270417379, 42217.36673949955, 43261.0, 43296.78351608348, 43542.78228608837, 36376.63623363733, 38502.42246366363, 38718.225635487695, 39396.6814480053, 39527.60472395354, 28378.0, 29064.0, 29310.706892930797, 29346.559801602565, 30670.233244169074], "value": 20123.19049424305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.42935596605076, 387.7227782135772, 391.620128475379, 396.2570180910792, 415.6446238466111, 13838.723225535483, 18779.812201877976, 19347.0, 20333.898330508346, 20335.67818091823, 19045.7143142853, 19258.614827703437, 19500.804991950077, 19520.804791952076, 19695.31066412676, 5748.5975981681195, 5882.911756323659, 5901.144334071557, 5921.940780592204, 5936.40635936405, 5778.768849246025, 5790.826275211751, 5914.083317085859, 5921.8815623687715, 5926.288845338566, 5735.08238681811, 5820.476157145856, 5845.152452894327, 5867.823965281027, 5886.793962211324, 5818.359980402152, 5850.619709718854, 5861.062230043215, 5863.677497737623, 5881.441263080001, 5086.949130508685, 5229.11105112128, 5237.188235823453, 5253.842384728426, 5260.842174734764, 22714.318570442912, 23147.421314467105, 23346.299611011527, 23445.0, 23718.0, 2137.187868609934, 2277.87471689057, 2311.3874823171705, 2424.5393375258645, 2457.3242358351417, 10267.0, 10470.16238700902, 10631.574737010511, 10647.0, 13708.52020179289, 1921.1162865082078, 1987.6620974434381, 2014.8791072535548, 2052.7434070741156, 2053.5071582820165, 78561.21438785596, 81879.0, 83424.0, 84084.57957710234, 84973.0, 10529.0, 10706.625268115735, 10800.841675954656, 10958.506867190996, 11041.0, 14900.329485173193, 14982.775258371134, 14995.250237488082, 15017.549473515593, 15089.396424142911, 7293.70825166998, 7344.706211751577, 7503.137139229058, 7534.095908491016, 7655.043119610049, 6904.654767261617, 6956.443484521226, 7119.679614417364, 7152.964235178895, 7388.482806203514, 4422.535633758409, 4725.1730947084125, 4820.493848145964, 4853.150698627796, 4868.610511159099, 1933.729277901095, 1939.9612007759765, 1955.951101222481, 1998.4204580671442, 2023.271622216001, 993.6820217530321, 1005.7385079879137, 1020.6529779874878, 1024.9641262555774, 1046.49768111307, 19619.0, 19999.500012499804, 20120.19519219244, 20157.29449469291, 20253.898730506255, 1015.2436434855932, 1016.2784423059562, 1024.861643678094, 1027.1936529824052, 1036.79782442423, 10419.843702344471, 10962.342259464458, 11202.831957520644, 11243.212975091828, 11243.60647377338, 477048.0, 480542.19457805675, 481300.0, 495050.0, 499789.0, 93772.53113734524, 95899.52050239705, 96308.0, 96866.5156674212, 98172.50913745529, 979.9804003919882, 996.8386829343733, 997.2271489595621, 1008.4201584089031, 1011.2870426349554, 16568.420105296256, 16752.832471675614, 17638.82361176423, 17708.203130858885, 18002.279908804026, 41237.79381103075, 41857.372139417326, 42114.789426053896, 42333.57666423296, 42947.78526107349, 58567.4143258579, 58874.0, 59088.0, 60082.39917600768, 61100.08349874844, 8168.7957801055445, 8279.13069127757, 8448.704295349633, 8502.74491765248, 9020.909790902007, 12458.688532786753, 13269.469221231042, 13346.466141354236, 13588.86411135876, 13869.237191954539, 11843.763124737628, 11906.0, 11964.0, 12025.63923082309, 12105.878941210827, 11497.885021149681, 11785.116116291483, 11857.0, 11928.642140735792, 12080.21478603888, 12126.151169418055, 12277.386130693609, 12289.56986505468, 12291.56979505713, 12350.258984460961, 7369.44729145327, 7618.542887426772, 7625.542467451971, 8126.593670316579, 8655.134486551295, 8682.956585217285, 11225.382603956861, 11428.542858285575, 11535.480903359537, 11581.594644187413], "value": 9226.47122607781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.224043497381, 1509.019137560586, 1665.475375256794, 1752.0976697001054, 1818.0364406864358, 7827.530348179113, 8490.490570565771, 8690.348223883218, 9045.592948317326, 9059.592318345674, 8819.073997230294, 8883.067277935821, 8889.777755556115, 8912.24245939096, 8919.286457083434, 2349.2952114365708, 2378.1914149189274, 2403.4472071423584, 2406.2179791567723, 2408.337707130536, 2364.7517010713887, 2367.7040369953756, 2421.8546887186735, 2429.514097180562, 2439.878006099697, 2366.95266094678, 2384.7376788553247, 2389.844660097097, 2429.3197904586746, 2431.161249368965, 2323.337848713117, 2339.4619237575284, 2357.398863289867, 2363.7990770784504, 2367.3963139399516, 2311.791938725523, 2313.6182529882717, 2314.409825494488, 2337.6960995070704, 2366.9289921302216, 8833.924027853449, 8883.111688831064, 8901.287896968292, 8933.508657023862, 8939.865902011476, 5189.455107213764, 5199.064168449678, 5241.633085684004, 5284.445133260991, 5289.0, 3276.770626056177, 3345.8159801210923, 3368.1916340078205, 3368.8147151906637, 3392.23674673199, 1100.4442756408043, 1135.267752299762, 1142.7543078238136, 1159.4144956796847, 1178.6640807369945, 12097.879021209763, 12154.392280385946, 12177.51289948401, 12238.326892020936, 12244.755104897853, 4332.545082766327, 4547.681662283675, 4651.093036857848, 4687.484376718558, 4696.342512048316, 10225.43760093202, 10326.535305911251, 10346.430946297874, 10359.792804143875, 10364.0, 5139.049275883974, 5149.356330458692, 5163.896722065538, 5165.276861239429, 5170.405403378584, 4151.709380343407, 4721.858344249678, 4769.880752981203, 4846.854594362175, 4872.9512704873205, 3807.638274363931, 3923.8822835314986, 3969.206158768258, 4029.1538776857187, 4055.9391609125887, 1271.4596296574105, 1274.2800317820402, 1275.8724127587168, 1279.6480967733949, 1294.4692676002794, 988.1650005745134, 995.2386424385351, 1014.1886490807325, 1018.1294992781213, 1019.1031891935198, 6106.267247930276, 6148.047052706837, 6190.81427557174, 6219.378062193744, 6273.0, 461.21823509151665, 472.5912086045546, 474.7673639916416, 477.4723930057237, 1051.4112097225577, 4147.605977432139, 4322.6325762309925, 4385.539518350591, 4403.9559604404185, 4419.7127186733405, 10741.355518668905, 11116.444177791078, 11133.220674552866, 11140.944295278472, 11164.60923867677, 11011.28426652265, 11017.11863050954, 11036.172287078502, 11037.558497660004, 11046.613368532062, 7804.297613214724, 8097.514149151069, 8104.797380065545, 8243.752687419386, 8415.663373465115, 6095.1771510845465, 6189.0, 6199.132121503083, 6268.182227154074, 6348.968255158695, 9993.350432221881, 10041.648542300984, 10208.744781380228, 10219.7445063874, 10313.845292320771, 10390.376577405379, 10473.528691209067, 10597.576096956343, 10604.257701961098, 10605.681829545127, 7210.2789721027475, 7620.31417172435, 7749.65126569317, 7778.611069446391, 7857.646405911862, 8722.91277087221, 8792.912070879465, 8813.867791983253, 8821.691240806798, 8826.91173088261, 7505.211952744883, 7661.425393095652, 7698.769036928901, 7815.882761758465, 7984.481008734414, 7640.617969101411, 7643.350315223268, 7692.115406728298, 7808.726694565663, 7854.72508462201, 6968.0, 7178.5692858428665, 7181.245969173162, 7183.461240406886, 7199.460040496879, 5184.948150518447, 5233.764480598458, 5281.9471805281455, 5293.602979776455, 5488.368837583729, 5376.408595054619, 5401.783928642967, 5434.212039254365, 5460.453954604508, 5506.760978779743], "value": 4646.5519074812055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.36847699701065, 335.34272825262485, 339.0726363396111, 339.53822800990633, 345.58357179598585, 5431.447219806684, 5553.750081246343, 5588.161775733642, 5667.206591077247, 5713.6000479966415, 5550.77796888124, 5589.245451863997, 5598.272224610805, 5620.522255608268, 5653.830385088454, 4389.934150987738, 4402.36165755966, 4418.5802348776815, 4432.6232270256905, 4439.80125366151, 4123.0, 4317.2228998780365, 4336.0, 4438.578335058164, 4442.267025940716, 4290.4422425084695, 4295.892602684927, 4298.828046878121, 4303.332983387564, 4303.526612072669, 4254.680898932593, 4278.0, 4290.806913688892, 4327.7186982846015, 4344.261475549164, 3716.0, 3728.539449939354, 3789.5831458539537, 3793.867214647474, 3798.753081049723, 5394.6493477924205, 5401.812266032263, 5409.459054094598, 5418.729063546807, 5434.266374039533, 4934.358533390672, 4948.604111671058, 4948.901021979576, 4960.305557221992, 4960.454350021495, 5600.327960644708, 5725.914111288334, 5797.0, 5811.186433899257, 5822.563307751893, 4108.239975604522, 4117.691173161995, 4125.66994640428, 4136.793160341971, 4158.438610787565, 6037.516998640098, 6077.908831367533, 6087.878242435171, 6128.601640893327, 6157.384261573851, 4159.604837540429, 4224.5353011168745, 4278.55075217104, 4281.715485354382, 4285.435815927164, 4298.9570104298555, 4332.0, 4338.392625032498, 4343.67422443318, 4361.934570981438, 4943.72809495474, 4978.1288274552535, 4985.376827896513, 4988.55103040728, 5003.49965003504, 5797.304323481209, 5921.911171332347, 5941.286695815115, 5946.554008449383, 5953.196318497034, 1466.9779953300708, 1471.6541612721003, 1472.3068471257925, 1473.506375364265, 1475.3287254299269, 898.2544488074882, 941.712777602824, 953.7663272498144, 954.4941181173989, 957.1577012229194, 4975.9847261859, 5005.4744251853035, 5030.84907452777, 5035.471275516018, 5071.4532067718965, 5279.838435544174, 5326.189095707478, 5355.143177091647, 5371.6239863209985, 5447.319085114361, 4897.730624815669, 5053.84838454847, 5061.861081256688, 5074.873128171826, 5145.588352931756, 2825.27955371379, 2862.5849251858363, 2871.8276903385445, 2887.768978481716, 2907.9418411632073, 5491.117163489121, 5563.610547261653, 5568.665880047129, 5576.888462230814, 5591.27313449249, 5240.082985477527, 5294.470552944752, 5458.635341164709, 5499.900019995936, 5552.333719953632, 5523.867607140526, 5555.2222688823595, 5587.664740115606, 5593.552515798727, 5599.440055994368, 5312.335958005249, 5344.412114667306, 5397.892042159214, 5406.0809662356705, 5678.517326027334, 6050.245428825591, 6082.422169893853, 6097.146399503984, 6101.7559297627595, 6141.324454310112, 6266.530010249158, 6299.6535190564955, 6342.936570634419, 6364.93635063662, 6387.297397286202, 4026.2350153470748, 4121.1345617420675, 4212.831486740496, 4250.958515163805, 4270.145970805789, 6073.210482637229, 6076.179715738319, 6095.3904609538695, 6104.481119104748, 6105.504151482915, 5738.684372359393, 5791.333996590446, 5951.196588460502, 5967.224260846062, 6001.609895356788, 5847.38602446737, 5894.145348924468, 5924.733386997682, 5926.67403292823, 5967.194428752063, 5822.243108395882, 5823.330317013598, 5902.6458412495385, 5914.970425147847, 5921.259842519685, 5800.361960184461, 5820.214271073351, 5941.31674857397, 5943.970280148572, 5947.732352044082, 5754.5684073695475, 5811.883762324645, 5819.70901454934, 5837.562182836389, 5858.209141765807], "value": 4354.2697601831815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4866350237322, 769.3456083602887, 775.976720698379, 799.0451410564374, 800.4313820550994, 15521.379144834207, 16687.916560417212, 16791.412300569482, 16797.916010419947, 16826.747598785998, 13890.583282501515, 13914.51299204528, 13942.442302307922, 13958.302084895766, 14053.367598458068, 648.8832010238156, 805.7663277649475, 824.0605709491185, 824.1511243419287, 824.3075816314295, 795.5226863881683, 809.0493669937829, 818.6193420059672, 823.8105235795771, 824.0358780227118, 869.0874581689233, 869.9608517616722, 870.5473153959937, 871.3029576338904, 873.3231745397304, 857.3741168946704, 861.7156338408311, 863.9395242333039, 866.9739907802776, 868.5223127280002, 626.2829060725444, 628.4249911331126, 628.5631486117151, 628.6196850905228, 632.3771085480797, 14564.92717536416, 14578.198199099046, 14659.120452772868, 14695.0, 14719.337629806685, 15199.0, 15379.615509612237, 15384.307706153138, 15440.764738820868, 15447.691046179014, 12575.434105465276, 12601.684957876034, 12803.359832008362, 12818.679533011657, 12911.289879056649, 3910.7262491625597, 3958.188571342868, 3982.681385489183, 4023.879283621496, 4173.39485774564, 79481.0, 79568.0, 79920.60039699764, 79989.0, 80123.59938200272, 11945.462454189583, 11958.521659133712, 12434.440450179764, 12664.556740514037, 12734.172278801849, 23081.42296442569, 23098.19156329554, 23172.420689482897, 23188.65217021746, 23487.0, 8501.829963400698, 8627.180417860292, 8637.740867773977, 8697.086805885418, 8829.64681412749, 4764.237721964469, 4811.206150985118, 4852.320675105488, 5039.949600504021, 5064.139096353629, 3499.842507087187, 3580.4987301777774, 3598.208394153282, 3618.9638103619154, 3623.07611559056, 515.939329187557, 623.5853157650112, 625.978090766821, 628.1802248066226, 630.5649102119523, 656.4485831901226, 691.9204291506542, 727.1492353945896, 731.2468157797371, 740.3632875726871, 9185.954070229605, 9346.803501177217, 10265.178785697126, 10516.789664206673, 10798.94600527008, 707.4658632732358, 723.8877973914052, 732.5824280160364, 757.3411132314922, 766.096006712074, 4950.232713929347, 5056.418511871108, 5102.107131252016, 5112.488751124858, 5126.436092029874, 110902.44548777204, 111306.0, 113143.43428282806, 115899.42050289694, 115992.42003789927, 97170.51414742881, 97783.51108244414, 98476.0, 98658.0, 98701.0, 86245.56877215573, 89767.55116224378, 89852.0, 90011.0, 91396.5430172845, 9541.284403669892, 9558.56986435598, 9559.23526117895, 9611.996026615607, 9663.178629816544, 52243.0, 53326.20010699765, 53440.46559534355, 53733.73133134309, 54719.17921231264, 67066.66466667636, 70102.0, 70514.64742676253, 72390.91413628694, 73363.63318183375, 13789.862101378858, 13868.098573592684, 13871.79192312096, 13880.236586987812, 14353.712925741636, 15013.324400401789, 15185.0, 15219.239038048274, 15960.441384551485, 16070.357185712908, 14659.780103298672, 14933.402663893323, 15192.46826361072, 15227.086374817547, 15541.378344866078, 12138.453769580567, 13713.588592342247, 14050.437982480586, 14232.35954382076, 14513.129212247299, 13255.469781209029, 14563.92718036403, 14722.337494812973, 14852.257387130385, 14897.553073407815, 11019.559217631526, 11641.06871450265, 11683.591074312359, 11981.64055078349, 12749.93625031869, 11062.723431914266, 11899.0, 12009.339486328336, 12286.754264914473, 12954.222746635232], "value": 7774.01037581353, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 105.0, 112.0, 111.0, 114.0, 113.0, 113.0, 112.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 117.0, 147.0, 188.0, 121.0, 146.0, 148.0, 118.0, 182.0, 118.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 163.0, 164.0, 164.0, 172.0, 165.0, 164.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 155.0, 77.0, 77.0, 77.0, 75.0, 161.0, 78.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 143.0, 83.0, 83.0, 84.0, 142.0, 85.0, 85.0, 142.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 53.0, 56.0, 56.0, 55.0, 59.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 65.0, 63.0, 65.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 79.0, 78.0, 87.0, 79.0, 83.0, 79.0, 80.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 134.0, 129.0, 127.0, 122.0, 132.0, 121.0, 129.0, 162.0, 137.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 164.0, 159.0, 162.0, 160.0, 163.0, 160.0, 172.0, 157.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 65.0, 68.0, 67.0, 65.0, 63.0, 64.0, 65.0, 63.0], "value": 65.2, "unit": "score"}]}]} 06:08:34 INFO - Return code: 0 06:08:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:34 ERROR - # TBPL SUCCESS # 06:08:34 INFO - Running post-action listener: _resource_record_post_action 06:08:34 INFO - [mozharness: 2016-07-27 13:08:34.928376Z] Finished run-tests step (success) 06:08:34 INFO - Running post-run listener: _resource_record_post_run 06:08:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 414318592; Read time: 0; Write time: 858116 06:08:35 INFO - TinderboxPrint: CPU usage
13.4% 06:08:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:08:35 INFO - TinderboxPrint: I/O write bytes / time
414,318,592 / 858,116 06:08:35 INFO - TinderboxPrint: CPU idle
8,238.4 (86.5%) 06:08:35 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 06:08:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:08:35 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 119394304; Read time: 0; Write time: 283788 06:08:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294924288; Read time: 0; Write time: 574328 06:08:35 INFO - Running post-run listener: _upload_blobber_files 06:08:35 INFO - Blob upload gear active. 06:08:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:35 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:08:35 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:08:35 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:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:47 INFO - (blobuploader) - INFO - Done attempting. 06:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:48 INFO - (blobuploader) - INFO - Done attempting. 06:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:08:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:48 INFO - (blobuploader) - INFO - Done attempting. 06:08:48 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:48 INFO - Return code: 0 06:08:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5c6b4e9dadfa6863fa9654e85504472c9c3634f92d1c0df67798443f993021fec5b84d2e045fc47ea7cdc440db987df1643961ee4a4095fe762d764f3df8807", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbe25417b142432145a95ec19211d94ddf7b34b9709243fa9cf6726c7636d16adab83335647f2f627d2d8ab1560527c4769bbdaeacd5f76d7f968d703e40668a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ba394e61a58261830fc49786923d96ee6393c947de9a9c2f01aaa09823e150dcd1293dd766597043377bcf5dea458222ac5c6db6ab19561c8fe8b00e8f18cca"} 06:08:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:48 INFO - Contents: 06:08:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5c6b4e9dadfa6863fa9654e85504472c9c3634f92d1c0df67798443f993021fec5b84d2e045fc47ea7cdc440db987df1643961ee4a4095fe762d764f3df8807", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbe25417b142432145a95ec19211d94ddf7b34b9709243fa9cf6726c7636d16adab83335647f2f627d2d8ab1560527c4769bbdaeacd5f76d7f968d703e40668a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ba394e61a58261830fc49786923d96ee6393c947de9a9c2f01aaa09823e150dcd1293dd766597043377bcf5dea458222ac5c6db6ab19561c8fe8b00e8f18cca"} 06:08:48 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:48 INFO - Copying logs to upload dir... 06:08:48 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.407407 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-27 06:08:48.797052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 06:08:48.801178) ========= 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=745a4373a2a16df560f216e000000264-1469623402.652399-1316382342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5c6b4e9dadfa6863fa9654e85504472c9c3634f92d1c0df67798443f993021fec5b84d2e045fc47ea7cdc440db987df1643961ee4a4095fe762d764f3df8807", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbe25417b142432145a95ec19211d94ddf7b34b9709243fa9cf6726c7636d16adab83335647f2f627d2d8ab1560527c4769bbdaeacd5f76d7f968d703e40668a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ba394e61a58261830fc49786923d96ee6393c947de9a9c2f01aaa09823e150dcd1293dd766597043377bcf5dea458222ac5c6db6ab19561c8fe8b00e8f18cca"} build_url:https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/M8w7e4OtSQmr-6yYjysGAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5c6b4e9dadfa6863fa9654e85504472c9c3634f92d1c0df67798443f993021fec5b84d2e045fc47ea7cdc440db987df1643961ee4a4095fe762d764f3df8807", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbe25417b142432145a95ec19211d94ddf7b34b9709243fa9cf6726c7636d16adab83335647f2f627d2d8ab1560527c4769bbdaeacd5f76d7f968d703e40668a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ba394e61a58261830fc49786923d96ee6393c947de9a9c2f01aaa09823e150dcd1293dd766597043377bcf5dea458222ac5c6db6ab19561c8fe8b00e8f18cca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 06:08:48.831546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 06:08:48.831924) ========= 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=745a4373a2a16df560f216e000000264-1469623402.652399-1316382342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 06:08:48.917033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 06:08:48.917596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 06:08:48.918373) ========= ========= Total master_lag: 0.20 =========