builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1460325335.01 results: success (0) buildid: 20160410132106 builduid: 33cedb91ef1949b6aa3382140c75c268 revision: 9332103718ecc5d23f4523f2faedd929e0fb46ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.010880) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.011279) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.011568) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006236 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.037004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.037333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.052517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.052865) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.101361) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.104683) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.105048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.105323) ========= 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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-10 14:55:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-04-10 14:55:35 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190881 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.311388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.312027) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018159 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.366037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:35.366783) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9332103718ecc5d23f4523f2faedd929e0fb46ee --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 9332103718ecc5d23f4523f2faedd929e0fb46ee --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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-10 14:55:35,611 truncating revision to first 12 chars 2016-04-10 14:55:35,611 Setting DEBUG logging. 2016-04-10 14:55:35,611 attempt 1/10 2016-04-10 14:55:35,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9332103718ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-10 14:55:36,255 unpacking tar archive at: mozilla-central-9332103718ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942945 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:36.327805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:36.328371) ========= echo 9332103718ecc5d23f4523f2faedd929e0fb46ee in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9332103718ecc5d23f4523f2faedd929e0fb46ee'] 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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9332103718ecc5d23f4523f2faedd929e0fb46ee program finished with exit code 0 elapsedTime=0.003166 script_repo_revision: '9332103718ecc5d23f4523f2faedd929e0fb46ee' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:36.378514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:36.378854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 14:55:36.389782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-10 14:55:36.390509) ========= /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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:55:36 INFO - MultiFileLogger online at 20160410 14:55:36 in /builds/slave/test 14:55:36 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 14:55:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:55:36 INFO - {'append_to_log': False, 14:55:36 INFO - 'base_work_dir': '/builds/slave/test', 14:55:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:55:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:55:36 INFO - 'branch': 'Firefox-Non-PGO', 14:55:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:55:36 INFO - 'config_files': ('talos/linux_config.py',), 14:55:36 INFO - 'default_actions': ('clobber', 14:55:36 INFO - 'read-buildbot-config', 14:55:36 INFO - 'download-and-extract', 14:55:36 INFO - 'populate-webroot', 14:55:36 INFO - 'create-virtualenv', 14:55:36 INFO - 'install', 14:55:36 INFO - 'run-tests'), 14:55:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:55:36 INFO - 'download_minidump_stackwalk': True, 14:55:36 INFO - 'download_symbols': 'ondemand', 14:55:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:55:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:55:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:55:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:55:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:55:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:55:36 INFO - 'installer_path': 'installer.exe', 14:55:36 INFO - 'log_level': 'info', 14:55:36 INFO - 'log_name': 'talos', 14:55:36 INFO - 'log_to_console': True, 14:55:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:55:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:55:36 INFO - 'opt_config_files': (), 14:55:36 INFO - 'pip_index': False, 14:55:36 INFO - 'sps_profile': False, 14:55:36 INFO - 'sps_profile_interval': 0, 14:55:36 INFO - 'suite': 'dromaeojs-e10s', 14:55:36 INFO - 'system_bits': '32', 14:55:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:55:36 INFO - 'title': 'talos-linux64-ix-011', 14:55:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:55:36 INFO - 'use_talos_json': True, 14:55:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:55:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:55:36 INFO - 'work_dir': 'build'} 14:55:36 INFO - ##### 14:55:36 INFO - ##### Running clobber step. 14:55:36 INFO - ##### 14:55:36 INFO - Running pre-action listener: _resource_record_pre_action 14:55:36 INFO - Running main action method: clobber 14:55:36 INFO - rmtree: /builds/slave/test/build 14:55:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:55:37 INFO - Running post-action listener: _resource_record_post_action 14:55:37 INFO - ##### 14:55:37 INFO - ##### Running read-buildbot-config step. 14:55:37 INFO - ##### 14:55:37 INFO - Running pre-action listener: _resource_record_pre_action 14:55:37 INFO - Running main action method: read_buildbot_config 14:55:37 INFO - Using buildbot properties: 14:55:37 INFO - { 14:55:37 INFO - "project": "", 14:55:37 INFO - "product": "firefox", 14:55:37 INFO - "script_repo_revision": "production", 14:55:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:55:37 INFO - "repository": "", 14:55:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:55:37 INFO - "buildid": "20160410132106", 14:55:37 INFO - "pgo_build": "False", 14:55:37 INFO - "basedir": "/builds/slave/test", 14:55:37 INFO - "buildnumber": 312, 14:55:37 INFO - "slavename": "talos-linux64-ix-011", 14:55:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:55:37 INFO - "platform": "ubuntu64_hw", 14:55:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:55:37 INFO - "branch": "mozilla-central", 14:55:37 INFO - "repo_path": "mozilla-central", 14:55:37 INFO - "revision": "9332103718ecc5d23f4523f2faedd929e0fb46ee", 14:55:37 INFO - "stage_platform": "linux64", 14:55:37 INFO - "builduid": "33cedb91ef1949b6aa3382140c75c268", 14:55:37 INFO - "slavebuilddir": "test" 14:55:37 INFO - } 14:55:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:55:37 INFO - Running post-action listener: _resource_record_post_action 14:55:37 INFO - ##### 14:55:37 INFO - ##### Running download-and-extract step. 14:55:37 INFO - ##### 14:55:37 INFO - Running pre-action listener: _resource_record_pre_action 14:55:37 INFO - Running main action method: download_and_extract 14:55:37 INFO - mkdir: /builds/slave/test/build/tests 14:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:37 INFO - https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:55:37 INFO - Downloaded 1361 bytes. 14:55:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:55:37 INFO - Using the following test package requirements: 14:55:37 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:55:37 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:55:37 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:55:37 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'jsshell-linux-x86_64.zip'], 14:55:37 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:55:37 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:55:37 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:55:37 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:55:37 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:55:37 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:55:37 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:55:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:37 INFO - https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:55:39 INFO - Downloaded 22186066 bytes. 14:55:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:55:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:55:40 INFO - Return code: 0 14:55:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:55:40 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')]} 14:55:40 INFO - https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:55:42 INFO - Downloaded 22186066 bytes. 14:55:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:55:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:55:44 INFO - Return code: 0 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:44 INFO - https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:55:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:55:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:55:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:55:45 INFO - Downloaded 10841097 bytes. 14:55:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:55:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:55:45 INFO - Return code: 0 14:55: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')]} 14:55:45 INFO - https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:55:46 INFO - Downloaded 54084728 bytes. 14:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:55:46 INFO - mkdir: /builds/slave/test/properties 14:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 14:55:46 INFO - Contents: 14:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:55:47 INFO - Running post-action listener: _resource_record_post_action 14:55:47 INFO - Running post-action listener: set_extra_try_arguments 14:55:47 INFO - ##### 14:55:47 INFO - ##### Running populate-webroot step. 14:55:47 INFO - ##### 14:55:47 INFO - Running pre-action listener: _resource_record_pre_action 14:55:47 INFO - Running main action method: populate_webroot 14:55:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:55:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:55:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:55:47 INFO - '--tppagecycles', 14:55:47 INFO - '7'], 14:55:47 INFO - 'tests': ['tsvgm']}}, 14:55:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:55:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:55:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:55:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:55:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['damp', 'tps']}, 14:55:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'tests': ['damp', 'tps']}, 14:55:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['dromaeo_dom']}, 14:55:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:55:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['a11yr', 14:55:47 INFO - 'ts_paint', 14:55:47 INFO - 'tpaint', 14:55:47 INFO - 'sessionrestore', 14:55:47 INFO - 'sessionrestore_no_auto_restore', 14:55:47 INFO - 'tabpaint']}, 14:55:47 INFO - 'other-e10s': {'tests': ['a11yr', 14:55:47 INFO - 'ts_paint', 14:55:47 INFO - 'tpaint', 14:55:47 INFO - 'sessionrestore', 14:55:47 INFO - 'sessionrestore_no_auto_restore', 14:55:47 INFO - 'tabpaint']}, 14:55:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:55:47 INFO - 'ts_paint', 14:55:47 INFO - 'tpaint', 14:55:47 INFO - 'sessionrestore', 14:55:47 INFO - 'sessionrestore_no_auto_restore', 14:55:47 INFO - 'tabpaint']}, 14:55:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:55:47 INFO - 'ts_paint', 14:55:47 INFO - 'tpaint', 14:55:47 INFO - 'sessionrestore', 14:55:47 INFO - 'sessionrestore_no_auto_restore', 14:55:47 INFO - 'tabpaint']}, 14:55:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['a11yr', 14:55:47 INFO - 'ts_paint', 14:55:47 INFO - 'tpaint', 14:55:47 INFO - 'sessionrestore', 14:55:47 INFO - 'sessionrestore_no_auto_restore', 14:55:47 INFO - 'tabpaint']}, 14:55:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['a11yr', 14:55:47 INFO - 'ts_paint', 14:55:47 INFO - 'tpaint', 14:55:47 INFO - 'sessionrestore', 14:55:47 INFO - 'sessionrestore_no_auto_restore', 14:55:47 INFO - 'tabpaint']}, 14:55:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['tsvgx', 14:55:47 INFO - 'tsvgr_opacity', 14:55:47 INFO - 'tart', 14:55:47 INFO - 'tscrollx', 14:55:47 INFO - 'cart']}, 14:55:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:55:47 INFO - 'tsvgr_opacity', 14:55:47 INFO - 'tart', 14:55:47 INFO - 'tscrollx', 14:55:47 INFO - 'cart']}, 14:55:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'talos_options': ['--disable-e10s'], 14:55:47 INFO - 'tests': ['tp5o']}, 14:55:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'tests': ['tp5o']}, 14:55:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'talos_options': ['--disable-e10s', 14:55:47 INFO - '--xperf_path', 14:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:47 INFO - 'tests': ['tp5n']}, 14:55:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:47 INFO - 'talos_options': ['--xperf_path', 14:55:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:47 INFO - 'tests': ['tp5n']}}, 14:55:47 INFO - 'talos.zip': {'path': '', 14:55:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:55:47 INFO - Running post-action listener: _resource_record_post_action 14:55:47 INFO - ##### 14:55:47 INFO - ##### Running create-virtualenv step. 14:55:47 INFO - ##### 14:55:47 INFO - Running pre-action listener: _resource_record_pre_action 14:55:47 INFO - Running main action method: create_virtualenv 14:55:47 INFO - Creating virtualenv /builds/slave/test/build/venv 14:55:47 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 14:55:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:55:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:55:47 INFO - Using real prefix '/usr' 14:55:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:55:49 INFO - Installing pip.................done. 14:55:49 INFO - Return code: 0 14:55:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:55:49 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')]} 14:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:49 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')]} 14:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:49 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 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:55:49 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 14:55:49 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 14:55:49 INFO - Using env: {'DISPLAY': ':0', 14:55:49 INFO - 'HOME': '/home/cltbld', 14:55:49 INFO - 'LANG': 'en_US.UTF-8', 14:55:49 INFO - 'LANGUAGE': 'en_US:en', 14:55:49 INFO - 'LOGNAME': 'cltbld', 14:55:49 INFO - 'MAIL': '/var/mail/cltbld', 14:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:49 INFO - 'MOZ_NO_REMOTE': '1', 14:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:49 INFO - 'NO_EM_RESTART': '1', 14:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:49 INFO - 'PWD': '/builds/slave/test', 14:55:49 INFO - 'SHELL': '/bin/bash', 14:55:49 INFO - 'SHLVL': '1', 14:55:49 INFO - 'TERM': 'linux', 14:55:49 INFO - 'TMOUT': '86400', 14:55:49 INFO - 'USER': 'cltbld', 14:55:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:49 INFO - '_': '/tools/buildbot/bin/python'} 14:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:50 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 14:55:50 INFO - Cleaning up... 14:55:50 INFO - Return code: 0 14:55:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:55:50 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')]} 14:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:50 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')]} 14:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:50 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:55:50 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>=0.7.1'] in /builds/slave/test/build 14:55:50 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>=0.7.1 14:55:50 INFO - Using env: {'DISPLAY': ':0', 14:55:50 INFO - 'HOME': '/home/cltbld', 14:55:50 INFO - 'LANG': 'en_US.UTF-8', 14:55:50 INFO - 'LANGUAGE': 'en_US:en', 14:55:50 INFO - 'LOGNAME': 'cltbld', 14:55:50 INFO - 'MAIL': '/var/mail/cltbld', 14:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:50 INFO - 'MOZ_NO_REMOTE': '1', 14:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:50 INFO - 'NO_EM_RESTART': '1', 14:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:50 INFO - 'PWD': '/builds/slave/test', 14:55:50 INFO - 'SHELL': '/bin/bash', 14:55:50 INFO - 'SHLVL': '1', 14:55:50 INFO - 'TERM': 'linux', 14:55:50 INFO - 'TMOUT': '86400', 14:55:50 INFO - 'USER': 'cltbld', 14:55:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:50 INFO - '_': '/tools/buildbot/bin/python'} 14:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:50 INFO - Downloading/unpacking psutil>=0.7.1 14:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:52 INFO - Installing collected packages: psutil 14:55:52 INFO - Running setup.py install for psutil 14:55:52 INFO - building 'psutil._psutil_linux' extension 14:55:52 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 14:55:52 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 14:55:52 INFO - building 'psutil._psutil_posix' extension 14:55:52 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 14:55:52 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 14:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:52 INFO - Successfully installed psutil 14:55:52 INFO - Cleaning up... 14:55:52 INFO - Return code: 0 14:55:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:55: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')]} 14:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55: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')]} 14:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:55: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:55: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 mozsystemmonitor==0.0.0 14:55:52 INFO - Using env: {'DISPLAY': ':0', 14:55:52 INFO - 'HOME': '/home/cltbld', 14:55:52 INFO - 'LANG': 'en_US.UTF-8', 14:55:52 INFO - 'LANGUAGE': 'en_US:en', 14:55:52 INFO - 'LOGNAME': 'cltbld', 14:55:52 INFO - 'MAIL': '/var/mail/cltbld', 14:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:52 INFO - 'MOZ_NO_REMOTE': '1', 14:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:52 INFO - 'NO_EM_RESTART': '1', 14:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:52 INFO - 'PWD': '/builds/slave/test', 14:55:52 INFO - 'SHELL': '/bin/bash', 14:55:52 INFO - 'SHLVL': '1', 14:55:52 INFO - 'TERM': 'linux', 14:55:52 INFO - 'TMOUT': '86400', 14:55:52 INFO - 'USER': 'cltbld', 14:55:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:52 INFO - '_': '/tools/buildbot/bin/python'} 14:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:55:53 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 14:55:53 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 14:55:53 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 14:55:53 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 14:55:53 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 14:55:53 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 14:55:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:55:55 INFO - Installing collected packages: mozsystemmonitor 14:55:55 INFO - Running setup.py install for mozsystemmonitor 14:55:55 INFO - Successfully installed mozsystemmonitor 14:55:55 INFO - Cleaning up... 14:55:55 INFO - Return code: 0 14:55:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:55:55 INFO - Using env: {'DISPLAY': ':0', 14:55:55 INFO - 'HOME': '/home/cltbld', 14:55:55 INFO - 'LANG': 'en_US.UTF-8', 14:55:55 INFO - 'LANGUAGE': 'en_US:en', 14:55:55 INFO - 'LOGNAME': 'cltbld', 14:55:55 INFO - 'MAIL': '/var/mail/cltbld', 14:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:55 INFO - 'MOZ_NO_REMOTE': '1', 14:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:55 INFO - 'NO_EM_RESTART': '1', 14:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:55 INFO - 'PWD': '/builds/slave/test', 14:55:55 INFO - 'SHELL': '/bin/bash', 14:55:55 INFO - 'SHLVL': '1', 14:55:55 INFO - 'TERM': 'linux', 14:55:55 INFO - 'TMOUT': '86400', 14:55:55 INFO - 'USER': 'cltbld', 14:55:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:55 INFO - '_': '/tools/buildbot/bin/python'} 14:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 14:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:57 INFO - Downloading docopt-0.6.1.tar.gz 14:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:55:57 INFO - Running setup.py install for blobuploader 14:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:55:58 INFO - Running setup.py install for requests 14:55:58 INFO - Running setup.py install for docopt 14:55:58 INFO - Successfully installed blobuploader requests docopt 14:55:58 INFO - Cleaning up... 14:55:58 INFO - Return code: 0 14:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:58 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')]} 14:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:58 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')]} 14:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:58 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 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:55:58 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 14:55:58 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 14:55:58 INFO - Using env: {'DISPLAY': ':0', 14:55:58 INFO - 'HOME': '/home/cltbld', 14:55:58 INFO - 'LANG': 'en_US.UTF-8', 14:55:58 INFO - 'LANGUAGE': 'en_US:en', 14:55:58 INFO - 'LOGNAME': 'cltbld', 14:55:58 INFO - 'MAIL': '/var/mail/cltbld', 14:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:58 INFO - 'MOZ_NO_REMOTE': '1', 14:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:58 INFO - 'NO_EM_RESTART': '1', 14:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:58 INFO - 'PWD': '/builds/slave/test', 14:55:58 INFO - 'SHELL': '/bin/bash', 14:55:58 INFO - 'SHLVL': '1', 14:55:58 INFO - 'TERM': 'linux', 14:55:58 INFO - 'TMOUT': '86400', 14:55:58 INFO - 'USER': 'cltbld', 14:55:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:58 INFO - '_': '/tools/buildbot/bin/python'} 14:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:58 INFO - Running setup.py (path:/tmp/pip-2ELrpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:58 INFO - Running setup.py (path:/tmp/pip-817cdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:58 INFO - Running setup.py (path:/tmp/pip-76hP_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:59 INFO - Running setup.py (path:/tmp/pip-y9UGdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:59 INFO - Running setup.py (path:/tmp/pip-LEfveJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:59 INFO - Running setup.py (path:/tmp/pip-NI1Cd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:59 INFO - Running setup.py (path:/tmp/pip-D4G_um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:59 INFO - Running setup.py (path:/tmp/pip-5EBlKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:59 INFO - Running setup.py (path:/tmp/pip-5YcwyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:59 INFO - Running setup.py (path:/tmp/pip-QmyizJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:59 INFO - Running setup.py (path:/tmp/pip-dXiHcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:59 INFO - Running setup.py (path:/tmp/pip-iuQ6Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:59 INFO - Running setup.py (path:/tmp/pip-VPExA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:59 INFO - Running setup.py (path:/tmp/pip-QNGPwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:59 INFO - Running setup.py (path:/tmp/pip-3g9czV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:59 INFO - Running setup.py (path:/tmp/pip-8X9K9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:59 INFO - Running setup.py (path:/tmp/pip-JrtS4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:56:00 INFO - Running setup.py install for manifestparser 14:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozcrash 14:56:00 INFO - Running setup.py install for mozdebug 14:56:00 INFO - Running setup.py install for mozdevice 14:56:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozfile 14:56:00 INFO - Running setup.py install for mozhttpd 14:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozinfo 14:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozInstall 14:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozleak 14:56:00 INFO - Running setup.py install for mozlog 14:56:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Running setup.py install for moznetwork 14:56:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Running setup.py install for mozprocess 14:56:01 INFO - Running setup.py install for mozprofile 14:56:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Running setup.py install for mozrunner 14:56:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Running setup.py install for mozscreenshot 14:56:01 INFO - Running setup.py install for moztest 14:56:01 INFO - Running setup.py install for mozversion 14:56:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:56:01 INFO - Cleaning up... 14:56:01 INFO - Return code: 0 14:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:01 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 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:56:01 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 14:56:01 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 14:56:01 INFO - Using env: {'DISPLAY': ':0', 14:56:01 INFO - 'HOME': '/home/cltbld', 14:56:01 INFO - 'LANG': 'en_US.UTF-8', 14:56:01 INFO - 'LANGUAGE': 'en_US:en', 14:56:01 INFO - 'LOGNAME': 'cltbld', 14:56:01 INFO - 'MAIL': '/var/mail/cltbld', 14:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:01 INFO - 'MOZ_NO_REMOTE': '1', 14:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:01 INFO - 'NO_EM_RESTART': '1', 14:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:01 INFO - 'PWD': '/builds/slave/test', 14:56:01 INFO - 'SHELL': '/bin/bash', 14:56:01 INFO - 'SHLVL': '1', 14:56:01 INFO - 'TERM': 'linux', 14:56:01 INFO - 'TMOUT': '86400', 14:56:01 INFO - 'USER': 'cltbld', 14:56:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:01 INFO - '_': '/tools/buildbot/bin/python'} 14:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:02 INFO - Running setup.py (path:/tmp/pip-Bg61sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:02 INFO - Running setup.py (path:/tmp/pip-tKkwuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:02 INFO - Running setup.py (path:/tmp/pip-rDpEGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:02 INFO - Running setup.py (path:/tmp/pip-NBI4JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:02 INFO - Running setup.py (path:/tmp/pip-GZZ3_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:02 INFO - Running setup.py (path:/tmp/pip-cciV8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:02 INFO - Running setup.py (path:/tmp/pip-gfqzDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:02 INFO - Running setup.py (path:/tmp/pip-Z5maLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:02 INFO - Running setup.py (path:/tmp/pip-95PWCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:02 INFO - Running setup.py (path:/tmp/pip-McU4qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:02 INFO - Running setup.py (path:/tmp/pip-DbpWgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:02 INFO - Running setup.py (path:/tmp/pip-8GIY2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:02 INFO - Running setup.py (path:/tmp/pip-3hQfA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:02 INFO - Running setup.py (path:/tmp/pip-9erBJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:03 INFO - Running setup.py (path:/tmp/pip-UcTyoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:03 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)) 14:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:03 INFO - Running setup.py (path:/tmp/pip-AgEp9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:03 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)) 14:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:03 INFO - Running setup.py (path:/tmp/pip-J1WiV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:03 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)) 14:56:03 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)) 14:56:03 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)) 14:56:03 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)) 14:56:03 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)) 14:56:03 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)) 14:56:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:56:03 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 14:56:03 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 14:56:03 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 14:56:03 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 14:56:03 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 14:56:03 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 14:56:05 INFO - Downloading blessings-1.6.tar.gz 14:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:56:05 INFO - Installing collected packages: blessings 14:56:05 INFO - Running setup.py install for blessings 14:56:05 INFO - Successfully installed blessings 14:56:05 INFO - Cleaning up... 14:56:05 INFO - Return code: 0 14:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:05 INFO - Reading from file tmpfile_stdout 14:56:05 INFO - Current package versions: 14:56:05 INFO - argparse == 1.2.1 14:56:05 INFO - blessings == 1.6 14:56:05 INFO - blobuploader == 1.2.4 14:56:05 INFO - docopt == 0.6.1 14:56:05 INFO - manifestparser == 1.1 14:56:05 INFO - mozInstall == 1.12 14:56:05 INFO - mozcrash == 0.17 14:56:05 INFO - mozdebug == 0.1 14:56:05 INFO - mozdevice == 0.48 14:56:05 INFO - mozfile == 1.2 14:56:05 INFO - mozhttpd == 0.7 14:56:05 INFO - mozinfo == 0.9 14:56:05 INFO - mozleak == 0.1 14:56:05 INFO - mozlog == 3.1 14:56:05 INFO - moznetwork == 0.27 14:56:05 INFO - mozprocess == 0.22 14:56:05 INFO - mozprofile == 0.28 14:56:05 INFO - mozrunner == 6.11 14:56:05 INFO - mozscreenshot == 0.1 14:56:05 INFO - mozsystemmonitor == 0.0 14:56:05 INFO - moztest == 0.7 14:56:05 INFO - mozversion == 1.4 14:56:05 INFO - psutil == 3.1.1 14:56:05 INFO - requests == 1.2.3 14:56:05 INFO - wsgiref == 0.1.2 14:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:05 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')]} 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 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')]} 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 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 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:56:05 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 14:56:05 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 14:56:05 INFO - Using env: {'DISPLAY': ':0', 14:56:05 INFO - 'HOME': '/home/cltbld', 14:56:05 INFO - 'LANG': 'en_US.UTF-8', 14:56:05 INFO - 'LANGUAGE': 'en_US:en', 14:56:05 INFO - 'LOGNAME': 'cltbld', 14:56:05 INFO - 'MAIL': '/var/mail/cltbld', 14:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:05 INFO - 'MOZ_NO_REMOTE': '1', 14:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:05 INFO - 'NO_EM_RESTART': '1', 14:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:05 INFO - 'PWD': '/builds/slave/test', 14:56:05 INFO - 'SHELL': '/bin/bash', 14:56:05 INFO - 'SHLVL': '1', 14:56:05 INFO - 'TERM': 'linux', 14:56:05 INFO - 'TMOUT': '86400', 14:56:05 INFO - 'USER': 'cltbld', 14:56:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:05 INFO - '_': '/tools/buildbot/bin/python'} 14:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 INFO - Cleaning up... 14:56:05 INFO - Return code: 0 14:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:56:05 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')]} 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 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')]} 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 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 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:56:05 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 14:56:05 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 14:56:05 INFO - Using env: {'DISPLAY': ':0', 14:56:05 INFO - 'HOME': '/home/cltbld', 14:56:05 INFO - 'LANG': 'en_US.UTF-8', 14:56:05 INFO - 'LANGUAGE': 'en_US:en', 14:56:05 INFO - 'LOGNAME': 'cltbld', 14:56:05 INFO - 'MAIL': '/var/mail/cltbld', 14:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:05 INFO - 'MOZ_NO_REMOTE': '1', 14:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:05 INFO - 'NO_EM_RESTART': '1', 14:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:05 INFO - 'PWD': '/builds/slave/test', 14:56:05 INFO - 'SHELL': '/bin/bash', 14:56:05 INFO - 'SHLVL': '1', 14:56:05 INFO - 'TERM': 'linux', 14:56:05 INFO - 'TMOUT': '86400', 14:56:05 INFO - 'USER': 'cltbld', 14:56:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:05 INFO - '_': '/tools/buildbot/bin/python'} 14:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:06 INFO - Downloading/unpacking jsonschema 14:56:06 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 14:56:06 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 14:56:06 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 14:56:06 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 14:56:06 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 14:56:06 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 14:56:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:56:08 INFO - Downloading/unpacking functools32 (from jsonschema) 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:08 INFO - Downloading functools32-3.2.3-2.tar.gz 14:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:56:08 INFO - warning: no files found matching '*.txt' 14:56:08 INFO - no previously-included directories found matching 'build' 14:56:08 INFO - no previously-included directories found matching 'dist' 14:56:08 INFO - no previously-included directories found matching '.git*' 14:56:08 INFO - Installing collected packages: jsonschema, functools32 14:56:08 INFO - Running setup.py install for functools32 14:56:08 INFO - warning: no files found matching '*.txt' 14:56:08 INFO - no previously-included directories found matching 'build' 14:56:08 INFO - no previously-included directories found matching 'dist' 14:56:08 INFO - no previously-included directories found matching '.git*' 14:56:08 INFO - Successfully installed jsonschema functools32 14:56:08 INFO - Cleaning up... 14:56:08 INFO - Return code: 0 14:56:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:08 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78a1068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, '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-1460325334.436917-1219897260', '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 14:56:08 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', 'flake8'] in /builds/slave/test/build 14:56:08 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 flake8 14:56:08 INFO - Using env: {'DISPLAY': ':0', 14:56:08 INFO - 'HOME': '/home/cltbld', 14:56:08 INFO - 'LANG': 'en_US.UTF-8', 14:56:08 INFO - 'LANGUAGE': 'en_US:en', 14:56:08 INFO - 'LOGNAME': 'cltbld', 14:56:08 INFO - 'MAIL': '/var/mail/cltbld', 14:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:08 INFO - 'MOZ_NO_REMOTE': '1', 14:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:08 INFO - 'NO_EM_RESTART': '1', 14:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:08 INFO - 'PWD': '/builds/slave/test', 14:56:08 INFO - 'SHELL': '/bin/bash', 14:56:08 INFO - 'SHLVL': '1', 14:56:08 INFO - 'TERM': 'linux', 14:56:08 INFO - 'TMOUT': '86400', 14:56:08 INFO - 'USER': 'cltbld', 14:56:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:08 INFO - '_': '/tools/buildbot/bin/python'} 14:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:08 INFO - Downloading/unpacking flake8 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:56:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:56:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 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 14:56:10 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 14:56:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:56:11 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 14:56:11 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 14:56:11 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 14:56:11 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 14:56:11 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 14:56:11 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 14:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:56:11 INFO - no previously-included directories found matching 'docs/_build' 14:56:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:56:11 INFO - Running setup.py install for pep8 14:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:56:11 INFO - no previously-included directories found matching 'docs/_build' 14:56:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:56:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:56:11 INFO - Cleaning up... 14:56:11 INFO - Return code: 0 14:56:11 INFO - Running post-action listener: _resource_record_post_action 14:56:11 INFO - Running post-action listener: _start_resource_monitoring 14:56:11 INFO - Starting resource monitoring. 14:56:11 INFO - ##### 14:56:11 INFO - ##### Running install step. 14:56:11 INFO - ##### 14:56:11 INFO - Running pre-action listener: _resource_record_pre_action 14:56:11 INFO - Running main action method: install 14:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:11 INFO - Reading from file tmpfile_stdout 14:56:11 INFO - Detecting whether we're running mozinstall >=1.0... 14:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:56:11 INFO - Reading from file tmpfile_stdout 14:56:11 INFO - Output received: 14:56:11 INFO - Usage: mozinstall [options] installer 14:56:11 INFO - Options: 14:56:11 INFO - -h, --help show this help message and exit 14:56:11 INFO - -d DEST, --destination=DEST 14:56:11 INFO - Directory to install application into. [default: 14:56:11 INFO - "/builds/slave/test"] 14:56:11 INFO - --app=APP Application being installed. [default: firefox] 14:56:11 INFO - mkdir: /builds/slave/test/build/application 14:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:56:27 INFO - Reading from file tmpfile_stdout 14:56:27 INFO - Output received: 14:56:27 INFO - /builds/slave/test/build/application/firefox/firefox 14:56:27 INFO - Running post-action listener: _resource_record_post_action 14:56:27 INFO - ##### 14:56:27 INFO - ##### Running run-tests step. 14:56:27 INFO - ##### 14:56:27 INFO - Running pre-action listener: _resource_record_pre_action 14:56:27 INFO - Running main action method: run_tests 14:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:56:27 INFO - Python 2.7.3 14:56:27 INFO - Return code: 0 14:56:27 INFO - grabbing minidump binary from tooltool 14:56: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')]} 14:56:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ce410>, '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 0x27cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27cf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:56:27 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 14:56:27 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 14:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:56:27 INFO - Return code: 0 14:56:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:56:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:56:28 INFO - Return code: 0 14:56:28 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/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.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 14:56:28 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/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.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 14:56:28 INFO - Using env: {'DISPLAY': ':0', 14:56:28 INFO - 'HOME': '/home/cltbld', 14:56:28 INFO - 'LANG': 'en_US.UTF-8', 14:56:28 INFO - 'LANGUAGE': 'en_US:en', 14:56:28 INFO - 'LOGNAME': 'cltbld', 14:56:28 INFO - 'MAIL': '/var/mail/cltbld', 14:56:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:56:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:28 INFO - 'MOZ_NO_REMOTE': '1', 14:56:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:28 INFO - 'NO_EM_RESTART': '1', 14:56:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:28 INFO - 'PWD': '/builds/slave/test', 14:56:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:56:28 INFO - 'SHELL': '/bin/bash', 14:56:28 INFO - 'SHLVL': '1', 14:56:28 INFO - 'TERM': 'linux', 14:56:28 INFO - 'TMOUT': '86400', 14:56:28 INFO - 'USER': 'cltbld', 14:56:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460325334.436917-1219897260', 14:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:28 INFO - '_': '/tools/buildbot/bin/python'} 14:56:28 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/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.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 14:56:28 INFO - mozversion application_buildid: 20160410132106 14:56:28 INFO - mozversion application_changeset: 9332103718ecc5d23f4523f2faedd929e0fb46ee 14:56:28 INFO - mozversion application_display_name: Nightly 14:56:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:56:28 INFO - mozversion application_name: Firefox 14:56:28 INFO - mozversion application_remotingname: firefox 14:56:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:56:28 INFO - mozversion application_vendor: Mozilla 14:56:28 INFO - mozversion application_version: 48.0a1 14:56:28 INFO - mozversion platform_buildid: 20160410132106 14:56:28 INFO - mozversion platform_changeset: 9332103718ecc5d23f4523f2faedd929e0fb46ee 14:56:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:56:28 INFO - mozversion platform_version: 48.0a1 14:56:28 INFO - using testdate: 1460325388 14:56:28 INFO - actual date: 1460325388 14:56:28 INFO - starting webserver on 'localhost:53577' 14:56:28 INFO - SUITE-START | Running 2 tests 14:56:28 INFO - TEST-START | dromaeo_css 14:56:28 INFO - operating with platform_type : linux_ 14:56:28 INFO - Initialising browser for dromaeo_css test... 14:56:28 INFO - TEST-INFO | started process 21781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qgfXN/profile http://localhost:53577/getInfo.html) 14:56:33 INFO - PROCESS | 21781 | 14:56:33 INFO - PROCESS | 21781 | (process:21848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:56:33 INFO - PROCESS | 21781 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:56:34 INFO - PROCESS | 21781 | __metrics Screen width/height:1600/1200 14:56:34 INFO - PROCESS | 21781 | colorDepth:24 14:56:34 INFO - PROCESS | 21781 | Browser inner width/height: 1024/697 14:56:34 INFO - PROCESS | 21781 | __metrics 14:56:34 ERROR - PROCESS | 21781 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 14:56:35 INFO - TEST-INFO | 21781: exit 0 14:56:35 INFO - Browser initialized. 14:56:35 INFO - Running cycle 1/1 for dromaeo_css test... 14:56:35 INFO - TEST-INFO | started process 21900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qgfXN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:37 INFO - PROCESS | 21900 | 14:56:37 INFO - PROCESS | 21900 | (process:21960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:56:47 INFO - PROCESS | 21900 | RSS: Main: 164069376 14:56:47 INFO - PROCESS | 21900 | 14:57:37 INFO - PROCESS | 21900 | 1460325457361 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] 14:59:49 INFO - PROCESS | 21900 | Cycle 1(1): loaded http://localhost:53577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53577/tests/dromaeo/cssquery-ext.html) 14:59:50 INFO - PROCESS | 21900 | RSS: Main: 169390080 14:59:50 INFO - PROCESS | 21900 | 15:02:52 INFO - PROCESS | 21900 | Cycle 1(1): loaded http://localhost:53577/tests/dromaeo/cssquery-ext.html (next: http://localhost:53577/tests/dromaeo/cssquery-jquery.html) 15:02:53 INFO - PROCESS | 21900 | RSS: Main: 167731200 15:02:53 INFO - PROCESS | 21900 | 15:05:54 INFO - PROCESS | 21900 | Cycle 1(1): loaded http://localhost:53577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53577/tests/dromaeo/cssquery-mootools.html) 15:05:55 INFO - PROCESS | 21900 | RSS: Main: 166449152 15:05:55 INFO - PROCESS | 21900 | 15:08:57 INFO - PROCESS | 21900 | Cycle 1(1): loaded http://localhost:53577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53577/tests/dromaeo/cssquery-prototype.html) 15:08:57 INFO - PROCESS | 21900 | RSS: Main: 164347904 15:08:57 INFO - PROCESS | 21900 | 15:12:00 INFO - PROCESS | 21900 | Cycle 1(1): loaded http://localhost:53577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53577/tests/dromaeo/cssquery-yui.html) 15:12:01 INFO - PROCESS | 21900 | RSS: Main: 165621760 15:12:01 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | Cycle 1(1): loaded http://localhost:53577/tests/dromaeo/cssquery-yui.html (next: http://localhost:53577/tests/dromaeo/cssquery-dojo.html) 15:15:03 INFO - PROCESS | 21900 | RSS: Main: 168247296 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | __start_tp_report 15:15:03 INFO - PROCESS | 21900 | _x_x_mozilla_page_load 15:15:03 INFO - PROCESS | 21900 | _x_x_mozilla_page_load_details 15:15:03 INFO - PROCESS | 21900 | |i|pagename|runs| 15:15:03 INFO - PROCESS | 21900 | |0;dojo.html;2609.0476975903794;2667.933301667458;2691.1119330620895;2718.7960902932286;2727.686316073652;4643.280291554806;4675.672702910793;4679.087577922306;4679.321498382733;4742.288656701497;4555.362249285103;4666.533346665332;4711.128441238373;4730.290456431537;4771.093492236481;4298.613124818766;4348.347747837834;4369.781510924457;4406.5373135820755;4482.596566309032;4303.978480107611;4326.84856030039;4378;4393.736375817445;4437.378766972626;4254.957450425487;4304.268274393329;4310.762908040057;4324.6972711910175;4361.040571074359;4283.614474697261;4300.333448315516;4308.073764140693;4312.784360781949;4339.869803905888;4204.978975105105;4251.553586873396;4268.189044081614;4276.850310239127;4309.547497512779;4555.63554915606;4577.084583083363;4580.038191979688;4619.376384188159;4624.5144259852905;4957.5042495750495;4980.2280646499485;4986.750662466899;4989.301497790312;5002.0246052019875;4947.233178857283;5004.524570165829;5023.070731914608;5030.597552195853;5072.467390923936;4675.532446755297;4681;4712.222483290253;4717.787699553528;4727.101850648366;5105.489451054865;5120.225038528894;5131.897362052813;5133.563647090039;5134.922976155361;4864.610831133501;4879.048585525859;4941.357623508921;4948.406191257072;4958.404991400983;4886.731229782396;4981.62637802159;4989.3264409305;5012.7994880205115;5049.495050494921;4920.827771027997;4933.531314525115;4934.432540257916;4943.431505376856;4998.375203099613;4868.853934381974;4913.877153071202;4923.990581930767;4939.407271127488;4997.175466048134;4263.914721705549;4268.061026574149;4270.167317373082;4291.31338985767;4297.39836422901;3694.168812017275;3742.1767211214033;3743.1765011697385;3763.0592351912023;3765.7175711821174;4267;4322.740635561813;4361.236783562864;4390.714603550759;4402.5597440255715;4991.326170966946;5003.849884503471;5025.673331233458;5041.092603331363;5094.974525127351;4246.7027308088755;4320.524742278347;4322.654187664979;4331.155424692155;4363.2364336241035;4475.552444755564;4506.031203291308;4507.954920450819;4530.977345113253;4533.569310915458;4647.953520464752;4654.767261636973;4661.184292748688;4667.883302917454;4695.9530404695515;4940.851774446773;4959.404871415453;4978.47725988766;4993.625478089085;5013.699178049329;4709.670323077352;4716.0332131913565;4738.194506933761;4742.952570474251;4793.9280910785665;4939.777710002986;4944.381952255968;4946.925796113133;4947.505249475023;4986.850394488171;4953.479884612064;5013.749312534285;5037.974810125926;5071.594272458121;5077.238414237746;4784.091022705675;4797.40032495938;4866.343043689199;4899.853004409873;4904.681195722266;4857.489963553776;4872.342233798392;4881.90236195267;4887.560119589254;4935.901281974268;4665.2302370108555;4729.43246810385;4801.159797035574;4814.759262036954;4849.563539281482;4833.05755377698;4835.20219163834;4836.564709176191;4838.709677419366;4917.508249175054;4809.903801923872;4813.95186048135;4821.397325334333;4838.104950584153;4842.297866809223 15:15:03 INFO - PROCESS | 21900 | |1;ext.html;577.8150991682663;594.2898236607255;613.129356314034;614.483833579793;639.0191056727923;32727.1818204545;33786.493202601916;33941.321173576514;34021.489677654856;34059.318813623715;34468.482972755366;34750.30499390011;34976.650233497654;35043.4743478848;35162.296754064904;7418.22108678589;7564.357029652486;7577.621118944058;7579.621018949058;7579.621018949058;7427.851442971138;7577.962110189442;7673.53958762476;7687.692492300302;7692;7641.808954776147;7662.501937374081;7672.578008209546;7714.614269286513;7749.263819937097;7592.126905405866;7688.038995125581;7706.229377062305;7709.036370453693;7711.6915323387275;7595.582242976634;7646.847063058708;7654.4259180561685;7688.923110768933;7692.923070769277;34034.48948265778;34663.480047799305;34665.653343466496;34675.653243467495;34698.30603387943;3072.2626569623353;3563.233904710474;3580.122869896892;3601.7838929664304;3645.106948797535;27835.86082069597;28407.147785566467;28550.571741423897;28599.714002859913;28639;3456.3778519866414;3520.4895290183035;3532.2935412917263;3664.871729489482;3665.725070619714;217131;218080;218214;218287;264948;52410.21384679233;53939.46060539344;54080;54116;54151;49279.50720492749;49382.506174938506;49458.50541494611;49529.50470495321;49752.75123624431;12161.209521381083;12314.322712250912;12315.4458049388;12331.260124392566;12369.505219791288;9339;9406.294527910297;9444;9586.376885502421;9611;16105.677886442205;16221.2700428481;16267.593310167103;16275.674486510203;16326.75509867353;5974.984252677055;5986.5210783137245;6134.631922084689;6188.545691762432;6207.720652570645;939.2764277550634;948.6584829461389;977.6675930183771;989.3074847606704;1011.0900189829213;28206.29484262869;28288;28532.286692832844;28541.57187642187;28785.136445906657;964.8697425847561;996.5798736800031;1045.8378951262566;1068.2201992545486;1097.9523189252147;13777.655558611115;13989.860101398855;15364.692706145814;16005.759913601305;16314.265858036417;242340;244705;246252;247077;247215;47379.289310660366;48716.26925596119;48870.51129488731;48951;49079.754601227476;1203.3321506563766;1233.784087784652;1276.3426835179705;1290.32258064515;1290.9289989050505;27999.440011199255;29125.126246212647;29238;29273;29390.05448706747;41201.587984119775;41896.162076758905;41898.37152442777;41945.58054419417;41989;287019;288158;289829;290073;290309;24807.379815504755;25152.24543263632;25170.496590068462;25242.495150097264;25243.11649092273;39920.60079399169;40150;40383.79808100941;41025.58974410217;41434.1713165741;35410.46884296686;35715.46426803548;36027.27945441129;36601.81699091488;37445;35865.82067089648;36285.27429451449;36376.27247455089;36379.45430818593;36783.44824827576;35185.296294074484;35448.82275588605;36136.096597585274;36177.819110904275;36243.81878090592;30788.53817192789;31884.840575796974;32893.835530822194;32982;32989.83505082459;25040.37399065038;25054;25112;25553.744462555136;25651.743482564936 15:15:03 INFO - PROCESS | 21900 | |2;jquery.html;382.17831661926846;384.0935392473762;384.6000159833775;394.27059939112627;397.1183971583084;15595.298211580477;16774.41289554864;16869;16873.49379518615;17166.141692915335;11733.53065877366;15629.531114066596;16376;16415.26131324093;16447.2598733057;4558.772061396933;4741.336212930192;4759.238521836507;4792.209285467911;4792.448868380146;3417.470292104728;5042.369703787027;5317.12267475866;5326.6537675051195;5335.67985920846;5270.104082305998;5302.231176479428;5311.309529761125;5325.680459172443;5339.252504649352;5235.345581802275;5314;5343.492368225013;5349.491798279158;5357.383900851393;5036.06832735945;5045.293658887758;5205.063088644042;5210.843674689765;5227.424983251839;12356.505739770399;15376.615584610363;20373.592528149504;20454.284100056575;20488.18047278107;1929.5851391950798;1932.4299331697182;1935.3032908153054;1938.0987840654163;1965.577400858808;8856.062935883554;9300.953495232548;9340.299477539213;9429.481378524179;9492.857607135898;1732.9480115596552;1808.6473137738146;1849.1863580024747;1853.4532312967706;1871.953201169968;65497;66188.3381166187;66617.3338266616;67594.66202669004;67737;10067.597296108073;10089.495525223709;10147.847782283125;10179.54192061359;10245.334053286662;14091.788623170456;14307.28463576817;14362.497312594009;14383.78424323636;14389.856101438852;6815.454763618898;6853.348931851466;6867.793966181022;7032.964835175791;7053.224145344008;6233.906491402633;6309.148264984168;6342.936570634327;6377.585456945284;6390.744370225232;4311.223979683625;4319.740815551077;4365.345198220292;4431.202383570923;4432.180046691373;1694.5594145522007;1764.7176451767655;1857.6099019206117;1874.7000479923147;1896.8956707381226;869.4913475616709;938.4181807279531;971.820213260535;1010.888802231754;1021.9489025548842;15462;15632.609184770245;16160.191990400668;16431.671366572842;16535.6692866142;856.3620103023163;883;890.2610833008588;919.5884317572494;953.666216824106;9095.388106720038;9231.399959002643;9246.86129708055;9324.720258392259;9459.337846350827;391891;395596;396961;399840;412038;76182.6190869042;78008.60995694985;78040.60979695065;80342;80344.45747947007;935.9906400936039;938.3666025432806;964.0985678390587;965.1024547171058;972.9221662267001;14628.34172462263;14762.704745904806;14863.851361486246;14877.330520126838;15211.771823422436;32522;33202.667973320924;33474.33051338911;33805;33878.830605846815;45785;45828.77085614684;48018.5198148014;48447.5155248443;48503;6864.691088900911;7310;7532.849343012999;7878.763637090897;7951.284384405431;7767.990161278997;9886.25853061009;11042.668719938414;12457.937710311753;12544.121911466109;10551.683449496528;10788.352698838095;10822.296550724177;10882.836757448486;10946.179036572448;8218.383621228551;10500.054995050483;10655.627053053417;10701.357918524913;11175.497102630563;10634.787304254027;10878.23852330361;10905.890941090805;11128.888711112786;11383.203175777948;7990.947248781326;7993.520388776692;8257.298129659046;8292.33661307082;8339;8177.754667359989;10137.695869123938;10763.730906727395;10844.45777711127;10982.670519884416 15:15:03 INFO - PROCESS | 21900 | |3;mootools.html;1426.5007247463388;1479.800226969359;1600.2078970909402;1763.7795275590552;1797.811229820868;6450.870982580345;7109.3957013653835;7370.115586129666;7450.366718828893;7479.476436649423;7671.731489397872;7761.728339508119;7769.261920117594;7804.453688241825;7812.609369531515;2217.456723102838;2247.763984781599;2253.5943530164564;2258.5934531784274;2261.050358849279;2236.317923033474;2239.6640503924377;2257.345369842744;2258.2434884313775;2258.762829902861;2216.8891555422247;2225.521512874732;2236.2955668964305;2244.842860999731;2269.1944359752297;2165.7725938776516;2183.563287342538;2186.8797216153107;2188.4310079379316;2194.440417693494;1996.620642078015;2029.8274646655052;2030.7664618568758;2035.714999900015;2040.1941233212797;7701.961490192569;7779.066512018538;7780.2219778021745;7802.258785415376;7821.921780782176;4510.571495707903;4701.952980470186;4703.341532185496;4715.504871988426;4731.645126615517;2854.557543580748;2856.48583255014;2917.9124626261246;2921.948098684472;2978.225661328049;961.485605201221;972.4991629310911;985.7535616095976;991.0287917840557;1003.8343673293971;10136.797264054678;10151.1371533419;10225.488725563766;10255.692329230134;10256.846147307797;4058.228936502055;4113.465249517543;4286.89282767927;4316.525182229952;4317.41714868495;8743.169398907094;8817.206451419403;8839.823203535892;8848.64605415789;8876.778080548038;4656.883577910512;4658.650601204856;4661.743604101807;4671.532846715301;4677.555632214934;3715.9628403716156;4117.938230926538;4241.172971270573;4262.573742625775;4303.203907277164;3614.4578313253223;3640.308341415123;3666.5966743658178;3720.1815600567834;3745.419459983707;1176.04152615618;1189.9643010709692;1195.8445402097673;1212.2120621595857;1237.5977807212691;1177.770334784726;1186.6084192216547;1202.729385888168;1215.0158371718935;1216.9026477881748;7061.435085193172;7081.504294699322;7127.857442851114;7159.391451726661;7341.853162936818;964.2141654551518;992.0575453319375;1009.8182327181031;1082.2910993299402;1089.2429761315968;5426.864328391822;5558.110702287615;5573.804916827891;5597.132444471114;5603.299587551556;8900.109989001177;9082.18260356571;9388.95305523468;9394.67118650844;9468.810623787485;9326.766830829149;9339.533023348806;9347.065293470734;9347.766305842273;9431.858522122173;6914.723411063602;7039.260877607778;7100.9289907100265;7107.324804143598;7131.92868071323;7162.7493037743425;7174.784756457315;7209.927900721135;7224.819379515554;7236.312550307713;8337.624291991753;8437.704680336159;8466.280366168945;8506.404551681322;8519.361047921308;8290.37822163328;8544.615492302737;8656.26421754158;8690.348223883107;8867.379283450355;5786.334571524329;6715.630640314829;6743.393094621508;6757.560758550679;6871.9312806873295;7250.166230883516;7295.671694773854;7319.926800731924;7362.558246505227;7387.704491820267;6129.816105516842;6386.329435409401;6393.776217832354;6486.643234622141;6536.542442029012;6318.557700960889;6361.427471527585;6526.412622863965;6557.967210163919;6658.1011563438315;6924.965375173092;6990.091288132714;6996.580205187705;6997.405220556309;7016.6491675415;6371.426571608577;6417.422431981144;6426.871462570629;6438.130852334875;6448.065030570635;6558.704858281293;6581.111549940697;6587.736490540517;6597.373249541286;6608.801735947929 15:15:03 INFO - PROCESS | 21900 | |4;prototype.html;311.20642361976957;320.0606220742122;322.0884895745042;322.65959412819467;324.1685077775504;5274.92087618686;5399.892002159954;5402.8919421611545;5404.243405923174;5411.350637923455;5281;5286.074936886049;5299.973500132494;5301.973490132554;5319.494648008443;3927.6268754468424;4043.919121617566;4164.666826653868;4179.916401671965;4191.329387298033;4164.5210800758;4167.687423443239;4170.353595192735;4180.5610410906875;4186.74879507229;4148.585141485857;4153.169366126772;4159.771212583307;4166.687493439572;4183.832646694129;4096.73371230869;4151.252774500589;4176.0603864130635;4186.602272784081;4189.937150942738;3668.5414323209598;3669.2294618130227;3689.981550092259;3695.2978934002454;3709.2581483703098;5072.188449848043;5081.923771143436;5083.517065878736;5086;5086.287919691209;4687.460941991681;4806.687565308243;4814.590759785422;4818.807247710088;4853.150698627726;5576.1356989666665;5614.164846752364;5646.915296270559;5647.661140331593;5655.604107712462;3974.3641017437362;3983.322835118037;3992.980035099835;4005.5193376794678;4011.8796436106672;5750.223719797816;5785.013974535284;5867.618604790718;5880.852978675567;5890.617109887844;4183.1215444756335;4194.3498757692605;4198.181354635817;4200.432941552913;4203.810828512725;4222.767747773841;4225.704200705983;4234.597713217239;4239.872803815891;4239.936400953989;4784.2823576463115;4803.975980120077;4816.397950256218;4824.782884770194;4829.95170048302;5433.646812957145;5652.604317697722;5666.348369937427;5668.943310566924;5701.515371193412;1445.7542217822995;1467.449706360115;1468.6622076922367;1470.2060887120836;1470.242824945154;986.9309148359546;1002.7493126718321;1016.7153197104823;1017.038898241155;1022.0801278849095;4644.86065418038;4772.164871147535;4897.657163998486;4951.900961980812;4963.205887058126;5806.9419305806405;5886.764529418775;5901.793437229677;5914.852128696731;5920.970395147997;4620.561046700558;4871.926921096187;4886.975565122223;4897.877553061131;4905.23968784839;3089.212250876012;3133.1853718033476;3146.229173852421;3148.511980643004;3159.7472202223767;5469.56243500519;5485.533729632946;5495.203195536625;5497.230387745719;5524.75138618755;5822.388649191858;6012.128241404972;6039;6058.303295121029;6061.727222275008;5508.9724551376985;5513.849598656527;5526.226328314039;5536.557075434036;5550.639208451437;5569;5848;5903.734331955158;5917.763289468545;5919.348871624032;5729.4244082875875;5779.248697669276;5805.506531944832;5805.970970145122;5833;5434.809781657623;5470.152126420411;5479.917801232905;5506.0089183947275;5516.448355164612;3974.8807535772817;4040.9393859092725;4059.4316795649224;4067.572904845067;4082.2243773682903;5846.532277417881;5886.440788125121;5904;5904.645721256738;5922.55580831448;5636.943630563642;5691.914621280601;5705.515031222392;5706.771729130955;5713.200151978809;5537.086380747292;5658.660480371191;5667.489925906688;5675.347335056521;5725.570582206268;5594.916076258778;5619.438056194348;5623.8594035149445;5627.606067575394;5638.21065050885;5442.836714898401;5518;5691.630044047124;5712.400197979152;5724.313082429969;5517.641353312022;5537.8061767837935;5554.444555544414;5565.526930210815;5571.860703482445 15:15:03 INFO - PROCESS | 21900 | |5;yui.html;595.6902410746414;621.841430435239;624.6189824207232;683.5898460923449;708.8086216721487;9933.106020458175;10006.54970526327;10041.046100620439;10165.745856353595;10179;10998.615048473304;11053.834192487118;11055.778884422307;11073.335599864015;11106;642.7910928948111;779.723198264615;790.3440144679902;798.9600519974007;809.6478032056045;799.476342995336;803.4496369986549;803.9919600804005;805.7904944714357;807.5881300536739;832.5587438657491;834.2158371131118;834.6244190114443;834.8288600836814;836.9288610468118;830.3481766813023;831.2809419851845;833.4124442268186;833.5873742497472;838.3586556284447;610.4536439886277;610.6854969690613;611.8562137897591;612.9233845769279;613.7084884679786;10740.409277489734;10792.676219713421;10836;10859.07697845684;10861.239713220079;11905.226160299553;11932.70168245792;11957.820632690517;12279.815802762965;12792.936035319857;9436.858447123299;9592.376495527838;9630.374025688308;9703.17523010545;9793.804123917482;3330.500424936279;3335.499675048738;3356.3958487472246;3356.932861342784;3359.5464612277274;43968.56031439677;45273.99999999967;45498.090038199385;45579.77210113961;45620.54379456196;9625.855612165824;9748.707538773848;9777.804443911224;9785.412875227508;9874.358166719141;15041.623959401102;17140.485785426456;17195.7420638688;17266;17271.91364043197;6468.417842394207;6547.607143571401;6558.836029099215;6676.031975363545;6680.665966701646;3760.0975765816006;3831.9808400958373;3852.57621661617;3927.2930872443235;3959.1883663848844;2832.3768770870374;2981.642202935618;2986.4773664608606;2988.118505041018;3005.0383877159097;558.3021223470662;559.1975515135794;560.1262031231292;560.5207547546789;560.9214709940611;577.971101444926;629.3109045595066;632.822809613309;633.4488994574749;654.306435178712;7678.232176782277;7805.907172995785;8099.352051835839;8234.629441675139;8284.25441710237;496.2135015999681;547.0170631460954;557.1976354050155;560.1289994059196;575.8704291534372;3794.6964242860504;3924.6656136913584;3999;4091.3453847384276;4121.052158003676;49951.25073123906;50219;54300.45699542954;54601.72699136479;54990.450095499335;45740.771296143306;46420.30369544459;46672.299915501295;47157.76421117873;48032.5196748035;40324.79837600852;42725.145497089885;42759.35860962088;42897;43178.568214317456;7416.517926334771;7581.203973582915;7629.54222746637;7672.156062833195;7782.649780759766;27868.721312786613;28406.57390139191;28857.711422885503;29056.273593159494;29167.124986250445;35846.64153358433;38923.80538097292;39071.02322441848;39242.60757392504;39542;9277.814443710953;9413.764655883657;9447.291453140904;9485;9553.808923821345;10730.89269107299;10750.384367405706;10831.404272765074;10899.455027248447;10900.945495272474;9620.903790962;9695.22438204956;9869.851952220579;9907.851382229128;10086.394816311045;9516.762080948032;9588.37675551087;9671.758206044906;9822.263330250116;9822.705318840446;9779.315447918578;9782.657606984007;10012.849807253042;10226.437545934747;10394.116500097576;8295.460795048544;8485.193906578865;8514.276286515715;8650.56747162652;8675.392722509616;8672.219500245008;8734.432261902955;8784.385093043682;8844.336674749291;9487.478188699688 15:15:03 INFO - PROCESS | 21900 | __end_tp_report 15:15:03 INFO - PROCESS | 21900 | __start_cc_report 15:15:03 INFO - PROCESS | 21900 | _x_x_mozilla_cycle_collect,376 15:15:03 INFO - PROCESS | 21900 | __end_cc_report 15:15:03 INFO - PROCESS | 21900 | __startTimestamp1460326503865__endTimestamp 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | ------- Summary: start ------- 15:15:03 INFO - PROCESS | 21900 | Number of tests: 6 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | [#0] dojo.html Cycles:165 Average:4626.11 Median:4738.19 stddev:466.03 (9.8%) stddev-sans-first:439.77 15:15:03 INFO - PROCESS | 21900 | Values: 2609.0 2667.9 2691.1 2718.8 2727.7 4643.3 4675.7 4679.1 4679.3 4742.3 4555.4 4666.5 4711.1 4730.3 4771.1 4298.6 4348.3 4369.8 4406.5 4482.6 4304.0 4326.8 4378.0 4393.7 4437.4 4255.0 4304.3 4310.8 4324.7 4361.0 4283.6 4300.3 4308.1 4312.8 4339.9 4205.0 4251.6 4268.2 4276.9 4309.5 4555.6 4577.1 4580.0 4619.4 4624.5 4957.5 4980.2 4986.8 4989.3 5002.0 4947.2 5004.5 5023.1 5030.6 5072.5 4675.5 4681.0 4712.2 4717.8 4727.1 5105.5 5120.2 5131.9 5133.6 5134.9 4864.6 4879.0 4941.4 4948.4 4958.4 4886.7 4981.6 4989.3 5012.8 5049.5 4920.8 4933.5 4934.4 4943.4 4998.4 4868.9 4913.9 4924.0 4939.4 4997.2 4263.9 4268.1 4270.2 4291.3 4297.4 3694.2 3742.2 3743.2 3763.1 3765.7 4267.0 4322.7 4361.2 4390.7 4402.6 4991.3 5003.8 5025.7 5041.1 5095.0 4246.7 4320.5 4322.7 4331.2 4363.2 4475.6 4506.0 4508.0 4531.0 4533.6 4648.0 4654.8 4661.2 4667.9 4696.0 4940.9 4959.4 4978.5 4993.6 5013.7 4709.7 4716.0 4738.2 4743.0 4793.9 4939.8 4944.4 4946.9 4947.5 4986.9 4953.5 5013.7 5038.0 5071.6 5077.2 4784.1 4797.4 4866.3 4899.9 4904.7 4857.5 4872.3 4881.9 4887.6 4935.9 4665.2 4729.4 4801.2 4814.8 4849.6 4833.1 4835.2 4836.6 4838.7 4917.5 4809.9 4814.0 4821.4 4838.1 4842.3 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | [#1] ext.html Cycles:180 Average:41238.41 Median:19506.03 stddev:66661.28 (341.7%) stddev-sans-first:66778.38 15:15:03 INFO - PROCESS | 21900 | Values: 577.8 594.3 613.1 614.5 639.0 32727.2 33786.5 33941.3 34021.5 34059.3 34468.5 34750.3 34976.7 35043.5 35162.3 7418.2 7564.4 7577.6 7579.6 7579.6 7427.9 7578.0 7673.5 7687.7 7692.0 7641.8 7662.5 7672.6 7714.6 7749.3 7592.1 7688.0 7706.2 7709.0 7711.7 7595.6 7646.8 7654.4 7688.9 7692.9 34034.5 34663.5 34665.7 34675.7 34698.3 3072.3 3563.2 3580.1 3601.8 3645.1 27835.9 28407.1 28550.6 28599.7 28639.0 3456.4 3520.5 3532.3 3664.9 3665.7 217131.0 218080.0 218214.0 218287.0 264948.0 52410.2 53939.5 54080.0 54116.0 54151.0 49279.5 49382.5 49458.5 49529.5 49752.8 12161.2 12314.3 12315.4 12331.3 12369.5 9339.0 9406.3 9444.0 9586.4 9611.0 16105.7 16221.3 16267.6 16275.7 16326.8 5975.0 5986.5 6134.6 6188.5 6207.7 939.3 948.7 977.7 989.3 1011.1 28206.3 28288.0 28532.3 28541.6 28785.1 964.9 996.6 1045.8 1068.2 1098.0 13777.7 13989.9 15364.7 16005.8 16314.3 242340.0 244705.0 246252.0 247077.0 247215.0 47379.3 48716.3 48870.5 48951.0 49079.8 1203.3 1233.8 1276.3 1290.3 1290.9 27999.4 29125.1 29238.0 29273.0 29390.1 41201.6 41896.2 41898.4 41945.6 41989.0 287019.0 288158.0 289829.0 290073.0 290309.0 24807.4 25152.2 25170.5 25242.5 25243.1 39920.6 40150.0 40383.8 41025.6 41434.2 35410.5 35715.5 36027.3 36601.8 37445.0 35865.8 36285.3 36376.3 36379.5 36783.4 35185.3 35448.8 36136.1 36177.8 36243.8 30788.5 31884.8 32893.8 32982.0 32989.8 25040.4 25054.0 25112.0 25553.7 25651.7 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | [#2] jquery.html Cycles:180 Average:24150.58 Median:4342.54 stddev:65840.47 (1516.2%) stddev-sans-first:66000.99 15:15:03 INFO - PROCESS | 21900 | Values: 382.2 384.1 384.6 394.3 397.1 15595.3 16774.4 16869.0 16873.5 17166.1 11733.5 15629.5 16376.0 16415.3 16447.3 4558.8 4741.3 4759.2 4792.2 4792.4 3417.5 5042.4 5317.1 5326.7 5335.7 5270.1 5302.2 5311.3 5325.7 5339.3 5235.3 5314.0 5343.5 5349.5 5357.4 5036.1 5045.3 5205.1 5210.8 5227.4 12356.5 15376.6 20373.6 20454.3 20488.2 1929.6 1932.4 1935.3 1938.1 1965.6 8856.1 9301.0 9340.3 9429.5 9492.9 1732.9 1808.6 1849.2 1853.5 1872.0 65497.0 66188.3 66617.3 67594.7 67737.0 10067.6 10089.5 10147.8 10179.5 10245.3 14091.8 14307.3 14362.5 14383.8 14389.9 6815.5 6853.3 6867.8 7033.0 7053.2 6233.9 6309.1 6342.9 6377.6 6390.7 4311.2 4319.7 4365.3 4431.2 4432.2 1694.6 1764.7 1857.6 1874.7 1896.9 869.5 938.4 971.8 1010.9 1021.9 15462.0 15632.6 16160.2 16431.7 16535.7 856.4 883.0 890.3 919.6 953.7 9095.4 9231.4 9246.9 9324.7 9459.3 391891.0 395596.0 396961.0 399840.0 412038.0 76182.6 78008.6 78040.6 80342.0 80344.5 936.0 938.4 964.1 965.1 972.9 14628.3 14762.7 14863.9 14877.3 15211.8 32522.0 33202.7 33474.3 33805.0 33878.8 45785.0 45828.8 48018.5 48447.5 48503.0 6864.7 7310.0 7532.8 7878.8 7951.3 7768.0 9886.3 11042.7 12457.9 12544.1 10551.7 10788.4 10822.3 10882.8 10946.2 8218.4 10500.1 10655.6 10701.4 11175.5 10634.8 10878.2 10905.9 11128.9 11383.2 7990.9 7993.5 8257.3 8292.3 8339.0 8177.8 10137.7 10763.7 10844.5 10982.7 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | [#3] mootools.html Cycles:180 Average:5343.93 Median:6405.60 stddev:2767.07 (43.2%) stddev-sans-first:2759.17 15:15:03 INFO - PROCESS | 21900 | Values: 1426.5 1479.8 1600.2 1763.8 1797.8 6450.9 7109.4 7370.1 7450.4 7479.5 7671.7 7761.7 7769.3 7804.5 7812.6 2217.5 2247.8 2253.6 2258.6 2261.1 2236.3 2239.7 2257.3 2258.2 2258.8 2216.9 2225.5 2236.3 2244.8 2269.2 2165.8 2183.6 2186.9 2188.4 2194.4 1996.6 2029.8 2030.8 2035.7 2040.2 7702.0 7779.1 7780.2 7802.3 7821.9 4510.6 4702.0 4703.3 4715.5 4731.6 2854.6 2856.5 2917.9 2921.9 2978.2 961.5 972.5 985.8 991.0 1003.8 10136.8 10151.1 10225.5 10255.7 10256.8 4058.2 4113.5 4286.9 4316.5 4317.4 8743.2 8817.2 8839.8 8848.6 8876.8 4656.9 4658.7 4661.7 4671.5 4677.6 3716.0 4117.9 4241.2 4262.6 4303.2 3614.5 3640.3 3666.6 3720.2 3745.4 1176.0 1190.0 1195.8 1212.2 1237.6 1177.8 1186.6 1202.7 1215.0 1216.9 7061.4 7081.5 7127.9 7159.4 7341.9 964.2 992.1 1009.8 1082.3 1089.2 5426.9 5558.1 5573.8 5597.1 5603.3 8900.1 9082.2 9389.0 9394.7 9468.8 9326.8 9339.5 9347.1 9347.8 9431.9 6914.7 7039.3 7100.9 7107.3 7131.9 7162.7 7174.8 7209.9 7224.8 7236.3 8337.6 8437.7 8466.3 8506.4 8519.4 8290.4 8544.6 8656.3 8690.3 8867.4 5786.3 6715.6 6743.4 6757.6 6871.9 7250.2 7295.7 7319.9 7362.6 7387.7 6129.8 6386.3 6393.8 6486.6 6536.5 6318.6 6361.4 6526.4 6558.0 6658.1 6925.0 6990.1 6996.6 6997.4 7016.6 6371.4 6417.4 6426.9 6438.1 6448.1 6558.7 6581.1 6587.7 6597.4 6608.8 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | [#4] prototype.html Cycles:180 Average:4690.33 Median:5283.54 stddev:1365.15 (25.8%) stddev-sans-first:1328.82 15:15:03 INFO - PROCESS | 21900 | Values: 311.2 320.1 322.1 322.7 324.2 5274.9 5399.9 5402.9 5404.2 5411.4 5281.0 5286.1 5300.0 5302.0 5319.5 3927.6 4043.9 4164.7 4179.9 4191.3 4164.5 4167.7 4170.4 4180.6 4186.7 4148.6 4153.2 4159.8 4166.7 4183.8 4096.7 4151.3 4176.1 4186.6 4189.9 3668.5 3669.2 3690.0 3695.3 3709.3 5072.2 5081.9 5083.5 5086.0 5086.3 4687.5 4806.7 4814.6 4818.8 4853.2 5576.1 5614.2 5646.9 5647.7 5655.6 3974.4 3983.3 3993.0 4005.5 4011.9 5750.2 5785.0 5867.6 5880.9 5890.6 4183.1 4194.3 4198.2 4200.4 4203.8 4222.8 4225.7 4234.6 4239.9 4239.9 4784.3 4804.0 4816.4 4824.8 4830.0 5433.6 5652.6 5666.3 5668.9 5701.5 1445.8 1467.4 1468.7 1470.2 1470.2 986.9 1002.7 1016.7 1017.0 1022.1 4644.9 4772.2 4897.7 4951.9 4963.2 5806.9 5886.8 5901.8 5914.9 5921.0 4620.6 4871.9 4887.0 4897.9 4905.2 3089.2 3133.2 3146.2 3148.5 3159.7 5469.6 5485.5 5495.2 5497.2 5524.8 5822.4 6012.1 6039.0 6058.3 6061.7 5509.0 5513.8 5526.2 5536.6 5550.6 5569.0 5848.0 5903.7 5917.8 5919.3 5729.4 5779.2 5805.5 5806.0 5833.0 5434.8 5470.2 5479.9 5506.0 5516.4 3974.9 4040.9 4059.4 4067.6 4082.2 5846.5 5886.4 5904.0 5904.6 5922.6 5636.9 5691.9 5705.5 5706.8 5713.2 5537.1 5658.7 5667.5 5675.3 5725.6 5594.9 5619.4 5623.9 5627.6 5638.2 5442.8 5518.0 5691.6 5712.4 5724.3 5517.6 5537.8 5554.4 5565.5 5571.9 15:15:03 INFO - PROCESS | 21900 | 15:15:03 INFO - PROCESS | 21900 | [#5] yui.html Cycles:180 Average:12347.96 Median:560.72 stddev:14449.05 (2576.9%) stddev-sans-first:14462.63 15:15:03 INFO - PROCESS | 21900 | Values: 595.7 621.8 624.6 683.6 708.8 9933.1 10006.5 10041.0 10165.7 10179.0 10998.6 11053.8 11055.8 11073.3 11106.0 642.8 779.7 790.3 799.0 809.6 799.5 803.4 804.0 805.8 807.6 832.6 834.2 834.6 834.8 836.9 830.3 831.3 833.4 833.6 838.4 610.5 610.7 611.9 612.9 613.7 10740.4 10792.7 10836.0 10859.1 10861.2 11905.2 11932.7 11957.8 12279.8 12792.9 9436.9 9592.4 9630.4 9703.2 9793.8 3330.5 3335.5 3356.4 3356.9 3359.5 43968.6 45274.0 45498.1 45579.8 45620.5 9625.9 9748.7 9777.8 9785.4 9874.4 15041.6 17140.5 17195.7 17266.0 17271.9 6468.4 6547.6 6558.8 6676.0 6680.7 3760.1 3832.0 3852.6 3927.3 3959.2 2832.4 2981.6 2986.5 2988.1 3005.0 558.3 559.2 560.1 560.5 560.9 578.0 629.3 632.8 633.4 654.3 7678.2 7805.9 8099.4 8234.6 8284.3 496.2 547.0 557.2 560.1 575.9 3794.7 3924.7 3999.0 4091.3 4121.1 49951.3 50219.0 54300.5 54601.7 54990.5 45740.8 46420.3 46672.3 47157.8 48032.5 40324.8 42725.1 42759.4 42897.0 43178.6 7416.5 7581.2 7629.5 7672.2 7782.6 27868.7 28406.6 28857.7 29056.3 29167.1 35846.6 38923.8 39071.0 39242.6 39542.0 9277.8 9413.8 9447.3 9485.0 9553.8 10730.9 10750.4 10831.4 10899.5 10900.9 9620.9 9695.2 9869.9 9907.9 10086.4 9516.8 9588.4 9671.8 9822.3 9822.7 9779.3 9782.7 10012.8 10226.4 10394.1 8295.5 8485.2 8514.3 8650.6 8675.4 8672.2 8734.4 8784.4 8844.3 9487.5 15:15:03 INFO - PROCESS | 21900 | -------- Summary: end -------- 15:15:03 INFO - PROCESS | 21900 | 15:15:04 INFO - TEST-INFO | 21900: exit 0 15:15:04 INFO - TEST-OK | dromaeo_css | took 1115826ms 15:15:04 INFO - TEST-START | kraken 15:15:04 INFO - operating with platform_type : linux_ 15:15:04 INFO - Initialising browser for kraken test... 15:15:04 INFO - TEST-INFO | started process 22128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9OiaW/profile http://localhost:53577/getInfo.html) 15:15:08 INFO - PROCESS | 22128 | 15:15:08 INFO - PROCESS | 22128 | (process:22194): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:15:09 INFO - PROCESS | 22128 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:15:10 INFO - PROCESS | 22128 | __metrics Screen width/height:1600/1200 15:15:10 INFO - PROCESS | 22128 | colorDepth:24 15:15:10 INFO - PROCESS | 22128 | Browser inner width/height: 1024/697 15:15:10 INFO - PROCESS | 22128 | __metrics 15:15:10 ERROR - PROCESS | 22128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 15:15:11 INFO - TEST-INFO | 22128: exit 0 15:15:11 INFO - Browser initialized. 15:15:11 INFO - Running cycle 1/1 for kraken test... 15:15:11 INFO - TEST-INFO | started process 22245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu9OiaW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:13 INFO - PROCESS | 22245 | 15:15:13 INFO - PROCESS | 22245 | (process:22305): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:15:23 INFO - PROCESS | 22245 | RSS: Main: 164401152 15:15:23 INFO - PROCESS | 22245 | 15:15:26 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53577/tests/kraken/driver.html?testName=audio-beat-detection) 15:15:27 INFO - PROCESS | 22245 | RSS: Main: 168464384 15:15:27 INFO - PROCESS | 22245 | 15:15:29 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53577/tests/kraken/driver.html?testName=audio-dft) 15:15:30 INFO - PROCESS | 22245 | RSS: Main: 172105728 15:15:30 INFO - PROCESS | 22245 | 15:15:33 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53577/tests/kraken/driver.html?testName=audio-fft) 15:15:33 INFO - PROCESS | 22245 | RSS: Main: 164556800 15:15:33 INFO - PROCESS | 22245 | 15:15:36 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53577/tests/kraken/driver.html?testName=audio-oscillator) 15:15:36 INFO - PROCESS | 22245 | RSS: Main: 165670912 15:15:36 INFO - PROCESS | 22245 | 15:15:38 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:15:39 INFO - PROCESS | 22245 | RSS: Main: 165548032 15:15:39 INFO - PROCESS | 22245 | 15:15:42 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53577/tests/kraken/driver.html?testName=imaging-darkroom) 15:15:43 INFO - PROCESS | 22245 | RSS: Main: 165838848 15:15:43 INFO - PROCESS | 22245 | 15:15:46 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53577/tests/kraken/driver.html?testName=imaging-desaturate) 15:15:47 INFO - PROCESS | 22245 | RSS: Main: 163250176 15:15:47 INFO - PROCESS | 22245 | 15:15:50 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53577/tests/kraken/driver.html?testName=json-parse-financial) 15:15:51 INFO - PROCESS | 22245 | RSS: Main: 164073472 15:15:51 INFO - PROCESS | 22245 | 15:15:52 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:15:53 INFO - PROCESS | 22245 | RSS: Main: 164061184 15:15:53 INFO - PROCESS | 22245 | 15:15:55 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:15:55 INFO - PROCESS | 22245 | RSS: Main: 164143104 15:15:55 INFO - PROCESS | 22245 | 15:15:58 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:15:58 INFO - PROCESS | 22245 | RSS: Main: 164515840 15:15:58 INFO - PROCESS | 22245 | 15:16:01 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:16:02 INFO - PROCESS | 22245 | RSS: Main: 164421632 15:16:02 INFO - PROCESS | 22245 | 15:16:04 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:16:05 INFO - PROCESS | 22245 | RSS: Main: 164458496 15:16:05 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | Cycle 1(1): loaded http://localhost:53577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53577/tests/kraken/driver.html?testName=ai-astar) 15:16:07 INFO - PROCESS | 22245 | RSS: Main: 165961728 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | __start_tp_report 15:16:07 INFO - PROCESS | 22245 | _x_x_mozilla_page_load 15:16:07 INFO - PROCESS | 22245 | _x_x_mozilla_page_load_details 15:16:07 INFO - PROCESS | 22245 | |i|pagename|runs| 15:16:07 INFO - PROCESS | 22245 | |0;ai-astar;115;108;114;113;116;127;115;115;114;113 15:16:07 INFO - PROCESS | 22245 | |1;audio-beat-detection;153;135;156;178;142;155;172;137;179;134 15:16:07 INFO - PROCESS | 22245 | |2;audio-dft;165;162;163;162;164;178;162;163;164;165 15:16:07 INFO - PROCESS | 22245 | |3;audio-fft;73;73;74;77;73;76;74;163;74;77 15:16:07 INFO - PROCESS | 22245 | |4;audio-oscillator;94;95;145;94;94;93;138;95;94;137 15:16:07 INFO - PROCESS | 22245 | |5;imaging-gaussian-blur;117;118;117;118;118;117;118;117;117;117 15:16:07 INFO - PROCESS | 22245 | |6;imaging-darkroom;147;148;147;147;147;149;147;147;147;147 15:16:07 INFO - PROCESS | 22245 | |7;imaging-desaturate;97;96;96;96;96;97;95;97;96;96 15:16:07 INFO - PROCESS | 22245 | |8;json-parse-financial;66;66;65;65;65;65;66;66;65;64 15:16:07 INFO - PROCESS | 22245 | |9;json-stringify-tinderbox;67;64;64;64;64;65;64;64;64;64 15:16:07 INFO - PROCESS | 22245 | |10;stanford-crypto-aes;88;85;86;87;86;86;87;86;86;91 15:16:07 INFO - PROCESS | 22245 | |11;stanford-crypto-ccm;155;153;139;143;139;140;144;140;141;138 15:16:07 INFO - PROCESS | 22245 | |12;stanford-crypto-pbkdf2;178;171;190;172;174;170;178;173;178;171 15:16:07 INFO - PROCESS | 22245 | |13;stanford-crypto-sha256-iterative;74;73;74;71;73;71;71;72;74;72 15:16:07 INFO - PROCESS | 22245 | __end_tp_report 15:16:07 INFO - PROCESS | 22245 | __start_cc_report 15:16:07 INFO - PROCESS | 22245 | _x_x_mozilla_cycle_collect,952 15:16:07 INFO - PROCESS | 22245 | __end_cc_report 15:16:07 INFO - PROCESS | 22245 | __startTimestamp1460326567653__endTimestamp 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | ------- Summary: start ------- 15:16:07 INFO - PROCESS | 22245 | Number of tests: 14 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:4.76 (4.1%) stddev-sans-first:5.05 15:16:07 INFO - PROCESS | 22245 | Values: 115.0 108.0 114.0 113.0 116.0 127.0 115.0 115.0 114.0 113.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:155.50 stddev:17.40 (11.2%) stddev-sans-first:18.45 15:16:07 INFO - PROCESS | 22245 | Values: 153.0 135.0 156.0 178.0 142.0 155.0 172.0 137.0 179.0 134.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.78 (2.9%) stddev-sans-first:5.07 15:16:07 INFO - PROCESS | 22245 | Values: 165.0 162.0 163.0 162.0 164.0 178.0 162.0 163.0 164.0 165.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#3] audio-fft Cycles:10 Average:83.40 Median:74.00 stddev:28.01 (37.9%) stddev-sans-first:29.46 15:16:07 INFO - PROCESS | 22245 | Values: 73.0 73.0 74.0 77.0 73.0 76.0 74.0 163.0 74.0 77.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:22.25 (23.7%) stddev-sans-first:23.03 15:16:07 INFO - PROCESS | 22245 | Values: 94.0 95.0 145.0 94.0 94.0 93.0 138.0 95.0 94.0 137.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:16:07 INFO - PROCESS | 22245 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:16:07 INFO - PROCESS | 22245 | Values: 147.0 148.0 147.0 147.0 147.0 149.0 147.0 147.0 147.0 147.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:16:07 INFO - PROCESS | 22245 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 95.0 97.0 96.0 96.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 15:16:07 INFO - PROCESS | 22245 | Values: 66.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 64.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:0.33 15:16:07 INFO - PROCESS | 22245 | Values: 67.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:1.69 (1.9%) stddev-sans-first:1.73 15:16:07 INFO - PROCESS | 22245 | Values: 88.0 85.0 86.0 87.0 86.0 86.0 87.0 86.0 86.0 91.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:142.00 stddev:6.00 (4.2%) stddev-sans-first:4.59 15:16:07 INFO - PROCESS | 22245 | Values: 155.0 153.0 139.0 143.0 139.0 140.0 144.0 140.0 141.0 138.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.00 stddev:5.97 (3.4%) stddev-sans-first:6.26 15:16:07 INFO - PROCESS | 22245 | Values: 178.0 171.0 190.0 172.0 174.0 170.0 178.0 173.0 178.0 171.0 15:16:07 INFO - PROCESS | 22245 | 15:16:07 INFO - PROCESS | 22245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.27 (1.7%) stddev-sans-first:1.22 15:16:07 INFO - PROCESS | 22245 | Values: 74.0 73.0 74.0 71.0 73.0 71.0 71.0 72.0 74.0 72.0 15:16:07 INFO - PROCESS | 22245 | -------- Summary: end -------- 15:16:07 INFO - PROCESS | 22245 | 15:16:08 INFO - TEST-INFO | 22245: exit 0 15:16:08 INFO - TEST-OK | kraken | took 64228ms 15:16:08 INFO - SUITE-END | took 1180s 15:16:09 INFO - Completed test suite (00:19:40) 15:16:09 INFO - javascript benchmark 15:16:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.0476975903794, 2667.933301667458, 2691.1119330620895, 2718.7960902932286, 2727.686316073652, 4643.280291554806, 4675.672702910793, 4679.087577922306, 4679.321498382733, 4742.288656701497, 4555.362249285103, 4666.533346665332, 4711.128441238373, 4730.290456431537, 4771.093492236481, 4298.613124818766, 4348.347747837834, 4369.781510924457, 4406.5373135820755, 4482.596566309032, 4303.978480107611, 4326.84856030039, 4378.0, 4393.736375817445, 4437.378766972626, 4254.957450425487, 4304.268274393329, 4310.762908040057, 4324.6972711910175, 4361.040571074359, 4283.614474697261, 4300.333448315516, 4308.073764140693, 4312.784360781949, 4339.869803905888, 4204.978975105105, 4251.553586873396, 4268.189044081614, 4276.850310239127, 4309.547497512779, 4555.63554915606, 4577.084583083363, 4580.038191979688, 4619.376384188159, 4624.5144259852905, 4957.5042495750495, 4980.2280646499485, 4986.750662466899, 4989.301497790312, 5002.0246052019875, 4947.233178857283, 5004.524570165829, 5023.070731914608, 5030.597552195853, 5072.467390923936, 4675.532446755297, 4681.0, 4712.222483290253, 4717.787699553528, 4727.101850648366, 5105.489451054865, 5120.225038528894, 5131.897362052813, 5133.563647090039, 5134.922976155361, 4864.610831133501, 4879.048585525859, 4941.357623508921, 4948.406191257072, 4958.404991400983, 4886.731229782396, 4981.62637802159, 4989.3264409305, 5012.7994880205115, 5049.495050494921, 4920.827771027997, 4933.531314525115, 4934.432540257916, 4943.431505376856, 4998.375203099613, 4868.853934381974, 4913.877153071202, 4923.990581930767, 4939.407271127488, 4997.175466048134, 4263.914721705549, 4268.061026574149, 4270.167317373082, 4291.31338985767, 4297.39836422901, 3694.168812017275, 3742.1767211214033, 3743.1765011697385, 3763.0592351912023, 3765.7175711821174, 4267.0, 4322.740635561813, 4361.236783562864, 4390.714603550759, 4402.5597440255715, 4991.326170966946, 5003.849884503471, 5025.673331233458, 5041.092603331363, 5094.974525127351, 4246.7027308088755, 4320.524742278347, 4322.654187664979, 4331.155424692155, 4363.2364336241035, 4475.552444755564, 4506.031203291308, 4507.954920450819, 4530.977345113253, 4533.569310915458, 4647.953520464752, 4654.767261636973, 4661.184292748688, 4667.883302917454, 4695.9530404695515, 4940.851774446773, 4959.404871415453, 4978.47725988766, 4993.625478089085, 5013.699178049329, 4709.670323077352, 4716.0332131913565, 4738.194506933761, 4742.952570474251, 4793.9280910785665, 4939.777710002986, 4944.381952255968, 4946.925796113133, 4947.505249475023, 4986.850394488171, 4953.479884612064, 5013.749312534285, 5037.974810125926, 5071.594272458121, 5077.238414237746, 4784.091022705675, 4797.40032495938, 4866.343043689199, 4899.853004409873, 4904.681195722266, 4857.489963553776, 4872.342233798392, 4881.90236195267, 4887.560119589254, 4935.901281974268, 4665.2302370108555, 4729.43246810385, 4801.159797035574, 4814.759262036954, 4849.563539281482, 4833.05755377698, 4835.20219163834, 4836.564709176191, 4838.709677419366, 4917.508249175054, 4809.903801923872, 4813.95186048135, 4821.397325334333, 4838.104950584153, 4842.297866809223], "value": 4597.686722571573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8150991682663, 594.2898236607255, 613.129356314034, 614.483833579793, 639.0191056727923, 32727.1818204545, 33786.493202601916, 33941.321173576514, 34021.489677654856, 34059.318813623715, 34468.482972755366, 34750.30499390011, 34976.650233497654, 35043.4743478848, 35162.296754064904, 7418.22108678589, 7564.357029652486, 7577.621118944058, 7579.621018949058, 7579.621018949058, 7427.851442971138, 7577.962110189442, 7673.53958762476, 7687.692492300302, 7692.0, 7641.808954776147, 7662.501937374081, 7672.578008209546, 7714.614269286513, 7749.263819937097, 7592.126905405866, 7688.038995125581, 7706.229377062305, 7709.036370453693, 7711.6915323387275, 7595.582242976634, 7646.847063058708, 7654.4259180561685, 7688.923110768933, 7692.923070769277, 34034.48948265778, 34663.480047799305, 34665.653343466496, 34675.653243467495, 34698.30603387943, 3072.2626569623353, 3563.233904710474, 3580.122869896892, 3601.7838929664304, 3645.106948797535, 27835.86082069597, 28407.147785566467, 28550.571741423897, 28599.714002859913, 28639.0, 3456.3778519866414, 3520.4895290183035, 3532.2935412917263, 3664.871729489482, 3665.725070619714, 217131.0, 218080.0, 218214.0, 218287.0, 264948.0, 52410.21384679233, 53939.46060539344, 54080.0, 54116.0, 54151.0, 49279.50720492749, 49382.506174938506, 49458.50541494611, 49529.50470495321, 49752.75123624431, 12161.209521381083, 12314.322712250912, 12315.4458049388, 12331.260124392566, 12369.505219791288, 9339.0, 9406.294527910297, 9444.0, 9586.376885502421, 9611.0, 16105.677886442205, 16221.2700428481, 16267.593310167103, 16275.674486510203, 16326.75509867353, 5974.984252677055, 5986.5210783137245, 6134.631922084689, 6188.545691762432, 6207.720652570645, 939.2764277550634, 948.6584829461389, 977.6675930183771, 989.3074847606704, 1011.0900189829213, 28206.29484262869, 28288.0, 28532.286692832844, 28541.57187642187, 28785.136445906657, 964.8697425847561, 996.5798736800031, 1045.8378951262566, 1068.2201992545486, 1097.9523189252147, 13777.655558611115, 13989.860101398855, 15364.692706145814, 16005.759913601305, 16314.265858036417, 242340.0, 244705.0, 246252.0, 247077.0, 247215.0, 47379.289310660366, 48716.26925596119, 48870.51129488731, 48951.0, 49079.754601227476, 1203.3321506563766, 1233.784087784652, 1276.3426835179705, 1290.32258064515, 1290.9289989050505, 27999.440011199255, 29125.126246212647, 29238.0, 29273.0, 29390.05448706747, 41201.587984119775, 41896.162076758905, 41898.37152442777, 41945.58054419417, 41989.0, 287019.0, 288158.0, 289829.0, 290073.0, 290309.0, 24807.379815504755, 25152.24543263632, 25170.496590068462, 25242.495150097264, 25243.11649092273, 39920.60079399169, 40150.0, 40383.79808100941, 41025.58974410217, 41434.1713165741, 35410.46884296686, 35715.46426803548, 36027.27945441129, 36601.81699091488, 37445.0, 35865.82067089648, 36285.27429451449, 36376.27247455089, 36379.45430818593, 36783.44824827576, 35185.296294074484, 35448.82275588605, 36136.096597585274, 36177.819110904275, 36243.81878090592, 30788.53817192789, 31884.840575796974, 32893.835530822194, 32982.0, 32989.83505082459, 25040.37399065038, 25054.0, 25112.0, 25553.744462555136, 25651.743482564936], "value": 16845.270776021574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.17831661926846, 384.0935392473762, 384.6000159833775, 394.27059939112627, 397.1183971583084, 15595.298211580477, 16774.41289554864, 16869.0, 16873.49379518615, 17166.141692915335, 11733.53065877366, 15629.531114066596, 16376.0, 16415.26131324093, 16447.2598733057, 4558.772061396933, 4741.336212930192, 4759.238521836507, 4792.209285467911, 4792.448868380146, 3417.470292104728, 5042.369703787027, 5317.12267475866, 5326.6537675051195, 5335.67985920846, 5270.104082305998, 5302.231176479428, 5311.309529761125, 5325.680459172443, 5339.252504649352, 5235.345581802275, 5314.0, 5343.492368225013, 5349.491798279158, 5357.383900851393, 5036.06832735945, 5045.293658887758, 5205.063088644042, 5210.843674689765, 5227.424983251839, 12356.505739770399, 15376.615584610363, 20373.592528149504, 20454.284100056575, 20488.18047278107, 1929.5851391950798, 1932.4299331697182, 1935.3032908153054, 1938.0987840654163, 1965.577400858808, 8856.062935883554, 9300.953495232548, 9340.299477539213, 9429.481378524179, 9492.857607135898, 1732.9480115596552, 1808.6473137738146, 1849.1863580024747, 1853.4532312967706, 1871.953201169968, 65497.0, 66188.3381166187, 66617.3338266616, 67594.66202669004, 67737.0, 10067.597296108073, 10089.495525223709, 10147.847782283125, 10179.54192061359, 10245.334053286662, 14091.788623170456, 14307.28463576817, 14362.497312594009, 14383.78424323636, 14389.856101438852, 6815.454763618898, 6853.348931851466, 6867.793966181022, 7032.964835175791, 7053.224145344008, 6233.906491402633, 6309.148264984168, 6342.936570634327, 6377.585456945284, 6390.744370225232, 4311.223979683625, 4319.740815551077, 4365.345198220292, 4431.202383570923, 4432.180046691373, 1694.5594145522007, 1764.7176451767655, 1857.6099019206117, 1874.7000479923147, 1896.8956707381226, 869.4913475616709, 938.4181807279531, 971.820213260535, 1010.888802231754, 1021.9489025548842, 15462.0, 15632.609184770245, 16160.191990400668, 16431.671366572842, 16535.6692866142, 856.3620103023163, 883.0, 890.2610833008588, 919.5884317572494, 953.666216824106, 9095.388106720038, 9231.399959002643, 9246.86129708055, 9324.720258392259, 9459.337846350827, 391891.0, 395596.0, 396961.0, 399840.0, 412038.0, 76182.6190869042, 78008.60995694985, 78040.60979695065, 80342.0, 80344.45747947007, 935.9906400936039, 938.3666025432806, 964.0985678390587, 965.1024547171058, 972.9221662267001, 14628.34172462263, 14762.704745904806, 14863.851361486246, 14877.330520126838, 15211.771823422436, 32522.0, 33202.667973320924, 33474.33051338911, 33805.0, 33878.830605846815, 45785.0, 45828.77085614684, 48018.5198148014, 48447.5155248443, 48503.0, 6864.691088900911, 7310.0, 7532.849343012999, 7878.763637090897, 7951.284384405431, 7767.990161278997, 9886.25853061009, 11042.668719938414, 12457.937710311753, 12544.121911466109, 10551.683449496528, 10788.352698838095, 10822.296550724177, 10882.836757448486, 10946.179036572448, 8218.383621228551, 10500.054995050483, 10655.627053053417, 10701.357918524913, 11175.497102630563, 10634.787304254027, 10878.23852330361, 10905.890941090805, 11128.888711112786, 11383.203175777948, 7990.947248781326, 7993.520388776692, 8257.298129659046, 8292.33661307082, 8339.0, 8177.754667359989, 10137.695869123938, 10763.730906727395, 10844.45777711127, 10982.670519884416], "value": 8091.899317872261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.5007247463388, 1479.800226969359, 1600.2078970909402, 1763.7795275590552, 1797.811229820868, 6450.870982580345, 7109.3957013653835, 7370.115586129666, 7450.366718828893, 7479.476436649423, 7671.731489397872, 7761.728339508119, 7769.261920117594, 7804.453688241825, 7812.609369531515, 2217.456723102838, 2247.763984781599, 2253.5943530164564, 2258.5934531784274, 2261.050358849279, 2236.317923033474, 2239.6640503924377, 2257.345369842744, 2258.2434884313775, 2258.762829902861, 2216.8891555422247, 2225.521512874732, 2236.2955668964305, 2244.842860999731, 2269.1944359752297, 2165.7725938776516, 2183.563287342538, 2186.8797216153107, 2188.4310079379316, 2194.440417693494, 1996.620642078015, 2029.8274646655052, 2030.7664618568758, 2035.714999900015, 2040.1941233212797, 7701.961490192569, 7779.066512018538, 7780.2219778021745, 7802.258785415376, 7821.921780782176, 4510.571495707903, 4701.952980470186, 4703.341532185496, 4715.504871988426, 4731.645126615517, 2854.557543580748, 2856.48583255014, 2917.9124626261246, 2921.948098684472, 2978.225661328049, 961.485605201221, 972.4991629310911, 985.7535616095976, 991.0287917840557, 1003.8343673293971, 10136.797264054678, 10151.1371533419, 10225.488725563766, 10255.692329230134, 10256.846147307797, 4058.228936502055, 4113.465249517543, 4286.89282767927, 4316.525182229952, 4317.41714868495, 8743.169398907094, 8817.206451419403, 8839.823203535892, 8848.64605415789, 8876.778080548038, 4656.883577910512, 4658.650601204856, 4661.743604101807, 4671.532846715301, 4677.555632214934, 3715.9628403716156, 4117.938230926538, 4241.172971270573, 4262.573742625775, 4303.203907277164, 3614.4578313253223, 3640.308341415123, 3666.5966743658178, 3720.1815600567834, 3745.419459983707, 1176.04152615618, 1189.9643010709692, 1195.8445402097673, 1212.2120621595857, 1237.5977807212691, 1177.770334784726, 1186.6084192216547, 1202.729385888168, 1215.0158371718935, 1216.9026477881748, 7061.435085193172, 7081.504294699322, 7127.857442851114, 7159.391451726661, 7341.853162936818, 964.2141654551518, 992.0575453319375, 1009.8182327181031, 1082.2910993299402, 1089.2429761315968, 5426.864328391822, 5558.110702287615, 5573.804916827891, 5597.132444471114, 5603.299587551556, 8900.109989001177, 9082.18260356571, 9388.95305523468, 9394.67118650844, 9468.810623787485, 9326.766830829149, 9339.533023348806, 9347.065293470734, 9347.766305842273, 9431.858522122173, 6914.723411063602, 7039.260877607778, 7100.9289907100265, 7107.324804143598, 7131.92868071323, 7162.7493037743425, 7174.784756457315, 7209.927900721135, 7224.819379515554, 7236.312550307713, 8337.624291991753, 8437.704680336159, 8466.280366168945, 8506.404551681322, 8519.361047921308, 8290.37822163328, 8544.615492302737, 8656.26421754158, 8690.348223883107, 8867.379283450355, 5786.334571524329, 6715.630640314829, 6743.393094621508, 6757.560758550679, 6871.9312806873295, 7250.166230883516, 7295.671694773854, 7319.926800731924, 7362.558246505227, 7387.704491820267, 6129.816105516842, 6386.329435409401, 6393.776217832354, 6486.643234622141, 6536.542442029012, 6318.557700960889, 6361.427471527585, 6526.412622863965, 6557.967210163919, 6658.1011563438315, 6924.965375173092, 6990.091288132714, 6996.580205187705, 6997.405220556309, 7016.6491675415, 6371.426571608577, 6417.422431981144, 6426.871462570629, 6438.130852334875, 6448.065030570635, 6558.704858281293, 6581.111549940697, 6587.736490540517, 6597.373249541286, 6608.801735947929], "value": 4394.875989834986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.20642361976957, 320.0606220742122, 322.0884895745042, 322.65959412819467, 324.1685077775504, 5274.92087618686, 5399.892002159954, 5402.8919421611545, 5404.243405923174, 5411.350637923455, 5281.0, 5286.074936886049, 5299.973500132494, 5301.973490132554, 5319.494648008443, 3927.6268754468424, 4043.919121617566, 4164.666826653868, 4179.916401671965, 4191.329387298033, 4164.5210800758, 4167.687423443239, 4170.353595192735, 4180.5610410906875, 4186.74879507229, 4148.585141485857, 4153.169366126772, 4159.771212583307, 4166.687493439572, 4183.832646694129, 4096.73371230869, 4151.252774500589, 4176.0603864130635, 4186.602272784081, 4189.937150942738, 3668.5414323209598, 3669.2294618130227, 3689.981550092259, 3695.2978934002454, 3709.2581483703098, 5072.188449848043, 5081.923771143436, 5083.517065878736, 5086.0, 5086.287919691209, 4687.460941991681, 4806.687565308243, 4814.590759785422, 4818.807247710088, 4853.150698627726, 5576.1356989666665, 5614.164846752364, 5646.915296270559, 5647.661140331593, 5655.604107712462, 3974.3641017437362, 3983.322835118037, 3992.980035099835, 4005.5193376794678, 4011.8796436106672, 5750.223719797816, 5785.013974535284, 5867.618604790718, 5880.852978675567, 5890.617109887844, 4183.1215444756335, 4194.3498757692605, 4198.181354635817, 4200.432941552913, 4203.810828512725, 4222.767747773841, 4225.704200705983, 4234.597713217239, 4239.872803815891, 4239.936400953989, 4784.2823576463115, 4803.975980120077, 4816.397950256218, 4824.782884770194, 4829.95170048302, 5433.646812957145, 5652.604317697722, 5666.348369937427, 5668.943310566924, 5701.515371193412, 1445.7542217822995, 1467.449706360115, 1468.6622076922367, 1470.2060887120836, 1470.242824945154, 986.9309148359546, 1002.7493126718321, 1016.7153197104823, 1017.038898241155, 1022.0801278849095, 4644.86065418038, 4772.164871147535, 4897.657163998486, 4951.900961980812, 4963.205887058126, 5806.9419305806405, 5886.764529418775, 5901.793437229677, 5914.852128696731, 5920.970395147997, 4620.561046700558, 4871.926921096187, 4886.975565122223, 4897.877553061131, 4905.23968784839, 3089.212250876012, 3133.1853718033476, 3146.229173852421, 3148.511980643004, 3159.7472202223767, 5469.56243500519, 5485.533729632946, 5495.203195536625, 5497.230387745719, 5524.75138618755, 5822.388649191858, 6012.128241404972, 6039.0, 6058.303295121029, 6061.727222275008, 5508.9724551376985, 5513.849598656527, 5526.226328314039, 5536.557075434036, 5550.639208451437, 5569.0, 5848.0, 5903.734331955158, 5917.763289468545, 5919.348871624032, 5729.4244082875875, 5779.248697669276, 5805.506531944832, 5805.970970145122, 5833.0, 5434.809781657623, 5470.152126420411, 5479.917801232905, 5506.0089183947275, 5516.448355164612, 3974.8807535772817, 4040.9393859092725, 4059.4316795649224, 4067.572904845067, 4082.2243773682903, 5846.532277417881, 5886.440788125121, 5904.0, 5904.645721256738, 5922.55580831448, 5636.943630563642, 5691.914621280601, 5705.515031222392, 5706.771729130955, 5713.200151978809, 5537.086380747292, 5658.660480371191, 5667.489925906688, 5675.347335056521, 5725.570582206268, 5594.916076258778, 5619.438056194348, 5623.8594035149445, 5627.606067575394, 5638.21065050885, 5442.836714898401, 5518.0, 5691.630044047124, 5712.400197979152, 5724.313082429969, 5517.641353312022, 5537.8061767837935, 5554.444555544414, 5565.526930210815, 5571.860703482445], "value": 4257.138323626563, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.6902410746414, 621.841430435239, 624.6189824207232, 683.5898460923449, 708.8086216721487, 9933.106020458175, 10006.54970526327, 10041.046100620439, 10165.745856353595, 10179.0, 10998.615048473304, 11053.834192487118, 11055.778884422307, 11073.335599864015, 11106.0, 642.7910928948111, 779.723198264615, 790.3440144679902, 798.9600519974007, 809.6478032056045, 799.476342995336, 803.4496369986549, 803.9919600804005, 805.7904944714357, 807.5881300536739, 832.5587438657491, 834.2158371131118, 834.6244190114443, 834.8288600836814, 836.9288610468118, 830.3481766813023, 831.2809419851845, 833.4124442268186, 833.5873742497472, 838.3586556284447, 610.4536439886277, 610.6854969690613, 611.8562137897591, 612.9233845769279, 613.7084884679786, 10740.409277489734, 10792.676219713421, 10836.0, 10859.07697845684, 10861.239713220079, 11905.226160299553, 11932.70168245792, 11957.820632690517, 12279.815802762965, 12792.936035319857, 9436.858447123299, 9592.376495527838, 9630.374025688308, 9703.17523010545, 9793.804123917482, 3330.500424936279, 3335.499675048738, 3356.3958487472246, 3356.932861342784, 3359.5464612277274, 43968.56031439677, 45273.99999999967, 45498.090038199385, 45579.77210113961, 45620.54379456196, 9625.855612165824, 9748.707538773848, 9777.804443911224, 9785.412875227508, 9874.358166719141, 15041.623959401102, 17140.485785426456, 17195.7420638688, 17266.0, 17271.91364043197, 6468.417842394207, 6547.607143571401, 6558.836029099215, 6676.031975363545, 6680.665966701646, 3760.0975765816006, 3831.9808400958373, 3852.57621661617, 3927.2930872443235, 3959.1883663848844, 2832.3768770870374, 2981.642202935618, 2986.4773664608606, 2988.118505041018, 3005.0383877159097, 558.3021223470662, 559.1975515135794, 560.1262031231292, 560.5207547546789, 560.9214709940611, 577.971101444926, 629.3109045595066, 632.822809613309, 633.4488994574749, 654.306435178712, 7678.232176782277, 7805.907172995785, 8099.352051835839, 8234.629441675139, 8284.25441710237, 496.2135015999681, 547.0170631460954, 557.1976354050155, 560.1289994059196, 575.8704291534372, 3794.6964242860504, 3924.6656136913584, 3999.0, 4091.3453847384276, 4121.052158003676, 49951.25073123906, 50219.0, 54300.45699542954, 54601.72699136479, 54990.450095499335, 45740.771296143306, 46420.30369544459, 46672.299915501295, 47157.76421117873, 48032.5196748035, 40324.79837600852, 42725.145497089885, 42759.35860962088, 42897.0, 43178.568214317456, 7416.517926334771, 7581.203973582915, 7629.54222746637, 7672.156062833195, 7782.649780759766, 27868.721312786613, 28406.57390139191, 28857.711422885503, 29056.273593159494, 29167.124986250445, 35846.64153358433, 38923.80538097292, 39071.02322441848, 39242.60757392504, 39542.0, 9277.814443710953, 9413.764655883657, 9447.291453140904, 9485.0, 9553.808923821345, 10730.89269107299, 10750.384367405706, 10831.404272765074, 10899.455027248447, 10900.945495272474, 9620.903790962, 9695.22438204956, 9869.851952220579, 9907.851382229128, 10086.394816311045, 9516.762080948032, 9588.37675551087, 9671.758206044906, 9822.263330250116, 9822.705318840446, 9779.315447918578, 9782.657606984007, 10012.849807253042, 10226.437545934747, 10394.116500097576, 8295.460795048544, 8485.193906578865, 8514.276286515715, 8650.56747162652, 8675.392722509616, 8672.219500245008, 8734.432261902955, 8784.385093043682, 8844.336674749291, 9487.478188699688], "value": 5716.297879998239, "unit": "score"}], "name": "dromaeo_css", "value": 6373.551383250302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 113.0, 116.0, 127.0, 115.0, 115.0, 114.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 135.0, 156.0, 178.0, 142.0, 155.0, 172.0, 137.0, 179.0, 134.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 162.0, 164.0, 178.0, 162.0, 163.0, 164.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 77.0, 73.0, 76.0, 74.0, 163.0, 74.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 145.0, 94.0, 94.0, 93.0, 138.0, 95.0, 94.0, 137.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 87.0, 86.0, 86.0, 87.0, 86.0, 86.0, 91.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 139.0, 143.0, 139.0, 140.0, 144.0, 140.0, 141.0, 138.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 171.0, 190.0, 172.0, 174.0, 170.0, 178.0, 173.0, 178.0, 171.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 71.0, 73.0, 71.0, 71.0, 72.0, 74.0, 72.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1593.8000000000002, "alertThreshold": 2.0}]} 15:16:09 INFO - Return code: 0 15:16:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:16:09 ERROR - # TBPL SUCCESS # 15:16:09 INFO - Running post-action listener: _resource_record_post_action 15:16:09 INFO - Running post-run listener: _resource_record_post_run 15:16:10 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 524738560; Read time: 204; Write time: 648964 15:16:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240123904; Read time: 0; Write time: 364872 15:16:10 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284614656; Read time: 204; Write time: 284092 15:16:10 INFO - Running post-run listener: _upload_blobber_files 15:16:10 INFO - Blob upload gear active. 15:16:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:16:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:16:11 INFO - (blobuploader) - INFO - Open directory for files ... 15:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:11 INFO - (blobuploader) - INFO - Done attempting. 15:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:12 INFO - (blobuploader) - INFO - Done attempting. 15:16:12 INFO - (blobuploader) - INFO - Iteration through files over. 15:16:12 INFO - Return code: 0 15:16:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:16:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:16:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a505b84902ea1e8b10b77329554d333e54e250d6383f946f04997f11313254ae0fb86877690f8a7f9f60998bb95d6c0a0d6c4f7f62eec3569c81cc26c7fb33c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3426b51fe6cf2d8a35b6c5057d7cc513bef388e27c8ddc66a8e2a9884a0e023f0b5bb842c0a0ae9c8a61ddf876cfc706ef8dcf6bb0e879961404f965a9fe1d13"} 15:16:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:16:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:16:12 INFO - Contents: 15:16:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a505b84902ea1e8b10b77329554d333e54e250d6383f946f04997f11313254ae0fb86877690f8a7f9f60998bb95d6c0a0d6c4f7f62eec3569c81cc26c7fb33c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3426b51fe6cf2d8a35b6c5057d7cc513bef388e27c8ddc66a8e2a9884a0e023f0b5bb842c0a0ae9c8a61ddf876cfc706ef8dcf6bb0e879961404f965a9fe1d13"} 15:16:12 INFO - Running post-run listener: copy_logs_to_upload_dir 15:16:12 INFO - Copying logs to upload dir... 15:16:12 INFO - mkdir: /builds/slave/test/build/upload/logs 15:16:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.411712 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-10 15:16:12.835908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 15:16:12.839058) ========= 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-1460325334.436917-1219897260 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/7a505b84902ea1e8b10b77329554d333e54e250d6383f946f04997f11313254ae0fb86877690f8a7f9f60998bb95d6c0a0d6c4f7f62eec3569c81cc26c7fb33c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3426b51fe6cf2d8a35b6c5057d7cc513bef388e27c8ddc66a8e2a9884a0e023f0b5bb842c0a0ae9c8a61ddf876cfc706ef8dcf6bb0e879961404f965a9fe1d13"} build_url:https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010507 build_url: 'https://queue.taskcluster.net/v1/task/beEkEMkfQLutdnj7JjHFXg/artifacts/public/build/firefox-48.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/7a505b84902ea1e8b10b77329554d333e54e250d6383f946f04997f11313254ae0fb86877690f8a7f9f60998bb95d6c0a0d6c4f7f62eec3569c81cc26c7fb33c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3426b51fe6cf2d8a35b6c5057d7cc513bef388e27c8ddc66a8e2a9884a0e023f0b5bb842c0a0ae9c8a61ddf876cfc706ef8dcf6bb0e879961404f965a9fe1d13"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 15:16:12.912699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:16:12.913029) ========= 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-1460325334.436917-1219897260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:16:13.000983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 15:16:13.001287) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 15:16:13.001592) ========= ========= Total master_lag: 0.36 =========