builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1469725815.5 results: success (0) buildid: 20160728084326 builduid: fe0bee7877a341fbac378305a1254f12 revision: 9ec789c0ee5bd3a5e765513c21027fdad953b022 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.503782) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.504314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.504623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.543605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.544010) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 10:10:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2016-07-28 10:10:16 (32.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.639229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.639575) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.690147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:15.690575) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ec789c0ee5bd3a5e765513c21027fdad953b022 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9ec789c0ee5bd3a5e765513c21027fdad953b022 --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=5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 10:10:16,181 truncating revision to first 12 chars 2016-07-28 10:10:16,181 Setting DEBUG logging. 2016-07-28 10:10:16,181 attempt 1/10 2016-07-28 10:10:16,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ec789c0ee5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 10:10:16,497 unpacking tar archive at: mozilla-central-9ec789c0ee5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:16.347955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:16.348260) ========= script_repo_revision: 9ec789c0ee5bd3a5e765513c21027fdad953b022 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:16.349156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:16.349482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 10:10:16.359667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-28 10:10:16.359987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:10:16 INFO - MultiFileLogger online at 20160728 10:10:16 in /builds/slave/test 10:10:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:10:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:10:16 INFO - {'append_to_log': False, 10:10:16 INFO - 'base_work_dir': '/builds/slave/test', 10:10:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:10:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:10:16 INFO - 'branch': 'Firefox-Non-PGO', 10:10:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:10:16 INFO - 'config_files': ('talos/linux_config.py',), 10:10:16 INFO - 'default_actions': ('clobber', 10:10:16 INFO - 'read-buildbot-config', 10:10:16 INFO - 'download-and-extract', 10:10:16 INFO - 'populate-webroot', 10:10:16 INFO - 'create-virtualenv', 10:10:16 INFO - 'install', 10:10:16 INFO - 'run-tests'), 10:10:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:10:16 INFO - 'download_minidump_stackwalk': True, 10:10:16 INFO - 'download_symbols': 'ondemand', 10:10:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:10:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:10:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:10:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:10:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:10:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:10:16 INFO - 'installer_path': 'installer.exe', 10:10:16 INFO - 'log_level': 'info', 10:10:16 INFO - 'log_name': 'talos', 10:10:16 INFO - 'log_to_console': True, 10:10:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:10:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:10:16 INFO - 'opt_config_files': (), 10:10:16 INFO - 'pip_index': False, 10:10:16 INFO - 'sps_profile': False, 10:10:16 INFO - 'sps_profile_interval': 0, 10:10:16 INFO - 'suite': 'dromaeojs-e10s', 10:10:16 INFO - 'system_bits': '32', 10:10:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:10:16 INFO - 'title': 'talos-linux64-ix-011', 10:10:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:10:16 INFO - 'use_talos_json': True, 10:10:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:10:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:10:16 INFO - 'work_dir': 'build'} 10:10:16 INFO - [mozharness: 2016-07-28 17:10:16.934278Z] Running clobber step. 10:10:16 INFO - Running pre-action listener: _resource_record_pre_action 10:10:16 INFO - Running main action method: clobber 10:10:16 INFO - rmtree: /builds/slave/test/build 10:10:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:10:17 INFO - Running post-action listener: _resource_record_post_action 10:10:17 INFO - [mozharness: 2016-07-28 17:10:17.412837Z] Finished clobber step (success) 10:10:17 INFO - [mozharness: 2016-07-28 17:10:17.412938Z] Running read-buildbot-config step. 10:10:17 INFO - Running pre-action listener: _resource_record_pre_action 10:10:17 INFO - Running main action method: read_buildbot_config 10:10:17 INFO - Using buildbot properties: 10:10:17 INFO - { 10:10:17 INFO - "project": "", 10:10:17 INFO - "product": "firefox", 10:10:17 INFO - "script_repo_revision": "production", 10:10:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:10:17 INFO - "repository": "", 10:10:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:10:17 INFO - "buildid": "20160728084326", 10:10:17 INFO - "pgo_build": "False", 10:10:17 INFO - "basedir": "/builds/slave/test", 10:10:17 INFO - "buildnumber": 142, 10:10:17 INFO - "slavename": "talos-linux64-ix-011", 10:10:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:10:17 INFO - "platform": "ubuntu64_hw", 10:10:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:10:17 INFO - "branch": "mozilla-central", 10:10:17 INFO - "repo_path": "mozilla-central", 10:10:17 INFO - "revision": "9ec789c0ee5bd3a5e765513c21027fdad953b022", 10:10:17 INFO - "stage_platform": "linux64", 10:10:17 INFO - "builduid": "fe0bee7877a341fbac378305a1254f12", 10:10:17 INFO - "slavebuilddir": "test" 10:10:17 INFO - } 10:10:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:10:17 INFO - Running post-action listener: _resource_record_post_action 10:10:17 INFO - [mozharness: 2016-07-28 17:10:17.415373Z] Finished read-buildbot-config step (success) 10:10:17 INFO - [mozharness: 2016-07-28 17:10:17.415462Z] Running download-and-extract step. 10:10:17 INFO - Running pre-action listener: _resource_record_pre_action 10:10:17 INFO - Running main action method: download_and_extract 10:10:17 INFO - mkdir: /builds/slave/test/build/tests 10:10:17 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')]} 10:10:17 INFO - https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:10:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:10:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:10:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:21 INFO - Downloaded 1361 bytes. 10:10:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:10:21 INFO - Using the following test package requirements: 10:10:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:10:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:10:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:10:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'jsshell-linux-x86_64.zip'], 10:10:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:10:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:10:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:10:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:10:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:10:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:10:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:21 INFO - https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:22 INFO - Downloaded 22749652 bytes. 10:10:22 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'] 10:10:22 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 10:10:23 INFO - Return code: 0 10:10:23 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 10:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:23 INFO - https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:26 INFO - Downloaded 22749652 bytes. 10:10:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:10:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:10:27 INFO - Return code: 0 10:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:27 INFO - https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:28 INFO - Downloaded 14413725 bytes. 10:10:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:10:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:10:28 INFO - Return code: 0 10:10: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')]} 10:10:28 INFO - https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IhrQXkNOTtCRJefmirzOrA/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 10:10:30 INFO - Downloaded 57166151 bytes. 10:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:10:30 INFO - mkdir: /builds/slave/test/properties 10:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:30 INFO - Contents: 10:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:10:30 INFO - Running post-action listener: _resource_record_post_action 10:10:30 INFO - Running post-action listener: set_extra_try_arguments 10:10:30 INFO - [mozharness: 2016-07-28 17:10:30.707141Z] Finished download-and-extract step (success) 10:10:30 INFO - [mozharness: 2016-07-28 17:10:30.707376Z] Running populate-webroot step. 10:10:30 INFO - Running pre-action listener: _resource_record_pre_action 10:10:30 INFO - Running main action method: populate_webroot 10:10:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:30 INFO - '--tppagecycles', 10:10:30 INFO - '7'], 10:10:30 INFO - 'tests': ['tsvgm']}}, 10:10:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:10:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:10:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['damp', 'tps']}, 10:10:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'tests': ['damp', 'tps']}, 10:10:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['dromaeo_dom']}, 10:10:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['basic_compositor_video']}, 10:10:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:10:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['a11yr', 10:10:30 INFO - 'ts_paint', 10:10:30 INFO - 'tpaint', 10:10:30 INFO - 'sessionrestore', 10:10:30 INFO - 'sessionrestore_no_auto_restore', 10:10:30 INFO - 'tabpaint']}, 10:10:30 INFO - 'other-e10s': {'tests': ['a11yr', 10:10:30 INFO - 'ts_paint', 10:10:30 INFO - 'tpaint', 10:10:30 INFO - 'sessionrestore', 10:10:30 INFO - 'sessionrestore_no_auto_restore', 10:10:30 INFO - 'tabpaint']}, 10:10:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:10:30 INFO - 'ts_paint', 10:10:30 INFO - 'tpaint', 10:10:30 INFO - 'sessionrestore', 10:10:30 INFO - 'sessionrestore_no_auto_restore', 10:10:30 INFO - 'tabpaint']}, 10:10:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:10:30 INFO - 'ts_paint', 10:10:30 INFO - 'tpaint', 10:10:30 INFO - 'sessionrestore', 10:10:30 INFO - 'sessionrestore_no_auto_restore', 10:10:30 INFO - 'tabpaint']}, 10:10:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['a11yr', 10:10:30 INFO - 'ts_paint', 10:10:30 INFO - 'tpaint', 10:10:30 INFO - 'sessionrestore', 10:10:30 INFO - 'sessionrestore_no_auto_restore', 10:10:30 INFO - 'tabpaint']}, 10:10:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['a11yr', 10:10:30 INFO - 'ts_paint', 10:10:30 INFO - 'tpaint', 10:10:30 INFO - 'sessionrestore', 10:10:30 INFO - 'sessionrestore_no_auto_restore', 10:10:30 INFO - 'tabpaint']}, 10:10:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['tsvgx', 10:10:30 INFO - 'tsvgr_opacity', 10:10:30 INFO - 'tart', 10:10:30 INFO - 'tscrollx', 10:10:30 INFO - 'cart']}, 10:10:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:10:30 INFO - 'tsvgr_opacity', 10:10:30 INFO - 'tart', 10:10:30 INFO - 'tscrollx', 10:10:30 INFO - 'cart']}, 10:10:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'talos_options': ['--disable-e10s'], 10:10:30 INFO - 'tests': ['tp5o']}, 10:10:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'tests': ['tp5o']}, 10:10:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'talos_options': ['--disable-e10s', 10:10:30 INFO - '--xperf_path', 10:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:30 INFO - 'tests': ['tp5n']}, 10:10:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:30 INFO - 'talos_options': ['--xperf_path', 10:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:30 INFO - 'tests': ['tp5n']}}, 10:10:30 INFO - 'talos.zip': {'path': '', 10:10:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:30 INFO - Running post-action listener: _resource_record_post_action 10:10:30 INFO - [mozharness: 2016-07-28 17:10:30.727188Z] Finished populate-webroot step (success) 10:10:30 INFO - [mozharness: 2016-07-28 17:10:30.727277Z] Running create-virtualenv step. 10:10:30 INFO - Running pre-action listener: _resource_record_pre_action 10:10:30 INFO - Running main action method: create_virtualenv 10:10:30 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10:30 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 10:10:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:30 INFO - Using real prefix '/usr' 10:10:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:31 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:33 INFO - Installing pip.................done. 10:10:33 INFO - Return code: 0 10:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:10:33 INFO - Using env: {'DISPLAY': ':0', 10:10:33 INFO - 'HOME': '/home/cltbld', 10:10:33 INFO - 'LANG': 'en_US.UTF-8', 10:10:33 INFO - 'LANGUAGE': 'en_US:en', 10:10:33 INFO - 'LOGNAME': 'cltbld', 10:10:33 INFO - 'MAIL': '/var/mail/cltbld', 10:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:33 INFO - 'MOZ_NO_REMOTE': '1', 10:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:33 INFO - 'NO_EM_RESTART': '1', 10:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:33 INFO - 'PWD': '/builds/slave/test', 10:10:33 INFO - 'SHELL': '/bin/bash', 10:10:33 INFO - 'SHLVL': '1', 10:10:33 INFO - 'TERM': 'linux', 10:10:33 INFO - 'TMOUT': '86400', 10:10:33 INFO - 'USER': 'cltbld', 10:10:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:33 INFO - '_': '/tools/buildbot/bin/python'} 10:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:10:33 INFO - Cleaning up... 10:10:33 INFO - Return code: 0 10:10:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:10:33 INFO - Using env: {'DISPLAY': ':0', 10:10:33 INFO - 'HOME': '/home/cltbld', 10:10:33 INFO - 'LANG': 'en_US.UTF-8', 10:10:33 INFO - 'LANGUAGE': 'en_US:en', 10:10:33 INFO - 'LOGNAME': 'cltbld', 10:10:33 INFO - 'MAIL': '/var/mail/cltbld', 10:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:33 INFO - 'MOZ_NO_REMOTE': '1', 10:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:33 INFO - 'NO_EM_RESTART': '1', 10:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:33 INFO - 'PWD': '/builds/slave/test', 10:10:33 INFO - 'SHELL': '/bin/bash', 10:10:33 INFO - 'SHLVL': '1', 10:10:33 INFO - 'TERM': 'linux', 10:10:33 INFO - 'TMOUT': '86400', 10:10:33 INFO - 'USER': 'cltbld', 10:10:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:33 INFO - '_': '/tools/buildbot/bin/python'} 10:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:33 INFO - Downloading/unpacking psutil>=3.1.1 10:10:33 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 10:10:33 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 10:10:33 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 10:10:33 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 10:10:33 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 10:10:33 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 10:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:35 INFO - Installing collected packages: psutil 10:10:35 INFO - Running setup.py install for psutil 10:10:35 INFO - building 'psutil._psutil_linux' extension 10:10:35 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 10:10:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:10:36 INFO - building 'psutil._psutil_posix' extension 10:10:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:10:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:36 INFO - Successfully installed psutil 10:10:36 INFO - Cleaning up... 10:10:36 INFO - Return code: 0 10:10:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:36 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')]} 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:36 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')]} 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:36 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 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:36 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 10:10:36 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 10:10:36 INFO - Using env: {'DISPLAY': ':0', 10:10:36 INFO - 'HOME': '/home/cltbld', 10:10:36 INFO - 'LANG': 'en_US.UTF-8', 10:10:36 INFO - 'LANGUAGE': 'en_US:en', 10:10:36 INFO - 'LOGNAME': 'cltbld', 10:10:36 INFO - 'MAIL': '/var/mail/cltbld', 10:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:36 INFO - 'MOZ_NO_REMOTE': '1', 10:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:36 INFO - 'NO_EM_RESTART': '1', 10:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:36 INFO - 'PWD': '/builds/slave/test', 10:10:36 INFO - 'SHELL': '/bin/bash', 10:10:36 INFO - 'SHLVL': '1', 10:10:36 INFO - 'TERM': 'linux', 10:10:36 INFO - 'TMOUT': '86400', 10:10:36 INFO - 'USER': 'cltbld', 10:10:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:36 INFO - '_': '/tools/buildbot/bin/python'} 10:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:38 INFO - Installing collected packages: mozsystemmonitor 10:10:38 INFO - Running setup.py install for mozsystemmonitor 10:10:38 INFO - Successfully installed mozsystemmonitor 10:10:38 INFO - Cleaning up... 10:10:38 INFO - Return code: 0 10:10:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:38 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 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:38 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 10:10:38 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 10:10:38 INFO - Using env: {'DISPLAY': ':0', 10:10:38 INFO - 'HOME': '/home/cltbld', 10:10:38 INFO - 'LANG': 'en_US.UTF-8', 10:10:38 INFO - 'LANGUAGE': 'en_US:en', 10:10:38 INFO - 'LOGNAME': 'cltbld', 10:10:38 INFO - 'MAIL': '/var/mail/cltbld', 10:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:38 INFO - 'MOZ_NO_REMOTE': '1', 10:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:38 INFO - 'NO_EM_RESTART': '1', 10:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:38 INFO - 'PWD': '/builds/slave/test', 10:10:38 INFO - 'SHELL': '/bin/bash', 10:10:38 INFO - 'SHLVL': '1', 10:10:38 INFO - 'TERM': 'linux', 10:10:38 INFO - 'TMOUT': '86400', 10:10:38 INFO - 'USER': 'cltbld', 10:10:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:38 INFO - '_': '/tools/buildbot/bin/python'} 10:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:39 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:10:40 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 10:10:40 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 10:10:40 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 10:10:40 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 10:10:40 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 10:10:40 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 10:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:41 INFO - warning: no files found matching '*.txt' 10:10:41 INFO - no previously-included directories found matching 'build' 10:10:41 INFO - no previously-included directories found matching 'dist' 10:10:41 INFO - no previously-included directories found matching '.git*' 10:10:41 INFO - Installing collected packages: jsonschema, functools32 10:10:41 INFO - Running setup.py install for functools32 10:10:41 INFO - warning: no files found matching '*.txt' 10:10:41 INFO - no previously-included directories found matching 'build' 10:10:41 INFO - no previously-included directories found matching 'dist' 10:10:41 INFO - no previously-included directories found matching '.git*' 10:10:41 INFO - Successfully installed jsonschema functools32 10:10:41 INFO - Cleaning up... 10:10:41 INFO - Return code: 0 10:10:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:10:41 INFO - Using env: {'DISPLAY': ':0', 10:10:41 INFO - 'HOME': '/home/cltbld', 10:10:41 INFO - 'LANG': 'en_US.UTF-8', 10:10:41 INFO - 'LANGUAGE': 'en_US:en', 10:10:41 INFO - 'LOGNAME': 'cltbld', 10:10:41 INFO - 'MAIL': '/var/mail/cltbld', 10:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:41 INFO - 'MOZ_NO_REMOTE': '1', 10:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:41 INFO - 'NO_EM_RESTART': '1', 10:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:41 INFO - 'PWD': '/builds/slave/test', 10:10:41 INFO - 'SHELL': '/bin/bash', 10:10:41 INFO - 'SHLVL': '1', 10:10:41 INFO - 'TERM': 'linux', 10:10:41 INFO - 'TMOUT': '86400', 10:10:41 INFO - 'USER': 'cltbld', 10:10:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:41 INFO - '_': '/tools/buildbot/bin/python'} 10:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:10:41 INFO - Cleaning up... 10:10:41 INFO - Return code: 0 10:10:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:10:41 INFO - Using env: {'DISPLAY': ':0', 10:10:41 INFO - 'HOME': '/home/cltbld', 10:10:41 INFO - 'LANG': 'en_US.UTF-8', 10:10:41 INFO - 'LANGUAGE': 'en_US:en', 10:10:41 INFO - 'LOGNAME': 'cltbld', 10:10:41 INFO - 'MAIL': '/var/mail/cltbld', 10:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:41 INFO - 'MOZ_NO_REMOTE': '1', 10:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:41 INFO - 'NO_EM_RESTART': '1', 10:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:41 INFO - 'PWD': '/builds/slave/test', 10:10:41 INFO - 'SHELL': '/bin/bash', 10:10:41 INFO - 'SHLVL': '1', 10:10:41 INFO - 'TERM': 'linux', 10:10:41 INFO - 'TMOUT': '86400', 10:10:41 INFO - 'USER': 'cltbld', 10:10:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:41 INFO - '_': '/tools/buildbot/bin/python'} 10:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:43 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 10:10:43 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 10:10:43 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 10:10:43 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 10:10:43 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 10:10:43 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 10:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:44 INFO - Downloading docopt-0.6.1.tar.gz 10:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:44 INFO - Running setup.py install for blobuploader 10:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:44 INFO - Running setup.py install for requests 10:10:44 INFO - Running setup.py install for docopt 10:10:45 INFO - Successfully installed blobuploader requests docopt 10:10:45 INFO - Cleaning up... 10:10:45 INFO - Return code: 0 10:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:10:45 INFO - Using env: {'DISPLAY': ':0', 10:10:45 INFO - 'HOME': '/home/cltbld', 10:10:45 INFO - 'LANG': 'en_US.UTF-8', 10:10:45 INFO - 'LANGUAGE': 'en_US:en', 10:10:45 INFO - 'LOGNAME': 'cltbld', 10:10:45 INFO - 'MAIL': '/var/mail/cltbld', 10:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:45 INFO - 'MOZ_NO_REMOTE': '1', 10:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:45 INFO - 'NO_EM_RESTART': '1', 10:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:45 INFO - 'PWD': '/builds/slave/test', 10:10:45 INFO - 'SHELL': '/bin/bash', 10:10:45 INFO - 'SHLVL': '1', 10:10:45 INFO - 'TERM': 'linux', 10:10:45 INFO - 'TMOUT': '86400', 10:10:45 INFO - 'USER': 'cltbld', 10:10:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:45 INFO - '_': '/tools/buildbot/bin/python'} 10:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:45 INFO - Running setup.py (path:/tmp/pip-izpuQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:45 INFO - Running setup.py (path:/tmp/pip-Q_jF1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:45 INFO - Running setup.py (path:/tmp/pip-8FY4pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:45 INFO - Running setup.py (path:/tmp/pip-NLpd9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:45 INFO - Running setup.py (path:/tmp/pip-7MedD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:45 INFO - Running setup.py (path:/tmp/pip-E1t3SI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:45 INFO - Running setup.py (path:/tmp/pip-kWz8Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:45 INFO - Running setup.py (path:/tmp/pip-9n8QFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:45 INFO - Running setup.py (path:/tmp/pip-ba1GTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:46 INFO - Running setup.py (path:/tmp/pip-bH4TuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:46 INFO - Running setup.py (path:/tmp/pip-GVLRzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:46 INFO - Running setup.py (path:/tmp/pip-njfRWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:46 INFO - Running setup.py (path:/tmp/pip-bnPdY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:46 INFO - Running setup.py (path:/tmp/pip-Ycek3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:46 INFO - Running setup.py (path:/tmp/pip-RLnX8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:46 INFO - Running setup.py (path:/tmp/pip-xMIGZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:46 INFO - Running setup.py (path:/tmp/pip-AcQpn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:46 INFO - Running setup.py install for manifestparser 10:10:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:46 INFO - Running setup.py install for mozcrash 10:10:46 INFO - Running setup.py install for mozdebug 10:10:46 INFO - Running setup.py install for mozdevice 10:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozfile 10:10:47 INFO - Running setup.py install for mozhttpd 10:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozinfo 10:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozInstall 10:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozleak 10:10:47 INFO - Running setup.py install for mozlog 10:10:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for moznetwork 10:10:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozprocess 10:10:47 INFO - Running setup.py install for mozprofile 10:10:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:47 INFO - Running setup.py install for mozrunner 10:10:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:48 INFO - Running setup.py install for mozscreenshot 10:10:48 INFO - Running setup.py install for moztest 10:10:48 INFO - Running setup.py install for mozversion 10:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:48 INFO - Cleaning up... 10:10:48 INFO - Return code: 0 10:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:10:48 INFO - Using env: {'DISPLAY': ':0', 10:10:48 INFO - 'HOME': '/home/cltbld', 10:10:48 INFO - 'LANG': 'en_US.UTF-8', 10:10:48 INFO - 'LANGUAGE': 'en_US:en', 10:10:48 INFO - 'LOGNAME': 'cltbld', 10:10:48 INFO - 'MAIL': '/var/mail/cltbld', 10:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:48 INFO - 'MOZ_NO_REMOTE': '1', 10:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:48 INFO - 'NO_EM_RESTART': '1', 10:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:48 INFO - 'PWD': '/builds/slave/test', 10:10:48 INFO - 'SHELL': '/bin/bash', 10:10:48 INFO - 'SHLVL': '1', 10:10:48 INFO - 'TERM': 'linux', 10:10:48 INFO - 'TMOUT': '86400', 10:10:48 INFO - 'USER': 'cltbld', 10:10:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:48 INFO - '_': '/tools/buildbot/bin/python'} 10:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 INFO - Running setup.py (path:/tmp/pip-U8m3tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 INFO - Running setup.py (path:/tmp/pip-OxeuhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 INFO - Running setup.py (path:/tmp/pip-U6POTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 INFO - Running setup.py (path:/tmp/pip-EVWUxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:48 INFO - Running setup.py (path:/tmp/pip-Sqccyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:48 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)) 10:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:48 INFO - Running setup.py (path:/tmp/pip-QzB0Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:49 INFO - Running setup.py (path:/tmp/pip-LeJx5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:49 INFO - Running setup.py (path:/tmp/pip-j78vhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:49 INFO - Running setup.py (path:/tmp/pip-yhZFUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:49 INFO - Running setup.py (path:/tmp/pip-Bn8DsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 INFO - Running setup.py (path:/tmp/pip-pg18m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 INFO - Running setup.py (path:/tmp/pip-mKuMSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 INFO - Running setup.py (path:/tmp/pip-KE9RIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 INFO - Running setup.py (path:/tmp/pip-6Yec4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:49 INFO - Running setup.py (path:/tmp/pip-zk8AK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:49 INFO - Running setup.py (path:/tmp/pip-z26OLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:49 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)) 10:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:49 INFO - Running setup.py (path:/tmp/pip-EfhXe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 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)) 10:10:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 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 10:10:49 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 10:10:51 INFO - Downloading blessings-1.6.tar.gz 10:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:51 INFO - Installing collected packages: blessings 10:10:51 INFO - Running setup.py install for blessings 10:10:51 INFO - Successfully installed blessings 10:10:51 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:52 INFO - Reading from file tmpfile_stdout 10:10:52 INFO - Current package versions: 10:10:52 INFO - argparse == 1.2.1 10:10:52 INFO - blessings == 1.6 10:10:52 INFO - blobuploader == 1.2.4 10:10:52 INFO - docopt == 0.6.1 10:10:52 INFO - functools32 == 3.2.3-2 10:10:52 INFO - jsonschema == 2.5.1 10:10:52 INFO - manifestparser == 1.1 10:10:52 INFO - mozInstall == 1.12 10:10:52 INFO - mozcrash == 0.17 10:10:52 INFO - mozdebug == 0.1 10:10:52 INFO - mozdevice == 0.48 10:10:52 INFO - mozfile == 1.2 10:10:52 INFO - mozhttpd == 0.7 10:10:52 INFO - mozinfo == 0.9 10:10:52 INFO - mozleak == 0.1 10:10:52 INFO - mozlog == 3.3 10:10:52 INFO - moznetwork == 0.27 10:10:52 INFO - mozprocess == 0.23 10:10:52 INFO - mozprofile == 0.28 10:10:52 INFO - mozrunner == 6.12 10:10:52 INFO - mozscreenshot == 0.1 10:10:52 INFO - mozsystemmonitor == 0.3 10:10:52 INFO - moztest == 0.7 10:10:52 INFO - mozversion == 1.4 10:10:52 INFO - psutil == 3.1.1 10:10:52 INFO - requests == 1.2.3 10:10:52 INFO - wsgiref == 0.1.2 10:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:10:52 INFO - Using env: {'DISPLAY': ':0', 10:10:52 INFO - 'HOME': '/home/cltbld', 10:10:52 INFO - 'LANG': 'en_US.UTF-8', 10:10:52 INFO - 'LANGUAGE': 'en_US:en', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MAIL': '/var/mail/cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SHLVL': '1', 10:10:52 INFO - 'TERM': 'linux', 10:10:52 INFO - 'TMOUT': '86400', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - '_': '/tools/buildbot/bin/python'} 10:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1157030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1386400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, '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': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', '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 10:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:10:52 INFO - Using env: {'DISPLAY': ':0', 10:10:52 INFO - 'HOME': '/home/cltbld', 10:10:52 INFO - 'LANG': 'en_US.UTF-8', 10:10:52 INFO - 'LANGUAGE': 'en_US:en', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MAIL': '/var/mail/cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SHLVL': '1', 10:10:52 INFO - 'TERM': 'linux', 10:10:52 INFO - 'TMOUT': '86400', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - '_': '/tools/buildbot/bin/python'} 10:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Running post-action listener: _resource_record_post_action 10:10:52 INFO - Running post-action listener: _start_resource_monitoring 10:10:52 INFO - Starting resource monitoring. 10:10:52 INFO - [mozharness: 2016-07-28 17:10:52.694508Z] Finished create-virtualenv step (success) 10:10:52 INFO - [mozharness: 2016-07-28 17:10:52.694986Z] Running install step. 10:10:52 INFO - Running pre-action listener: _resource_record_pre_action 10:10:52 INFO - Running main action method: install 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:52 INFO - Reading from file tmpfile_stdout 10:10:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:52 INFO - Reading from file tmpfile_stdout 10:10:52 INFO - Output received: 10:10:52 INFO - Usage: mozinstall [options] installer 10:10:52 INFO - Options: 10:10:52 INFO - -h, --help show this help message and exit 10:10:52 INFO - -d DEST, --destination=DEST 10:10:52 INFO - Directory to install application into. [default: 10:10:52 INFO - "/builds/slave/test"] 10:10:52 INFO - --app=APP Application being installed. [default: firefox] 10:10:52 INFO - mkdir: /builds/slave/test/build/application 10:10:52 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'] 10:10:52 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 10:11:09 INFO - Reading from file tmpfile_stdout 10:11:09 INFO - Output received: 10:11:09 INFO - /builds/slave/test/build/application/firefox/firefox 10:11:09 INFO - Running post-action listener: _resource_record_post_action 10:11:09 INFO - [mozharness: 2016-07-28 17:11:09.409171Z] Finished install step (success) 10:11:09 INFO - [mozharness: 2016-07-28 17:11:09.409509Z] Running run-tests step. 10:11:09 INFO - Running pre-action listener: _resource_record_pre_action 10:11:09 INFO - Running main action method: run_tests 10:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:11:09 INFO - Python 2.7.3 10:11:09 INFO - Return code: 0 10:11:09 INFO - grabbing minidump binary from tooltool 10:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1415570>, '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 0x1416470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1416900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:11:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:11:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:11:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:11:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:11:09 INFO - Return code: 0 10:11:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:11:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:11:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 10:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 10:11:09 INFO - Using env: {'DISPLAY': ':0', 10:11:09 INFO - 'HOME': '/home/cltbld', 10:11:09 INFO - 'LANG': 'en_US.UTF-8', 10:11:09 INFO - 'LANGUAGE': 'en_US:en', 10:11:09 INFO - 'LOGNAME': 'cltbld', 10:11:09 INFO - 'MAIL': '/var/mail/cltbld', 10:11:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:09 INFO - 'MOZ_NO_REMOTE': '1', 10:11:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:09 INFO - 'NO_EM_RESTART': '1', 10:11:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:09 INFO - 'PWD': '/builds/slave/test', 10:11:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:09 INFO - 'SHELL': '/bin/bash', 10:11:09 INFO - 'SHLVL': '1', 10:11:09 INFO - 'TERM': 'linux', 10:11:09 INFO - 'TMOUT': '86400', 10:11:09 INFO - 'USER': 'cltbld', 10:11:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837', 10:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:09 INFO - '_': '/tools/buildbot/bin/python'} 10:11:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 10:11:09 INFO - mozversion application_buildid: 20160728084326 10:11:09 INFO - mozversion application_changeset: 9ec789c0ee5bd3a5e765513c21027fdad953b022 10:11:09 INFO - mozversion application_display_name: Nightly 10:11:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:11:09 INFO - mozversion application_name: Firefox 10:11:09 INFO - mozversion application_remotingname: firefox 10:11:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:11:09 INFO - mozversion application_vendor: Mozilla 10:11:09 INFO - mozversion application_version: 50.0a1 10:11:09 INFO - mozversion platform_buildid: 20160728084326 10:11:09 INFO - mozversion platform_changeset: 9ec789c0ee5bd3a5e765513c21027fdad953b022 10:11:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:11:09 INFO - mozversion platform_version: 50.0a1 10:11:09 INFO - using testdate: 1469725869 10:11:09 INFO - actual date: 1469725869 10:11:09 INFO - starting webserver on 'localhost:47704' 10:11:09 INFO - SUITE-START | Running 2 tests 10:11:09 INFO - TEST-START | dromaeo_css 10:11:09 INFO - operating with platform_type : linux_ 10:11:09 INFO - Initialising browser for dromaeo_css test... 10:11:09 INFO - TEST-INFO | started process 3052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR9_Yer/profile http://localhost:47704/getInfo.html) 10:11:13 INFO - PROCESS | 3052 | JavaScript error: , line 0: uncaught exception: undefined 10:11:15 INFO - PROCESS | 3052 | __metrics Screen width/height:1600/1200 10:11:15 INFO - PROCESS | 3052 | colorDepth:24 10:11:15 INFO - PROCESS | 3052 | Browser inner width/height: 1024/697 10:11:15 INFO - PROCESS | 3052 | __metrics 10:11:16 ERROR - PROCESS | 3052 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:11:17 INFO - TEST-INFO | 3052: exit 0 10:11:17 INFO - Browser initialized. 10:11:17 INFO - Running cycle 1/1 for dromaeo_css test... 10:11:17 INFO - TEST-INFO | started process 3168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR9_Yer/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:29 INFO - PROCESS | 3168 | RSS: Main: 165965824 10:11:29 INFO - PROCESS | 3168 | 10:12:18 INFO - PROCESS | 3168 | 1469725938885 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] 10:14:30 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47704/tests/dromaeo/cssquery-ext.html) 10:14:32 INFO - PROCESS | 3168 | RSS: Main: 168796160 10:14:32 INFO - PROCESS | 3168 | 10:17:34 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-ext.html (next: http://localhost:47704/tests/dromaeo/cssquery-jquery.html) 10:17:35 INFO - PROCESS | 3168 | RSS: Main: 167714816 10:17:35 INFO - PROCESS | 3168 | 10:20:37 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47704/tests/dromaeo/cssquery-mootools.html) 10:20:38 INFO - PROCESS | 3168 | RSS: Main: 171401216 10:20:38 INFO - PROCESS | 3168 | 10:23:40 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47704/tests/dromaeo/cssquery-prototype.html) 10:23:40 INFO - PROCESS | 3168 | RSS: Main: 165859328 10:23:40 INFO - PROCESS | 3168 | 10:26:43 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47704/tests/dromaeo/cssquery-yui.html) 10:26:44 INFO - PROCESS | 3168 | RSS: Main: 167911424 10:26:44 INFO - PROCESS | 3168 | 10:29:46 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:47704/tests/dromaeo/cssquery-yui.html (next: http://localhost:47704/tests/dromaeo/cssquery-dojo.html) 10:29:47 INFO - PROCESS | 3168 | RSS: Main: 171036672 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | __start_tp_report 10:29:47 INFO - PROCESS | 3168 | _x_x_mozilla_page_load 10:29:47 INFO - PROCESS | 3168 | _x_x_mozilla_page_load_details 10:29:47 INFO - PROCESS | 3168 | |i|pagename|runs| 10:29:47 INFO - PROCESS | 3168 | |0;dojo.html;2641.8414895106293;2660.8536530490837;2673.157955244099;2681.6916054653716;2709.065372446505;4691.038337140886;4879.999999999995;4886.780094895729;4945.975270123648;4947.777350019249;4795.064962332338;4821.180399332113;4828.73441960692;4851.102546028978;4895.485973972735;4443.82224711012;4527.230370836965;4540.568645978627;4580.1984652685815;4655.953440465586;4579.67942244043;4589.059242855206;4605.838795642153;4609;4631.536846315358;4357.1721372939355;4402.845900393503;4525.275955847082;4526.23054080807;4610.4467463904375;4424.491183513905;4478.619317358029;4491.214037543449;4528.230200865861;4537.795799189012;4413.955860441387;4453.376527286183;4468.687191896569;4481.507034226265;4487.259602165639;4696.107739529479;4779.80880764769;4795.352627395292;4857.489963553847;4863.465018847924;5235.58115350771;5248;5285;5306.575473962073;5319.813806516792;5305.681659100466;5307.177387504943;5318.22885681574;5329.893402131975;5374.7850085996515;4686.390769199982;4740.715557066587;4935.481774413706;4950.653454258168;4953.479884612136;5235.685858848481;5295.4969277918535;5299.072662284085;5344.091504444254;5344.412114667383;5080.237964305384;5093;5097.1844504879045;5097.235414687826;5132.871678208075;5019.322391477177;5046.545810876965;5156;5158.613104017214;5167.560757335594;5145.048166089286;5164.1995490699;5169.974150129226;5196.68819870809;5249.527542521115;5124.923126153036;5152.7166005869285;5179.61152913533;5185.662931909414;5235.05768961583;4243.8090285937205;4348.956510434855;4360.607545320936;4420.778961051935;4449.688521803443;3739.1960728442973;3759.9060023499633;3785.242951409729;3818.770873747584;3872.8838134856;4414.624756895636;4451.532589078165;4453.376527286183;4485.215087359764;4496.235639941217;5004.974975125101;5126.871828204325;5160.587153027749;5168.3539557555305;5177.119889618773;4385.407969924019;4438.023634800339;4438.090191510732;4456.710313829591;4490.618297444688;4610.492845786961;4622.86131416058;4640.257558790578;4658.068386322749;4687.484376718558;4686.5782079613;4785.971016231527;4790.664653474223;4807.879803004953;4876.512348765095;5150.201718733602;5201.973990130025;5222.634415590872;5255.290535777621;5293.7353132344;4857.101436234308;4881.219004959189;4884.291777692286;4895.265710143507;4896.853094407174;4904.166291730343;5087.13518701829;5093.006863661551;5103.591712662904;5122.078025955364;5037.269595908646;5069.391672999263;5095.87260318495;5101.362329708786;5102.821401250939;4901.607871370353;4942.851714448572;4957.925631115609;4970.403551573834;4981.501849814989;4939.456659767351;4972.005598880166;4982.277569752293;5024.271480635214;5073.137566613611;4861.756912154307;4902.3872015998;4912.140375434356;4922.4339200992345;4976.726280054487;4915.5330243626795;5030;5040.949590504195;5051.6716413433005;5052.520010598987;4842.176829938849;4888.780004899859;4936.234883593049;4937.432195297587;4949.727764972961 10:29:47 INFO - PROCESS | 3168 | |1;ext.html;554.1161846854266;569.720836789973;576.5070864410928;578.0664227272954;595.0627761275991;35107.824460877695;39483.40774888379;39618;39623.207535849266;39681;40566.7971660142;40998.18003639925;41003.79498102505;41102.58897411025;41146.17707645845;7727.806804829882;7856.764297071097;7868.488548244346;7881.921180788176;7884.80287992799;7844;7866.331361834251;7896.131425543185;7902.446828721992;7930.325922296583;7885.211478852127;7919.881201781949;7925.2867241948215;7938.960305198495;7969.641366138538;7895.921040789604;7932.881006784932;7959.7214097506885;7963.840723185562;7978.880316795253;7625.237476252386;7626.351760100398;7630.923690763132;7680.807979800494;7695.769126926201;37734.05664858373;37750.81124594387;37838.43242351367;37906.81046594749;38115.809420952995;3124.6875312468796;3186.2512309607223;3303.306305675811;3401.897943061712;3525.4183059795105;28901.42197156066;29215.269618259503;30025.549616755765;30071.849640751876;30129.849350753324;3444.603870554868;3521.102118959649;3593.4789455528803;3653.12325041988;3694.4273637586216;258175;259148;259351;260030;261253;31365.843170784;53723.73138134363;54248.728756355966;54364;54395.72802136043;32011.359772804415;33600.15999600029;33627.663723362944;33640.327193455996;33771.49342759861;13582.185068895898;13725.313734313244;13730.862691373159;13748.106373085717;13778.65553361174;11205.66383008511;11310.60412885545;11314;11327.716807079723;11337.659870203906;7741.341985931259;7902.960485197537;7915.287624113857;7973.242541958504;8012.0786109596975;3060.2655362713235;3060.586820779211;3111.2844045869124;3138.764592655514;3171.6194056713343;912.3385545479474;954.1984732824461;967.4630580028152;1001.5392919257223;1007.7128018514688;27695.584566231522;28707.425851482854;29115.708842911725;29251.45474805002;29315.85342073276;926.8609708543637;960.3037797596686;1012.5291739341242;1017.1151098544166;1061.7239517725448;15171.331153573097;15380.615484612974;15514.9224253878;15547.766783498257;15751.921240393955;387925;388497;390277;390387;392458;49091.263631045564;49583;49599.50400495949;49690.254646180336;49862;1151.9078473722082;1157.3403160198607;1197.9820302695293;1200.771853347861;1200.9159358844797;27091.322716932234;28197.15408537747;28332.575011374433;28783;28913.56629650599;43612.76646802404;43780.56219437892;43949.340759889266;44046;44067.33898991453;325311;325914;327916;328335;329173;25411.745882541676;25651.743482564936;25719;26171.345716357242;26187.214383568524;41873.79063104665;41958.37062444127;42077.78961105175;42218.155636887706;43038.35442468428;35797.46303805497;36530.452043218844;36975.630243698295;37988.81005594954;38152.236955261294;36640;36763.08092297607;37029.44455833111;37098;37305.25389492249;31675.683243168194;35382.8230858844;37187.44218836666;38090.428643569816;38110;34851.65148348585;37791.811040944616;38011.42982855315;38267.6173238264;38629.689724166215;30036.549451758678;30573.08280751581;30602.693973059984;30899;31059.53410698796 10:29:47 INFO - PROCESS | 3168 | |2;jquery.html;346.07425137756496;346.3091133189288;346.7382126494496;361.6202986863794;366.50338790938264;15893.602659933507;16896.408625698117;17084.48746537604;17428.912855435738;17475.126243687828;16295;16927.49217523476;17211.05339206343;17471.91264043681;17506.299748010064;4907;5073.213651883964;5100.744962751847;5101.183810590306;5102.36220472441;3702.8518859245596;5087.694738315713;5608.130739735328;5855.0046492096235;5889.322727886305;5894.58737888348;5900.97049514754;5907.527397808165;5923;5949.107633854935;5840.123981402781;5877.911831322513;5922.318933322658;5954.821355359368;5962.821115366546;4598.747068911209;5256.6057545684225;5260.736963151827;5262.526372626444;5278.736063196825;12325.938370308091;12967.481300747959;18874;20352.898235508877;20396.5920681587;1860.7860096088987;1916.2430839818333;1955.7457530521083;1990.164131064956;2376.144587948337;8751.78120546985;8880.33397495184;8967.372283940062;11634.825477617842;12866.356682165855;1535.071281874461;1571.206540696952;1670.0480725986192;1683.781108455905;1701.6256423586792;63912.680436597984;67143.32856671468;67617;68850.65574672095;70372;9686.418814870989;9726.784151981003;9766;10053.949730251448;10077.848832267522;13269.66825829362;13306.068575199643;13341.19952802835;13388.19670819754;13407.597772066854;7007.684654190573;7330.266973302627;7347.70609175627;7462.664180111908;7499.400047996147;6945.7221711132;7133.89299160513;7221.061262035902;7221.350078492961;7255.347018768231;4074.735142215806;4225.556316586775;4267.381229721673;4319.460067491564;4320.416743739618;1658.353242235529;1691.8392752688476;1730.9826901731074;1817.5728703754608;1826.7168588868747;820.2781552234115;867.3364875869838;890.6259371064168;944.9574769135405;948.4925564822787;16902.239399227063;16964.236609352363;17086.2311195994;17515.474535763948;17562.209700563504;850.7308956938548;878.9868151977597;899.604174163366;908.0737647599411;912.7672443526858;9862.274102032115;9898.851517227247;9930.602775889029;9936.552855121538;9975.401475911469;403348;407816;408852;452713;468872;80228.59885700651;83030.58484707659;83430.58284708537;83560;84462.5776871124;931.0735817861272;950.9809803803885;999.9100080992746;1001.3691374434205;1004.081265641944;15099.773503397239;15802.446914358403;15815.446459374327;16161.59596010109;16576.83423165753;36288.4556731644;37162.62837371592;37659;37828.24343513059;38241;50787.23819142642;52134.95730085301;52136.47863521468;52200.738996304775;53386.1992070127;7548.962255188689;7645.503042302233;7649.235076492307;7709.190534993745;7724.1117271514495;9576.808463830544;12265.877341226473;12274.87725122773;12317.44571494267;12519.93740031294;9145.451272923647;9932.900670993198;10229.437380943822;10308.587656493657;10345.534450949575;9648.228141748503;10095.192384609067;10171.694849154537;10276.332038417479;10663.946680266548;6927.445804335742;10170.288079834341;10308.32995855267;10668.946655266674;10761.354318740901;7346.228645992308;7591.430642701709;7600.923990760243;7794.766157015299;7828.412869034732;9941.602335906771;10392.844107338246;10403;10469.110125639407;10544 10:29:47 INFO - PROCESS | 3168 | |3;mootools.html;1330.2151730479015;1361.4690270794388;1410.5204230561612;1631.820499745027;1639.2951031056648;6594.175728033996;7289.744858929938;7412.777616671495;7754.806129846756;7760.573168475738;7504.099508059027;7775.805604859881;7781.6498257578405;7791.688332466694;7816.960915195416;2190.211523851416;2221.6667499875066;2226.944326391845;2236.888155592222;2237.865728056322;2191.9123235070656;2195.5060111474872;2234.9217777377794;2236.888155592222;2252.0653928619604;2208.403730992631;2208.7018252535863;2212.856164349312;2223.2218723446827;2234.82121430286;2129.5315030693223;2137.8931053447345;2145.0776166248506;2150.064721846002;2159.730033745782;2091.8221951134174;2112.9577408451746;2132.5308432144902;2139.1978008246906;2143.2498625480957;7758.14660387357;7832.334251588622;7834.216578342177;7836.294733474015;7837.373010159174;4539.477960034572;4703.412073490814;4707.176244157259;4708.387909571734;4710.128626204163;2854.200823769327;2933.0467598030514;2981.5825784390204;3006.293521022558;3038.9240268993453;867.4535042922981;916.2990312411011;934.1172591900656;938.1181689212119;948.1798244518442;10353.844692329621;10357.430341331225;10395.116415104725;10454.215933804919;10479.68560943173;3979.4428779970826;4114.238865809834;4262.85080022204;4277.914441711148;4333.025069359369;8905.688300909436;8999.235065019415;9001.279897608176;9001.54992250385;9019.413738107001;4707.764611769398;4710.246360582359;4725.740084295328;4738.786754596052;4747.145513807479;3638.945415818765;4061.837526498966;4194.203101410722;4295.355696645528;4324.654027677778;3591.174029973121;3593.2813437312643;3702.296563652951;3725.0314918121485;3745.5318085239346;1165.9828496700754;1180.2446434282067;1201.5734414282979;1205.2346759807585;1214.942999590362;664.5182242873974;802.4783890471241;818.6029775558849;841.1336323586715;857.2670366836389;5137.0753264412015;5228.111221092423;5262.079136151235;5309.495597918191;5498.367687715884;350.43055035567204;353.867299762589;376.5481422293259;376.6591234932336;381.01127573945564;3548.1307079765625;3572.5534308211472;3634.436662317345;3637.909052273714;3660.5058317127377;9334.766630834283;9530.857037144448;9632.662856800118;9641.517924103768;9671.419714816993;9429.292803039662;9542.713718588453;9580.66467673628;9617.23062155026;9628.855567166498;7247.767879460504;7280.6723697433745;7331.596762178131;7370.705171793175;7376.225496322916;5139.126348520836;5304.098303288373;5306.28365170697;5319.654222475527;5513.862153446196;8734.91265087341;8767.868481972648;8779.912200877909;8797.12028797115;8828.602712878064;8275.379346549153;8825.117488251124;8915.42049766763;9020.909790902007;9095.681651142178;5920.348761636131;6181.660008699565;6419.582727122722;6720.6975686093265;6770.729170833111;7374.33630973215;7396.186419493743;7401.629918504161;7412;7443.925560744323;6626.105475760904;6673.499487538357;6726.730930762715;6802.04771332004;6977.232504424611;6428.164338635947;6476.417122459001;6479.8056058318325;6501.934980650322;6521.02184672303;6076.726547305293;6094.603850749687;6134.877302454015;6153.38466153399;6173.938260617516;4376.649868010615;4458.06380660065;4464.263396539534;4473.530279320625;4475.776211189363;4445.688801783844;4536.455625324982;4539.591436770706;4632.976835115803;4762.309465127606 10:29:47 INFO - PROCESS | 3168 | |4;prototype.html;296.055582691215;298.6505788227774;302.16903515332837;303.9118655589879;306.7469337796318;5039.622028347875;5071.771770270338;5084.313617661614;5087.5421212090905;5108.106081435743;4961.553460188582;4986.227134794103;4997.900041999158;5000.399952005755;5012.9749351253195;3675.117971686796;3827.5789663137034;3906.19922915803;3922.9607703923025;3955;3894.785786781726;3908.257431088098;3911.9804400977955;3935.9016024599327;3954.980225098885;3885.261800257956;3890.3775395936655;3894.571597124314;3907.6678482329035;3910.863119790808;3827.5981021992848;3884.9611503885167;3913.3738601823716;3919.1377896862646;3935.409688546698;3427.5715535558056;3435.95560641418;3436.742244331685;3446.1556918554866;3483.89548313551;4838;4883.9511604883855;4897.436794768611;4899.314096026559;4927.630427717935;4331.393604895317;4472.172648060119;4503.256962601167;4510.458744950594;4512.616427603658;5153.381594208681;5191.714455704935;5199.896002079975;5201.219817027439;5201.8501683333225;3760.7743535387963;3767.6797472214894;3770.6040865709256;3777.565579958285;3796.9620303796883;5337.893242135175;5459.47134802256;5482.342118945712;5497.725113744297;5516.586256030773;3777.527809023872;3842.538895332522;3843.2889915365745;3843.6348546888003;3858.1704933439446;3921.411788231731;3925.980370098131;3932.0956180078742;3936.2324346752107;3946.7631942083567;4443.311286750559;4462.9107417851465;4469.329600559877;4472.552744725502;4480.551944805558;5070;5243.632945693765;5291.3121294231505;5305.36335639718;5306.389765176977;1341.6042267531102;1358.9116707413987;1361.5983284930771;1362.9727405451836;1368.6920442900268;837.8073043199976;865.9956700216585;868.826234753052;871.9825603488022;880.3713130708139;4335.544767799399;4458.528685533766;4613.95386046142;4615.469221039556;4627.1439783640135;5399.83800485986;5419.945800541944;5439.809606663748;5454.400015998237;5487.725613719298;4608.769561521911;4623.537646235417;4626.467956185082;4634.907301853944;4644.883877903012;2712.240572639664;2858.5997960285576;2869.5408734602365;2878.510653188963;2893.2495840016486;5116.462771408948;5137.460566640524;5142.408623008402;5143.71709555978;5152.536271735562;5317.361916569959;5541.445855414427;5555.027870122713;5577.498025177753;5596;5122.564582010571;5126.282695297043;5126.923346097361;5151.356080489939;5152.124138896396;5464.098423760035;5476.644018138808;5483.616146869681;5496.756913421101;5510.724463776715;5044.764032811984;5296.470352964673;5306.787728490817;5343.492368225013;5358.4105748366865;5071.949280507148;5112.258722485144;5142.305788718475;5146.073706732824;5147.356580427447;3761.9059523512133;3801.6198380161763;3805.105800137021;3814.256220037066;3825.062859599305;5185.066687996197;5440.510354068153;5445.101558243004;5518.862028449321;5520.7515661796115;5258.684478931276;5259.684418934876;5293.947060529345;5311.521963023347;5323.520883120537;5284.709340986283;5296;5297.894042119213;5300.9734951325;5301.575873929999;5068.898622027465;5203.427622961395;5205.869853253699;5207.973960130175;5213.879016011576;5086.618503612318;5160.690358578498;5239.607029472729;5327.334083239595;5332.9733351333;5083.92374114396;5089.643724939218;5097.92353114711;5098.41368242642;5101.336826212569 10:29:47 INFO - PROCESS | 3168 | |5;yui.html;613.148857811178;631.4664108828042;637.4549759955238;688.6866475753533;739.065082670422;12211.328376939276;12746.55387061453;12768.425420856049;12773.616791496259;12792.68018299543;13606.251656158907;14253.216073115975;14259.857401425983;14597.051191672534;14752.188629625367;772.5943879463271;781.4217479065508;789.72754399732;790.9841803163933;793.817421992942;627.8524546731514;745.1579714922158;781.0510230070463;787.2796391301952;788.6727008291552;820.4953953318726;839.1692224697535;840.5545061117587;841.1336323586715;842.1704620948361;823.0493779684474;823.27551754456;828.3331917806164;828.4449418889328;832.2343444031505;607.2318517075903;608.0605464557269;608.3460280198804;609.5489337889974;610.3194937644495;14157.646058848508;14256.92871535646;14295.213763243017;14311;14342.139471631735;12371.628851134481;12402.937985310105;12467.438965246585;12863.356832158355;13240.602781916557;10452.68641940743;10522.579096836194;10719.249652524326;10826.079783218436;10911.672649820519;3106.301082256497;3118.7193152616373;3132.248260417506;3142.8271445070513;3186.283086305586;53632.463675363135;54781;55963.720181398836;72399.2760072403;72777.90833137507;10325.84511232332;10435;10493.9475302623;10619.734506637396;10665.146788256921;18684.719729204073;18858.339958101675;19022.714659280122;19111.23555057782;19122.330718425066;6777.559458635173;6786.4570834333135;6857.588544687334;6875.690593923286;6913.793360020234;3790.2040571479747;3804.156393096156;3837.4819399380726;3852.2295540891932;3891.571927088018;2703.5539136042335;2780.138157171283;2798.594203840432;2805.9438811223663;2809.12916995732;487.46378983118996;506.94170170430135;509.236145781328;513.6712503997445;519.9012187684328;477.015191251424;539.4740128374804;576.2508738639751;618.6883806330608;634.7683095670047;7146.606936618536;7522;8202.900275744349;8281.17188281167;8639.654413823377;599.712138173679;618.2951435363689;627.5983370642792;630.5743623054511;636.096742625473;3630.1832087780567;3742.812859357076;3789.109559253573;3873.3996230584303;3892.2993861104706;82360;95790;96739;99725.50137249412;100065;78706;80751;82514;82727.586362069;84274.15725842786;63084;74339.62830185922;75307.24692753112;77338;78426.60786696144;6963.059986901906;7033.824154396181;7097.893531596927;7187.496875218684;7268.309510596485;45464.54535454736;45568.088638226385;46093.76953115213;46370.768146159055;46642.533574663816;63732;67479;67709.66145169243;68301.3169868295;70283;9233;9254.861177082215;9260.073992600686;9300.581473833558;9302.441853488812;11394.48724807369;11466.31202127875;11536.711582210512;11771.293722376684;11796.4691588877;10332.948335258276;10462.267641265038;10631.468426578795;11049.226554141133;11070.557177713123;10072.093511583993;10381.273310868166;10415.427151506437;10764.46177691128;10782.514786834769;9752.46361450127;10136.949315253376;10279.972002799661;10325.896741032493;10333;8785.560721964004;8899.199072083544;8909.461651807704;9155.679551215675;9164.221041211571;8991.910080899108;9864.901350986398;10142.543585538817;10232.795344092927;10440.791184176425 10:29:47 INFO - PROCESS | 3168 | __end_tp_report 10:29:47 INFO - PROCESS | 3168 | __start_cc_report 10:29:47 INFO - PROCESS | 3168 | _x_x_mozilla_cycle_collect,354 10:29:47 INFO - PROCESS | 3168 | __end_cc_report 10:29:47 INFO - PROCESS | 3168 | __startTimestamp1469726987041__endTimestamp 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | ------- Summary: start ------- 10:29:47 INFO - PROCESS | 3168 | Number of tests: 6 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | [#0] dojo.html Cycles:165 Average:4780.94 Median:4896.85 stddev:503.10 (10.3%) stddev-sans-first:475.83 10:29:47 INFO - PROCESS | 3168 | Values: 2641.8 2660.9 2673.2 2681.7 2709.1 4691.0 4880.0 4886.8 4946.0 4947.8 4795.1 4821.2 4828.7 4851.1 4895.5 4443.8 4527.2 4540.6 4580.2 4656.0 4579.7 4589.1 4605.8 4609.0 4631.5 4357.2 4402.8 4525.3 4526.2 4610.4 4424.5 4478.6 4491.2 4528.2 4537.8 4414.0 4453.4 4468.7 4481.5 4487.3 4696.1 4779.8 4795.4 4857.5 4863.5 5235.6 5248.0 5285.0 5306.6 5319.8 5305.7 5307.2 5318.2 5329.9 5374.8 4686.4 4740.7 4935.5 4950.7 4953.5 5235.7 5295.5 5299.1 5344.1 5344.4 5080.2 5093.0 5097.2 5097.2 5132.9 5019.3 5046.5 5156.0 5158.6 5167.6 5145.0 5164.2 5170.0 5196.7 5249.5 5124.9 5152.7 5179.6 5185.7 5235.1 4243.8 4349.0 4360.6 4420.8 4449.7 3739.2 3759.9 3785.2 3818.8 3872.9 4414.6 4451.5 4453.4 4485.2 4496.2 5005.0 5126.9 5160.6 5168.4 5177.1 4385.4 4438.0 4438.1 4456.7 4490.6 4610.5 4622.9 4640.3 4658.1 4687.5 4686.6 4786.0 4790.7 4807.9 4876.5 5150.2 5202.0 5222.6 5255.3 5293.7 4857.1 4881.2 4884.3 4895.3 4896.9 4904.2 5087.1 5093.0 5103.6 5122.1 5037.3 5069.4 5095.9 5101.4 5102.8 4901.6 4942.9 4957.9 4970.4 4981.5 4939.5 4972.0 4982.3 5024.3 5073.1 4861.8 4902.4 4912.1 4922.4 4976.7 4915.5 5030.0 5040.9 5051.7 5052.5 4842.2 4888.8 4936.2 4937.4 4949.7 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | [#1] ext.html Cycles:180 Average:47367.88 Median:37063.72 stddev:86967.88 (234.6%) stddev-sans-first:87140.82 10:29:47 INFO - PROCESS | 3168 | Values: 554.1 569.7 576.5 578.1 595.1 35107.8 39483.4 39618.0 39623.2 39681.0 40566.8 40998.2 41003.8 41102.6 41146.2 7727.8 7856.8 7868.5 7881.9 7884.8 7844.0 7866.3 7896.1 7902.4 7930.3 7885.2 7919.9 7925.3 7939.0 7969.6 7895.9 7932.9 7959.7 7963.8 7978.9 7625.2 7626.4 7630.9 7680.8 7695.8 37734.1 37750.8 37838.4 37906.8 38115.8 3124.7 3186.3 3303.3 3401.9 3525.4 28901.4 29215.3 30025.5 30071.8 30129.8 3444.6 3521.1 3593.5 3653.1 3694.4 258175.0 259148.0 259351.0 260030.0 261253.0 31365.8 53723.7 54248.7 54364.0 54395.7 32011.4 33600.2 33627.7 33640.3 33771.5 13582.2 13725.3 13730.9 13748.1 13778.7 11205.7 11310.6 11314.0 11327.7 11337.7 7741.3 7903.0 7915.3 7973.2 8012.1 3060.3 3060.6 3111.3 3138.8 3171.6 912.3 954.2 967.5 1001.5 1007.7 27695.6 28707.4 29115.7 29251.5 29315.9 926.9 960.3 1012.5 1017.1 1061.7 15171.3 15380.6 15514.9 15547.8 15751.9 387925.0 388497.0 390277.0 390387.0 392458.0 49091.3 49583.0 49599.5 49690.3 49862.0 1151.9 1157.3 1198.0 1200.8 1200.9 27091.3 28197.2 28332.6 28783.0 28913.6 43612.8 43780.6 43949.3 44046.0 44067.3 325311.0 325914.0 327916.0 328335.0 329173.0 25411.7 25651.7 25719.0 26171.3 26187.2 41873.8 41958.4 42077.8 42218.2 43038.4 35797.5 36530.5 36975.6 37988.8 38152.2 36640.0 36763.1 37029.4 37098.0 37305.3 31675.7 35382.8 37187.4 38090.4 38110.0 34851.7 37791.8 38011.4 38267.6 38629.7 30036.5 30573.1 30602.7 30899.0 31059.5 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | [#2] jquery.html Cycles:180 Average:25492.04 Median:236735.37 stddev:70756.35 (29.9%) stddev-sans-first:70929.65 10:29:47 INFO - PROCESS | 3168 | Values: 346.1 346.3 346.7 361.6 366.5 15893.6 16896.4 17084.5 17428.9 17475.1 16295.0 16927.5 17211.1 17471.9 17506.3 4907.0 5073.2 5100.7 5101.2 5102.4 3702.9 5087.7 5608.1 5855.0 5889.3 5894.6 5901.0 5907.5 5923.0 5949.1 5840.1 5877.9 5922.3 5954.8 5962.8 4598.7 5256.6 5260.7 5262.5 5278.7 12325.9 12967.5 18874.0 20352.9 20396.6 1860.8 1916.2 1955.7 1990.2 2376.1 8751.8 8880.3 8967.4 11634.8 12866.4 1535.1 1571.2 1670.0 1683.8 1701.6 63912.7 67143.3 67617.0 68850.7 70372.0 9686.4 9726.8 9766.0 10053.9 10077.8 13269.7 13306.1 13341.2 13388.2 13407.6 7007.7 7330.3 7347.7 7462.7 7499.4 6945.7 7133.9 7221.1 7221.4 7255.3 4074.7 4225.6 4267.4 4319.5 4320.4 1658.4 1691.8 1731.0 1817.6 1826.7 820.3 867.3 890.6 945.0 948.5 16902.2 16964.2 17086.2 17515.5 17562.2 850.7 879.0 899.6 908.1 912.8 9862.3 9898.9 9930.6 9936.6 9975.4 403348.0 407816.0 408852.0 452713.0 468872.0 80228.6 83030.6 83430.6 83560.0 84462.6 931.1 951.0 999.9 1001.4 1004.1 15099.8 15802.4 15815.4 16161.6 16576.8 36288.5 37162.6 37659.0 37828.2 38241.0 50787.2 52135.0 52136.5 52200.7 53386.2 7549.0 7645.5 7649.2 7709.2 7724.1 9576.8 12265.9 12274.9 12317.4 12519.9 9145.5 9932.9 10229.4 10308.6 10345.5 9648.2 10095.2 10171.7 10276.3 10663.9 6927.4 10170.3 10308.3 10668.9 10761.4 7346.2 7591.4 7600.9 7794.8 7828.4 9941.6 10392.8 10403.0 10469.1 10544.0 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | [#3] mootools.html Cycles:180 Average:5077.81 Median:5138.10 stddev:2842.16 (55.3%) stddev-sans-first:2836.18 10:29:47 INFO - PROCESS | 3168 | Values: 1330.2 1361.5 1410.5 1631.8 1639.3 6594.2 7289.7 7412.8 7754.8 7760.6 7504.1 7775.8 7781.6 7791.7 7817.0 2190.2 2221.7 2226.9 2236.9 2237.9 2191.9 2195.5 2234.9 2236.9 2252.1 2208.4 2208.7 2212.9 2223.2 2234.8 2129.5 2137.9 2145.1 2150.1 2159.7 2091.8 2113.0 2132.5 2139.2 2143.2 7758.1 7832.3 7834.2 7836.3 7837.4 4539.5 4703.4 4707.2 4708.4 4710.1 2854.2 2933.0 2981.6 3006.3 3038.9 867.5 916.3 934.1 938.1 948.2 10353.8 10357.4 10395.1 10454.2 10479.7 3979.4 4114.2 4262.9 4277.9 4333.0 8905.7 8999.2 9001.3 9001.5 9019.4 4707.8 4710.2 4725.7 4738.8 4747.1 3638.9 4061.8 4194.2 4295.4 4324.7 3591.2 3593.3 3702.3 3725.0 3745.5 1166.0 1180.2 1201.6 1205.2 1214.9 664.5 802.5 818.6 841.1 857.3 5137.1 5228.1 5262.1 5309.5 5498.4 350.4 353.9 376.5 376.7 381.0 3548.1 3572.6 3634.4 3637.9 3660.5 9334.8 9530.9 9632.7 9641.5 9671.4 9429.3 9542.7 9580.7 9617.2 9628.9 7247.8 7280.7 7331.6 7370.7 7376.2 5139.1 5304.1 5306.3 5319.7 5513.9 8734.9 8767.9 8779.9 8797.1 8828.6 8275.4 8825.1 8915.4 9020.9 9095.7 5920.3 6181.7 6419.6 6720.7 6770.7 7374.3 7396.2 7401.6 7412.0 7443.9 6626.1 6673.5 6726.7 6802.0 6977.2 6428.2 6476.4 6479.8 6501.9 6521.0 6076.7 6094.6 6134.9 6153.4 6173.9 4376.6 4458.1 4464.3 4473.5 4475.8 4445.7 4536.5 4539.6 4633.0 4762.3 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | [#4] prototype.html Cycles:180 Average:4369.24 Median:5042.19 stddev:1274.47 (25.3%) stddev-sans-first:1240.83 10:29:47 INFO - PROCESS | 3168 | Values: 296.1 298.7 302.2 303.9 306.7 5039.6 5071.8 5084.3 5087.5 5108.1 4961.6 4986.2 4997.9 5000.4 5013.0 3675.1 3827.6 3906.2 3923.0 3955.0 3894.8 3908.3 3912.0 3935.9 3955.0 3885.3 3890.4 3894.6 3907.7 3910.9 3827.6 3885.0 3913.4 3919.1 3935.4 3427.6 3436.0 3436.7 3446.2 3483.9 4838.0 4884.0 4897.4 4899.3 4927.6 4331.4 4472.2 4503.3 4510.5 4512.6 5153.4 5191.7 5199.9 5201.2 5201.9 3760.8 3767.7 3770.6 3777.6 3797.0 5337.9 5459.5 5482.3 5497.7 5516.6 3777.5 3842.5 3843.3 3843.6 3858.2 3921.4 3926.0 3932.1 3936.2 3946.8 4443.3 4462.9 4469.3 4472.6 4480.6 5070.0 5243.6 5291.3 5305.4 5306.4 1341.6 1358.9 1361.6 1363.0 1368.7 837.8 866.0 868.8 872.0 880.4 4335.5 4458.5 4614.0 4615.5 4627.1 5399.8 5419.9 5439.8 5454.4 5487.7 4608.8 4623.5 4626.5 4634.9 4644.9 2712.2 2858.6 2869.5 2878.5 2893.2 5116.5 5137.5 5142.4 5143.7 5152.5 5317.4 5541.4 5555.0 5577.5 5596.0 5122.6 5126.3 5126.9 5151.4 5152.1 5464.1 5476.6 5483.6 5496.8 5510.7 5044.8 5296.5 5306.8 5343.5 5358.4 5071.9 5112.3 5142.3 5146.1 5147.4 3761.9 3801.6 3805.1 3814.3 3825.1 5185.1 5440.5 5445.1 5518.9 5520.8 5258.7 5259.7 5293.9 5311.5 5323.5 5284.7 5296.0 5297.9 5301.0 5301.6 5068.9 5203.4 5205.9 5208.0 5213.9 5086.6 5160.7 5239.6 5327.3 5333.0 5083.9 5089.6 5097.9 5098.4 5101.3 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - PROCESS | 3168 | [#5] yui.html Cycles:180 Average:17574.16 Median:27660.24 stddev:25310.84 (91.5%) stddev-sans-first:25349.80 10:29:47 INFO - PROCESS | 3168 | Values: 613.1 631.5 637.5 688.7 739.1 12211.3 12746.6 12768.4 12773.6 12792.7 13606.3 14253.2 14259.9 14597.1 14752.2 772.6 781.4 789.7 791.0 793.8 627.9 745.2 781.1 787.3 788.7 820.5 839.2 840.6 841.1 842.2 823.0 823.3 828.3 828.4 832.2 607.2 608.1 608.3 609.5 610.3 14157.6 14256.9 14295.2 14311.0 14342.1 12371.6 12402.9 12467.4 12863.4 13240.6 10452.7 10522.6 10719.2 10826.1 10911.7 3106.3 3118.7 3132.2 3142.8 3186.3 53632.5 54781.0 55963.7 72399.3 72777.9 10325.8 10435.0 10493.9 10619.7 10665.1 18684.7 18858.3 19022.7 19111.2 19122.3 6777.6 6786.5 6857.6 6875.7 6913.8 3790.2 3804.2 3837.5 3852.2 3891.6 2703.6 2780.1 2798.6 2805.9 2809.1 487.5 506.9 509.2 513.7 519.9 477.0 539.5 576.3 618.7 634.8 7146.6 7522.0 8202.9 8281.2 8639.7 599.7 618.3 627.6 630.6 636.1 3630.2 3742.8 3789.1 3873.4 3892.3 82360.0 95790.0 96739.0 99725.5 100065.0 78706.0 80751.0 82514.0 82727.6 84274.2 63084.0 74339.6 75307.2 77338.0 78426.6 6963.1 7033.8 7097.9 7187.5 7268.3 45464.5 45568.1 46093.8 46370.8 46642.5 63732.0 67479.0 67709.7 68301.3 70283.0 9233.0 9254.9 9260.1 9300.6 9302.4 11394.5 11466.3 11536.7 11771.3 11796.5 10332.9 10462.3 10631.5 11049.2 11070.6 10072.1 10381.3 10415.4 10764.5 10782.5 9752.5 10136.9 10280.0 10325.9 10333.0 8785.6 8899.2 8909.5 9155.7 9164.2 8991.9 9864.9 10142.5 10232.8 10440.8 10:29:47 INFO - PROCESS | 3168 | -------- Summary: end -------- 10:29:47 INFO - PROCESS | 3168 | 10:29:47 INFO - TEST-INFO | 3168: exit 0 10:29:47 INFO - TEST-OK | dromaeo_css | took 1118268ms 10:29:47 INFO - TEST-START | kraken 10:29:47 INFO - operating with platform_type : linux_ 10:29:47 INFO - Initialising browser for kraken test... 10:29:47 INFO - TEST-INFO | started process 3415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7Xb64/profile http://localhost:47704/getInfo.html) 10:29:51 INFO - PROCESS | 3415 | JavaScript error: , line 0: uncaught exception: undefined 10:29:53 INFO - PROCESS | 3415 | __metrics Screen width/height:1600/1200 10:29:53 INFO - PROCESS | 3415 | colorDepth:24 10:29:53 INFO - PROCESS | 3415 | Browser inner width/height: 1024/697 10:29:53 INFO - PROCESS | 3415 | __metrics 10:29:54 ERROR - PROCESS | 3415 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:29:55 INFO - TEST-INFO | 3415: exit 0 10:29:55 INFO - Browser initialized. 10:29:55 INFO - Running cycle 1/1 for kraken test... 10:29:55 INFO - TEST-INFO | started process 3535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7Xb64/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:07 INFO - PROCESS | 3535 | RSS: Main: 166277120 10:30:07 INFO - PROCESS | 3535 | 10:30:09 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-beat-detection) 10:30:10 INFO - PROCESS | 3535 | RSS: Main: 171851776 10:30:10 INFO - PROCESS | 3535 | 10:30:13 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-dft) 10:30:14 INFO - PROCESS | 3535 | RSS: Main: 170582016 10:30:14 INFO - PROCESS | 3535 | 10:30:17 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-fft) 10:30:17 INFO - PROCESS | 3535 | RSS: Main: 166625280 10:30:17 INFO - PROCESS | 3535 | 10:30:19 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47704/tests/kraken/driver.html?testName=audio-oscillator) 10:30:20 INFO - PROCESS | 3535 | RSS: Main: 167657472 10:30:20 INFO - PROCESS | 3535 | 10:30:22 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:30:23 INFO - PROCESS | 3535 | RSS: Main: 167804928 10:30:23 INFO - PROCESS | 3535 | 10:30:26 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47704/tests/kraken/driver.html?testName=imaging-darkroom) 10:30:27 INFO - PROCESS | 3535 | RSS: Main: 167948288 10:30:27 INFO - PROCESS | 3535 | 10:30:30 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47704/tests/kraken/driver.html?testName=imaging-desaturate) 10:30:31 INFO - PROCESS | 3535 | RSS: Main: 165351424 10:30:31 INFO - PROCESS | 3535 | 10:30:34 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47704/tests/kraken/driver.html?testName=json-parse-financial) 10:30:34 INFO - PROCESS | 3535 | RSS: Main: 167346176 10:30:34 INFO - PROCESS | 3535 | 10:30:36 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:37 INFO - PROCESS | 3535 | RSS: Main: 167456768 10:30:37 INFO - PROCESS | 3535 | 10:30:39 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:39 INFO - PROCESS | 3535 | RSS: Main: 167882752 10:30:39 INFO - PROCESS | 3535 | 10:30:42 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:42 INFO - PROCESS | 3535 | RSS: Main: 168525824 10:30:42 INFO - PROCESS | 3535 | 10:30:45 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:46 INFO - PROCESS | 3535 | RSS: Main: 168660992 10:30:46 INFO - PROCESS | 3535 | 10:30:49 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:49 INFO - PROCESS | 3535 | RSS: Main: 168566784 10:30:49 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:47704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47704/tests/kraken/driver.html?testName=ai-astar) 10:30:51 INFO - PROCESS | 3535 | RSS: Main: 169541632 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | __start_tp_report 10:30:51 INFO - PROCESS | 3535 | _x_x_mozilla_page_load 10:30:51 INFO - PROCESS | 3535 | _x_x_mozilla_page_load_details 10:30:51 INFO - PROCESS | 3535 | |i|pagename|runs| 10:30:51 INFO - PROCESS | 3535 | |0;ai-astar;105;117;107;115;114;114;115;114;116;113 10:30:51 INFO - PROCESS | 3535 | |1;audio-beat-detection;146;124;147;177;123;148;156;126;205;125 10:30:51 INFO - PROCESS | 3535 | |2;audio-dft;164;164;165;168;167;163;164;162;162;164 10:30:51 INFO - PROCESS | 3535 | |3;audio-fft;76;77;76;167;77;78;76;76;158;79 10:30:51 INFO - PROCESS | 3535 | |4;audio-oscillator;86;86;153;86;86;86;133;85;85;139 10:30:51 INFO - PROCESS | 3535 | |5;imaging-gaussian-blur;117;118;118;117;121;118;119;117;118;118 10:30:51 INFO - PROCESS | 3535 | |6;imaging-darkroom;147;147;149;148;147;148;147;149;148;147 10:30:51 INFO - PROCESS | 3535 | |7;imaging-desaturate;95;95;95;95;96;95;96;96;95;96 10:30:51 INFO - PROCESS | 3535 | |8;json-parse-financial;64;64;64;64;66;64;63;65;63;64 10:30:51 INFO - PROCESS | 3535 | |9;json-stringify-tinderbox;65;67;65;66;66;66;69;66;67;67 10:30:51 INFO - PROCESS | 3535 | |10;stanford-crypto-aes;83;84;86;88;81;85;85;80;90;79 10:30:51 INFO - PROCESS | 3535 | |11;stanford-crypto-ccm;142;133;130;136;132;133;140;144;172;137 10:30:51 INFO - PROCESS | 3535 | |12;stanford-crypto-pbkdf2;171;168;169;168;172;166;164;165;173;162 10:30:51 INFO - PROCESS | 3535 | |13;stanford-crypto-sha256-iterative;69;69;69;70;69;67;69;66;66;66 10:30:51 INFO - PROCESS | 3535 | __end_tp_report 10:30:51 INFO - PROCESS | 3535 | __start_cc_report 10:30:51 INFO - PROCESS | 3535 | _x_x_mozilla_cycle_collect,950 10:30:51 INFO - PROCESS | 3535 | __end_cc_report 10:30:51 INFO - PROCESS | 3535 | __startTimestamp1469727051745__endTimestamp 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | ------- Summary: start ------- 10:30:51 INFO - PROCESS | 3535 | Number of tests: 14 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:3.89 (3.4%) stddev-sans-first:2.85 10:30:51 INFO - PROCESS | 3535 | Values: 105.0 117.0 107.0 115.0 114.0 114.0 115.0 114.0 116.0 113.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:147.50 stddev:26.61 (18.0%) stddev-sans-first:28.22 10:30:51 INFO - PROCESS | 3535 | Values: 146.0 124.0 147.0 177.0 123.0 148.0 156.0 126.0 205.0 125.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:1.95 (1.2%) stddev-sans-first:2.06 10:30:51 INFO - PROCESS | 3535 | Values: 164.0 164.0 165.0 168.0 167.0 163.0 164.0 162.0 162.0 164.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.50 stddev:36.18 (47.3%) stddev-sans-first:37.78 10:30:51 INFO - PROCESS | 3535 | Values: 76.0 77.0 76.0 167.0 77.0 78.0 76.0 76.0 158.0 79.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:86.00 stddev:27.46 (31.9%) stddev-sans-first:28.47 10:30:51 INFO - PROCESS | 3535 | Values: 86.0 86.0 153.0 86.0 86.0 86.0 133.0 85.0 85.0 139.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.20 10:30:51 INFO - PROCESS | 3535 | Values: 117.0 118.0 118.0 117.0 121.0 118.0 119.0 117.0 118.0 118.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 10:30:51 INFO - PROCESS | 3535 | Values: 147.0 147.0 149.0 148.0 147.0 148.0 147.0 149.0 148.0 147.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:30:51 INFO - PROCESS | 3535 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 10:30:51 INFO - PROCESS | 3535 | Values: 64.0 64.0 64.0 64.0 66.0 64.0 63.0 65.0 63.0 64.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.13 10:30:51 INFO - PROCESS | 3535 | Values: 65.0 67.0 65.0 66.0 66.0 66.0 69.0 66.0 67.0 67.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:85.00 stddev:3.48 (4.1%) stddev-sans-first:3.67 10:30:51 INFO - PROCESS | 3535 | Values: 83.0 84.0 86.0 88.0 81.0 85.0 85.0 80.0 90.0 79.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:138.50 stddev:12.16 (8.8%) stddev-sans-first:12.87 10:30:51 INFO - PROCESS | 3535 | Values: 142.0 133.0 130.0 136.0 132.0 133.0 140.0 144.0 172.0 137.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.50 stddev:3.58 (2.1%) stddev-sans-first:3.61 10:30:51 INFO - PROCESS | 3535 | Values: 171.0 168.0 169.0 168.0 172.0 166.0 164.0 165.0 173.0 162.0 10:30:51 INFO - PROCESS | 3535 | 10:30:51 INFO - PROCESS | 3535 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 10:30:51 INFO - PROCESS | 3535 | Values: 69.0 69.0 69.0 70.0 69.0 67.0 69.0 66.0 66.0 66.0 10:30:51 INFO - PROCESS | 3535 | -------- Summary: end -------- 10:30:51 INFO - PROCESS | 3535 | 10:30:52 INFO - TEST-INFO | 3535: exit 0 10:30:52 INFO - TEST-OK | kraken | took 65002ms 10:30:52 INFO - SUITE-END | took 1183s 10:30:53 INFO - Completed test suite (00:19:43) 10:30:53 INFO - javascript benchmark 10:30:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6382.355737608381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.8414895106293, 2660.8536530490837, 2673.157955244099, 2681.6916054653716, 2709.065372446505, 4691.038337140886, 4879.999999999995, 4886.780094895729, 4945.975270123648, 4947.777350019249, 4795.064962332338, 4821.180399332113, 4828.73441960692, 4851.102546028978, 4895.485973972735, 4443.82224711012, 4527.230370836965, 4540.568645978627, 4580.1984652685815, 4655.953440465586, 4579.67942244043, 4589.059242855206, 4605.838795642153, 4609.0, 4631.536846315358, 4357.1721372939355, 4402.845900393503, 4525.275955847082, 4526.23054080807, 4610.4467463904375, 4424.491183513905, 4478.619317358029, 4491.214037543449, 4528.230200865861, 4537.795799189012, 4413.955860441387, 4453.376527286183, 4468.687191896569, 4481.507034226265, 4487.259602165639, 4696.107739529479, 4779.80880764769, 4795.352627395292, 4857.489963553847, 4863.465018847924, 5235.58115350771, 5248.0, 5285.0, 5306.575473962073, 5319.813806516792, 5305.681659100466, 5307.177387504943, 5318.22885681574, 5329.893402131975, 5374.7850085996515, 4686.390769199982, 4740.715557066587, 4935.481774413706, 4950.653454258168, 4953.479884612136, 5235.685858848481, 5295.4969277918535, 5299.072662284085, 5344.091504444254, 5344.412114667383, 5080.237964305384, 5093.0, 5097.1844504879045, 5097.235414687826, 5132.871678208075, 5019.322391477177, 5046.545810876965, 5156.0, 5158.613104017214, 5167.560757335594, 5145.048166089286, 5164.1995490699, 5169.974150129226, 5196.68819870809, 5249.527542521115, 5124.923126153036, 5152.7166005869285, 5179.61152913533, 5185.662931909414, 5235.05768961583, 4243.8090285937205, 4348.956510434855, 4360.607545320936, 4420.778961051935, 4449.688521803443, 3739.1960728442973, 3759.9060023499633, 3785.242951409729, 3818.770873747584, 3872.8838134856, 4414.624756895636, 4451.532589078165, 4453.376527286183, 4485.215087359764, 4496.235639941217, 5004.974975125101, 5126.871828204325, 5160.587153027749, 5168.3539557555305, 5177.119889618773, 4385.407969924019, 4438.023634800339, 4438.090191510732, 4456.710313829591, 4490.618297444688, 4610.492845786961, 4622.86131416058, 4640.257558790578, 4658.068386322749, 4687.484376718558, 4686.5782079613, 4785.971016231527, 4790.664653474223, 4807.879803004953, 4876.512348765095, 5150.201718733602, 5201.973990130025, 5222.634415590872, 5255.290535777621, 5293.7353132344, 4857.101436234308, 4881.219004959189, 4884.291777692286, 4895.265710143507, 4896.853094407174, 4904.166291730343, 5087.13518701829, 5093.006863661551, 5103.591712662904, 5122.078025955364, 5037.269595908646, 5069.391672999263, 5095.87260318495, 5101.362329708786, 5102.821401250939, 4901.607871370353, 4942.851714448572, 4957.925631115609, 4970.403551573834, 4981.501849814989, 4939.456659767351, 4972.005598880166, 4982.277569752293, 5024.271480635214, 5073.137566613611, 4861.756912154307, 4902.3872015998, 4912.140375434356, 4922.4339200992345, 4976.726280054487, 4915.5330243626795, 5030.0, 5040.949590504195, 5051.6716413433005, 5052.520010598987, 4842.176829938849, 4888.780004899859, 4936.234883593049, 4937.432195297587, 4949.727764972961], "value": 4748.492146748719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1161846854266, 569.720836789973, 576.5070864410928, 578.0664227272954, 595.0627761275991, 35107.824460877695, 39483.40774888379, 39618.0, 39623.207535849266, 39681.0, 40566.7971660142, 40998.18003639925, 41003.79498102505, 41102.58897411025, 41146.17707645845, 7727.806804829882, 7856.764297071097, 7868.488548244346, 7881.921180788176, 7884.80287992799, 7844.0, 7866.331361834251, 7896.131425543185, 7902.446828721992, 7930.325922296583, 7885.211478852127, 7919.881201781949, 7925.2867241948215, 7938.960305198495, 7969.641366138538, 7895.921040789604, 7932.881006784932, 7959.7214097506885, 7963.840723185562, 7978.880316795253, 7625.237476252386, 7626.351760100398, 7630.923690763132, 7680.807979800494, 7695.769126926201, 37734.05664858373, 37750.81124594387, 37838.43242351367, 37906.81046594749, 38115.809420952995, 3124.6875312468796, 3186.2512309607223, 3303.306305675811, 3401.897943061712, 3525.4183059795105, 28901.42197156066, 29215.269618259503, 30025.549616755765, 30071.849640751876, 30129.849350753324, 3444.603870554868, 3521.102118959649, 3593.4789455528803, 3653.12325041988, 3694.4273637586216, 258175.0, 259148.0, 259351.0, 260030.0, 261253.0, 31365.843170784, 53723.73138134363, 54248.728756355966, 54364.0, 54395.72802136043, 32011.359772804415, 33600.15999600029, 33627.663723362944, 33640.327193455996, 33771.49342759861, 13582.185068895898, 13725.313734313244, 13730.862691373159, 13748.106373085717, 13778.65553361174, 11205.66383008511, 11310.60412885545, 11314.0, 11327.716807079723, 11337.659870203906, 7741.341985931259, 7902.960485197537, 7915.287624113857, 7973.242541958504, 8012.0786109596975, 3060.2655362713235, 3060.586820779211, 3111.2844045869124, 3138.764592655514, 3171.6194056713343, 912.3385545479474, 954.1984732824461, 967.4630580028152, 1001.5392919257223, 1007.7128018514688, 27695.584566231522, 28707.425851482854, 29115.708842911725, 29251.45474805002, 29315.85342073276, 926.8609708543637, 960.3037797596686, 1012.5291739341242, 1017.1151098544166, 1061.7239517725448, 15171.331153573097, 15380.615484612974, 15514.9224253878, 15547.766783498257, 15751.921240393955, 387925.0, 388497.0, 390277.0, 390387.0, 392458.0, 49091.263631045564, 49583.0, 49599.50400495949, 49690.254646180336, 49862.0, 1151.9078473722082, 1157.3403160198607, 1197.9820302695293, 1200.771853347861, 1200.9159358844797, 27091.322716932234, 28197.15408537747, 28332.575011374433, 28783.0, 28913.56629650599, 43612.76646802404, 43780.56219437892, 43949.340759889266, 44046.0, 44067.33898991453, 325311.0, 325914.0, 327916.0, 328335.0, 329173.0, 25411.745882541676, 25651.743482564936, 25719.0, 26171.345716357242, 26187.214383568524, 41873.79063104665, 41958.37062444127, 42077.78961105175, 42218.155636887706, 43038.35442468428, 35797.46303805497, 36530.452043218844, 36975.630243698295, 37988.81005594954, 38152.236955261294, 36640.0, 36763.08092297607, 37029.44455833111, 37098.0, 37305.25389492249, 31675.683243168194, 35382.8230858844, 37187.44218836666, 38090.428643569816, 38110.0, 34851.65148348585, 37791.811040944616, 38011.42982855315, 38267.6173238264, 38629.689724166215, 30036.549451758678, 30573.08280751581, 30602.693973059984, 30899.0, 31059.53410698796], "value": 16860.652835971756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.07425137756496, 346.3091133189288, 346.7382126494496, 361.6202986863794, 366.50338790938264, 15893.602659933507, 16896.408625698117, 17084.48746537604, 17428.912855435738, 17475.126243687828, 16295.0, 16927.49217523476, 17211.05339206343, 17471.91264043681, 17506.299748010064, 4907.0, 5073.213651883964, 5100.744962751847, 5101.183810590306, 5102.36220472441, 3702.8518859245596, 5087.694738315713, 5608.130739735328, 5855.0046492096235, 5889.322727886305, 5894.58737888348, 5900.97049514754, 5907.527397808165, 5923.0, 5949.107633854935, 5840.123981402781, 5877.911831322513, 5922.318933322658, 5954.821355359368, 5962.821115366546, 4598.747068911209, 5256.6057545684225, 5260.736963151827, 5262.526372626444, 5278.736063196825, 12325.938370308091, 12967.481300747959, 18874.0, 20352.898235508877, 20396.5920681587, 1860.7860096088987, 1916.2430839818333, 1955.7457530521083, 1990.164131064956, 2376.144587948337, 8751.78120546985, 8880.33397495184, 8967.372283940062, 11634.825477617842, 12866.356682165855, 1535.071281874461, 1571.206540696952, 1670.0480725986192, 1683.781108455905, 1701.6256423586792, 63912.680436597984, 67143.32856671468, 67617.0, 68850.65574672095, 70372.0, 9686.418814870989, 9726.784151981003, 9766.0, 10053.949730251448, 10077.848832267522, 13269.66825829362, 13306.068575199643, 13341.19952802835, 13388.19670819754, 13407.597772066854, 7007.684654190573, 7330.266973302627, 7347.70609175627, 7462.664180111908, 7499.400047996147, 6945.7221711132, 7133.89299160513, 7221.061262035902, 7221.350078492961, 7255.347018768231, 4074.735142215806, 4225.556316586775, 4267.381229721673, 4319.460067491564, 4320.416743739618, 1658.353242235529, 1691.8392752688476, 1730.9826901731074, 1817.5728703754608, 1826.7168588868747, 820.2781552234115, 867.3364875869838, 890.6259371064168, 944.9574769135405, 948.4925564822787, 16902.239399227063, 16964.236609352363, 17086.2311195994, 17515.474535763948, 17562.209700563504, 850.7308956938548, 878.9868151977597, 899.604174163366, 908.0737647599411, 912.7672443526858, 9862.274102032115, 9898.851517227247, 9930.602775889029, 9936.552855121538, 9975.401475911469, 403348.0, 407816.0, 408852.0, 452713.0, 468872.0, 80228.59885700651, 83030.58484707659, 83430.58284708537, 83560.0, 84462.5776871124, 931.0735817861272, 950.9809803803885, 999.9100080992746, 1001.3691374434205, 1004.081265641944, 15099.773503397239, 15802.446914358403, 15815.446459374327, 16161.59596010109, 16576.83423165753, 36288.4556731644, 37162.62837371592, 37659.0, 37828.24343513059, 38241.0, 50787.23819142642, 52134.95730085301, 52136.47863521468, 52200.738996304775, 53386.1992070127, 7548.962255188689, 7645.503042302233, 7649.235076492307, 7709.190534993745, 7724.1117271514495, 9576.808463830544, 12265.877341226473, 12274.87725122773, 12317.44571494267, 12519.93740031294, 9145.451272923647, 9932.900670993198, 10229.437380943822, 10308.587656493657, 10345.534450949575, 9648.228141748503, 10095.192384609067, 10171.694849154537, 10276.332038417479, 10663.946680266548, 6927.445804335742, 10170.288079834341, 10308.32995855267, 10668.946655266674, 10761.354318740901, 7346.228645992308, 7591.430642701709, 7600.923990760243, 7794.766157015299, 7828.412869034732, 9941.602335906771, 10392.844107338246, 10403.0, 10469.110125639407, 10544.0], "value": 8254.06525566887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.2151730479015, 1361.4690270794388, 1410.5204230561612, 1631.820499745027, 1639.2951031056648, 6594.175728033996, 7289.744858929938, 7412.777616671495, 7754.806129846756, 7760.573168475738, 7504.099508059027, 7775.805604859881, 7781.6498257578405, 7791.688332466694, 7816.960915195416, 2190.211523851416, 2221.6667499875066, 2226.944326391845, 2236.888155592222, 2237.865728056322, 2191.9123235070656, 2195.5060111474872, 2234.9217777377794, 2236.888155592222, 2252.0653928619604, 2208.403730992631, 2208.7018252535863, 2212.856164349312, 2223.2218723446827, 2234.82121430286, 2129.5315030693223, 2137.8931053447345, 2145.0776166248506, 2150.064721846002, 2159.730033745782, 2091.8221951134174, 2112.9577408451746, 2132.5308432144902, 2139.1978008246906, 2143.2498625480957, 7758.14660387357, 7832.334251588622, 7834.216578342177, 7836.294733474015, 7837.373010159174, 4539.477960034572, 4703.412073490814, 4707.176244157259, 4708.387909571734, 4710.128626204163, 2854.200823769327, 2933.0467598030514, 2981.5825784390204, 3006.293521022558, 3038.9240268993453, 867.4535042922981, 916.2990312411011, 934.1172591900656, 938.1181689212119, 948.1798244518442, 10353.844692329621, 10357.430341331225, 10395.116415104725, 10454.215933804919, 10479.68560943173, 3979.4428779970826, 4114.238865809834, 4262.85080022204, 4277.914441711148, 4333.025069359369, 8905.688300909436, 8999.235065019415, 9001.279897608176, 9001.54992250385, 9019.413738107001, 4707.764611769398, 4710.246360582359, 4725.740084295328, 4738.786754596052, 4747.145513807479, 3638.945415818765, 4061.837526498966, 4194.203101410722, 4295.355696645528, 4324.654027677778, 3591.174029973121, 3593.2813437312643, 3702.296563652951, 3725.0314918121485, 3745.5318085239346, 1165.9828496700754, 1180.2446434282067, 1201.5734414282979, 1205.2346759807585, 1214.942999590362, 664.5182242873974, 802.4783890471241, 818.6029775558849, 841.1336323586715, 857.2670366836389, 5137.0753264412015, 5228.111221092423, 5262.079136151235, 5309.495597918191, 5498.367687715884, 350.43055035567204, 353.867299762589, 376.5481422293259, 376.6591234932336, 381.01127573945564, 3548.1307079765625, 3572.5534308211472, 3634.436662317345, 3637.909052273714, 3660.5058317127377, 9334.766630834283, 9530.857037144448, 9632.662856800118, 9641.517924103768, 9671.419714816993, 9429.292803039662, 9542.713718588453, 9580.66467673628, 9617.23062155026, 9628.855567166498, 7247.767879460504, 7280.6723697433745, 7331.596762178131, 7370.705171793175, 7376.225496322916, 5139.126348520836, 5304.098303288373, 5306.28365170697, 5319.654222475527, 5513.862153446196, 8734.91265087341, 8767.868481972648, 8779.912200877909, 8797.12028797115, 8828.602712878064, 8275.379346549153, 8825.117488251124, 8915.42049766763, 9020.909790902007, 9095.681651142178, 5920.348761636131, 6181.660008699565, 6419.582727122722, 6720.6975686093265, 6770.729170833111, 7374.33630973215, 7396.186419493743, 7401.629918504161, 7412.0, 7443.925560744323, 6626.105475760904, 6673.499487538357, 6726.730930762715, 6802.04771332004, 6977.232504424611, 6428.164338635947, 6476.417122459001, 6479.8056058318325, 6501.934980650322, 6521.02184672303, 6076.726547305293, 6094.603850749687, 6134.877302454015, 6153.38466153399, 6173.938260617516, 4376.649868010615, 4458.06380660065, 4464.263396539534, 4473.530279320625, 4475.776211189363, 4445.688801783844, 4536.455625324982, 4539.591436770706, 4632.976835115803, 4762.309465127606], "value": 4018.983718445685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.055582691215, 298.6505788227774, 302.16903515332837, 303.9118655589879, 306.7469337796318, 5039.622028347875, 5071.771770270338, 5084.313617661614, 5087.5421212090905, 5108.106081435743, 4961.553460188582, 4986.227134794103, 4997.900041999158, 5000.399952005755, 5012.9749351253195, 3675.117971686796, 3827.5789663137034, 3906.19922915803, 3922.9607703923025, 3955.0, 3894.785786781726, 3908.257431088098, 3911.9804400977955, 3935.9016024599327, 3954.980225098885, 3885.261800257956, 3890.3775395936655, 3894.571597124314, 3907.6678482329035, 3910.863119790808, 3827.5981021992848, 3884.9611503885167, 3913.3738601823716, 3919.1377896862646, 3935.409688546698, 3427.5715535558056, 3435.95560641418, 3436.742244331685, 3446.1556918554866, 3483.89548313551, 4838.0, 4883.9511604883855, 4897.436794768611, 4899.314096026559, 4927.630427717935, 4331.393604895317, 4472.172648060119, 4503.256962601167, 4510.458744950594, 4512.616427603658, 5153.381594208681, 5191.714455704935, 5199.896002079975, 5201.219817027439, 5201.8501683333225, 3760.7743535387963, 3767.6797472214894, 3770.6040865709256, 3777.565579958285, 3796.9620303796883, 5337.893242135175, 5459.47134802256, 5482.342118945712, 5497.725113744297, 5516.586256030773, 3777.527809023872, 3842.538895332522, 3843.2889915365745, 3843.6348546888003, 3858.1704933439446, 3921.411788231731, 3925.980370098131, 3932.0956180078742, 3936.2324346752107, 3946.7631942083567, 4443.311286750559, 4462.9107417851465, 4469.329600559877, 4472.552744725502, 4480.551944805558, 5070.0, 5243.632945693765, 5291.3121294231505, 5305.36335639718, 5306.389765176977, 1341.6042267531102, 1358.9116707413987, 1361.5983284930771, 1362.9727405451836, 1368.6920442900268, 837.8073043199976, 865.9956700216585, 868.826234753052, 871.9825603488022, 880.3713130708139, 4335.544767799399, 4458.528685533766, 4613.95386046142, 4615.469221039556, 4627.1439783640135, 5399.83800485986, 5419.945800541944, 5439.809606663748, 5454.400015998237, 5487.725613719298, 4608.769561521911, 4623.537646235417, 4626.467956185082, 4634.907301853944, 4644.883877903012, 2712.240572639664, 2858.5997960285576, 2869.5408734602365, 2878.510653188963, 2893.2495840016486, 5116.462771408948, 5137.460566640524, 5142.408623008402, 5143.71709555978, 5152.536271735562, 5317.361916569959, 5541.445855414427, 5555.027870122713, 5577.498025177753, 5596.0, 5122.564582010571, 5126.282695297043, 5126.923346097361, 5151.356080489939, 5152.124138896396, 5464.098423760035, 5476.644018138808, 5483.616146869681, 5496.756913421101, 5510.724463776715, 5044.764032811984, 5296.470352964673, 5306.787728490817, 5343.492368225013, 5358.4105748366865, 5071.949280507148, 5112.258722485144, 5142.305788718475, 5146.073706732824, 5147.356580427447, 3761.9059523512133, 3801.6198380161763, 3805.105800137021, 3814.256220037066, 3825.062859599305, 5185.066687996197, 5440.510354068153, 5445.101558243004, 5518.862028449321, 5520.7515661796115, 5258.684478931276, 5259.684418934876, 5293.947060529345, 5311.521963023347, 5323.520883120537, 5284.709340986283, 5296.0, 5297.894042119213, 5300.9734951325, 5301.575873929999, 5068.898622027465, 5203.427622961395, 5205.869853253699, 5207.973960130175, 5213.879016011576, 5086.618503612318, 5160.690358578498, 5239.607029472729, 5327.334083239595, 5332.9733351333, 5083.92374114396, 5089.643724939218, 5097.92353114711, 5098.41368242642, 5101.336826212569], "value": 3959.588464501313, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.148857811178, 631.4664108828042, 637.4549759955238, 688.6866475753533, 739.065082670422, 12211.328376939276, 12746.55387061453, 12768.425420856049, 12773.616791496259, 12792.68018299543, 13606.251656158907, 14253.216073115975, 14259.857401425983, 14597.051191672534, 14752.188629625367, 772.5943879463271, 781.4217479065508, 789.72754399732, 790.9841803163933, 793.817421992942, 627.8524546731514, 745.1579714922158, 781.0510230070463, 787.2796391301952, 788.6727008291552, 820.4953953318726, 839.1692224697535, 840.5545061117587, 841.1336323586715, 842.1704620948361, 823.0493779684474, 823.27551754456, 828.3331917806164, 828.4449418889328, 832.2343444031505, 607.2318517075903, 608.0605464557269, 608.3460280198804, 609.5489337889974, 610.3194937644495, 14157.646058848508, 14256.92871535646, 14295.213763243017, 14311.0, 14342.139471631735, 12371.628851134481, 12402.937985310105, 12467.438965246585, 12863.356832158355, 13240.602781916557, 10452.68641940743, 10522.579096836194, 10719.249652524326, 10826.079783218436, 10911.672649820519, 3106.301082256497, 3118.7193152616373, 3132.248260417506, 3142.8271445070513, 3186.283086305586, 53632.463675363135, 54781.0, 55963.720181398836, 72399.2760072403, 72777.90833137507, 10325.84511232332, 10435.0, 10493.9475302623, 10619.734506637396, 10665.146788256921, 18684.719729204073, 18858.339958101675, 19022.714659280122, 19111.23555057782, 19122.330718425066, 6777.559458635173, 6786.4570834333135, 6857.588544687334, 6875.690593923286, 6913.793360020234, 3790.2040571479747, 3804.156393096156, 3837.4819399380726, 3852.2295540891932, 3891.571927088018, 2703.5539136042335, 2780.138157171283, 2798.594203840432, 2805.9438811223663, 2809.12916995732, 487.46378983118996, 506.94170170430135, 509.236145781328, 513.6712503997445, 519.9012187684328, 477.015191251424, 539.4740128374804, 576.2508738639751, 618.6883806330608, 634.7683095670047, 7146.606936618536, 7522.0, 8202.900275744349, 8281.17188281167, 8639.654413823377, 599.712138173679, 618.2951435363689, 627.5983370642792, 630.5743623054511, 636.096742625473, 3630.1832087780567, 3742.812859357076, 3789.109559253573, 3873.3996230584303, 3892.2993861104706, 82360.0, 95790.0, 96739.0, 99725.50137249412, 100065.0, 78706.0, 80751.0, 82514.0, 82727.586362069, 84274.15725842786, 63084.0, 74339.62830185922, 75307.24692753112, 77338.0, 78426.60786696144, 6963.059986901906, 7033.824154396181, 7097.893531596927, 7187.496875218684, 7268.309510596485, 45464.54535454736, 45568.088638226385, 46093.76953115213, 46370.768146159055, 46642.533574663816, 63732.0, 67479.0, 67709.66145169243, 68301.3169868295, 70283.0, 9233.0, 9254.861177082215, 9260.073992600686, 9300.581473833558, 9302.441853488812, 11394.48724807369, 11466.31202127875, 11536.711582210512, 11771.293722376684, 11796.4691588877, 10332.948335258276, 10462.267641265038, 10631.468426578795, 11049.226554141133, 11070.557177713123, 10072.093511583993, 10381.273310868166, 10415.427151506437, 10764.46177691128, 10782.514786834769, 9752.46361450127, 10136.949315253376, 10279.972002799661, 10325.896741032493, 10333.0, 8785.560721964004, 8899.199072083544, 8909.461651807704, 9155.679551215675, 9164.221041211571, 8991.910080899108, 9864.901350986398, 10142.543585538817, 10232.795344092927, 10440.791184176425], "value": 6426.5053516544285, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 107.0, 115.0, 114.0, 114.0, 115.0, 114.0, 116.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 147.0, 177.0, 123.0, 148.0, 156.0, 126.0, 205.0, 125.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 168.0, 167.0, 163.0, 164.0, 162.0, 162.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 167.0, 77.0, 78.0, 76.0, 76.0, 158.0, 79.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 153.0, 86.0, 86.0, 86.0, 133.0, 85.0, 85.0, 139.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 121.0, 118.0, 119.0, 117.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 64.0, 63.0, 65.0, 63.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 66.0, 66.0, 66.0, 69.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 88.0, 81.0, 85.0, 85.0, 80.0, 90.0, 79.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 130.0, 136.0, 132.0, 133.0, 140.0, 144.0, 172.0, 137.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 169.0, 168.0, 172.0, 166.0, 164.0, 165.0, 173.0, 162.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 67.0, 69.0, 66.0, 66.0, 66.0], "value": 68.0, "unit": "score"}]}]} 10:30:53 INFO - Return code: 0 10:30:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:53 ERROR - # TBPL SUCCESS # 10:30:53 INFO - Running post-action listener: _resource_record_post_action 10:30:53 INFO - [mozharness: 2016-07-28 17:30:53.536454Z] Finished run-tests step (success) 10:30:53 INFO - Running post-run listener: _resource_record_post_run 10:30:53 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557133824; Read time: 12; Write time: 1075256 10:30:53 INFO - TinderboxPrint: CPU usage
13.4% 10:30:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:30:53 INFO - TinderboxPrint: I/O write bytes / time
557,133,824 / 1,075,256 10:30:53 INFO - TinderboxPrint: CPU idle
8,293.7 (86.6%) 10:30:53 INFO - TinderboxPrint: CPU user
1,216.2 (12.7%) 10:30:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:30:53 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 258580480; Read time: 0; Write time: 599488 10:30:53 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297938944; Read time: 12; Write time: 475768 10:30:54 INFO - Running post-run listener: _upload_blobber_files 10:30:54 INFO - Blob upload gear active. 10:30:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:54 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 10:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:30:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:55 INFO - (blobuploader) - INFO - Done attempting. 10:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:56 INFO - (blobuploader) - INFO - Done attempting. 10:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:00 INFO - (blobuploader) - INFO - Done attempting. 10:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:00 INFO - Return code: 0 10:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1457c6fc0a9a182541b0dd72a04b9eb2b6a509589cfc311c89345444602395ef15f3b63db347e3b27fb1edcdc8b2d295b2663673d896a06e4b77619f886e9c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/540798eb5c49fc209581386a02f29954a434dad45a418244d9e8e043dc509d7035b0f861fd44d47134bb613a748bb9d1787415201f433a14c6f693d1776e65f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cd8eabe3c3b0e47062b22fcabdfbc99fb147146957865453db7d77430b1af800a3e23fa528f7111d6123c09f58c276821452db0aa5e28fa88dd5ee886d4ea5e"} 10:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:00 INFO - Contents: 10:31:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1457c6fc0a9a182541b0dd72a04b9eb2b6a509589cfc311c89345444602395ef15f3b63db347e3b27fb1edcdc8b2d295b2663673d896a06e4b77619f886e9c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/540798eb5c49fc209581386a02f29954a434dad45a418244d9e8e043dc509d7035b0f861fd44d47134bb613a748bb9d1787415201f433a14c6f693d1776e65f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cd8eabe3c3b0e47062b22fcabdfbc99fb147146957865453db7d77430b1af800a3e23fa528f7111d6123c09f58c276821452db0aa5e28fa88dd5ee886d4ea5e"} 10:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:00 INFO - Copying logs to upload dir... 10:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.892291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-28 10:31:00.269174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:31:00.272338) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1457c6fc0a9a182541b0dd72a04b9eb2b6a509589cfc311c89345444602395ef15f3b63db347e3b27fb1edcdc8b2d295b2663673d896a06e4b77619f886e9c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/540798eb5c49fc209581386a02f29954a434dad45a418244d9e8e043dc509d7035b0f861fd44d47134bb613a748bb9d1787415201f433a14c6f693d1776e65f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cd8eabe3c3b0e47062b22fcabdfbc99fb147146957865453db7d77430b1af800a3e23fa528f7111d6123c09f58c276821452db0aa5e28fa88dd5ee886d4ea5e"} build_url:https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/IhrQXkNOTtCRJefmirzOrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1457c6fc0a9a182541b0dd72a04b9eb2b6a509589cfc311c89345444602395ef15f3b63db347e3b27fb1edcdc8b2d295b2663673d896a06e4b77619f886e9c11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/540798eb5c49fc209581386a02f29954a434dad45a418244d9e8e043dc509d7035b0f861fd44d47134bb613a748bb9d1787415201f433a14c6f693d1776e65f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cd8eabe3c3b0e47062b22fcabdfbc99fb147146957865453db7d77430b1af800a3e23fa528f7111d6123c09f58c276821452db0aa5e28fa88dd5ee886d4ea5e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 10:31:00.297618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:31:00.297966) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469725562.494987-1238518837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 10:31:00.382667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:31:00.382982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 10:31:00.383273) ========= ========= Total master_lag: 0.17 =========