builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1469637095.95 results: success (0) buildid: 20160727074713 builduid: 3c4f771bcdf74039981dcadefcceab42 revision: 6b54e59980fb1cad35f72c88a729f4199b8402b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:35.947448) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:35.947934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:35.948216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:35.965300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:35.965710) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 09:31:36-- 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% 225M=0s 2016-07-27 09:31:36 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070708 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:36.050929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:36.051285) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:36.101109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 09:31:36.101470) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6b54e59980fb1cad35f72c88a729f4199b8402b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6b54e59980fb1cad35f72c88a729f4199b8402b8 --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=8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 09:31:36,346 truncating revision to first 12 chars 2016-07-27 09:31:36,346 Setting DEBUG logging. 2016-07-27 09:31:36,346 attempt 1/10 2016-07-27 09:31:36,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6b54e59980fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 09:31:37,375 unpacking tar archive at: autoland-6b54e59980fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 09:31:37.487873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:37.488281) ========= script_repo_revision: 6b54e59980fb1cad35f72c88a729f4199b8402b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:37.488722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:37.489032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 09:31:37.499050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-27 09:31:37.499541) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:31:37 INFO - MultiFileLogger online at 20160727 09:31:37 in /builds/slave/test 09:31:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:31:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:37 INFO - {'append_to_log': False, 09:31:37 INFO - 'base_work_dir': '/builds/slave/test', 09:31:37 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:31:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:37 INFO - 'branch': 'Autoland-Non-PGO', 09:31:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:37 INFO - 'config_files': ('talos/linux_config.py',), 09:31:37 INFO - 'default_actions': ('clobber', 09:31:37 INFO - 'read-buildbot-config', 09:31:37 INFO - 'download-and-extract', 09:31:37 INFO - 'populate-webroot', 09:31:37 INFO - 'create-virtualenv', 09:31:37 INFO - 'install', 09:31:37 INFO - 'run-tests'), 09:31:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:37 INFO - 'download_minidump_stackwalk': True, 09:31:37 INFO - 'download_symbols': 'ondemand', 09:31:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:37 INFO - 'installer_path': 'installer.exe', 09:31:37 INFO - 'log_level': 'info', 09:31:37 INFO - 'log_name': 'talos', 09:31:37 INFO - 'log_to_console': True, 09:31:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:31:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:31:37 INFO - 'opt_config_files': (), 09:31:37 INFO - 'pip_index': False, 09:31:37 INFO - 'sps_profile': False, 09:31:37 INFO - 'sps_profile_interval': 0, 09:31:37 INFO - 'suite': 'dromaeojs-e10s', 09:31:37 INFO - 'system_bits': '32', 09:31:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:37 INFO - 'title': 'talos-linux64-ix-001', 09:31:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:37 INFO - 'use_talos_json': True, 09:31:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:37 INFO - 'work_dir': 'build'} 09:31:37 INFO - [mozharness: 2016-07-27 16:31:37.837477Z] Running clobber step. 09:31:37 INFO - Running pre-action listener: _resource_record_pre_action 09:31:37 INFO - Running main action method: clobber 09:31:37 INFO - rmtree: /builds/slave/test/build 09:31:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:38 INFO - Running post-action listener: _resource_record_post_action 09:31:38 INFO - [mozharness: 2016-07-27 16:31:38.310450Z] Finished clobber step (success) 09:31:38 INFO - [mozharness: 2016-07-27 16:31:38.310551Z] Running read-buildbot-config step. 09:31:38 INFO - Running pre-action listener: _resource_record_pre_action 09:31:38 INFO - Running main action method: read_buildbot_config 09:31:38 INFO - Using buildbot properties: 09:31:38 INFO - { 09:31:38 INFO - "project": "", 09:31:38 INFO - "product": "firefox", 09:31:38 INFO - "script_repo_revision": "production", 09:31:38 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:31:38 INFO - "repository": "", 09:31:38 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 09:31:38 INFO - "buildid": "20160727074713", 09:31:38 INFO - "pgo_build": "False", 09:31:38 INFO - "basedir": "/builds/slave/test", 09:31:38 INFO - "buildnumber": 154, 09:31:38 INFO - "slavename": "talos-linux64-ix-001", 09:31:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:31:38 INFO - "platform": "ubuntu64_hw", 09:31:38 INFO - "scheduler": "tests-autoland-linux64-talos", 09:31:38 INFO - "branch": "autoland", 09:31:38 INFO - "repo_path": "integration/autoland", 09:31:38 INFO - "revision": "6b54e59980fb1cad35f72c88a729f4199b8402b8", 09:31:38 INFO - "stage_platform": "linux64", 09:31:38 INFO - "builduid": "3c4f771bcdf74039981dcadefcceab42", 09:31:38 INFO - "slavebuilddir": "test" 09:31:38 INFO - } 09:31:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:31:38 INFO - Running post-action listener: _resource_record_post_action 09:31:38 INFO - [mozharness: 2016-07-27 16:31:38.312967Z] Finished read-buildbot-config step (success) 09:31:38 INFO - [mozharness: 2016-07-27 16:31:38.313069Z] Running download-and-extract step. 09:31:38 INFO - Running pre-action listener: _resource_record_pre_action 09:31:38 INFO - Running main action method: download_and_extract 09:31:38 INFO - mkdir: /builds/slave/test/build/tests 09:31:38 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')]} 09:31:38 INFO - https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:38 INFO - Downloaded 1361 bytes. 09:31:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:38 INFO - Using the following test package requirements: 09:31:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:31:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:31:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'jsshell-linux-x86_64.zip'], 09:31:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:31:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:31:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:31:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:31:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:31:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:31:38 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')]} 09:31:38 INFO - https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:39 INFO - Downloaded 22746774 bytes. 09:31:39 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'] 09:31:39 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 09:31:41 INFO - Return code: 0 09:31:41 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 09:31: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')]} 09:31:41 INFO - https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:42 INFO - Downloaded 22746774 bytes. 09:31:42 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'] 09:31:42 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 09:31:43 INFO - Return code: 0 09:31:43 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')]} 09:31:43 INFO - https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:44 INFO - Downloaded 14413725 bytes. 09:31:44 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'] 09:31:44 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 09:31:44 INFO - Return code: 0 09:31:44 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')]} 09:31:44 INFO - https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:31:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OXN65moXRT25kZYSm-cd3w/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 09:31:48 INFO - Downloaded 57158173 bytes. 09:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:48 INFO - mkdir: /builds/slave/test/properties 09:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:48 INFO - Contents: 09:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:49 INFO - Running post-action listener: _resource_record_post_action 09:31:49 INFO - Running post-action listener: set_extra_try_arguments 09:31:49 INFO - [mozharness: 2016-07-27 16:31:49.568354Z] Finished download-and-extract step (success) 09:31:49 INFO - [mozharness: 2016-07-27 16:31:49.568593Z] Running populate-webroot step. 09:31:49 INFO - Running pre-action listener: _resource_record_pre_action 09:31:49 INFO - Running main action method: populate_webroot 09:31:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:49 INFO - '--tppagecycles', 09:31:49 INFO - '7'], 09:31:49 INFO - 'tests': ['tsvgm']}}, 09:31:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['damp', 'tps']}, 09:31:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'tests': ['damp', 'tps']}, 09:31:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['dromaeo_dom']}, 09:31:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['basic_compositor_video']}, 09:31:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:31:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tsvgx', 09:31:49 INFO - 'tsvgr_opacity', 09:31:49 INFO - 'tart', 09:31:49 INFO - 'tscrollx', 09:31:49 INFO - 'cart']}, 09:31:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:49 INFO - 'tsvgr_opacity', 09:31:49 INFO - 'tart', 09:31:49 INFO - 'tscrollx', 09:31:49 INFO - 'cart']}, 09:31:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tp5o']}, 09:31:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'tests': ['tp5o']}, 09:31:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s', 09:31:49 INFO - '--xperf_path', 09:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:49 INFO - 'tests': ['tp5n']}, 09:31:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--xperf_path', 09:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:49 INFO - 'tests': ['tp5n']}}, 09:31:49 INFO - 'talos.zip': {'path': '', 09:31:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:49 INFO - Running post-action listener: _resource_record_post_action 09:31:49 INFO - [mozharness: 2016-07-27 16:31:49.584761Z] Finished populate-webroot step (success) 09:31:49 INFO - [mozharness: 2016-07-27 16:31:49.584849Z] Running create-virtualenv step. 09:31:49 INFO - Running pre-action listener: _resource_record_pre_action 09:31:49 INFO - Running main action method: create_virtualenv 09:31:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:49 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 09:31:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:49 INFO - Using real prefix '/usr' 09:31:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:52 INFO - Installing pip.................done. 09:31:52 INFO - Return code: 0 09:31:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:52 INFO - Using env: {'DISPLAY': ':0', 09:31:52 INFO - 'HOME': '/home/cltbld', 09:31:52 INFO - 'LANG': 'en_US.UTF-8', 09:31:52 INFO - 'LANGUAGE': 'en_US:en', 09:31:52 INFO - 'LOGNAME': 'cltbld', 09:31:52 INFO - 'MAIL': '/var/mail/cltbld', 09:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:52 INFO - 'MOZ_NO_REMOTE': '1', 09:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:52 INFO - 'NO_EM_RESTART': '1', 09:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:52 INFO - 'PWD': '/builds/slave/test', 09:31:52 INFO - 'SHELL': '/bin/bash', 09:31:52 INFO - 'SHLVL': '1', 09:31:52 INFO - 'TERM': 'linux', 09:31:52 INFO - 'TMOUT': '86400', 09:31:52 INFO - 'USER': 'cltbld', 09:31:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:52 INFO - '_': '/tools/buildbot/bin/python'} 09:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:52 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 09:31:52 INFO - Cleaning up... 09:31:52 INFO - Return code: 0 09:31:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:31:52 INFO - Using env: {'DISPLAY': ':0', 09:31:52 INFO - 'HOME': '/home/cltbld', 09:31:52 INFO - 'LANG': 'en_US.UTF-8', 09:31:52 INFO - 'LANGUAGE': 'en_US:en', 09:31:52 INFO - 'LOGNAME': 'cltbld', 09:31:52 INFO - 'MAIL': '/var/mail/cltbld', 09:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:52 INFO - 'MOZ_NO_REMOTE': '1', 09:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:52 INFO - 'NO_EM_RESTART': '1', 09:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:52 INFO - 'PWD': '/builds/slave/test', 09:31:52 INFO - 'SHELL': '/bin/bash', 09:31:52 INFO - 'SHLVL': '1', 09:31:52 INFO - 'TERM': 'linux', 09:31:52 INFO - 'TMOUT': '86400', 09:31:52 INFO - 'USER': 'cltbld', 09:31:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:52 INFO - '_': '/tools/buildbot/bin/python'} 09:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:52 INFO - Downloading/unpacking psutil>=3.1.1 09:31:52 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 09:31:52 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 09:31:52 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 09:31:52 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 09:31:52 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 09:31:52 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 09:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:54 INFO - Installing collected packages: psutil 09:31:54 INFO - Running setup.py install for psutil 09:31:54 INFO - building 'psutil._psutil_linux' extension 09:31:54 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 09:31:54 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 09:31:54 INFO - building 'psutil._psutil_posix' extension 09:31:54 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 09:31:54 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 09:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:55 INFO - Successfully installed psutil 09:31:55 INFO - Cleaning up... 09:31:55 INFO - Return code: 0 09:31:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:31:55 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')]} 09:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:55 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')]} 09:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:55 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:31:55 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 09:31:55 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 09:31:55 INFO - Using env: {'DISPLAY': ':0', 09:31:55 INFO - 'HOME': '/home/cltbld', 09:31:55 INFO - 'LANG': 'en_US.UTF-8', 09:31:55 INFO - 'LANGUAGE': 'en_US:en', 09:31:55 INFO - 'LOGNAME': 'cltbld', 09:31:55 INFO - 'MAIL': '/var/mail/cltbld', 09:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:55 INFO - 'MOZ_NO_REMOTE': '1', 09:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:55 INFO - 'NO_EM_RESTART': '1', 09:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:55 INFO - 'PWD': '/builds/slave/test', 09:31:55 INFO - 'SHELL': '/bin/bash', 09:31:55 INFO - 'SHLVL': '1', 09:31:55 INFO - 'TERM': 'linux', 09:31:55 INFO - 'TMOUT': '86400', 09:31:55 INFO - 'USER': 'cltbld', 09:31:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:55 INFO - '_': '/tools/buildbot/bin/python'} 09:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:31:55 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 09:31:55 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 09:31:55 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 09:31:55 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 09:31:55 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 09:31:55 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 09:31:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:31:57 INFO - Installing collected packages: mozsystemmonitor 09:31:57 INFO - Running setup.py install for mozsystemmonitor 09:31:57 INFO - Successfully installed mozsystemmonitor 09:31:57 INFO - Cleaning up... 09:31:57 INFO - Return code: 0 09:31:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:57 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:31:57 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 09:31:57 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 09:31:57 INFO - Using env: {'DISPLAY': ':0', 09:31:57 INFO - 'HOME': '/home/cltbld', 09:31:57 INFO - 'LANG': 'en_US.UTF-8', 09:31:57 INFO - 'LANGUAGE': 'en_US:en', 09:31:57 INFO - 'LOGNAME': 'cltbld', 09:31:57 INFO - 'MAIL': '/var/mail/cltbld', 09:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:57 INFO - 'MOZ_NO_REMOTE': '1', 09:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:57 INFO - 'NO_EM_RESTART': '1', 09:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:57 INFO - 'PWD': '/builds/slave/test', 09:31:57 INFO - 'SHELL': '/bin/bash', 09:31:57 INFO - 'SHLVL': '1', 09:31:57 INFO - 'TERM': 'linux', 09:31:57 INFO - 'TMOUT': '86400', 09:31:57 INFO - 'USER': 'cltbld', 09:31:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:57 INFO - '_': '/tools/buildbot/bin/python'} 09:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:31:57 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 09:31:57 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 09:31:57 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 09:31:57 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 09:31:57 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 09:31:57 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 09:31:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:31:59 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 09:31:59 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 09:31:59 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 09:31:59 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 09:31:59 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 09:31:59 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 09:31:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:31:59 INFO - warning: no files found matching '*.txt' 09:31:59 INFO - no previously-included directories found matching 'build' 09:31:59 INFO - no previously-included directories found matching 'dist' 09:31:59 INFO - no previously-included directories found matching '.git*' 09:31:59 INFO - Installing collected packages: jsonschema, functools32 09:31:59 INFO - Running setup.py install for functools32 09:31:59 INFO - warning: no files found matching '*.txt' 09:31:59 INFO - no previously-included directories found matching 'build' 09:31:59 INFO - no previously-included directories found matching 'dist' 09:31:59 INFO - no previously-included directories found matching '.git*' 09:31:59 INFO - Successfully installed jsonschema functools32 09:31:59 INFO - Cleaning up... 09:32:00 INFO - Return code: 0 09:32:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:32:00 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 09:32:00 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 09:32:00 INFO - Using env: {'DISPLAY': ':0', 09:32:00 INFO - 'HOME': '/home/cltbld', 09:32:00 INFO - 'LANG': 'en_US.UTF-8', 09:32:00 INFO - 'LANGUAGE': 'en_US:en', 09:32:00 INFO - 'LOGNAME': 'cltbld', 09:32:00 INFO - 'MAIL': '/var/mail/cltbld', 09:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:00 INFO - 'MOZ_NO_REMOTE': '1', 09:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:00 INFO - 'NO_EM_RESTART': '1', 09:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:00 INFO - 'PWD': '/builds/slave/test', 09:32:00 INFO - 'SHELL': '/bin/bash', 09:32:00 INFO - 'SHLVL': '1', 09:32:00 INFO - 'TERM': 'linux', 09:32:00 INFO - 'TMOUT': '86400', 09:32:00 INFO - 'USER': 'cltbld', 09:32:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:00 INFO - '_': '/tools/buildbot/bin/python'} 09:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:00 INFO - Cleaning up... 09:32:00 INFO - Return code: 0 09:32:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:32:00 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 09:32:00 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 09:32:00 INFO - Using env: {'DISPLAY': ':0', 09:32:00 INFO - 'HOME': '/home/cltbld', 09:32:00 INFO - 'LANG': 'en_US.UTF-8', 09:32:00 INFO - 'LANGUAGE': 'en_US:en', 09:32:00 INFO - 'LOGNAME': 'cltbld', 09:32:00 INFO - 'MAIL': '/var/mail/cltbld', 09:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:00 INFO - 'MOZ_NO_REMOTE': '1', 09:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:00 INFO - 'NO_EM_RESTART': '1', 09:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:00 INFO - 'PWD': '/builds/slave/test', 09:32:00 INFO - 'SHELL': '/bin/bash', 09:32:00 INFO - 'SHLVL': '1', 09:32:00 INFO - 'TERM': 'linux', 09:32:00 INFO - 'TMOUT': '86400', 09:32:00 INFO - 'USER': 'cltbld', 09:32:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:00 INFO - '_': '/tools/buildbot/bin/python'} 09:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:00 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 09:32:00 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 09:32:00 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 09:32:00 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 09:32:00 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 09:32:00 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 09:32:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 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 09:32:02 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 09:32:03 INFO - Downloading docopt-0.6.1.tar.gz 09:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:03 INFO - Running setup.py install for blobuploader 09:32:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:03 INFO - Running setup.py install for requests 09:32:03 INFO - Running setup.py install for docopt 09:32:03 INFO - Successfully installed blobuploader requests docopt 09:32:03 INFO - Cleaning up... 09:32:03 INFO - Return code: 0 09:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:03 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:32:03 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 09:32:03 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 09:32:03 INFO - Using env: {'DISPLAY': ':0', 09:32:03 INFO - 'HOME': '/home/cltbld', 09:32:03 INFO - 'LANG': 'en_US.UTF-8', 09:32:03 INFO - 'LANGUAGE': 'en_US:en', 09:32:03 INFO - 'LOGNAME': 'cltbld', 09:32:03 INFO - 'MAIL': '/var/mail/cltbld', 09:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:03 INFO - 'MOZ_NO_REMOTE': '1', 09:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:03 INFO - 'NO_EM_RESTART': '1', 09:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:03 INFO - 'PWD': '/builds/slave/test', 09:32:03 INFO - 'SHELL': '/bin/bash', 09:32:03 INFO - 'SHLVL': '1', 09:32:03 INFO - 'TERM': 'linux', 09:32:03 INFO - 'TMOUT': '86400', 09:32:03 INFO - 'USER': 'cltbld', 09:32:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:03 INFO - '_': '/tools/buildbot/bin/python'} 09:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:04 INFO - Running setup.py (path:/tmp/pip-2tlXLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:04 INFO - Running setup.py (path:/tmp/pip-Sl70ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:04 INFO - Running setup.py (path:/tmp/pip-8F3HVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:04 INFO - Running setup.py (path:/tmp/pip-5fm3KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:04 INFO - Running setup.py (path:/tmp/pip-pUbfM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:04 INFO - Running setup.py (path:/tmp/pip-QrL6EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:04 INFO - Running setup.py (path:/tmp/pip-LwJCiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:04 INFO - Running setup.py (path:/tmp/pip-P2yJ6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:04 INFO - Running setup.py (path:/tmp/pip-pjToqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:04 INFO - Running setup.py (path:/tmp/pip-WimIba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:04 INFO - Running setup.py (path:/tmp/pip-prkwaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:04 INFO - Running setup.py (path:/tmp/pip-1eJSAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:04 INFO - Running setup.py (path:/tmp/pip-3gu8pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:04 INFO - Running setup.py (path:/tmp/pip-LEiCDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:05 INFO - Running setup.py (path:/tmp/pip-ab2X_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:05 INFO - Running setup.py (path:/tmp/pip-y05PPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:05 INFO - Running setup.py (path:/tmp/pip-UbTIZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:05 INFO - Running setup.py install for manifestparser 09:32:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozcrash 09:32:05 INFO - Running setup.py install for mozdebug 09:32:05 INFO - Running setup.py install for mozdevice 09:32:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozfile 09:32:05 INFO - Running setup.py install for mozhttpd 09:32:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozinfo 09:32:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozInstall 09:32:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Running setup.py install for mozleak 09:32:06 INFO - Running setup.py install for mozlog 09:32:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Running setup.py install for moznetwork 09:32:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Running setup.py install for mozprocess 09:32:06 INFO - Running setup.py install for mozprofile 09:32:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Running setup.py install for mozrunner 09:32:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Running setup.py install for mozscreenshot 09:32:06 INFO - Running setup.py install for moztest 09:32:06 INFO - Running setup.py install for mozversion 09:32:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:07 INFO - Cleaning up... 09:32:07 INFO - Return code: 0 09:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:07 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:32:07 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 09:32:07 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 09:32:07 INFO - Using env: {'DISPLAY': ':0', 09:32:07 INFO - 'HOME': '/home/cltbld', 09:32:07 INFO - 'LANG': 'en_US.UTF-8', 09:32:07 INFO - 'LANGUAGE': 'en_US:en', 09:32:07 INFO - 'LOGNAME': 'cltbld', 09:32:07 INFO - 'MAIL': '/var/mail/cltbld', 09:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:07 INFO - 'MOZ_NO_REMOTE': '1', 09:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:07 INFO - 'NO_EM_RESTART': '1', 09:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:07 INFO - 'PWD': '/builds/slave/test', 09:32:07 INFO - 'SHELL': '/bin/bash', 09:32:07 INFO - 'SHLVL': '1', 09:32:07 INFO - 'TERM': 'linux', 09:32:07 INFO - 'TMOUT': '86400', 09:32:07 INFO - 'USER': 'cltbld', 09:32:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:07 INFO - '_': '/tools/buildbot/bin/python'} 09:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:07 INFO - Running setup.py (path:/tmp/pip-ozZg_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:07 INFO - Running setup.py (path:/tmp/pip-1Ge2mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:07 INFO - Running setup.py (path:/tmp/pip-wlj4ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:07 INFO - Running setup.py (path:/tmp/pip-03MaBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:07 INFO - Running setup.py (path:/tmp/pip-v2rWc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:07 INFO - Running setup.py (path:/tmp/pip-c3Ymv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:07 INFO - Running setup.py (path:/tmp/pip-57YGaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:07 INFO - Running setup.py (path:/tmp/pip-YqZUbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:07 INFO - Running setup.py (path:/tmp/pip-EpswPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:07 INFO - Running setup.py (path:/tmp/pip-xLB2KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:07 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)) 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:07 INFO - Running setup.py (path:/tmp/pip-aPgkTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:08 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)) 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:08 INFO - Running setup.py (path:/tmp/pip-9PCDMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:08 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)) 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:08 INFO - Running setup.py (path:/tmp/pip-PPH98U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:08 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)) 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:08 INFO - Running setup.py (path:/tmp/pip-9PSLC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:08 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)) 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:08 INFO - Running setup.py (path:/tmp/pip-yQgORY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:08 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)) 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:08 INFO - Running setup.py (path:/tmp/pip-exptnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:08 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)) 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:08 INFO - Running setup.py (path:/tmp/pip-OkpmwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:08 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)) 09:32:08 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)) 09:32:08 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)) 09:32:08 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)) 09:32:08 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)) 09:32:08 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)) 09:32:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:08 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 09:32:08 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 09:32:08 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 09:32:08 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 09:32:08 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 09:32:08 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 09:32:10 INFO - Downloading blessings-1.6.tar.gz 09:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:10 INFO - Installing collected packages: blessings 09:32:10 INFO - Running setup.py install for blessings 09:32:10 INFO - Successfully installed blessings 09:32:10 INFO - Cleaning up... 09:32:10 INFO - Return code: 0 09:32:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:10 INFO - Reading from file tmpfile_stdout 09:32:10 INFO - Current package versions: 09:32:10 INFO - argparse == 1.2.1 09:32:10 INFO - blessings == 1.6 09:32:10 INFO - blobuploader == 1.2.4 09:32:10 INFO - docopt == 0.6.1 09:32:10 INFO - functools32 == 3.2.3-2 09:32:10 INFO - jsonschema == 2.5.1 09:32:10 INFO - manifestparser == 1.1 09:32:10 INFO - mozInstall == 1.12 09:32:10 INFO - mozcrash == 0.17 09:32:10 INFO - mozdebug == 0.1 09:32:10 INFO - mozdevice == 0.48 09:32:10 INFO - mozfile == 1.2 09:32:10 INFO - mozhttpd == 0.7 09:32:10 INFO - mozinfo == 0.9 09:32:10 INFO - mozleak == 0.1 09:32:10 INFO - mozlog == 3.3 09:32:10 INFO - moznetwork == 0.27 09:32:10 INFO - mozprocess == 0.23 09:32:10 INFO - mozprofile == 0.28 09:32:10 INFO - mozrunner == 6.12 09:32:10 INFO - mozscreenshot == 0.1 09:32:10 INFO - mozsystemmonitor == 0.3 09:32:10 INFO - moztest == 0.7 09:32:10 INFO - mozversion == 1.4 09:32:10 INFO - psutil == 3.1.1 09:32:10 INFO - requests == 1.2.3 09:32:10 INFO - wsgiref == 0.1.2 09:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:10 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:32:10 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 09:32:10 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 09:32:10 INFO - Using env: {'DISPLAY': ':0', 09:32:10 INFO - 'HOME': '/home/cltbld', 09:32:10 INFO - 'LANG': 'en_US.UTF-8', 09:32:10 INFO - 'LANGUAGE': 'en_US:en', 09:32:10 INFO - 'LOGNAME': 'cltbld', 09:32:10 INFO - 'MAIL': '/var/mail/cltbld', 09:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:10 INFO - 'MOZ_NO_REMOTE': '1', 09:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:10 INFO - 'NO_EM_RESTART': '1', 09:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:10 INFO - 'PWD': '/builds/slave/test', 09:32:10 INFO - 'SHELL': '/bin/bash', 09:32:10 INFO - 'SHLVL': '1', 09:32:10 INFO - 'TERM': 'linux', 09:32:10 INFO - 'TMOUT': '86400', 09:32:10 INFO - 'USER': 'cltbld', 09:32:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:10 INFO - '_': '/tools/buildbot/bin/python'} 09:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 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)) 09:32:11 INFO - Cleaning up... 09:32:11 INFO - Return code: 0 09:32:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32:11 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')]} 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:11 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')]} 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:11 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 0xd46030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf75400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', '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 09:32:11 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 09:32:11 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 09:32:11 INFO - Using env: {'DISPLAY': ':0', 09:32:11 INFO - 'HOME': '/home/cltbld', 09:32:11 INFO - 'LANG': 'en_US.UTF-8', 09:32:11 INFO - 'LANGUAGE': 'en_US:en', 09:32:11 INFO - 'LOGNAME': 'cltbld', 09:32:11 INFO - 'MAIL': '/var/mail/cltbld', 09:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:11 INFO - 'MOZ_NO_REMOTE': '1', 09:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:11 INFO - 'NO_EM_RESTART': '1', 09:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:11 INFO - 'PWD': '/builds/slave/test', 09:32:11 INFO - 'SHELL': '/bin/bash', 09:32:11 INFO - 'SHLVL': '1', 09:32:11 INFO - 'TERM': 'linux', 09:32:11 INFO - 'TMOUT': '86400', 09:32:11 INFO - 'USER': 'cltbld', 09:32:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:11 INFO - '_': '/tools/buildbot/bin/python'} 09:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:32:11 INFO - Cleaning up... 09:32:11 INFO - Return code: 0 09:32:11 INFO - Running post-action listener: _resource_record_post_action 09:32:11 INFO - Running post-action listener: _start_resource_monitoring 09:32:11 INFO - Starting resource monitoring. 09:32:11 INFO - [mozharness: 2016-07-27 16:32:11.344893Z] Finished create-virtualenv step (success) 09:32:11 INFO - [mozharness: 2016-07-27 16:32:11.345453Z] Running install step. 09:32:11 INFO - Running pre-action listener: _resource_record_pre_action 09:32:11 INFO - Running main action method: install 09:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:11 INFO - Reading from file tmpfile_stdout 09:32:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:11 INFO - Reading from file tmpfile_stdout 09:32:11 INFO - Output received: 09:32:11 INFO - Usage: mozinstall [options] installer 09:32:11 INFO - Options: 09:32:11 INFO - -h, --help show this help message and exit 09:32:11 INFO - -d DEST, --destination=DEST 09:32:11 INFO - Directory to install application into. [default: 09:32:11 INFO - "/builds/slave/test"] 09:32:11 INFO - --app=APP Application being installed. [default: firefox] 09:32:11 INFO - mkdir: /builds/slave/test/build/application 09:32:11 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'] 09:32:11 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 09:32:28 INFO - Reading from file tmpfile_stdout 09:32:28 INFO - Output received: 09:32:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:32:28 INFO - Running post-action listener: _resource_record_post_action 09:32:28 INFO - [mozharness: 2016-07-27 16:32:28.042005Z] Finished install step (success) 09:32:28 INFO - [mozharness: 2016-07-27 16:32:28.042282Z] Running run-tests step. 09:32:28 INFO - Running pre-action listener: _resource_record_pre_action 09:32:28 INFO - Running main action method: run_tests 09:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:28 INFO - Python 2.7.3 09:32:28 INFO - Return code: 0 09:32:28 INFO - grabbing minidump binary from tooltool 09:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:28 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 0x1004570>, '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 0x1005470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1005900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:28 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 09:32:28 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 09:32:28 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 09:32:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:28 INFO - Return code: 0 09:32:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:32:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:32:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 09:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 09:32:28 INFO - Using env: {'DISPLAY': ':0', 09:32:28 INFO - 'HOME': '/home/cltbld', 09:32:28 INFO - 'LANG': 'en_US.UTF-8', 09:32:28 INFO - 'LANGUAGE': 'en_US:en', 09:32:28 INFO - 'LOGNAME': 'cltbld', 09:32:28 INFO - 'MAIL': '/var/mail/cltbld', 09:32:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:28 INFO - 'MOZ_NO_REMOTE': '1', 09:32:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:28 INFO - 'NO_EM_RESTART': '1', 09:32:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:28 INFO - 'PWD': '/builds/slave/test', 09:32:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:28 INFO - 'SHELL': '/bin/bash', 09:32:28 INFO - 'SHLVL': '1', 09:32:28 INFO - 'TERM': 'linux', 09:32:28 INFO - 'TMOUT': '86400', 09:32:28 INFO - 'USER': 'cltbld', 09:32:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680', 09:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:28 INFO - '_': '/tools/buildbot/bin/python'} 09:32:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 09:32:28 INFO - mozversion application_buildid: 20160727074713 09:32:28 INFO - mozversion application_changeset: 6b54e59980fb1cad35f72c88a729f4199b8402b8 09:32:28 INFO - mozversion application_display_name: Nightly 09:32:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:28 INFO - mozversion application_name: Firefox 09:32:28 INFO - mozversion application_remotingname: firefox 09:32:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:32:28 INFO - mozversion application_vendor: Mozilla 09:32:28 INFO - mozversion application_version: 50.0a1 09:32:28 INFO - mozversion platform_buildid: 20160727074713 09:32:28 INFO - mozversion platform_changeset: 6b54e59980fb1cad35f72c88a729f4199b8402b8 09:32:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:32:28 INFO - mozversion platform_version: 50.0a1 09:32:28 INFO - using testdate: 1469637148 09:32:28 INFO - actual date: 1469637148 09:32:28 INFO - starting webserver on 'localhost:55147' 09:32:28 INFO - SUITE-START | Running 2 tests 09:32:28 INFO - TEST-START | dromaeo_css 09:32:28 INFO - operating with platform_type : linux_ 09:32:28 INFO - Initialising browser for dromaeo_css test... 09:32:28 INFO - TEST-INFO | started process 25393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvc336/profile http://localhost:55147/getInfo.html) 09:32:31 INFO - PROCESS | 25393 | JavaScript error: , line 0: uncaught exception: undefined 09:32:33 INFO - PROCESS | 25393 | __metrics Screen width/height:1600/1200 09:32:33 INFO - PROCESS | 25393 | colorDepth:24 09:32:33 INFO - PROCESS | 25393 | Browser inner width/height: 1024/697 09:32:33 INFO - PROCESS | 25393 | __metrics 09:32:33 ERROR - PROCESS | 25393 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:32:34 INFO - TEST-INFO | 25393: exit 0 09:32:34 INFO - Browser initialized. 09:32:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:34 INFO - TEST-INFO | started process 25513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphvc336/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:46 INFO - PROCESS | 25513 | RSS: Main: 166227968 09:32:46 INFO - PROCESS | 25513 | 09:33:36 INFO - PROCESS | 25513 | 1469637216324 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] 09:35:48 INFO - PROCESS | 25513 | Cycle 1(1): loaded http://localhost:55147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55147/tests/dromaeo/cssquery-ext.html) 09:35:49 INFO - PROCESS | 25513 | RSS: Main: 168284160 09:35:49 INFO - PROCESS | 25513 | 09:38:52 INFO - PROCESS | 25513 | Cycle 1(1): loaded http://localhost:55147/tests/dromaeo/cssquery-ext.html (next: http://localhost:55147/tests/dromaeo/cssquery-jquery.html) 09:38:52 INFO - PROCESS | 25513 | RSS: Main: 168075264 09:38:52 INFO - PROCESS | 25513 | 09:41:54 INFO - PROCESS | 25513 | Cycle 1(1): loaded http://localhost:55147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55147/tests/dromaeo/cssquery-mootools.html) 09:41:55 INFO - PROCESS | 25513 | RSS: Main: 171675648 09:41:55 INFO - PROCESS | 25513 | 09:44:57 INFO - PROCESS | 25513 | Cycle 1(1): loaded http://localhost:55147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55147/tests/dromaeo/cssquery-prototype.html) 09:44:58 INFO - PROCESS | 25513 | RSS: Main: 165957632 09:44:58 INFO - PROCESS | 25513 | 09:48:00 INFO - PROCESS | 25513 | Cycle 1(1): loaded http://localhost:55147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55147/tests/dromaeo/cssquery-yui.html) 09:48:01 INFO - PROCESS | 25513 | RSS: Main: 168312832 09:48:01 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | Cycle 1(1): loaded http://localhost:55147/tests/dromaeo/cssquery-yui.html (next: http://localhost:55147/tests/dromaeo/cssquery-dojo.html) 09:51:04 INFO - PROCESS | 25513 | RSS: Main: 171384832 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | __start_tp_report 09:51:04 INFO - PROCESS | 25513 | _x_x_mozilla_page_load 09:51:04 INFO - PROCESS | 25513 | _x_x_mozilla_page_load_details 09:51:04 INFO - PROCESS | 25513 | |i|pagename|runs| 09:51:04 INFO - PROCESS | 25513 | |0;dojo.html;2636.749508796664;2641.062422839893;2673.291577731901;2675.063727695307;2690.825096368736;4710.929336059953;4774.737389443583;4805.399325084364;4807.254875494295;4856.247281671346;4778.952210477903;4796.760161991904;4801.879953001177;4821.325014497973;4831.082094402062;4373.650107991361;4441.822327106928;4450.621697155746;4518.977405112986;4546.113507865951;4471.441069866267;4477.574630410106;4508.864734057984;4527.366168736379;4557.475890272612;4320.913581728348;4405.691601587891;4419.138268037734;4468.687191896569;4486.990427153881;4457.821687132511;4458.175237581057;4482.372467854503;4484;4504.594586487199;4404.977975110104;4411.669124815619;4430.534793846664;4434.800433980478;4476.820927162909;4583.289590113538;4597.471290801567;4662.860114196579;4779.187538118528;4836.854894353175;4968.428630707479;4974.87562810929;4979.278004689336;4983.078130545824;5013.924791128136;4979.203327467624;4986.152354099811;4986.750662466862;4986.82546110888;5028.170351891933;4671.953280467186;4696.835610753676;4729.243321068612;4825.396825396825;4883.487233840467;5267.341582302212;5269.71016594091;5273.6044796639635;5324.680519168863;5336.759845806948;5017.89964200714;5039.294498770175;5043.773030213649;5073.213651883964;5100.132977393852;5022.397312322471;5067;5128.1282182029145;5157.6647517911215;5180.870478237999;5097.413797413345;5104.617153713486;5114.616403769732;5184.870378240499;5185.896282074337;5066.898662026812;5090.109230884655;5095.210242412432;5111.9899854869445;5153.819616313411;4296.871093867189;4410.051838854662;4422;4434.5343738907595;4499.865004049884;3865.8646947356706;3869.342211823997;3908.6286802753693;3912.080661044652;3925.2345792570745;4488.312414502368;4507.684462087623;4525.389072475174;4529.501754806968;4555.2711566149255;5013.724245166551;5135.97432012845;5157.174852023733;5187.63686541946;5257.76340064698;4485.102979404132;4506.797194126272;4536.092781443725;4546.204414227497;4552.339910712928;4671.416072990876;4683.396411060388;4698.436187657503;4705.882352941136;4722.630437173181;4685.929711054268;4792.784324705466;4802.903941921142;4824.8793780155775;4845.63657725672;5156;5159.638825282344;5170.250313704567;5231.686098834082;5241.685498869928;4828.975855120702;4849.102915960559;4862.3922009748785;4869.829555965666;4887.853364398931;4987.700737955734;5071.137906555969;5079.6698214615935;5109.489051094861;5121.5221861606815;5217.217417387422;5221.112410890082;5222.216667499905;5223.5559977402345;5243.711595862264;5018.949810501848;5049.747512624427;5052.5705315048635;5075.6193285502995;5080.212567052113;4884.267359896044;4947.82682606107;5009.298698182184;5029.5221953914315;5042.873928151679;4955.430125535466;4959.801607935787;5004.47453017428;5020.774065167003;5028.974855125701;5074.314967479343;5092.337996060489;5094.821681241138;5110.9488905110475;5143.537081662668;4720.669553131248;4904.288878112582;4920.975395123001;4948.826791062295;4958.528939750718 09:51:04 INFO - PROCESS | 25513 | |1;ext.html;552.94939614732;560.2632538212248;567.9886402271954;573.0287163258276;592.8577141486039;35708.10729731755;38656.80671596641;38900.416493752615;39008.414873776914;39271.60728392715;39047.41428878562;39778.8011059945;39844.80077599608;39923.60076399242;39995.200095998065;7657.310842024217;7739.961300193491;7796.142424333347;7818.530888146701;7821.21787821219;7619.885701714478;7771.727989520368;7790.376769858398;7791.688332466694;7793.142754297051;7734.497257678233;7772.145064042951;7833.5299882006975;7847.097583777853;7851.764447066568;7720.806979825549;7767.378609711238;7785.3771698264;7805.219478052178;7811.375089992844;7629.732959346452;7672;7687.654055567513;7695.268949449794;7732.3040926316335;36452;36512.634873651186;36820;36896.63103368959;36934.630653693384;2378.607529757588;2678.1296078774476;2868.182567968119;2911.461379644751;2928.2679330167457;25547.744522554724;26937;27405;27688.307792305353;28371.716282837115;3220.1144685211752;3269.8038117713013;3290.457074582691;3357.412452820771;3366;234248;235413;236058.99999999828;237054;238967;32135;32804.179895502326;32904.67095329016;33230.335393292;34265.48601770975;33491.49762753561;33520;33698.15754606154;33704.83147584246;33751.83124084364;12971.675708107185;12977.35113244334;13024.739505209844;13031.283279419724;13116.213027218397;10510.211734119819;10665;10667.83998240027;10714.142868570496;10811.081058110149;7763.573003484863;7805.492642978302;7808.102068262109;7817.8827317590285;7930.524168549906;3012.7137921897383;3108.347247078139;3148.449021421242;3162.5528174290134;3166.746660267173;857.9875746618925;863.6502216602286;930.1721467893581;946.8248374050822;1035.2028937717914;28134.155975320773;28512.144635660963;28627.856860715565;28824.711752882624;29003.274918126794;942.8632848236967;974.0600320690426;982.9508524573743;1010.7978404319166;1070.4219721350385;14916.14344632239;15191.392344306105;15363.462278820187;15376.154311512973;15381.615459613375;406730;416010;416159;417127;417211;50189.49810501848;50617.74691126521;50806.49193508018;50989.745051274505;51072.744636277326;1190.4880901212389;1201.7536405036947;1209.7580483903255;1213.6298428979246;1221.5724496426358;27288.454230915668;27997;28432.85783571069;28961.7103828959;29125.85437072886;43667.126657467306;43844.34233486564;43878;43976.12047759091;43996.34005489984;365074;368151;370706;371352;371932;25923.611145833205;25969.48061038731;26094.60858087092;26142.86928565421;26201.34496637523;43178.35232471453;43431.34852977271;43795;44051;44123;36124.09689757777;37406.438903417016;37773.86678399653;37897.105144743204;38864.417033745085;36872.81563592165;37818.43272350972;38031.809840951726;38309.04227394338;38539.42190867083;32136.35727285488;34788.65211347854;35366.29267414586;36221.81889090538;37288.254234915694;32050.83974580112;33931.321373572886;34369;34725;34912.127196820285;26435.603465947643;26717.198484045508;26786.59820102739;26951.460970780867;27008.72991270141 09:51:04 INFO - PROCESS | 25513 | |2;jquery.html;349.1637528120154;352.6279774837546;355.0785711079748;370.18189800540836;372.6534323079535;16391.180440977947;17151.485455436326;17315.740263896038;17687.91156044221;17760.822391776077;16131.91934040331;16236.350545978175;16803.41188058415;17007.744883826752;17010.234539445722;4973.154563724166;5168.534831865131;5169.095408303532;5177.715225662587;5181.870453238662;3828.540575130988;5165.3026841376495;5749.166370876221;5976.163337132805;6004.609700369484;5955.285365756115;6056.818295451121;6087.665178415185;6088.9391106088815;6089.299730530979;6270.467010304107;6590.703418346162;6607.339266073378;6726.3609957054005;6748.730050797963;6355.777547785805;6368.5860419072615;6417.8395540111405;6423.7430502779835;6430.356964303579;21910.780892191033;23257.418564535852;24192.758072419227;24302.878485607635;24351.756482435125;1938.6316599845984;2024.848136389762;2109.6097222013977;2128.8403369747175;2591.2226332100295;13828.585142445743;14398.280085995762;14862.628434289121;14865.628359290997;15418.845811541853;1911.7132430135453;1930.4015755115818;1996.3511858645998;1999.4201681512488;2032.1464984706458;84651.5767421159;85280;86480;88562;88739.11260887438;16035.438759643357;16293.674126517404;16685.666286674197;17102.657946840995;17173.7423938641;29089.12732618025;29219.56170657442;29252;29351.706482934896;29433.411331773244;8308.376871734645;8389.412741108186;8471.178939639092;8626.266767324847;8741;6731.158605174353;6738.59568425896;6929.514933954575;6969.16370035599;6983.3714965653335;8031.915691381706;8621.137886211454;8660.26387757035;8776.16626420489;8821.691240806542;1489.5531340597777;1586.5954181683596;1595.84839440253;3323.983589702646;3381.2561236527927;800.2757504458474;819.5164852736795;836.3016880904391;977.6236149082512;980.1325826643472;16683.332666693197;17449.476515704548;17459.21433535494;17580.472585822445;17865;841.6338892581747;854.4446110028531;863.6070587882498;873.750980970433;896.3904544909394;9092.27261819053;9917.801643967081;9932.503374831229;9977.201823854075;10004.049615286536;415312;415667;444882;448727;451701;82544.58727706443;84154;85723;85731;86685.56657216673;911.2846415563884;916.4318122763929;935.7286386947709;937.376644531379;943.8631398447187;15706.9214653926;15743.921280393524;16267.349306027627;16425.425110121567;16562.254698538836;38173.61826381701;38849.80575097106;38920.8323750288;38967;39257;48358.758206208746;53486.465135348146;54559.454405455435;55284.170737439774;55578;6339.683015849097;6731.697073631601;6909;6924.861502769816;7505.737299194502;11236.213465057368;11463.082953363544;11494.252873563191;11609.955104040677;11689.649310520357;9993.450360230258;10241.948790256001;10311.175105991653;10541.104006159256;10882.727931801768;9729.270304727315;10243.84634230502;10418.895811041793;10776.67669969902;10855.434410745387;10091.848622270818;10686.73283167927;10694.037536621741;10713;11091.944540277247;7478.551286922802;7482.738104166328;7487.251274872469;7706.845863082819;7715.691372345268;5045.9243111352625;9175.495347755937;10595.629152979609;10639.095676867553;11001.17491188148 09:51:04 INFO - PROCESS | 25513 | |3;mootools.html;1341.9597412077637;1385.9584212473624;1446.4937271954811;1622.8133764617073;1640.8304774049577;6645.435138013263;7060.293970602944;7440.8139796504975;7453.291937265958;7532.623368831557;7505.211952744951;7775.339096176832;7776.4945278557;7782.182870798555;7792.376609871211;2122.564874200789;2147.4309308033307;2153.6015837070113;2164.0586344939925;2172.7935846094597;2069.7205877206534;2123.4054464749893;2164.6103701333755;2166.2959538150085;2173.804357607815;2100.527381339202;2128.3508529898377;2132.051237199447;2133.370655656577;2137.5190582118976;2126.7447906251273;2144.7426308842882;2146.0450099705636;2148.581026699794;2149.9677504837364;2057.1668474267794;2095.685647152924;2112.672535756945;2115.3548167808813;2116.3968269043403;7816.140224575292;7824.217578242187;7834.686612535492;7845.568493732842;7895.723649672292;4401.273789824675;4427.53510881356;4436.423264975565;4444.622207112399;4459.643228541709;2769.3076730817297;2804.5232310507263;2805.887764489418;2833.2208642623236;2909.7090290970946;908.3686837647838;945.5130607737021;958.7363475044349;963.0610155098793;975.1467465967279;10346.275760696753;10366.948165259126;10404.427756473468;10408.375497470177;10430.68707938763;3876.205377897524;4026.295398305285;4152.045029643199;4161.750294982311;4202.957970420318;8863.423877448075;8889.599968001456;8894.199522043047;8901.109889011048;8901.421407608485;4506.526814684476;4510.143072816154;4510.413646225969;4513.593776560126;4521.208788462006;3525.629808870032;3969.0672691917375;4079.918401631951;4097.242010228058;4109.116539943926;3473.652634736506;3567.161716996504;3587.551556055493;3669.9266014679556;3670.926581468356;1142.7771584540935;1152.4065106470175;1166.6091859227083;1177.4877928101303;1183.3668987092037;639.8080575827233;678.4199509419474;708.929107089287;714.8141483214298;763.9381260048536;5053.772580233898;5066.341375621146;5202.53177214045;5282.445343238982;5301.390340110859;836.3309352517962;845.3955421873267;867.9826403471895;883.9381243313035;903.4037535226719;3465.3069386122875;3672.706183505313;3692.9630703693156;3715.0898029982286;3798.5441746990537;8560.101189375151;8968.372213944962;9060.093990600888;9078.500682462529;9112;8992.145746154105;9004.81990360189;9012.684556040507;9022.14289642483;9043.909560904438;7145.321194486515;7259.165196002422;7280.854382912312;7293.5259208152365;7362;5209.630345349816;5265.341832270966;5396.622236443412;5441.7551210196425;5530.7511161997;8889.4666320021;8983.685571004984;8992.775180620276;8993.910060899307;9010.14403631654;8453.070162282267;8863.423877447945;8869.11308869108;9093.136152065543;9097.317701172571;5879.764809407747;6388.968055159695;6500.122483464861;6587.440067594308;6742.764003259862;7243.637818109179;7270.345668889825;7304.598247096461;7309.744158954411;7314.158871729819;6384.329645387167;6565.113709649328;6682;6708.6310252936555;6912.619805910522;6263.123162757127;6647.800565983028;6650.600963942179;6766.391024807791;6799.490038247052;5827.59206855533;6044.697765111815;6047.606905551125;6051.576389652682;6052.576319657758;4394.714343567658;4449.243628583214;4451.399061126836;4500.549945005473;4543.250363689954;4306.65546756265;4392;4437.644988400984;4518.299663552155;4555.726656400627 09:51:04 INFO - PROCESS | 25513 | |4;prototype.html;299.0579674026816;301.234863446845;302.6368357970436;303.6614175194657;305.7401208972373;5129.410117836445;5139.691618502888;5154.922676159856;5159.3808742950805;5177.912638345952;5033.043721692885;5045.293658887749;5062.139436295829;5071.695698258098;5079.3904731432185;3728.552573691161;3854.9807250963704;3934.862279820207;3941.9211615767667;3968.226195891802;3918.5101862267215;3946.585608511108;3948.2103579284258;3988.361862102064;3990.461287726149;3958.8812335629977;3963.4054891766177;3970.563238043813;3972.106276087886;3973.880783576483;3823.235352929425;3919.6668283195963;3932.4691166692414;3988.940165897514;3994.9001274968214;3462.082548124749;3469.8785542505893;3470.4620783778555;3471.5313432686517;3483.1292176955762;4936.7531623419045;4944.90110197794;4959.7768100435205;4977.676451030671;5008.270492581515;4410.735355878657;4557.840475583339;4576.519465456146;4589.1088614173195;4593.931091033637;5251.95386675731;5264.8683782905355;5300.787968481256;5307.681539107666;5339.866503337409;3807.1243613968663;3826.7371767316718;3838.3858582626644;3849.3263678856088;3856.917264677099;5449.754761035723;5524.889502209933;5585.134304182858;5606.187102870061;5607.663540187561;3900.687944964396;3902.512185976753;3928.705347098979;3939.6998990333122;3949.30887094763;3984.900377490586;3995.5405128410025;4001.559828418872;4007.0783719744622;4008.3987401889367;4541.341505481752;4543.522930092293;4543.795529201194;4547.2269714148015;4561.29299958507;5152.175651895679;5310.8141215057285;5320.201969704575;5346.861255497832;5353.634823120079;1356.3421740455872;1365.453818472599;1376.9311534423439;1378.600205940266;1380;855.3157474020759;898.5731777405811;899.1323372945009;907.7412937312967;912.7763697893926;4445.488768791565;4533.614642755403;4670.925687091988;4672.252439609714;4688.249880019181;5470.56235501159;5483.424240454775;5487.5609951203805;5497.422770609029;5544.944550554524;4648.953510464919;4662.883427914261;4696;4709.3642358281195;4714.693544919569;2765.9723402765717;2909.2726818295428;2911.956320655192;2937.383149538578;2945.013420504112;5142.305788718475;5154.634021984177;5179.8446046618665;5194.740262986836;5200.479952004845;5337.332833395825;5619.943800562024;5638.97180514103;5660.29246344207;5660.716964151776;5128.153854613947;5131.461196574381;5137.640365174477;5138.409082955433;5141.971605678805;5530.695811730394;5550.7779688812;5555.388907220284;5575.358833734173;5594.888102237851;5202.583793296603;5399.433059528693;5415.5938304626525;5426.755795989269;5490.599897026393;5134.820281290286;5136.5377116059735;5161.354830646169;5162.716050617252;5175.223716442413;3764.454154147688;3787.791671458096;3799.7150213733526;3813.7139714520968;3814;5381.838544843661;5520.834374968757;5539.806106786243;5564.1931919870585;5626.887462250814;5341.531078953163;5355.196720491957;5360.410354860885;5368.40947495783;5380.192971054373;5332.96007278577;5354.36691809002;5363.417791751364;5364.222187782671;5381.650192737459;4989.900201996013;5192.727781693509;5253.23828044939;5254.710990895537;5268.762905669178;5125.692458452505;5214.165733482625;5336.306280183551;5379.784808607612;5392.218128371443;5225.973870130625;5251;5254.474552544715;5257.5005374489365;5264.236685680478 09:51:04 INFO - PROCESS | 25513 | |5;yui.html;604.6848105370818;667.2393471442559;677.177229665956;711.8078118907894;714.9928500714994;11703.941480292597;12493.875061249384;12568.81146782799;12572.057095717812;12586.874131258695;12317.507299708024;12341.382930853466;12367.938160309208;12369.876301236985;12401.627951161458;632.7469012395032;763.3015790551639;763.4503157726456;764.4801534956227;772.2624893226955;763.1147868472573;785.9764207073797;790.8932294140275;791.2720297326473;792.4373694676786;806.6208881825532;811.4563242627424;811.7889348769332;812.569338250728;813.6297984417076;799.936005119592;806.4959400374765;807.6083099696642;809.6113865344638;809.6963638635511;586.3286536915251;590.9143174239712;591.2638764737928;591.5918016568597;593.5696619950545;12071.57749478764;12120.696982575506;12179.269243845398;12201.633950981484;12224.205426647328;12521.43653535584;12892;12934.094613377067;13047.151935124282;13109;9982.151517121054;10053.748656283578;10080.143187829044;10121.898781012169;10155.39067655943;3218.6459489456142;3244.0916543367894;3269.2317305433203;3294.6870047345465;3325.96674033259;60547.69726151341;61883.381166188214;62107.68946155286;62110.37889621136;63090.36909630937;9215.815683686289;9263.768405789775;9342.346035777566;9368.67209647659;9468.810623787485;18295.54261143482;18465.7230141548;18549;18676.34632787873;20078.09648565818;6569.507286953498;6686.3313668632745;6828.5902845829405;6900.309969003059;6926.099607051051;3677.9080522987138;3682.1531047859144;3738.039020753076;3775.867844625425;3779.3952967525065;2783.6937936826935;2844.672862620825;2875.7268059534313;2880.423915216965;2883.9134825955257;479.1303783632765;486.84664330735706;488.3407400009958;498.26008377559293;498.73317774990204;548.1394211088552;551.4154995704566;569.3054473542272;577.3187638586509;594.8929192745261;7440.404767618577;7512.812179695442;7828.138904720477;7832;8024.48045871148;517.3894804131086;517.438579141628;518.5436815602246;539.9568034557226;544.5398638150756;3746.925061498755;3802.3726085196186;3812.1232116613332;3828.8659896903473;4081.1225586499045;63560.364396356366;93930;94072.52963735274;95760.52119739357;97352.51323743336;81223;82264;83332.58333708292;83625;86188.56905715431;68020;71008;71614;71757.2824271761;72246;7250.927490725026;7373.59445230496;7419.258074192538;7451.552906825391;7646.65590048438;44636;44953.77523112363;45080;45569.772151139034;45628.315575267065;57948;59743.10385344137;61366.38633613785;63155;66162.33837661562;9187.356885017985;9682.9031709682;9709.6116155353;9879.20966322678;9963.302568820403;10848.67453976382;10901.127909767358;11002.779944400907;11086.889131108586;11189.832152517556;9731;9920.156786672926;9981.15160211361;9998.700038998843;10031.54730854273;9503.904960950578;9665;9686.70939871805;9768.218542516724;9881.308308418342;9651.947331398178;9689.563969621244;9909.157721593745;9918;9930.205583553443;8085.782208282445;8409.705660301861;8442.071372148936;8571.357148213785;8585.785355366166;7974.601269936364;8238.093809680811;8447.619857106321;8619.094995025684;8638.45190032024 09:51:04 INFO - PROCESS | 25513 | __end_tp_report 09:51:04 INFO - PROCESS | 25513 | __start_cc_report 09:51:04 INFO - PROCESS | 25513 | _x_x_mozilla_cycle_collect,384 09:51:04 INFO - PROCESS | 25513 | __end_cc_report 09:51:04 INFO - PROCESS | 25513 | __startTimestamp1469638264334__endTimestamp 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | ------- Summary: start ------- 09:51:04 INFO - PROCESS | 25513 | Number of tests: 6 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | [#0] dojo.html Cycles:165 Average:4759.58 Median:4862.39 stddev:486.43 (10.0%) stddev-sans-first:458.53 09:51:04 INFO - PROCESS | 25513 | Values: 2636.7 2641.1 2673.3 2675.1 2690.8 4710.9 4774.7 4805.4 4807.3 4856.2 4779.0 4796.8 4801.9 4821.3 4831.1 4373.7 4441.8 4450.6 4519.0 4546.1 4471.4 4477.6 4508.9 4527.4 4557.5 4320.9 4405.7 4419.1 4468.7 4487.0 4457.8 4458.2 4482.4 4484.0 4504.6 4405.0 4411.7 4430.5 4434.8 4476.8 4583.3 4597.5 4662.9 4779.2 4836.9 4968.4 4974.9 4979.3 4983.1 5013.9 4979.2 4986.2 4986.8 4986.8 5028.2 4672.0 4696.8 4729.2 4825.4 4883.5 5267.3 5269.7 5273.6 5324.7 5336.8 5017.9 5039.3 5043.8 5073.2 5100.1 5022.4 5067.0 5128.1 5157.7 5180.9 5097.4 5104.6 5114.6 5184.9 5185.9 5066.9 5090.1 5095.2 5112.0 5153.8 4296.9 4410.1 4422.0 4434.5 4499.9 3865.9 3869.3 3908.6 3912.1 3925.2 4488.3 4507.7 4525.4 4529.5 4555.3 5013.7 5136.0 5157.2 5187.6 5257.8 4485.1 4506.8 4536.1 4546.2 4552.3 4671.4 4683.4 4698.4 4705.9 4722.6 4685.9 4792.8 4802.9 4824.9 4845.6 5156.0 5159.6 5170.3 5231.7 5241.7 4829.0 4849.1 4862.4 4869.8 4887.9 4987.7 5071.1 5079.7 5109.5 5121.5 5217.2 5221.1 5222.2 5223.6 5243.7 5018.9 5049.7 5052.6 5075.6 5080.2 4884.3 4947.8 5009.3 5029.5 5042.9 4955.4 4959.8 5004.5 5020.8 5029.0 5074.3 5092.3 5094.8 5110.9 5143.5 4720.7 4904.3 4921.0 4948.8 4958.5 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | [#1] ext.html Cycles:180 Average:47787.44 Median:200793.32 stddev:92308.44 (46.0%) stddev-sans-first:92499.26 09:51:04 INFO - PROCESS | 25513 | Values: 552.9 560.3 568.0 573.0 592.9 35708.1 38656.8 38900.4 39008.4 39271.6 39047.4 39778.8 39844.8 39923.6 39995.2 7657.3 7740.0 7796.1 7818.5 7821.2 7619.9 7771.7 7790.4 7791.7 7793.1 7734.5 7772.1 7833.5 7847.1 7851.8 7720.8 7767.4 7785.4 7805.2 7811.4 7629.7 7672.0 7687.7 7695.3 7732.3 36452.0 36512.6 36820.0 36896.6 36934.6 2378.6 2678.1 2868.2 2911.5 2928.3 25547.7 26937.0 27405.0 27688.3 28371.7 3220.1 3269.8 3290.5 3357.4 3366.0 234248.0 235413.0 236059.0 237054.0 238967.0 32135.0 32804.2 32904.7 33230.3 34265.5 33491.5 33520.0 33698.2 33704.8 33751.8 12971.7 12977.4 13024.7 13031.3 13116.2 10510.2 10665.0 10667.8 10714.1 10811.1 7763.6 7805.5 7808.1 7817.9 7930.5 3012.7 3108.3 3148.4 3162.6 3166.7 858.0 863.7 930.2 946.8 1035.2 28134.2 28512.1 28627.9 28824.7 29003.3 942.9 974.1 983.0 1010.8 1070.4 14916.1 15191.4 15363.5 15376.2 15381.6 406730.0 416010.0 416159.0 417127.0 417211.0 50189.5 50617.7 50806.5 50989.7 51072.7 1190.5 1201.8 1209.8 1213.6 1221.6 27288.5 27997.0 28432.9 28961.7 29125.9 43667.1 43844.3 43878.0 43976.1 43996.3 365074.0 368151.0 370706.0 371352.0 371932.0 25923.6 25969.5 26094.6 26142.9 26201.3 43178.4 43431.3 43795.0 44051.0 44123.0 36124.1 37406.4 37773.9 37897.1 38864.4 36872.8 37818.4 38031.8 38309.0 38539.4 32136.4 34788.7 35366.3 36221.8 37288.3 32050.8 33931.3 34369.0 34725.0 34912.1 26435.6 26717.2 26786.6 26951.5 27008.7 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | [#2] jquery.html Cycles:180 Average:27508.94 Median:446804.50 stddev:72037.68 (16.1%) stddev-sans-first:72210.90 09:51:04 INFO - PROCESS | 25513 | Values: 349.2 352.6 355.1 370.2 372.7 16391.2 17151.5 17315.7 17687.9 17760.8 16131.9 16236.4 16803.4 17007.7 17010.2 4973.2 5168.5 5169.1 5177.7 5181.9 3828.5 5165.3 5749.2 5976.2 6004.6 5955.3 6056.8 6087.7 6088.9 6089.3 6270.5 6590.7 6607.3 6726.4 6748.7 6355.8 6368.6 6417.8 6423.7 6430.4 21910.8 23257.4 24192.8 24302.9 24351.8 1938.6 2024.8 2109.6 2128.8 2591.2 13828.6 14398.3 14862.6 14865.6 15418.8 1911.7 1930.4 1996.4 1999.4 2032.1 84651.6 85280.0 86480.0 88562.0 88739.1 16035.4 16293.7 16685.7 17102.7 17173.7 29089.1 29219.6 29252.0 29351.7 29433.4 8308.4 8389.4 8471.2 8626.3 8741.0 6731.2 6738.6 6929.5 6969.2 6983.4 8031.9 8621.1 8660.3 8776.2 8821.7 1489.6 1586.6 1595.8 3324.0 3381.3 800.3 819.5 836.3 977.6 980.1 16683.3 17449.5 17459.2 17580.5 17865.0 841.6 854.4 863.6 873.8 896.4 9092.3 9917.8 9932.5 9977.2 10004.0 415312.0 415667.0 444882.0 448727.0 451701.0 82544.6 84154.0 85723.0 85731.0 86685.6 911.3 916.4 935.7 937.4 943.9 15706.9 15743.9 16267.3 16425.4 16562.3 38173.6 38849.8 38920.8 38967.0 39257.0 48358.8 53486.5 54559.5 55284.2 55578.0 6339.7 6731.7 6909.0 6924.9 7505.7 11236.2 11463.1 11494.3 11610.0 11689.6 9993.5 10241.9 10311.2 10541.1 10882.7 9729.3 10243.8 10418.9 10776.7 10855.4 10091.8 10686.7 10694.0 10713.0 11091.9 7478.6 7482.7 7487.3 7706.8 7715.7 5045.9 9175.5 10595.6 10639.1 11001.2 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | [#3] mootools.html Cycles:180 Average:5014.45 Median:5291.92 stddev:2788.71 (52.7%) stddev-sans-first:2782.87 09:51:04 INFO - PROCESS | 25513 | Values: 1342.0 1386.0 1446.5 1622.8 1640.8 6645.4 7060.3 7440.8 7453.3 7532.6 7505.2 7775.3 7776.5 7782.2 7792.4 2122.6 2147.4 2153.6 2164.1 2172.8 2069.7 2123.4 2164.6 2166.3 2173.8 2100.5 2128.4 2132.1 2133.4 2137.5 2126.7 2144.7 2146.0 2148.6 2150.0 2057.2 2095.7 2112.7 2115.4 2116.4 7816.1 7824.2 7834.7 7845.6 7895.7 4401.3 4427.5 4436.4 4444.6 4459.6 2769.3 2804.5 2805.9 2833.2 2909.7 908.4 945.5 958.7 963.1 975.1 10346.3 10366.9 10404.4 10408.4 10430.7 3876.2 4026.3 4152.0 4161.8 4203.0 8863.4 8889.6 8894.2 8901.1 8901.4 4506.5 4510.1 4510.4 4513.6 4521.2 3525.6 3969.1 4079.9 4097.2 4109.1 3473.7 3567.2 3587.6 3669.9 3670.9 1142.8 1152.4 1166.6 1177.5 1183.4 639.8 678.4 708.9 714.8 763.9 5053.8 5066.3 5202.5 5282.4 5301.4 836.3 845.4 868.0 883.9 903.4 3465.3 3672.7 3693.0 3715.1 3798.5 8560.1 8968.4 9060.1 9078.5 9112.0 8992.1 9004.8 9012.7 9022.1 9043.9 7145.3 7259.2 7280.9 7293.5 7362.0 5209.6 5265.3 5396.6 5441.8 5530.8 8889.5 8983.7 8992.8 8993.9 9010.1 8453.1 8863.4 8869.1 9093.1 9097.3 5879.8 6389.0 6500.1 6587.4 6742.8 7243.6 7270.3 7304.6 7309.7 7314.2 6384.3 6565.1 6682.0 6708.6 6912.6 6263.1 6647.8 6650.6 6766.4 6799.5 5827.6 6044.7 6047.6 6051.6 6052.6 4394.7 4449.2 4451.4 4500.5 4543.3 4306.7 4392.0 4437.6 4518.3 4555.7 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | [#4] prototype.html Cycles:180 Average:4427.98 Median:5102.54 stddev:1291.33 (25.3%) stddev-sans-first:1257.22 09:51:04 INFO - PROCESS | 25513 | Values: 299.1 301.2 302.6 303.7 305.7 5129.4 5139.7 5154.9 5159.4 5177.9 5033.0 5045.3 5062.1 5071.7 5079.4 3728.6 3855.0 3934.9 3941.9 3968.2 3918.5 3946.6 3948.2 3988.4 3990.5 3958.9 3963.4 3970.6 3972.1 3973.9 3823.2 3919.7 3932.5 3988.9 3994.9 3462.1 3469.9 3470.5 3471.5 3483.1 4936.8 4944.9 4959.8 4977.7 5008.3 4410.7 4557.8 4576.5 4589.1 4593.9 5252.0 5264.9 5300.8 5307.7 5339.9 3807.1 3826.7 3838.4 3849.3 3856.9 5449.8 5524.9 5585.1 5606.2 5607.7 3900.7 3902.5 3928.7 3939.7 3949.3 3984.9 3995.5 4001.6 4007.1 4008.4 4541.3 4543.5 4543.8 4547.2 4561.3 5152.2 5310.8 5320.2 5346.9 5353.6 1356.3 1365.5 1376.9 1378.6 1380.0 855.3 898.6 899.1 907.7 912.8 4445.5 4533.6 4670.9 4672.3 4688.2 5470.6 5483.4 5487.6 5497.4 5544.9 4649.0 4662.9 4696.0 4709.4 4714.7 2766.0 2909.3 2912.0 2937.4 2945.0 5142.3 5154.6 5179.8 5194.7 5200.5 5337.3 5619.9 5639.0 5660.3 5660.7 5128.2 5131.5 5137.6 5138.4 5142.0 5530.7 5550.8 5555.4 5575.4 5594.9 5202.6 5399.4 5415.6 5426.8 5490.6 5134.8 5136.5 5161.4 5162.7 5175.2 3764.5 3787.8 3799.7 3813.7 3814.0 5381.8 5520.8 5539.8 5564.2 5626.9 5341.5 5355.2 5360.4 5368.4 5380.2 5333.0 5354.4 5363.4 5364.2 5381.7 4989.9 5192.7 5253.2 5254.7 5268.8 5125.7 5214.2 5336.3 5379.8 5392.2 5226.0 5251.0 5254.5 5257.5 5264.2 09:51:04 INFO - PROCESS | 25513 | 09:51:04 INFO - PROCESS | 25513 | [#5] yui.html Cycles:180 Average:16905.64 Median:32096.56 stddev:24492.12 (76.3%) stddev-sans-first:24530.24 09:51:04 INFO - PROCESS | 25513 | Values: 604.7 667.2 677.2 711.8 715.0 11703.9 12493.9 12568.8 12572.1 12586.9 12317.5 12341.4 12367.9 12369.9 12401.6 632.7 763.3 763.5 764.5 772.3 763.1 786.0 790.9 791.3 792.4 806.6 811.5 811.8 812.6 813.6 799.9 806.5 807.6 809.6 809.7 586.3 590.9 591.3 591.6 593.6 12071.6 12120.7 12179.3 12201.6 12224.2 12521.4 12892.0 12934.1 13047.2 13109.0 9982.2 10053.7 10080.1 10121.9 10155.4 3218.6 3244.1 3269.2 3294.7 3326.0 60547.7 61883.4 62107.7 62110.4 63090.4 9215.8 9263.8 9342.3 9368.7 9468.8 18295.5 18465.7 18549.0 18676.3 20078.1 6569.5 6686.3 6828.6 6900.3 6926.1 3677.9 3682.2 3738.0 3775.9 3779.4 2783.7 2844.7 2875.7 2880.4 2883.9 479.1 486.8 488.3 498.3 498.7 548.1 551.4 569.3 577.3 594.9 7440.4 7512.8 7828.1 7832.0 8024.5 517.4 517.4 518.5 540.0 544.5 3746.9 3802.4 3812.1 3828.9 4081.1 63560.4 93930.0 94072.5 95760.5 97352.5 81223.0 82264.0 83332.6 83625.0 86188.6 68020.0 71008.0 71614.0 71757.3 72246.0 7250.9 7373.6 7419.3 7451.6 7646.7 44636.0 44953.8 45080.0 45569.8 45628.3 57948.0 59743.1 61366.4 63155.0 66162.3 9187.4 9682.9 9709.6 9879.2 9963.3 10848.7 10901.1 11002.8 11086.9 11189.8 9731.0 9920.2 9981.2 9998.7 10031.5 9503.9 9665.0 9686.7 9768.2 9881.3 9651.9 9689.6 9909.2 9918.0 9930.2 8085.8 8409.7 8442.1 8571.4 8585.8 7974.6 8238.1 8447.6 8619.1 8638.5 09:51:04 INFO - PROCESS | 25513 | -------- Summary: end -------- 09:51:04 INFO - PROCESS | 25513 | 09:51:05 INFO - TEST-INFO | 25513: exit 0 09:51:05 INFO - TEST-OK | dromaeo_css | took 1116800ms 09:51:05 INFO - TEST-START | kraken 09:51:05 INFO - operating with platform_type : linux_ 09:51:05 INFO - Initialising browser for kraken test... 09:51:05 INFO - TEST-INFO | started process 25758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWE9sYI/profile http://localhost:55147/getInfo.html) 09:51:08 INFO - PROCESS | 25758 | JavaScript error: , line 0: uncaught exception: undefined 09:51:09 INFO - PROCESS | 25758 | __metrics Screen width/height:1600/1200 09:51:09 INFO - PROCESS | 25758 | colorDepth:24 09:51:09 INFO - PROCESS | 25758 | Browser inner width/height: 1024/697 09:51:09 INFO - PROCESS | 25758 | __metrics 09:51:10 ERROR - PROCESS | 25758 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:51:11 INFO - TEST-INFO | 25758: exit 0 09:51:11 INFO - Browser initialized. 09:51:11 INFO - Running cycle 1/1 for kraken test... 09:51:11 INFO - TEST-INFO | started process 25876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWE9sYI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:23 INFO - PROCESS | 25876 | RSS: Main: 165896192 09:51:23 INFO - PROCESS | 25876 | 09:51:26 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55147/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:27 INFO - PROCESS | 25876 | RSS: Main: 171188224 09:51:27 INFO - PROCESS | 25876 | 09:51:30 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55147/tests/kraken/driver.html?testName=audio-dft) 09:51:30 INFO - PROCESS | 25876 | RSS: Main: 170106880 09:51:30 INFO - PROCESS | 25876 | 09:51:33 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55147/tests/kraken/driver.html?testName=audio-fft) 09:51:34 INFO - PROCESS | 25876 | RSS: Main: 166133760 09:51:34 INFO - PROCESS | 25876 | 09:51:36 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55147/tests/kraken/driver.html?testName=audio-oscillator) 09:51:37 INFO - PROCESS | 25876 | RSS: Main: 167194624 09:51:37 INFO - PROCESS | 25876 | 09:51:39 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:39 INFO - PROCESS | 25876 | RSS: Main: 167628800 09:51:39 INFO - PROCESS | 25876 | 09:51:43 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55147/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:43 INFO - PROCESS | 25876 | RSS: Main: 167731200 09:51:43 INFO - PROCESS | 25876 | 09:51:47 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55147/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:47 INFO - PROCESS | 25876 | RSS: Main: 165003264 09:51:47 INFO - PROCESS | 25876 | 09:51:50 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55147/tests/kraken/driver.html?testName=json-parse-financial) 09:51:51 INFO - PROCESS | 25876 | RSS: Main: 167190528 09:51:51 INFO - PROCESS | 25876 | 09:51:53 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:53 INFO - PROCESS | 25876 | RSS: Main: 167505920 09:51:53 INFO - PROCESS | 25876 | 09:51:55 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:56 INFO - PROCESS | 25876 | RSS: Main: 167571456 09:51:56 INFO - PROCESS | 25876 | 09:51:58 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:59 INFO - PROCESS | 25876 | RSS: Main: 168361984 09:51:59 INFO - PROCESS | 25876 | 09:52:02 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:02 INFO - PROCESS | 25876 | RSS: Main: 168292352 09:52:02 INFO - PROCESS | 25876 | 09:52:05 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:06 INFO - PROCESS | 25876 | RSS: Main: 168370176 09:52:06 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | Cycle 1(1): loaded http://localhost:55147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55147/tests/kraken/driver.html?testName=ai-astar) 09:52:08 INFO - PROCESS | 25876 | RSS: Main: 169308160 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | __start_tp_report 09:52:08 INFO - PROCESS | 25876 | _x_x_mozilla_page_load 09:52:08 INFO - PROCESS | 25876 | _x_x_mozilla_page_load_details 09:52:08 INFO - PROCESS | 25876 | |i|pagename|runs| 09:52:08 INFO - PROCESS | 25876 | |0;ai-astar;104;116;110;115;118;115;123;115;114;115 09:52:08 INFO - PROCESS | 25876 | |1;audio-beat-detection;153;125;156;191;124;157;157;130;187;127 09:52:08 INFO - PROCESS | 25876 | |2;audio-dft;165;164;164;173;169;165;164;165;163;163 09:52:08 INFO - PROCESS | 25876 | |3;audio-fft;76;77;78;182;77;78;76;76;157;78 09:52:08 INFO - PROCESS | 25876 | |4;audio-oscillator;86;85;140;86;87;85;139;86;85;129 09:52:08 INFO - PROCESS | 25876 | |5;imaging-gaussian-blur;117;118;118;118;117;117;118;118;118;117 09:52:08 INFO - PROCESS | 25876 | |6;imaging-darkroom;147;147;152;148;148;147;147;153;148;148 09:52:08 INFO - PROCESS | 25876 | |7;imaging-desaturate;95;98;96;95;95;95;96;97;95;96 09:52:08 INFO - PROCESS | 25876 | |8;json-parse-financial;64;63;63;66;63;62;61;63;62;63 09:52:08 INFO - PROCESS | 25876 | |9;json-stringify-tinderbox;66;67;65;67;67;66;65;65;66;66 09:52:08 INFO - PROCESS | 25876 | |10;stanford-crypto-aes;80;86;81;80;80;81;80;80;82;79 09:52:08 INFO - PROCESS | 25876 | |11;stanford-crypto-ccm;141;138;137;141;146;139;150;151;185;131 09:52:08 INFO - PROCESS | 25876 | |12;stanford-crypto-pbkdf2;171;174;168;169;169;168;175;170;174;170 09:52:08 INFO - PROCESS | 25876 | |13;stanford-crypto-sha256-iterative;69;72;69;66;69;73;68;68;67;67 09:52:08 INFO - PROCESS | 25876 | __end_tp_report 09:52:08 INFO - PROCESS | 25876 | __start_cc_report 09:52:08 INFO - PROCESS | 25876 | _x_x_mozilla_cycle_collect,964 09:52:08 INFO - PROCESS | 25876 | __end_cc_report 09:52:08 INFO - PROCESS | 25876 | __startTimestamp1469638328378__endTimestamp 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | ------- Summary: start ------- 09:52:08 INFO - PROCESS | 25876 | Number of tests: 14 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:4.93 (4.3%) stddev-sans-first:3.46 09:52:08 INFO - PROCESS | 25876 | Values: 104.0 116.0 110.0 115.0 118.0 115.0 123.0 115.0 114.0 115.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.50 stddev:24.54 (15.7%) stddev-sans-first:26.01 09:52:08 INFO - PROCESS | 25876 | Values: 153.0 125.0 156.0 191.0 124.0 157.0 157.0 130.0 187.0 127.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:3.14 (1.9%) stddev-sans-first:3.32 09:52:08 INFO - PROCESS | 25876 | Values: 165.0 164.0 164.0 173.0 169.0 165.0 164.0 165.0 163.0 163.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#3] audio-fft Cycles:10 Average:95.50 Median:77.00 stddev:39.45 (51.2%) stddev-sans-first:41.21 09:52:08 INFO - PROCESS | 25876 | Values: 76.0 77.0 78.0 182.0 77.0 78.0 76.0 76.0 157.0 78.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:85.50 stddev:24.47 (28.6%) stddev-sans-first:25.36 09:52:08 INFO - PROCESS | 25876 | Values: 86.0 85.0 140.0 86.0 87.0 85.0 139.0 86.0 85.0 129.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:52:08 INFO - PROCESS | 25876 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:2.17 (1.5%) stddev-sans-first:2.24 09:52:08 INFO - PROCESS | 25876 | Values: 147.0 147.0 152.0 148.0 148.0 147.0 147.0 153.0 148.0 148.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 09:52:08 INFO - PROCESS | 25876 | Values: 95.0 98.0 96.0 95.0 95.0 95.0 96.0 97.0 95.0 96.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 09:52:08 INFO - PROCESS | 25876 | Values: 64.0 63.0 63.0 66.0 63.0 62.0 61.0 63.0 62.0 63.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 09:52:08 INFO - PROCESS | 25876 | Values: 66.0 67.0 65.0 67.0 67.0 66.0 65.0 65.0 66.0 66.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:1.97 (2.4%) stddev-sans-first:2.06 09:52:08 INFO - PROCESS | 25876 | Values: 80.0 86.0 81.0 80.0 80.0 81.0 80.0 80.0 82.0 79.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:143.50 stddev:15.02 (10.5%) stddev-sans-first:15.83 09:52:08 INFO - PROCESS | 25876 | Values: 141.0 138.0 137.0 141.0 146.0 139.0 150.0 151.0 185.0 131.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:170.50 stddev:2.62 (1.5%) stddev-sans-first:2.77 09:52:08 INFO - PROCESS | 25876 | Values: 171.0 174.0 168.0 169.0 169.0 168.0 175.0 170.0 174.0 170.0 09:52:08 INFO - PROCESS | 25876 | 09:52:08 INFO - PROCESS | 25876 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:2.20 (3.2%) stddev-sans-first:2.33 09:52:08 INFO - PROCESS | 25876 | Values: 69.0 72.0 69.0 66.0 69.0 73.0 68.0 68.0 67.0 67.0 09:52:08 INFO - PROCESS | 25876 | -------- Summary: end -------- 09:52:08 INFO - PROCESS | 25876 | 09:52:09 INFO - TEST-INFO | 25876: exit 0 09:52:09 INFO - TEST-OK | kraken | took 64441ms 09:52:09 INFO - SUITE-END | took 1181s 09:52:10 INFO - Completed test suite (00:19:41) 09:52:10 INFO - javascript benchmark 09:52:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6442.012959623438, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.749508796664, 2641.062422839893, 2673.291577731901, 2675.063727695307, 2690.825096368736, 4710.929336059953, 4774.737389443583, 4805.399325084364, 4807.254875494295, 4856.247281671346, 4778.952210477903, 4796.760161991904, 4801.879953001177, 4821.325014497973, 4831.082094402062, 4373.650107991361, 4441.822327106928, 4450.621697155746, 4518.977405112986, 4546.113507865951, 4471.441069866267, 4477.574630410106, 4508.864734057984, 4527.366168736379, 4557.475890272612, 4320.913581728348, 4405.691601587891, 4419.138268037734, 4468.687191896569, 4486.990427153881, 4457.821687132511, 4458.175237581057, 4482.372467854503, 4484.0, 4504.594586487199, 4404.977975110104, 4411.669124815619, 4430.534793846664, 4434.800433980478, 4476.820927162909, 4583.289590113538, 4597.471290801567, 4662.860114196579, 4779.187538118528, 4836.854894353175, 4968.428630707479, 4974.87562810929, 4979.278004689336, 4983.078130545824, 5013.924791128136, 4979.203327467624, 4986.152354099811, 4986.750662466862, 4986.82546110888, 5028.170351891933, 4671.953280467186, 4696.835610753676, 4729.243321068612, 4825.396825396825, 4883.487233840467, 5267.341582302212, 5269.71016594091, 5273.6044796639635, 5324.680519168863, 5336.759845806948, 5017.89964200714, 5039.294498770175, 5043.773030213649, 5073.213651883964, 5100.132977393852, 5022.397312322471, 5067.0, 5128.1282182029145, 5157.6647517911215, 5180.870478237999, 5097.413797413345, 5104.617153713486, 5114.616403769732, 5184.870378240499, 5185.896282074337, 5066.898662026812, 5090.109230884655, 5095.210242412432, 5111.9899854869445, 5153.819616313411, 4296.871093867189, 4410.051838854662, 4422.0, 4434.5343738907595, 4499.865004049884, 3865.8646947356706, 3869.342211823997, 3908.6286802753693, 3912.080661044652, 3925.2345792570745, 4488.312414502368, 4507.684462087623, 4525.389072475174, 4529.501754806968, 4555.2711566149255, 5013.724245166551, 5135.97432012845, 5157.174852023733, 5187.63686541946, 5257.76340064698, 4485.102979404132, 4506.797194126272, 4536.092781443725, 4546.204414227497, 4552.339910712928, 4671.416072990876, 4683.396411060388, 4698.436187657503, 4705.882352941136, 4722.630437173181, 4685.929711054268, 4792.784324705466, 4802.903941921142, 4824.8793780155775, 4845.63657725672, 5156.0, 5159.638825282344, 5170.250313704567, 5231.686098834082, 5241.685498869928, 4828.975855120702, 4849.102915960559, 4862.3922009748785, 4869.829555965666, 4887.853364398931, 4987.700737955734, 5071.137906555969, 5079.6698214615935, 5109.489051094861, 5121.5221861606815, 5217.217417387422, 5221.112410890082, 5222.216667499905, 5223.5559977402345, 5243.711595862264, 5018.949810501848, 5049.747512624427, 5052.5705315048635, 5075.6193285502995, 5080.212567052113, 4884.267359896044, 4947.82682606107, 5009.298698182184, 5029.5221953914315, 5042.873928151679, 4955.430125535466, 4959.801607935787, 5004.47453017428, 5020.774065167003, 5028.974855125701, 5074.314967479343, 5092.337996060489, 5094.821681241138, 5110.9488905110475, 5143.537081662668, 4720.669553131248, 4904.288878112582, 4920.975395123001, 4948.826791062295, 4958.528939750718], "value": 4728.85028779938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.94939614732, 560.2632538212248, 567.9886402271954, 573.0287163258276, 592.8577141486039, 35708.10729731755, 38656.80671596641, 38900.416493752615, 39008.414873776914, 39271.60728392715, 39047.41428878562, 39778.8011059945, 39844.80077599608, 39923.60076399242, 39995.200095998065, 7657.310842024217, 7739.961300193491, 7796.142424333347, 7818.530888146701, 7821.21787821219, 7619.885701714478, 7771.727989520368, 7790.376769858398, 7791.688332466694, 7793.142754297051, 7734.497257678233, 7772.145064042951, 7833.5299882006975, 7847.097583777853, 7851.764447066568, 7720.806979825549, 7767.378609711238, 7785.3771698264, 7805.219478052178, 7811.375089992844, 7629.732959346452, 7672.0, 7687.654055567513, 7695.268949449794, 7732.3040926316335, 36452.0, 36512.634873651186, 36820.0, 36896.63103368959, 36934.630653693384, 2378.607529757588, 2678.1296078774476, 2868.182567968119, 2911.461379644751, 2928.2679330167457, 25547.744522554724, 26937.0, 27405.0, 27688.307792305353, 28371.716282837115, 3220.1144685211752, 3269.8038117713013, 3290.457074582691, 3357.412452820771, 3366.0, 234248.0, 235413.0, 236058.99999999828, 237054.0, 238967.0, 32135.0, 32804.179895502326, 32904.67095329016, 33230.335393292, 34265.48601770975, 33491.49762753561, 33520.0, 33698.15754606154, 33704.83147584246, 33751.83124084364, 12971.675708107185, 12977.35113244334, 13024.739505209844, 13031.283279419724, 13116.213027218397, 10510.211734119819, 10665.0, 10667.83998240027, 10714.142868570496, 10811.081058110149, 7763.573003484863, 7805.492642978302, 7808.102068262109, 7817.8827317590285, 7930.524168549906, 3012.7137921897383, 3108.347247078139, 3148.449021421242, 3162.5528174290134, 3166.746660267173, 857.9875746618925, 863.6502216602286, 930.1721467893581, 946.8248374050822, 1035.2028937717914, 28134.155975320773, 28512.144635660963, 28627.856860715565, 28824.711752882624, 29003.274918126794, 942.8632848236967, 974.0600320690426, 982.9508524573743, 1010.7978404319166, 1070.4219721350385, 14916.14344632239, 15191.392344306105, 15363.462278820187, 15376.154311512973, 15381.615459613375, 406730.0, 416010.0, 416159.0, 417127.0, 417211.0, 50189.49810501848, 50617.74691126521, 50806.49193508018, 50989.745051274505, 51072.744636277326, 1190.4880901212389, 1201.7536405036947, 1209.7580483903255, 1213.6298428979246, 1221.5724496426358, 27288.454230915668, 27997.0, 28432.85783571069, 28961.7103828959, 29125.85437072886, 43667.126657467306, 43844.34233486564, 43878.0, 43976.12047759091, 43996.34005489984, 365074.0, 368151.0, 370706.0, 371352.0, 371932.0, 25923.611145833205, 25969.48061038731, 26094.60858087092, 26142.86928565421, 26201.34496637523, 43178.35232471453, 43431.34852977271, 43795.0, 44051.0, 44123.0, 36124.09689757777, 37406.438903417016, 37773.86678399653, 37897.105144743204, 38864.417033745085, 36872.81563592165, 37818.43272350972, 38031.809840951726, 38309.04227394338, 38539.42190867083, 32136.35727285488, 34788.65211347854, 35366.29267414586, 36221.81889090538, 37288.254234915694, 32050.83974580112, 33931.321373572886, 34369.0, 34725.0, 34912.127196820285, 26435.603465947643, 26717.198484045508, 26786.59820102739, 26951.460970780867, 27008.72991270141], "value": 16348.656193443025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.1637528120154, 352.6279774837546, 355.0785711079748, 370.18189800540836, 372.6534323079535, 16391.180440977947, 17151.485455436326, 17315.740263896038, 17687.91156044221, 17760.822391776077, 16131.91934040331, 16236.350545978175, 16803.41188058415, 17007.744883826752, 17010.234539445722, 4973.154563724166, 5168.534831865131, 5169.095408303532, 5177.715225662587, 5181.870453238662, 3828.540575130988, 5165.3026841376495, 5749.166370876221, 5976.163337132805, 6004.609700369484, 5955.285365756115, 6056.818295451121, 6087.665178415185, 6088.9391106088815, 6089.299730530979, 6270.467010304107, 6590.703418346162, 6607.339266073378, 6726.3609957054005, 6748.730050797963, 6355.777547785805, 6368.5860419072615, 6417.8395540111405, 6423.7430502779835, 6430.356964303579, 21910.780892191033, 23257.418564535852, 24192.758072419227, 24302.878485607635, 24351.756482435125, 1938.6316599845984, 2024.848136389762, 2109.6097222013977, 2128.8403369747175, 2591.2226332100295, 13828.585142445743, 14398.280085995762, 14862.628434289121, 14865.628359290997, 15418.845811541853, 1911.7132430135453, 1930.4015755115818, 1996.3511858645998, 1999.4201681512488, 2032.1464984706458, 84651.5767421159, 85280.0, 86480.0, 88562.0, 88739.11260887438, 16035.438759643357, 16293.674126517404, 16685.666286674197, 17102.657946840995, 17173.7423938641, 29089.12732618025, 29219.56170657442, 29252.0, 29351.706482934896, 29433.411331773244, 8308.376871734645, 8389.412741108186, 8471.178939639092, 8626.266767324847, 8741.0, 6731.158605174353, 6738.59568425896, 6929.514933954575, 6969.16370035599, 6983.3714965653335, 8031.915691381706, 8621.137886211454, 8660.26387757035, 8776.16626420489, 8821.691240806542, 1489.5531340597777, 1586.5954181683596, 1595.84839440253, 3323.983589702646, 3381.2561236527927, 800.2757504458474, 819.5164852736795, 836.3016880904391, 977.6236149082512, 980.1325826643472, 16683.332666693197, 17449.476515704548, 17459.21433535494, 17580.472585822445, 17865.0, 841.6338892581747, 854.4446110028531, 863.6070587882498, 873.750980970433, 896.3904544909394, 9092.27261819053, 9917.801643967081, 9932.503374831229, 9977.201823854075, 10004.049615286536, 415312.0, 415667.0, 444882.0, 448727.0, 451701.0, 82544.58727706443, 84154.0, 85723.0, 85731.0, 86685.56657216673, 911.2846415563884, 916.4318122763929, 935.7286386947709, 937.376644531379, 943.8631398447187, 15706.9214653926, 15743.921280393524, 16267.349306027627, 16425.425110121567, 16562.254698538836, 38173.61826381701, 38849.80575097106, 38920.8323750288, 38967.0, 39257.0, 48358.758206208746, 53486.465135348146, 54559.454405455435, 55284.170737439774, 55578.0, 6339.683015849097, 6731.697073631601, 6909.0, 6924.861502769816, 7505.737299194502, 11236.213465057368, 11463.082953363544, 11494.252873563191, 11609.955104040677, 11689.649310520357, 9993.450360230258, 10241.948790256001, 10311.175105991653, 10541.104006159256, 10882.727931801768, 9729.270304727315, 10243.84634230502, 10418.895811041793, 10776.67669969902, 10855.434410745387, 10091.848622270818, 10686.73283167927, 10694.037536621741, 10713.0, 11091.944540277247, 7478.551286922802, 7482.738104166328, 7487.251274872469, 7706.845863082819, 7715.691372345268, 5045.9243111352625, 9175.495347755937, 10595.629152979609, 10639.095676867553, 11001.17491188148], "value": 9201.259016093592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.9597412077637, 1385.9584212473624, 1446.4937271954811, 1622.8133764617073, 1640.8304774049577, 6645.435138013263, 7060.293970602944, 7440.8139796504975, 7453.291937265958, 7532.623368831557, 7505.211952744951, 7775.339096176832, 7776.4945278557, 7782.182870798555, 7792.376609871211, 2122.564874200789, 2147.4309308033307, 2153.6015837070113, 2164.0586344939925, 2172.7935846094597, 2069.7205877206534, 2123.4054464749893, 2164.6103701333755, 2166.2959538150085, 2173.804357607815, 2100.527381339202, 2128.3508529898377, 2132.051237199447, 2133.370655656577, 2137.5190582118976, 2126.7447906251273, 2144.7426308842882, 2146.0450099705636, 2148.581026699794, 2149.9677504837364, 2057.1668474267794, 2095.685647152924, 2112.672535756945, 2115.3548167808813, 2116.3968269043403, 7816.140224575292, 7824.217578242187, 7834.686612535492, 7845.568493732842, 7895.723649672292, 4401.273789824675, 4427.53510881356, 4436.423264975565, 4444.622207112399, 4459.643228541709, 2769.3076730817297, 2804.5232310507263, 2805.887764489418, 2833.2208642623236, 2909.7090290970946, 908.3686837647838, 945.5130607737021, 958.7363475044349, 963.0610155098793, 975.1467465967279, 10346.275760696753, 10366.948165259126, 10404.427756473468, 10408.375497470177, 10430.68707938763, 3876.205377897524, 4026.295398305285, 4152.045029643199, 4161.750294982311, 4202.957970420318, 8863.423877448075, 8889.599968001456, 8894.199522043047, 8901.109889011048, 8901.421407608485, 4506.526814684476, 4510.143072816154, 4510.413646225969, 4513.593776560126, 4521.208788462006, 3525.629808870032, 3969.0672691917375, 4079.918401631951, 4097.242010228058, 4109.116539943926, 3473.652634736506, 3567.161716996504, 3587.551556055493, 3669.9266014679556, 3670.926581468356, 1142.7771584540935, 1152.4065106470175, 1166.6091859227083, 1177.4877928101303, 1183.3668987092037, 639.8080575827233, 678.4199509419474, 708.929107089287, 714.8141483214298, 763.9381260048536, 5053.772580233898, 5066.341375621146, 5202.53177214045, 5282.445343238982, 5301.390340110859, 836.3309352517962, 845.3955421873267, 867.9826403471895, 883.9381243313035, 903.4037535226719, 3465.3069386122875, 3672.706183505313, 3692.9630703693156, 3715.0898029982286, 3798.5441746990537, 8560.101189375151, 8968.372213944962, 9060.093990600888, 9078.500682462529, 9112.0, 8992.145746154105, 9004.81990360189, 9012.684556040507, 9022.14289642483, 9043.909560904438, 7145.321194486515, 7259.165196002422, 7280.854382912312, 7293.5259208152365, 7362.0, 5209.630345349816, 5265.341832270966, 5396.622236443412, 5441.7551210196425, 5530.7511161997, 8889.4666320021, 8983.685571004984, 8992.775180620276, 8993.910060899307, 9010.14403631654, 8453.070162282267, 8863.423877447945, 8869.11308869108, 9093.136152065543, 9097.317701172571, 5879.764809407747, 6388.968055159695, 6500.122483464861, 6587.440067594308, 6742.764003259862, 7243.637818109179, 7270.345668889825, 7304.598247096461, 7309.744158954411, 7314.158871729819, 6384.329645387167, 6565.113709649328, 6682.0, 6708.6310252936555, 6912.619805910522, 6263.123162757127, 6647.800565983028, 6650.600963942179, 6766.391024807791, 6799.490038247052, 5827.59206855533, 6044.697765111815, 6047.606905551125, 6051.576389652682, 6052.576319657758, 4394.714343567658, 4449.243628583214, 4451.399061126836, 4500.549945005473, 4543.250363689954, 4306.65546756265, 4392.0, 4437.644988400984, 4518.299663552155, 4555.726656400627], "value": 4042.0971365270066, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.0579674026816, 301.234863446845, 302.6368357970436, 303.6614175194657, 305.7401208972373, 5129.410117836445, 5139.691618502888, 5154.922676159856, 5159.3808742950805, 5177.912638345952, 5033.043721692885, 5045.293658887749, 5062.139436295829, 5071.695698258098, 5079.3904731432185, 3728.552573691161, 3854.9807250963704, 3934.862279820207, 3941.9211615767667, 3968.226195891802, 3918.5101862267215, 3946.585608511108, 3948.2103579284258, 3988.361862102064, 3990.461287726149, 3958.8812335629977, 3963.4054891766177, 3970.563238043813, 3972.106276087886, 3973.880783576483, 3823.235352929425, 3919.6668283195963, 3932.4691166692414, 3988.940165897514, 3994.9001274968214, 3462.082548124749, 3469.8785542505893, 3470.4620783778555, 3471.5313432686517, 3483.1292176955762, 4936.7531623419045, 4944.90110197794, 4959.7768100435205, 4977.676451030671, 5008.270492581515, 4410.735355878657, 4557.840475583339, 4576.519465456146, 4589.1088614173195, 4593.931091033637, 5251.95386675731, 5264.8683782905355, 5300.787968481256, 5307.681539107666, 5339.866503337409, 3807.1243613968663, 3826.7371767316718, 3838.3858582626644, 3849.3263678856088, 3856.917264677099, 5449.754761035723, 5524.889502209933, 5585.134304182858, 5606.187102870061, 5607.663540187561, 3900.687944964396, 3902.512185976753, 3928.705347098979, 3939.6998990333122, 3949.30887094763, 3984.900377490586, 3995.5405128410025, 4001.559828418872, 4007.0783719744622, 4008.3987401889367, 4541.341505481752, 4543.522930092293, 4543.795529201194, 4547.2269714148015, 4561.29299958507, 5152.175651895679, 5310.8141215057285, 5320.201969704575, 5346.861255497832, 5353.634823120079, 1356.3421740455872, 1365.453818472599, 1376.9311534423439, 1378.600205940266, 1380.0, 855.3157474020759, 898.5731777405811, 899.1323372945009, 907.7412937312967, 912.7763697893926, 4445.488768791565, 4533.614642755403, 4670.925687091988, 4672.252439609714, 4688.249880019181, 5470.56235501159, 5483.424240454775, 5487.5609951203805, 5497.422770609029, 5544.944550554524, 4648.953510464919, 4662.883427914261, 4696.0, 4709.3642358281195, 4714.693544919569, 2765.9723402765717, 2909.2726818295428, 2911.956320655192, 2937.383149538578, 2945.013420504112, 5142.305788718475, 5154.634021984177, 5179.8446046618665, 5194.740262986836, 5200.479952004845, 5337.332833395825, 5619.943800562024, 5638.97180514103, 5660.29246344207, 5660.716964151776, 5128.153854613947, 5131.461196574381, 5137.640365174477, 5138.409082955433, 5141.971605678805, 5530.695811730394, 5550.7779688812, 5555.388907220284, 5575.358833734173, 5594.888102237851, 5202.583793296603, 5399.433059528693, 5415.5938304626525, 5426.755795989269, 5490.599897026393, 5134.820281290286, 5136.5377116059735, 5161.354830646169, 5162.716050617252, 5175.223716442413, 3764.454154147688, 3787.791671458096, 3799.7150213733526, 3813.7139714520968, 3814.0, 5381.838544843661, 5520.834374968757, 5539.806106786243, 5564.1931919870585, 5626.887462250814, 5341.531078953163, 5355.196720491957, 5360.410354860885, 5368.40947495783, 5380.192971054373, 5332.96007278577, 5354.36691809002, 5363.417791751364, 5364.222187782671, 5381.650192737459, 4989.900201996013, 5192.727781693509, 5253.23828044939, 5254.710990895537, 5268.762905669178, 5125.692458452505, 5214.165733482625, 5336.306280183551, 5379.784808607612, 5392.218128371443, 5225.973870130625, 5251.0, 5254.474552544715, 5257.5005374489365, 5264.236685680478], "value": 4013.1468023693815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6848105370818, 667.2393471442559, 677.177229665956, 711.8078118907894, 714.9928500714994, 11703.941480292597, 12493.875061249384, 12568.81146782799, 12572.057095717812, 12586.874131258695, 12317.507299708024, 12341.382930853466, 12367.938160309208, 12369.876301236985, 12401.627951161458, 632.7469012395032, 763.3015790551639, 763.4503157726456, 764.4801534956227, 772.2624893226955, 763.1147868472573, 785.9764207073797, 790.8932294140275, 791.2720297326473, 792.4373694676786, 806.6208881825532, 811.4563242627424, 811.7889348769332, 812.569338250728, 813.6297984417076, 799.936005119592, 806.4959400374765, 807.6083099696642, 809.6113865344638, 809.6963638635511, 586.3286536915251, 590.9143174239712, 591.2638764737928, 591.5918016568597, 593.5696619950545, 12071.57749478764, 12120.696982575506, 12179.269243845398, 12201.633950981484, 12224.205426647328, 12521.43653535584, 12892.0, 12934.094613377067, 13047.151935124282, 13109.0, 9982.151517121054, 10053.748656283578, 10080.143187829044, 10121.898781012169, 10155.39067655943, 3218.6459489456142, 3244.0916543367894, 3269.2317305433203, 3294.6870047345465, 3325.96674033259, 60547.69726151341, 61883.381166188214, 62107.68946155286, 62110.37889621136, 63090.36909630937, 9215.815683686289, 9263.768405789775, 9342.346035777566, 9368.67209647659, 9468.810623787485, 18295.54261143482, 18465.7230141548, 18549.0, 18676.34632787873, 20078.09648565818, 6569.507286953498, 6686.3313668632745, 6828.5902845829405, 6900.309969003059, 6926.099607051051, 3677.9080522987138, 3682.1531047859144, 3738.039020753076, 3775.867844625425, 3779.3952967525065, 2783.6937936826935, 2844.672862620825, 2875.7268059534313, 2880.423915216965, 2883.9134825955257, 479.1303783632765, 486.84664330735706, 488.3407400009958, 498.26008377559293, 498.73317774990204, 548.1394211088552, 551.4154995704566, 569.3054473542272, 577.3187638586509, 594.8929192745261, 7440.404767618577, 7512.812179695442, 7828.138904720477, 7832.0, 8024.48045871148, 517.3894804131086, 517.438579141628, 518.5436815602246, 539.9568034557226, 544.5398638150756, 3746.925061498755, 3802.3726085196186, 3812.1232116613332, 3828.8659896903473, 4081.1225586499045, 63560.364396356366, 93930.0, 94072.52963735274, 95760.52119739357, 97352.51323743336, 81223.0, 82264.0, 83332.58333708292, 83625.0, 86188.56905715431, 68020.0, 71008.0, 71614.0, 71757.2824271761, 72246.0, 7250.927490725026, 7373.59445230496, 7419.258074192538, 7451.552906825391, 7646.65590048438, 44636.0, 44953.77523112363, 45080.0, 45569.772151139034, 45628.315575267065, 57948.0, 59743.10385344137, 61366.38633613785, 63155.0, 66162.33837661562, 9187.356885017985, 9682.9031709682, 9709.6116155353, 9879.20966322678, 9963.302568820403, 10848.67453976382, 10901.127909767358, 11002.779944400907, 11086.889131108586, 11189.832152517556, 9731.0, 9920.156786672926, 9981.15160211361, 9998.700038998843, 10031.54730854273, 9503.904960950578, 9665.0, 9686.70939871805, 9768.218542516724, 9881.308308418342, 9651.947331398178, 9689.563969621244, 9909.157721593745, 9918.0, 9930.205583553443, 8085.782208282445, 8409.705660301861, 8442.071372148936, 8571.357148213785, 8585.785355366166, 7974.601269936364, 8238.093809680811, 8447.619857106321, 8619.094995025684, 8638.45190032024], "value": 6193.070306668011, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 110.0, 115.0, 118.0, 115.0, 123.0, 115.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 156.0, 191.0, 124.0, 157.0, 157.0, 130.0, 187.0, 127.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 173.0, 169.0, 165.0, 164.0, 165.0, 163.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 182.0, 77.0, 78.0, 76.0, 76.0, 157.0, 78.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 140.0, 86.0, 87.0, 85.0, 139.0, 86.0, 85.0, 129.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 152.0, 148.0, 148.0, 147.0, 147.0, 153.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 66.0, 63.0, 62.0, 61.0, 63.0, 62.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 67.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 81.0, 80.0, 80.0, 81.0, 80.0, 80.0, 82.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 137.0, 141.0, 146.0, 139.0, 150.0, 151.0, 185.0, 131.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 168.0, 169.0, 169.0, 168.0, 175.0, 170.0, 174.0, 170.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 69.0, 66.0, 69.0, 73.0, 68.0, 68.0, 67.0, 67.0], "value": 68.8, "unit": "score"}]}]} 09:52:10 INFO - Return code: 0 09:52:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:10 ERROR - # TBPL SUCCESS # 09:52:10 INFO - Running post-action listener: _resource_record_post_action 09:52:10 INFO - [mozharness: 2016-07-27 16:52:10.179138Z] Finished run-tests step (success) 09:52:10 INFO - Running post-run listener: _resource_record_post_run 09:52:10 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 548302848; Read time: 0; Write time: 391892 09:52:10 INFO - TinderboxPrint: CPU usage
13.3% 09:52:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:52:10 INFO - TinderboxPrint: I/O write bytes / time
548,302,848 / 391,892 09:52:10 INFO - TinderboxPrint: CPU idle
8,286.2 (86.7%) 09:52:10 INFO - TinderboxPrint: CPU user
1,216.1 (12.7%) 09:52:10 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246362112; Read time: 0; Write time: 182608 09:52:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 301940736; Read time: 0; Write time: 209284 09:52:10 INFO - Running post-run listener: _upload_blobber_files 09:52:10 INFO - Blob upload gear active. 09:52:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:10 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 09:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:52:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:14 INFO - (blobuploader) - INFO - Done attempting. 09:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:15 INFO - (blobuploader) - INFO - Done attempting. 09:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:15 INFO - (blobuploader) - INFO - Done attempting. 09:52:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:15 INFO - Return code: 0 09:52:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/349f422e7675016595fd19eeca6016b77defcef4ef83b38a7f407878ae4958f565037a925d202ab4fc4b9e77ceaf483eeb38e6ab738b73dbad4d6881797265fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/71abf0446fa1904b3027da8a2343a37c250226a32f885e42c0749888fb8f118f45f568e9e45c30cbb9c08f46bd0ebe1db7c8d9c2f4ca1f2494774eafc9fc2540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/56d5242130ae9605028474a9a3a4f7d7b82f7a0143bec6fadc857304d61263017ae799206178a1f1afa3fe73bac42d701427808d02028be6e615411fa82aee34"} 09:52:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:15 INFO - Contents: 09:52:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/349f422e7675016595fd19eeca6016b77defcef4ef83b38a7f407878ae4958f565037a925d202ab4fc4b9e77ceaf483eeb38e6ab738b73dbad4d6881797265fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/71abf0446fa1904b3027da8a2343a37c250226a32f885e42c0749888fb8f118f45f568e9e45c30cbb9c08f46bd0ebe1db7c8d9c2f4ca1f2494774eafc9fc2540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/56d5242130ae9605028474a9a3a4f7d7b82f7a0143bec6fadc857304d61263017ae799206178a1f1afa3fe73bac42d701427808d02028be6e615411fa82aee34"} 09:52:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:15 INFO - Copying logs to upload dir... 09:52:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.311324 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-27 09:52:15.825828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 09:52:15.829449) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680 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/Autoland-Non-PGO/sha512/349f422e7675016595fd19eeca6016b77defcef4ef83b38a7f407878ae4958f565037a925d202ab4fc4b9e77ceaf483eeb38e6ab738b73dbad4d6881797265fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/71abf0446fa1904b3027da8a2343a37c250226a32f885e42c0749888fb8f118f45f568e9e45c30cbb9c08f46bd0ebe1db7c8d9c2f4ca1f2494774eafc9fc2540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/56d5242130ae9605028474a9a3a4f7d7b82f7a0143bec6fadc857304d61263017ae799206178a1f1afa3fe73bac42d701427808d02028be6e615411fa82aee34"} build_url:https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/OXN65moXRT25kZYSm-cd3w/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/Autoland-Non-PGO/sha512/349f422e7675016595fd19eeca6016b77defcef4ef83b38a7f407878ae4958f565037a925d202ab4fc4b9e77ceaf483eeb38e6ab738b73dbad4d6881797265fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/71abf0446fa1904b3027da8a2343a37c250226a32f885e42c0749888fb8f118f45f568e9e45c30cbb9c08f46bd0ebe1db7c8d9c2f4ca1f2494774eafc9fc2540", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/56d5242130ae9605028474a9a3a4f7d7b82f7a0143bec6fadc857304d61263017ae799206178a1f1afa3fe73bac42d701427808d02028be6e615411fa82aee34"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 09:52:15.855221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:52:15.855554) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469637095.77200-187279680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 09:52:15.939137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 09:52:15.939461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 09:52:15.939767) ========= ========= Total master_lag: 0.17 =========