builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1458889122.97 results: success (0) buildid: 20160324223743 builduid: 93d965b16d1b4dfcbf51a2a37d68b0a6 revision: d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:42.969996) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:42.970385) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:42.970682) ========= 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006552 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.001796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.002070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.031372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.031637) ========= 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.086816) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.087076) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.087416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.087704) ========= 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 23:58:43-- 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% 33.3M=0s 2016-03-24 23:58:43 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.201674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.201965) ========= 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015779 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:43.252719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 23:58:43.253035) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 --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 d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 --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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 23:58:44,051 truncating revision to first 12 chars 2016-03-24 23:58:44,051 Setting DEBUG logging. 2016-03-24 23:58:44,051 attempt 1/10 2016-03-24 23:58:44,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5f3da0cfe7c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 23:58:44,754 unpacking tar archive at: mozilla-central-d5f3da0cfe7c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.005131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 23:58:44.271455) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:44.271807) ========= echo d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd5f3da0cfe7ccf846c354014c9b059fad6ba0de5'] 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 program finished with exit code 0 elapsedTime=0.003819 script_repo_revision: 'd5f3da0cfe7ccf846c354014c9b059fad6ba0de5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:44.320846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:44.321123) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 23:58:44.331273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-03-24 23:58:44.331541) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:58:45 INFO - MultiFileLogger online at 20160324 23:58:45 in /builds/slave/test 23:58:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 23:58:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:58:45 INFO - {'append_to_log': False, 23:58:45 INFO - 'base_work_dir': '/builds/slave/test', 23:58:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:58:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:58:45 INFO - 'branch': 'Firefox-Non-PGO', 23:58:45 INFO - 'buildbot_json_path': 'buildprops.json', 23:58:45 INFO - 'config_files': ('talos/linux_config.py',), 23:58:45 INFO - 'default_actions': ('clobber', 23:58:45 INFO - 'read-buildbot-config', 23:58:45 INFO - 'download-and-extract', 23:58:45 INFO - 'populate-webroot', 23:58:45 INFO - 'create-virtualenv', 23:58:45 INFO - 'install', 23:58:45 INFO - 'run-tests'), 23:58:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:58:45 INFO - 'download_minidump_stackwalk': True, 23:58:45 INFO - 'download_symbols': 'ondemand', 23:58:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:58:45 INFO - 'tooltool.py': '/tools/tooltool.py', 23:58:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:58:45 INFO - '/tools/misc-python/virtualenv.py')}, 23:58:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:58:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:58:45 INFO - 'installer_path': 'installer.exe', 23:58:45 INFO - 'log_level': 'info', 23:58:45 INFO - 'log_name': 'talos', 23:58:45 INFO - 'log_to_console': True, 23:58:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:58:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:58:45 INFO - 'opt_config_files': (), 23:58:45 INFO - 'pip_index': False, 23:58:45 INFO - 'sps_profile': False, 23:58:45 INFO - 'sps_profile_interval': 0, 23:58:45 INFO - 'suite': 'dromaeojs', 23:58:45 INFO - 'system_bits': '32', 23:58:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:58:45 INFO - 'title': 'talos-linux64-ix-069', 23:58:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:58:45 INFO - 'use_talos_json': True, 23:58:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:58:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:58:45 INFO - 'work_dir': 'build'} 23:58:45 INFO - ##### 23:58:45 INFO - ##### Running clobber step. 23:58:45 INFO - ##### 23:58:45 INFO - Running pre-action listener: _resource_record_pre_action 23:58:45 INFO - Running main action method: clobber 23:58:45 INFO - rmtree: /builds/slave/test/build 23:58:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:58:45 INFO - Running post-action listener: _resource_record_post_action 23:58:45 INFO - ##### 23:58:45 INFO - ##### Running read-buildbot-config step. 23:58:45 INFO - ##### 23:58:45 INFO - Running pre-action listener: _resource_record_pre_action 23:58:45 INFO - Running main action method: read_buildbot_config 23:58:45 INFO - Using buildbot properties: 23:58:45 INFO - { 23:58:45 INFO - "project": "", 23:58:45 INFO - "product": "firefox", 23:58:45 INFO - "script_repo_revision": "production", 23:58:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 23:58:45 INFO - "repository": "", 23:58:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 23:58:45 INFO - "buildid": "20160324223743", 23:58:45 INFO - "pgo_build": "False", 23:58:45 INFO - "basedir": "/builds/slave/test", 23:58:45 INFO - "buildnumber": 525, 23:58:45 INFO - "slavename": "talos-linux64-ix-069", 23:58:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:58:45 INFO - "platform": "ubuntu64_hw", 23:58:45 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 23:58:45 INFO - "branch": "mozilla-central", 23:58:45 INFO - "repo_path": "mozilla-central", 23:58:45 INFO - "revision": "d5f3da0cfe7ccf846c354014c9b059fad6ba0de5", 23:58:45 INFO - "stage_platform": "linux64", 23:58:45 INFO - "builduid": "93d965b16d1b4dfcbf51a2a37d68b0a6", 23:58:45 INFO - "slavebuilddir": "test" 23:58:45 INFO - } 23:58:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 23:58:45 INFO - Running post-action listener: _resource_record_post_action 23:58:45 INFO - ##### 23:58:45 INFO - ##### Running download-and-extract step. 23:58:45 INFO - ##### 23:58:45 INFO - Running pre-action listener: _resource_record_pre_action 23:58:45 INFO - Running main action method: download_and_extract 23:58:45 INFO - mkdir: /builds/slave/test/build/tests 23:58: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')]} 23:58:45 INFO - https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:58:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:58:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:58:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:58:57 INFO - Downloaded 1361 bytes. 23:58:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 23:58:57 INFO - Using the following test package requirements: 23:58:57 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:58:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:58:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:58:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'jsshell-linux-x86_64.zip'], 23:58:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:58:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 23:58:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:58:57 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:58:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:58:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:58:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:57 INFO - https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:58:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:58:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:58:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:00 INFO - Downloaded 22065821 bytes. 23:59:00 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'] 23:59:00 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 23:59:01 INFO - Return code: 0 23:59:01 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 23:59: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')]} 23:59:01 INFO - https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 23:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:10 INFO - Downloaded 22065821 bytes. 23:59:10 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'] 23:59:10 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 23:59:11 INFO - Return code: 0 23:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:11 INFO - https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:59:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:59:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 23:59:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:13 INFO - Downloaded 10847187 bytes. 23:59:13 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'] 23:59:13 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 23:59:13 INFO - Return code: 0 23:59:13 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')]} 23:59:13 INFO - https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:59:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:59:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:59:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DaqMa2TARZa7jH_TOgngVw/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 23:59:16 INFO - Downloaded 54265265 bytes. 23:59:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:59:16 INFO - mkdir: /builds/slave/test/properties 23:59:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:59:16 INFO - Writing to file /builds/slave/test/properties/build_url 23:59:16 INFO - Contents: 23:59:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 23:59:17 INFO - Running post-action listener: _resource_record_post_action 23:59:17 INFO - Running post-action listener: set_extra_try_arguments 23:59:17 INFO - ##### 23:59:17 INFO - ##### Running populate-webroot step. 23:59:17 INFO - ##### 23:59:17 INFO - Running pre-action listener: _resource_record_pre_action 23:59:17 INFO - Running main action method: populate_webroot 23:59:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:59:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:59:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:59:17 INFO - '--tppagecycles', 23:59:17 INFO - '7'], 23:59:17 INFO - 'tests': ['tsvgm']}}, 23:59:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:59:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:59:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:59:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:59:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:59:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:59:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'tests': ['damp', 'tps']}, 23:59:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['damp', 'tps']}, 23:59:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:59:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:59:17 INFO - 'other': {'tests': ['a11yr', 23:59:17 INFO - 'ts_paint', 23:59:17 INFO - 'tpaint', 23:59:17 INFO - 'sessionrestore', 23:59:17 INFO - 'sessionrestore_no_auto_restore', 23:59:17 INFO - 'tabpaint']}, 23:59:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['a11yr', 23:59:17 INFO - 'ts_paint', 23:59:17 INFO - 'tpaint', 23:59:17 INFO - 'sessionrestore', 23:59:17 INFO - 'sessionrestore_no_auto_restore', 23:59:17 INFO - 'tabpaint']}, 23:59:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['a11yr', 23:59:17 INFO - 'ts_paint', 23:59:17 INFO - 'tpaint', 23:59:17 INFO - 'sessionrestore', 23:59:17 INFO - 'sessionrestore_no_auto_restore', 23:59:17 INFO - 'tabpaint']}, 23:59:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['a11yr', 23:59:17 INFO - 'ts_paint', 23:59:17 INFO - 'tpaint', 23:59:17 INFO - 'sessionrestore', 23:59:17 INFO - 'sessionrestore_no_auto_restore', 23:59:17 INFO - 'tabpaint']}, 23:59:17 INFO - 'other_l64': {'tests': ['a11yr', 23:59:17 INFO - 'ts_paint', 23:59:17 INFO - 'tpaint', 23:59:17 INFO - 'sessionrestore', 23:59:17 INFO - 'sessionrestore_no_auto_restore', 23:59:17 INFO - 'tabpaint']}, 23:59:17 INFO - 'other_nol64': {'tests': ['a11yr', 23:59:17 INFO - 'ts_paint', 23:59:17 INFO - 'tpaint', 23:59:17 INFO - 'sessionrestore', 23:59:17 INFO - 'sessionrestore_no_auto_restore', 23:59:17 INFO - 'tabpaint']}, 23:59:17 INFO - 'svgr': {'tests': ['tsvgx', 23:59:17 INFO - 'tsvgr_opacity', 23:59:17 INFO - 'tart', 23:59:17 INFO - 'tscrollx', 23:59:17 INFO - 'cart']}, 23:59:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['tsvgx', 23:59:17 INFO - 'tsvgr_opacity', 23:59:17 INFO - 'tart', 23:59:17 INFO - 'tscrollx', 23:59:17 INFO - 'cart']}, 23:59:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'tests': ['tp5o']}, 23:59:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'talos_options': ['--e10s'], 23:59:17 INFO - 'tests': ['tp5o']}, 23:59:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'talos_options': ['--xperf_path', 23:59:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:59:17 INFO - 'tests': ['tp5n']}, 23:59:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:17 INFO - 'talos_options': ['--e10s', 23:59:17 INFO - '--xperf_path', 23:59:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:59:17 INFO - 'tests': ['tp5n']}}, 23:59:17 INFO - 'talos.zip': {'path': '', 23:59:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:59:17 INFO - Running post-action listener: _resource_record_post_action 23:59:17 INFO - ##### 23:59:17 INFO - ##### Running create-virtualenv step. 23:59:17 INFO - ##### 23:59:17 INFO - Running pre-action listener: _resource_record_pre_action 23:59:17 INFO - Running main action method: create_virtualenv 23:59:17 INFO - Creating virtualenv /builds/slave/test/build/venv 23:59:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:59:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:59:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:59:17 INFO - Using real prefix '/usr' 23:59:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:59:18 INFO - Installing distribute.............................................................................................................................................................................................done. 23:59:20 INFO - Installing pip.................done. 23:59:20 INFO - Return code: 0 23:59:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:59:20 INFO - Using env: {'DISPLAY': ':0', 23:59:20 INFO - 'HOME': '/home/cltbld', 23:59:20 INFO - 'LANG': 'en_US.UTF-8', 23:59:20 INFO - 'LANGUAGE': 'en_US:en', 23:59:20 INFO - 'LOGNAME': 'cltbld', 23:59:20 INFO - 'MAIL': '/var/mail/cltbld', 23:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:20 INFO - 'MOZ_NO_REMOTE': '1', 23:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:20 INFO - 'NO_EM_RESTART': '1', 23:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:20 INFO - 'PWD': '/builds/slave/test', 23:59:20 INFO - 'SHELL': '/bin/bash', 23:59:20 INFO - 'SHLVL': '1', 23:59:20 INFO - 'TERM': 'linux', 23:59:20 INFO - 'TMOUT': '86400', 23:59:20 INFO - 'USER': 'cltbld', 23:59:20 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:20 INFO - '_': '/tools/buildbot/bin/python'} 23:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:59:20 INFO - Cleaning up... 23:59:20 INFO - Return code: 0 23:59:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:59:20 INFO - Using env: {'DISPLAY': ':0', 23:59:20 INFO - 'HOME': '/home/cltbld', 23:59:20 INFO - 'LANG': 'en_US.UTF-8', 23:59:20 INFO - 'LANGUAGE': 'en_US:en', 23:59:20 INFO - 'LOGNAME': 'cltbld', 23:59:20 INFO - 'MAIL': '/var/mail/cltbld', 23:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:20 INFO - 'MOZ_NO_REMOTE': '1', 23:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:20 INFO - 'NO_EM_RESTART': '1', 23:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:20 INFO - 'PWD': '/builds/slave/test', 23:59:20 INFO - 'SHELL': '/bin/bash', 23:59:20 INFO - 'SHLVL': '1', 23:59:20 INFO - 'TERM': 'linux', 23:59:20 INFO - 'TMOUT': '86400', 23:59:20 INFO - 'USER': 'cltbld', 23:59:20 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:20 INFO - '_': '/tools/buildbot/bin/python'} 23:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:20 INFO - Downloading/unpacking psutil>=0.7.1 23:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:59:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:59:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:59:22 INFO - Installing collected packages: psutil 23:59:22 INFO - Running setup.py install for psutil 23:59:22 INFO - building 'psutil._psutil_linux' extension 23:59:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:59:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:59:22 INFO - building 'psutil._psutil_posix' extension 23:59:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:59:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:59:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:59:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:59:23 INFO - Successfully installed psutil 23:59:23 INFO - Cleaning up... 23:59:23 INFO - Return code: 0 23:59:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:59:23 INFO - Using env: {'DISPLAY': ':0', 23:59:23 INFO - 'HOME': '/home/cltbld', 23:59:23 INFO - 'LANG': 'en_US.UTF-8', 23:59:23 INFO - 'LANGUAGE': 'en_US:en', 23:59:23 INFO - 'LOGNAME': 'cltbld', 23:59:23 INFO - 'MAIL': '/var/mail/cltbld', 23:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:23 INFO - 'MOZ_NO_REMOTE': '1', 23:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:23 INFO - 'NO_EM_RESTART': '1', 23:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:23 INFO - 'PWD': '/builds/slave/test', 23:59:23 INFO - 'SHELL': '/bin/bash', 23:59:23 INFO - 'SHLVL': '1', 23:59:23 INFO - 'TERM': 'linux', 23:59:23 INFO - 'TMOUT': '86400', 23:59:23 INFO - 'USER': 'cltbld', 23:59:23 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:23 INFO - '_': '/tools/buildbot/bin/python'} 23:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:59:25 INFO - Installing collected packages: mozsystemmonitor 23:59:25 INFO - Running setup.py install for mozsystemmonitor 23:59:25 INFO - Successfully installed mozsystemmonitor 23:59:25 INFO - Cleaning up... 23:59:25 INFO - Return code: 0 23:59:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:59:25 INFO - Using env: {'DISPLAY': ':0', 23:59:25 INFO - 'HOME': '/home/cltbld', 23:59:25 INFO - 'LANG': 'en_US.UTF-8', 23:59:25 INFO - 'LANGUAGE': 'en_US:en', 23:59:25 INFO - 'LOGNAME': 'cltbld', 23:59:25 INFO - 'MAIL': '/var/mail/cltbld', 23:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:25 INFO - 'MOZ_NO_REMOTE': '1', 23:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:25 INFO - 'NO_EM_RESTART': '1', 23:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:25 INFO - 'PWD': '/builds/slave/test', 23:59:25 INFO - 'SHELL': '/bin/bash', 23:59:25 INFO - 'SHLVL': '1', 23:59:25 INFO - 'TERM': 'linux', 23:59:25 INFO - 'TMOUT': '86400', 23:59:25 INFO - 'USER': 'cltbld', 23:59:25 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:25 INFO - '_': '/tools/buildbot/bin/python'} 23:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:25 INFO - Downloading/unpacking blobuploader==1.2.4 23:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:27 INFO - Downloading blobuploader-1.2.4.tar.gz 23:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:59:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:59:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:28 INFO - Downloading docopt-0.6.1.tar.gz 23:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:59:28 INFO - Installing collected packages: blobuploader, requests, docopt 23:59:28 INFO - Running setup.py install for blobuploader 23:59:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:59:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:59:28 INFO - Running setup.py install for requests 23:59:28 INFO - Running setup.py install for docopt 23:59:28 INFO - Successfully installed blobuploader requests docopt 23:59:28 INFO - Cleaning up... 23:59:28 INFO - Return code: 0 23:59:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:28 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 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:28 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 23:59:28 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 23:59:28 INFO - Using env: {'DISPLAY': ':0', 23:59:28 INFO - 'HOME': '/home/cltbld', 23:59:28 INFO - 'LANG': 'en_US.UTF-8', 23:59:28 INFO - 'LANGUAGE': 'en_US:en', 23:59:28 INFO - 'LOGNAME': 'cltbld', 23:59:28 INFO - 'MAIL': '/var/mail/cltbld', 23:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:28 INFO - 'MOZ_NO_REMOTE': '1', 23:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:28 INFO - 'NO_EM_RESTART': '1', 23:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:28 INFO - 'PWD': '/builds/slave/test', 23:59:28 INFO - 'SHELL': '/bin/bash', 23:59:28 INFO - 'SHLVL': '1', 23:59:28 INFO - 'TERM': 'linux', 23:59:28 INFO - 'TMOUT': '86400', 23:59:28 INFO - 'USER': 'cltbld', 23:59:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:28 INFO - '_': '/tools/buildbot/bin/python'} 23:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:59:29 INFO - Running setup.py (path:/tmp/pip-9abiFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:59:29 INFO - Running setup.py (path:/tmp/pip-_UX2Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:59:29 INFO - Running setup.py (path:/tmp/pip-D34CXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:59:29 INFO - Running setup.py (path:/tmp/pip-CS0t_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:59:29 INFO - Running setup.py (path:/tmp/pip-YloRDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:59:29 INFO - Running setup.py (path:/tmp/pip-UfJ2a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:59:29 INFO - Running setup.py (path:/tmp/pip-7y_MkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:59:29 INFO - Running setup.py (path:/tmp/pip-JFl0u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:59:29 INFO - Running setup.py (path:/tmp/pip-MLcTZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:59:29 INFO - Running setup.py (path:/tmp/pip-COXKCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:59:29 INFO - Running setup.py (path:/tmp/pip-XyK_So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:59:29 INFO - Running setup.py (path:/tmp/pip-wiVkMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:59:29 INFO - Running setup.py (path:/tmp/pip-1nQoBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:59:30 INFO - Running setup.py (path:/tmp/pip-PrO3By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:30 INFO - Running setup.py (path:/tmp/pip-IYKZyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:59:30 INFO - Running setup.py (path:/tmp/pip-BzR1GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:59:30 INFO - Running setup.py (path:/tmp/pip-yieQ6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:59:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:59:30 INFO - Running setup.py install for manifestparser 23:59:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:59:30 INFO - Running setup.py install for mozcrash 23:59:30 INFO - Running setup.py install for mozdebug 23:59:30 INFO - Running setup.py install for mozdevice 23:59:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:59:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:59:30 INFO - Running setup.py install for mozfile 23:59:30 INFO - Running setup.py install for mozhttpd 23:59:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:59:30 INFO - Running setup.py install for mozinfo 23:59:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozInstall 23:59:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozleak 23:59:31 INFO - Running setup.py install for mozlog 23:59:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for moznetwork 23:59:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozprocess 23:59:31 INFO - Running setup.py install for mozprofile 23:59:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozrunner 23:59:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozscreenshot 23:59:31 INFO - Running setup.py install for moztest 23:59:31 INFO - Running setup.py install for mozversion 23:59:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:59:32 INFO - Cleaning up... 23:59:32 INFO - Return code: 0 23:59:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:32 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')]} 23:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:32 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')]} 23:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:32 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 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:32 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 23:59:32 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 23:59:32 INFO - Using env: {'DISPLAY': ':0', 23:59:32 INFO - 'HOME': '/home/cltbld', 23:59:32 INFO - 'LANG': 'en_US.UTF-8', 23:59:32 INFO - 'LANGUAGE': 'en_US:en', 23:59:32 INFO - 'LOGNAME': 'cltbld', 23:59:32 INFO - 'MAIL': '/var/mail/cltbld', 23:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:32 INFO - 'MOZ_NO_REMOTE': '1', 23:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:32 INFO - 'NO_EM_RESTART': '1', 23:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:32 INFO - 'PWD': '/builds/slave/test', 23:59:32 INFO - 'SHELL': '/bin/bash', 23:59:32 INFO - 'SHLVL': '1', 23:59:32 INFO - 'TERM': 'linux', 23:59:32 INFO - 'TMOUT': '86400', 23:59:32 INFO - 'USER': 'cltbld', 23:59:32 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:32 INFO - '_': '/tools/buildbot/bin/python'} 23:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:59:32 INFO - Running setup.py (path:/tmp/pip-CCEdvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:59:32 INFO - Running setup.py (path:/tmp/pip-tF45Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:59:32 INFO - Running setup.py (path:/tmp/pip-QepiH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:59:32 INFO - Running setup.py (path:/tmp/pip-8CS4ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:59:32 INFO - Running setup.py (path:/tmp/pip-ZU7Cq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:59:32 INFO - Running setup.py (path:/tmp/pip-C6MMF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:59:32 INFO - Running setup.py (path:/tmp/pip-TXQVVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:59:32 INFO - Running setup.py (path:/tmp/pip-K_Sr25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:59:32 INFO - Running setup.py (path:/tmp/pip-fOJx0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:59:32 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)) 23:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:59:32 INFO - Running setup.py (path:/tmp/pip-uQsYNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:59:33 INFO - Running setup.py (path:/tmp/pip-SSrtVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:59:33 INFO - Running setup.py (path:/tmp/pip-Q5pHJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:59:33 INFO - Running setup.py (path:/tmp/pip-a9OQS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:59:33 INFO - Running setup.py (path:/tmp/pip-lFxH89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:33 INFO - Running setup.py (path:/tmp/pip-llDnnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:59:33 INFO - Running setup.py (path:/tmp/pip-Mx76cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:59:33 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)) 23:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:59:33 INFO - Running setup.py (path:/tmp/pip-Ou4_mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:59:33 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)) 23:59:33 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)) 23:59:33 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)) 23:59:33 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)) 23:59:33 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)) 23:59:33 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)) 23:59:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:35 INFO - Downloading blessings-1.6.tar.gz 23:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:59:35 INFO - Installing collected packages: blessings 23:59:35 INFO - Running setup.py install for blessings 23:59:35 INFO - Successfully installed blessings 23:59:35 INFO - Cleaning up... 23:59:35 INFO - Return code: 0 23:59:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:59:35 INFO - Reading from file tmpfile_stdout 23:59:35 INFO - Current package versions: 23:59:35 INFO - argparse == 1.2.1 23:59:35 INFO - blessings == 1.6 23:59:35 INFO - blobuploader == 1.2.4 23:59:35 INFO - docopt == 0.6.1 23:59:35 INFO - manifestparser == 1.1 23:59:35 INFO - mozInstall == 1.12 23:59:35 INFO - mozcrash == 0.17 23:59:35 INFO - mozdebug == 0.1 23:59:35 INFO - mozdevice == 0.48 23:59:35 INFO - mozfile == 1.2 23:59:35 INFO - mozhttpd == 0.7 23:59:35 INFO - mozinfo == 0.9 23:59:35 INFO - mozleak == 0.1 23:59:35 INFO - mozlog == 3.1 23:59:35 INFO - moznetwork == 0.27 23:59:35 INFO - mozprocess == 0.22 23:59:35 INFO - mozprofile == 0.28 23:59:35 INFO - mozrunner == 6.11 23:59:35 INFO - mozscreenshot == 0.1 23:59:35 INFO - mozsystemmonitor == 0.0 23:59:35 INFO - moztest == 0.7 23:59:35 INFO - mozversion == 1.4 23:59:35 INFO - psutil == 3.1.1 23:59:35 INFO - requests == 1.2.3 23:59:35 INFO - wsgiref == 0.1.2 23:59:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:35 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 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:35 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 23:59:35 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 23:59:35 INFO - Using env: {'DISPLAY': ':0', 23:59:35 INFO - 'HOME': '/home/cltbld', 23:59:35 INFO - 'LANG': 'en_US.UTF-8', 23:59:35 INFO - 'LANGUAGE': 'en_US:en', 23:59:35 INFO - 'LOGNAME': 'cltbld', 23:59:35 INFO - 'MAIL': '/var/mail/cltbld', 23:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:35 INFO - 'MOZ_NO_REMOTE': '1', 23:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:35 INFO - 'NO_EM_RESTART': '1', 23:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:35 INFO - 'PWD': '/builds/slave/test', 23:59:35 INFO - 'SHELL': '/bin/bash', 23:59:35 INFO - 'SHLVL': '1', 23:59:35 INFO - 'TERM': 'linux', 23:59:35 INFO - 'TMOUT': '86400', 23:59:35 INFO - 'USER': 'cltbld', 23:59:35 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:35 INFO - '_': '/tools/buildbot/bin/python'} 23:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 INFO - Cleaning up... 23:59:36 INFO - Return code: 0 23:59:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:59:36 INFO - Using env: {'DISPLAY': ':0', 23:59:36 INFO - 'HOME': '/home/cltbld', 23:59:36 INFO - 'LANG': 'en_US.UTF-8', 23:59:36 INFO - 'LANGUAGE': 'en_US:en', 23:59:36 INFO - 'LOGNAME': 'cltbld', 23:59:36 INFO - 'MAIL': '/var/mail/cltbld', 23:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:36 INFO - 'MOZ_NO_REMOTE': '1', 23:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:36 INFO - 'NO_EM_RESTART': '1', 23:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:36 INFO - 'PWD': '/builds/slave/test', 23:59:36 INFO - 'SHELL': '/bin/bash', 23:59:36 INFO - 'SHLVL': '1', 23:59:36 INFO - 'TERM': 'linux', 23:59:36 INFO - 'TMOUT': '86400', 23:59:36 INFO - 'USER': 'cltbld', 23:59:36 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:36 INFO - '_': '/tools/buildbot/bin/python'} 23:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:36 INFO - Downloading/unpacking jsonschema 23:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:59:38 INFO - Downloading/unpacking functools32 (from jsonschema) 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 INFO - Downloading functools32-3.2.3-2.tar.gz 23:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:59:38 INFO - warning: no files found matching '*.txt' 23:59:38 INFO - no previously-included directories found matching 'build' 23:59:38 INFO - no previously-included directories found matching 'dist' 23:59:38 INFO - no previously-included directories found matching '.git*' 23:59:38 INFO - Installing collected packages: jsonschema, functools32 23:59:38 INFO - Running setup.py install for functools32 23:59:38 INFO - warning: no files found matching '*.txt' 23:59:38 INFO - no previously-included directories found matching 'build' 23:59:38 INFO - no previously-included directories found matching 'dist' 23:59:38 INFO - no previously-included directories found matching '.git*' 23:59:38 INFO - Successfully installed jsonschema functools32 23:59:38 INFO - Cleaning up... 23:59:38 INFO - Return code: 0 23:59:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7195596f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, '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': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', '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 23:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:59:38 INFO - Using env: {'DISPLAY': ':0', 23:59:38 INFO - 'HOME': '/home/cltbld', 23:59:38 INFO - 'LANG': 'en_US.UTF-8', 23:59:38 INFO - 'LANGUAGE': 'en_US:en', 23:59:38 INFO - 'LOGNAME': 'cltbld', 23:59:38 INFO - 'MAIL': '/var/mail/cltbld', 23:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:38 INFO - 'MOZ_NO_REMOTE': '1', 23:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:38 INFO - 'NO_EM_RESTART': '1', 23:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:38 INFO - 'PWD': '/builds/slave/test', 23:59:38 INFO - 'SHELL': '/bin/bash', 23:59:38 INFO - 'SHLVL': '1', 23:59:38 INFO - 'TERM': 'linux', 23:59:38 INFO - 'TMOUT': '86400', 23:59:38 INFO - 'USER': 'cltbld', 23:59:38 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:38 INFO - '_': '/tools/buildbot/bin/python'} 23:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:38 INFO - Downloading/unpacking flake8 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 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 23:59:38 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 23:59:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:59:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:59:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:59:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:59:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:59:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:59:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:59:41 INFO - no previously-included directories found matching 'docs/_build' 23:59:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:59:41 INFO - Running setup.py install for pep8 23:59:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:59:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:59:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:59:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:59:41 INFO - no previously-included directories found matching 'docs/_build' 23:59:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:59:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:59:41 INFO - Cleaning up... 23:59:41 INFO - Return code: 0 23:59:41 INFO - Running post-action listener: _resource_record_post_action 23:59:41 INFO - Running post-action listener: _start_resource_monitoring 23:59:41 INFO - Starting resource monitoring. 23:59:41 INFO - ##### 23:59:41 INFO - ##### Running install step. 23:59:41 INFO - ##### 23:59:41 INFO - Running pre-action listener: _resource_record_pre_action 23:59:41 INFO - Running main action method: install 23:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:59:41 INFO - Reading from file tmpfile_stdout 23:59:41 INFO - Detecting whether we're running mozinstall >=1.0... 23:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:59:41 INFO - Reading from file tmpfile_stdout 23:59:41 INFO - Output received: 23:59:41 INFO - Usage: mozinstall [options] installer 23:59:41 INFO - Options: 23:59:41 INFO - -h, --help show this help message and exit 23:59:41 INFO - -d DEST, --destination=DEST 23:59:41 INFO - Directory to install application into. [default: 23:59:41 INFO - "/builds/slave/test"] 23:59:41 INFO - --app=APP Application being installed. [default: firefox] 23:59:41 INFO - mkdir: /builds/slave/test/build/application 23:59:41 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'] 23:59:41 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 23:59:57 INFO - Reading from file tmpfile_stdout 23:59:57 INFO - Output received: 23:59:57 INFO - /builds/slave/test/build/application/firefox/firefox 23:59:57 INFO - Running post-action listener: _resource_record_post_action 23:59:57 INFO - ##### 23:59:57 INFO - ##### Running run-tests step. 23:59:57 INFO - ##### 23:59:57 INFO - Running pre-action listener: _resource_record_pre_action 23:59:57 INFO - Running main action method: run_tests 23:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:59:57 INFO - Python 2.7.3 23:59:57 INFO - Return code: 0 23:59:57 INFO - grabbing minidump binary from tooltool 23:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d11410>, '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 0x1d12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d127a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:59:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:59:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:59:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:59:57 INFO - Return code: 0 23:59:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:59:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:59:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:59:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:59:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:59:58 INFO - Return code: 0 23:59:58 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:59:58 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:59:58 INFO - Using env: {'DISPLAY': ':0', 23:59:58 INFO - 'HOME': '/home/cltbld', 23:59:58 INFO - 'LANG': 'en_US.UTF-8', 23:59:58 INFO - 'LANGUAGE': 'en_US:en', 23:59:58 INFO - 'LOGNAME': 'cltbld', 23:59:58 INFO - 'MAIL': '/var/mail/cltbld', 23:59:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:59:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:58 INFO - 'MOZ_NO_REMOTE': '1', 23:59:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:59:58 INFO - 'NO_EM_RESTART': '1', 23:59:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:58 INFO - 'PWD': '/builds/slave/test', 23:59:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:59:58 INFO - 'SHELL': '/bin/bash', 23:59:58 INFO - 'SHLVL': '1', 23:59:58 INFO - 'TERM': 'linux', 23:59:58 INFO - 'TMOUT': '86400', 23:59:58 INFO - 'USER': 'cltbld', 23:59:58 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1458888129.478584-524697437', 23:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:58 INFO - '_': '/tools/buildbot/bin/python'} 23:59:58 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:59:58 INFO - mozversion application_buildid: 20160324223743 23:59:58 INFO - mozversion application_changeset: d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 23:59:58 INFO - mozversion application_display_name: Nightly 23:59:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:59:58 INFO - mozversion application_name: Firefox 23:59:58 INFO - mozversion application_remotingname: firefox 23:59:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:59:58 INFO - mozversion application_vendor: Mozilla 23:59:58 INFO - mozversion application_version: 48.0a1 23:59:58 INFO - mozversion platform_buildid: 20160324223743 23:59:58 INFO - mozversion platform_changeset: d5f3da0cfe7ccf846c354014c9b059fad6ba0de5 23:59:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:59:58 INFO - mozversion platform_version: 48.0a1 23:59:58 INFO - using testdate: 1458889198 23:59:58 INFO - actual date: 1458889198 23:59:58 INFO - starting webserver on 'localhost:40764' 23:59:58 INFO - SUITE-START | Running 2 tests 23:59:58 INFO - TEST-START | dromaeo_css 23:59:58 INFO - operating with platform_type : linux_ 23:59:58 INFO - Initialising browser for dromaeo_css test... 23:59:58 INFO - TEST-INFO | started process 10880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_4VoN/profile http://localhost:40764/getInfo.html) 00:00:04 INFO - PROCESS | 10880 | __metrics Screen width/height:1600/1200 00:00:04 INFO - PROCESS | 10880 | colorDepth:24 00:00:04 INFO - PROCESS | 10880 | Browser inner width/height: 1024/697 00:00:04 INFO - PROCESS | 10880 | __metrics 00:00:05 ERROR - PROCESS | 10880 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:00:06 INFO - TEST-INFO | 10880: exit 0 00:00:06 INFO - Browser initialized. 00:00:06 INFO - Running cycle 1/1 for dromaeo_css test... 00:00:06 INFO - TEST-INFO | started process 10973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD_4VoN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:00:18 INFO - PROCESS | 10973 | RSS: Main: 155332608 00:00:18 INFO - PROCESS | 10973 | 00:01:08 INFO - PROCESS | 10973 | 1458889268907 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] 00:03:20 INFO - PROCESS | 10973 | Cycle 1(1): loaded http://localhost:40764/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40764/tests/dromaeo/cssquery-ext.html) 00:03:21 INFO - PROCESS | 10973 | RSS: Main: 245420032 00:03:21 INFO - PROCESS | 10973 | 00:06:24 INFO - PROCESS | 10973 | Cycle 1(1): loaded http://localhost:40764/tests/dromaeo/cssquery-ext.html (next: http://localhost:40764/tests/dromaeo/cssquery-jquery.html) 00:06:24 INFO - PROCESS | 10973 | RSS: Main: 233144320 00:06:24 INFO - PROCESS | 10973 | 00:09:26 INFO - PROCESS | 10973 | Cycle 1(1): loaded http://localhost:40764/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40764/tests/dromaeo/cssquery-mootools.html) 00:09:27 INFO - PROCESS | 10973 | RSS: Main: 231825408 00:09:27 INFO - PROCESS | 10973 | 00:12:29 INFO - PROCESS | 10973 | Cycle 1(1): loaded http://localhost:40764/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40764/tests/dromaeo/cssquery-prototype.html) 00:12:29 INFO - PROCESS | 10973 | RSS: Main: 211709952 00:12:29 INFO - PROCESS | 10973 | 00:15:32 INFO - PROCESS | 10973 | Cycle 1(1): loaded http://localhost:40764/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40764/tests/dromaeo/cssquery-yui.html) 00:15:33 INFO - PROCESS | 10973 | RSS: Main: 207888384 00:15:33 INFO - PROCESS | 10973 | 00:18:35 INFO - PROCESS | 10973 | Cycle 1(1): loaded http://localhost:40764/tests/dromaeo/cssquery-yui.html (next: http://localhost:40764/tests/dromaeo/cssquery-dojo.html) 00:18:36 INFO - PROCESS | 10973 | RSS: Main: 287653888 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | __start_tp_report 00:18:36 INFO - PROCESS | 10973 | _x_x_mozilla_page_load 00:18:36 INFO - PROCESS | 10973 | _x_x_mozilla_page_load_details 00:18:36 INFO - PROCESS | 10973 | |i|pagename|runs| 00:18:36 INFO - PROCESS | 10973 | |0;dojo.html;2608.152350486092;2687.9462410751785;2692.5422678144714;2708.2146177608506;2727.509048371294;4669.463011753645;4682.742449165303;4710.269908164236;4723.315119307698;4784.856454306377;4649.37233473481;4701.435827700672;4781.7130972141695;4786.760661966897;4796.9280460793025;4279.850205242809;4301.182775272689;4302.956970430287;4350.934735978963;4451.399061126739;4369.366441865927;4413.161499315136;4444.799984000711;4469.061497085616;4469.329600559926;4273.0385663225525;4342.609165175134;4350.934735978963;4355.869323920288;4362.498312694049;4307.741535507848;4346.456692913386;4348.695591308609;4349.043210493686;4354.455693038371;4223.68322375823;4294;4305.784710764449;4307.073979094478;4314.762688052156;4675.088357770236;4676.859694209179;4683.742394168319;4685.789139488731;4754.168020596417;5106.310648062538;5112.3865136183895;5116.897662046738;5128.666636668642;5152.665076770036;4966.850994470172;5107.923381149286;5124.4875512448825;5136.049830781318;5189.766460509286;4666.673332866701;4670.439547254283;4673.088747694167;4710.434747830213;4727.952720472786;5052.898942021213;5104.591632669378;5109.335786347751;5113.335266415343;5138.563222126161;4871.415430148405;4957.876053098701;5001.599872010231;5077.466865979093;5090.41460232078;5046.369203849519;5070.873228169252;5088.465711100355;5094.821681241138;5149.871253218699;5038.219076043146;5052.1663925451885;5053.646244762905;5061.164907790247;5062.316587260746;4900.828471003498;5045.949540504622;5079.390473143247;5116.74416279192;5148.716820574904;4330.761808100585;4356.869293921188;4360.4767427908855;4362.454693163355;4397.538258482878;3745.438184272381;3796.240751849641;3829.4064420014943;3836.175222327213;3869.1101046759404;4333.285007973712;4339.631131353807;4383.3863259143745;4422.20400327944;4430.446194225722;5089.134847076006;5092.465291144376;5124.871878203075;5135.152699804565;5176.611754118456;4315.892102697458;4389.956100439019;4412.779361031936;4414.55854414556;4460.487043989982;4626.976865115653;4657.69724967876;4662.673612847068;4698.083873644675;4711.411073615798;4730.503297153749;4751.263554149113;4756.120117778222;4760.904781904412;4807.759612019455;5025.974870125772;5054.545090941833;5055.039542486916;5073.34046573943;5105.259737337991;4712.858614241578;4736.573708366263;4742.454617718869;4755.476897541337;4792.520747925179;4959.60323174138;4963.503649635008;4967.677100988424;4968.403791545038;5017.4731653175895;4933.6299777516115;5036.471170527042;5046.243063540352;5092.159793634009;5145.485451454824;4913.656044077024;4929.630277729257;4929.728864912464;4930.309756634002;4973.428055773632;4912.484189160086;4924.138275801792;4929.926051109164;4932.852014439429;4984.077945580079;4765.976170119127;4782.545658162469;4813.350197723403;4855.854324370274;4864.73243971585;4961.950380496149;4973.626977976739;4994.350734404504;4997.700137991732;5048.0156369507595;4876.707397556158;4876.853694389174;4886.315915771724;4889.828855990023;4939.135651261086 00:18:36 INFO - PROCESS | 10973 | |1;ext.html;527.3065918317412;533.0458479322014;546.7539607176769;559.8320503848844;559.8964191624548;26945.730542694568;37514.624853751455;38527.42208866866;38551.614483855155;38616.80691596538;42780.35829462561;43316.56683433165;43335.56664433355;43414.348784768255;43415;7654.770356889288;7901.48640338379;7911.248431399008;7912.683492660315;7913.564753938531;7807.063152421689;7928.643211055488;7928.8810667840025;7936.682532698714;7940.40446966477;7880.172581878906;7941.20587941207;7941.880871786928;7960.044794624653;7961.124276329628;7853.136155022971;7930.0880398753725;7935.523868567847;7937.603119843985;7941.6029198539845;7823.178566250519;7943;7947.682092716284;7951.324137448324;7952.045754509438;38200.426993595116;38738.61261387378;38771;38820.611793882264;38850;3131.718145366905;3175.523671449301;3224.2261857154112;3265.9020229393154;3392.3045775616188;28829.27926801847;29792.40415191684;29941.98951521594;29983.250418739488;30776;3427.9828600857086;3462.4113900636953;3482.3383557124066;3558.19940513385;3578.427451607756;244672;247185;247431;247875;248272;45383.31925021127;46259.76870115628;56156.157657635165;56591;56603;44230.33654495185;44275.557244427786;44323.89190270269;44487.55512444834;44500;13540.796888046687;13771.104878182887;13776.793348099787;13783.241921694404;13786.310684465736;11148.888511114785;11329.263597866113;11342.829857552144;11344.602938897264;11345.09239260857;14819.925900370428;14877.619580867009;14902.627434314229;14904.925475372555;15028.173450460112;5609.214709940612;5694.544436445074;5707.143928410772;5834.387389324144;5883.294004719461;872.5375550957875;883.779055236191;897.8787863638325;927.0868194828089;927.8144371125802;26897.596536051973;27555.724442755316;27718.5842212367;27858.721412786017;28054;892.2817132208635;945.5697657565792;963.4171326347599;976.2580438866513;1041.8228901086834;12732.23606583608;13716.725665486634;13756.312184390741;13988.790168147487;14019.088759230617;288266;289670;294052;294573;294770;47700.284495732594;48174.759126204845;48198.9999999993;48201.276980845316;48237.517624824;1029.629333439961;1131.2194585735815;1198.0894520164738;1222.4743360355133;1248.444442223202;23626;24723.232524538176;27210.31974200661;27344.589831152152;27402.862985684944;38209.56113949758;38524;38695.80652096721;38706.22587548177;38728.22543549057;205501;205878;206988;207003;207369;31791.36417271688;31815.363692726478;32767.18082047968;32936.505952411215;32944;41260.58739412687;41269.1746165069;41809.37285940774;42147.15705685808;42210.5778942219;34670;35342;35572.466413004346;35668.46497302595;36133.457998129525;34678.30643387169;35326.64673353233;35415.46876796902;35590.64409355873;35617.64382356247;35602.8219858899;35644.82177589095;35761.821190893876;37666.623333767406;38494.80752596219;28530.85734571314;31100;31126.533102003035;31182.532262015633;31260.687393125776;24487.020519179034;24859.875700621382;24875.378115546533;25187.622185667595;25213.747862521876 00:18:36 INFO - PROCESS | 10973 | |2;jquery.html;355.37808834539555;359.8524604911985;360.60513737457484;366.88993302009425;370.7460389633101;15509.612259693498;15548.84451155488;16231.26959286832;16400.589985250375;16458.177091145455;14868.553943381688;15162.924185379085;15528;15560.610984725388;15602.531924042269;4988.600911927056;5077.492250774912;5125.897482050356;5137.871553211162;5145.614078944075;4958.851234462972;5067.6452648314635;5085.974570127144;5095.566876815476;5115.232715092748;5062.367204099488;5066.847994560169;5074.441811400743;5079.644424890259;5080.034793389263;6367.6816159192085;6615.371539703745;6640.93359066408;6658.966705166443;6669.566478178903;6339.556231063827;6342.968285158545;6361.9045714314325;6381.904271435886;6432.131662225586;21909.123635054577;22184.889075554518;22483.662745058675;22499;22970.196043138578;2102.6425507663735;2111.7782632823487;2145.6996020557135;2194.659827726689;2198.934031979043;13901.58295251144;13915;13934.860651393457;13949;14545.49090781828;1840.6778813707547;1889.9905500472546;1901.7052356884706;1973.319204874316;1981.5343394302472;64860.571302966724;66204.66897665529;67544.32455675479;69096.65451672759;69274.30725692779;14588.772521963694;14824.777628335583;15015.324310406058;15040.62398440026;15079.321430535652;25232.243032709048;25475;25606.231813045637;25650;25710;8290.502569845828;8413.15868413166;8496.150384961455;8577.828443431097;8839.911600884037;7043.366097051187;7102.041224434738;7253.782386528413;7282.781516554512;7397.26027397256;7484.663190156456;7540.736074237376;7637.312641862259;7652.69389224436;7658.195889431529;2918.1829087855435;3053.5267033609825;3064.1726733782198;3092.9845350773103;3159.3681263747344;770.2374649097466;830.2030051150842;875.8160786234962;917.8256131335025;950.9809803803885;15220.695586088437;15824.208789560476;16169.353225870833;16260.918695406684;16559.6688066238;823.9258466738022;859.6819176904461;872.882160908282;898.2140626951417;926.5830376330678;9067.863982040275;9311.90688093124;10016.549255283384;10326.81241657204;10345.224108191916;431821;443253;444768;453183;459500.7024964854;70459;71149;71200;71977.6401117991;73868.63065684745;990.9405435673883;996.0587245053355;1008.6923488335981;1022.8772547294373;1023.1558963854701;12333.93833030829;14074.577762667137;15386.769198462256;15430.768538471708;15813.604659883595;32247.516287256178;34100.488492672135;35304.64695353014;35416.29167416689;37270.62729372671;41759.791201045016;41873.37189942093;41975.370369443874;42401.36397953972;42508;7455.366293864865;7621.466497345133;7842.50992311459;7887.250711182429;7915.485493442908;9472.479013654316;11860.40697965081;11866.584669536525;12025;12054;9947.751306217402;10193.286469947032;10457.790844183226;10477.266591338837;10577.524011419351;4934.210526315772;9256.49089300068;9686.273529485175;10289.176865850564;10309.690709278733;9925.3548519346;10175.49122543855;10273.486325683536;10364.792704145724;10428.947855260978;7318.085239345082;7444.441666875115;7564.773056808304;7574.394048476219;7718.343940765098;8002.679892804223;9247.72256832296;10535.157187424835;10675;10683.626073087406 00:18:36 INFO - PROCESS | 10973 | |3;mootools.html;1451.4121780678825;1452.295636616241;1625.6504851456934;1745;1802.8197180281973;7536.81157971051;7674.923250767491;7717.614119294034;7724.073111226647;7726.111497177812;6588.37410446008;6719.462443004561;6728;7414.480986330959;7587.051618547682;2215.5679642469727;2258.2660635293514;2259.1754009786473;2259.423846919033;2261.231181398324;2214.424249695083;2217.090992692996;2275.920342788003;2279.943001424969;2281.315605318406;1934.4970307720023;2205.7683943185975;2215.3907675389237;2268.262814585258;2273.3407311879537;2186.387811412791;2198.0987795004053;2239.115549358011;2239.652853807654;2241.977580224201;2152.9031193596325;2154.9784502154935;2157.169489746443;2160.2763074370105;2161.3623980925663;7415.88876166858;7481.102267727853;7481.513701609378;7484.887726684104;7496.887546686804;4692.8122875084955;4805.927911081337;4825.662203645747;4832.154372984749;4833.275008748716;3024.7126522980284;3064.233941514621;3151.952720709191;3240.2223466368137;3256.478963365874;1072.7532667486444;1082.6373164989739;1783.9910800446044;1828.3783513605306;1830.6247219320142;10394.272400931937;10484.266101372907;10499.632512862014;10509.264351495398;10524.631637892713;4044.5550989391145;4143.233501802116;4222.282212023963;4226.239276930182;4228.365745138254;8326.250637442537;8345.332373410112;8371.246587807127;8375.748727538183;8378.49729016261;4631.95368046322;4670.136024835417;4676.275177347517;4676.485586585472;4677.602403795648;3794.905127371838;4097.098638299629;4170.103427763045;4294.57054294568;4303.139372125587;3433.6909678129086;3494.1264683829045;3500.1599616091953;3522.8238588070494;3542.1321776165005;1022.2435397805571;1077.6766969908997;1078.9190810689229;1086.603389762731;1092.5629748100823;1216.5255550335376;1222.773786849418;1244.440001999104;1245.9875401246052;1250.224860586424;7292.3801476874;7310.086239220098;7322.1579518355;7415.25847415265;7465.216152304039;478.38049725605424;479.1686424054263;484.4211167654689;492.1706923833352;494.0884068892887;5620.466055724782;5723.856903577361;5740.655560666373;5748.252727145528;5781.19063331134;9036.548172591343;9114.13415725505;9159.954200228956;9282.071792820663;9290.953545232365;9100.681476148304;9141.862872056925;9146.314026448043;9188.8621670675;9199.724008279762;7174.820629484305;7277.963610181915;7298.4891057625455;7350.7427240046345;7374.668139933716;7348.412127029718;7376.96311518439;7390.29792169743;7394.408447324094;7413.443991700752;8351.1648835116;8368.41421100517;8603.52680602573;8702.216800487986;8730.869036964323;8579.65681372738;8787.780305492413;8959.73120806377;8970.282377409922;8974.102589741235;6096.847578810388;6469.061986011908;6607.669616519251;6919.965400173169;7031.578105313698;7179.569225846466;7183.03029091066;7201.207867134715;7208.098987626547;7219.205887352282;6350.142730731292;6409.615423074631;6452.677366131768;6678.49911256648;6770.52606317553;6356.77751278703;6370.735307317223;6456.644884531208;6526.641034743135;6573.5398522103;6892.586444813327;6911.067005954132;6917.308269173042;6957.756478523227;6964.338387853146;6054.3642917493025;6091.664958427152;6126.5098792097415;6128.754849805958;6179.721912513858;6407.551471396958;6423.389777971085;6459.354064593691;6485.837854053686;6506.544541882023 00:18:36 INFO - PROCESS | 10973 | |4;prototype.html;321.23866436545393;324.1879092872354;324.5067497403946;326.4091993491781;331.58055060348664;5357.169638705997;5381.273528073709;5385.784568617256;5397.62216644834;5407.405185429599;5277.577793776489;5287.127623942045;5305.4164041955355;5309.469053094698;5357.946420535794;3994.8002599870038;4104.835806567734;4179.582041795811;4209.305464598346;4217.936730949023;4184.497860256758;4198.8530401435955;4205.243056249874;4206.663466922654;4213.978930105345;4153.584641535837;4157.376393540978;4163.479565054368;4168.812403441837;4176.728512646683;3972.443857859902;4077.490313710801;4178.310578754502;4182.079942412664;4182.456280683492;3687.4100143976834;3688.889333320005;3693.9445908311395;3699.6300369963055;3709.109813644706;5142.408623008365;5161.251618515332;5170.405403378584;5173.249878767558;5174.2238664200295;4863.124637565237;4867.82962596311;4868.172410690156;4872.366592342973;4878.317035614981;5688.118341657008;5688.260526131618;5698.51562617178;5704.77180912763;5708.20085188074;3990.182012687392;4086.734362266443;4087.1825634873144;4088.407180958774;4100.487439070116;5879.823605291848;5988.700564971734;5993.280806303228;6000.549958753111;6002.669853158074;4175.31107367287;4205.137946720914;4205.747655140702;4205.747655140702;4206.8737937861915;4257.425247591597;4259.87220383389;4265.104328091135;4272.060146767706;4274.059706864547;4841.878953026132;4847.079054979543;4849.151398505247;4860.756962151878;4861.1979023460735;5704.286964129484;5711.971440142773;5718.599698021182;5720.685362305113;5721.656700597978;1396.7555677756352;1468.3172324868988;1507.1333982959843;1508.4192585854526;1516.2418790604697;908.2280061947424;947.9573419196153;950.933434659581;966.8349638685368;970.1656575345197;4953.578945789576;4981.028699403581;4996.775145118406;5006.274090256892;5007.749612519359;5904.793332233351;5937.554683398676;5980.252468441445;5983.401659833982;5989.880202395928;4970.72661003641;4995.325631039763;4997.575206107522;5005.074061298671;5005.224190250517;3135.059482155344;3170.1757543038975;3175.714185723296;3179.5071763876635;3179.8410079495934;5491.752871120809;5494.708743445287;5507.669539827623;5509.118541033416;5511.3937466878615;5824.417558244227;6078.179445774852;6120.938790612036;6139.508839292846;6143.508519318444;5535.6955367455175;5563.666180029211;5575.66546007249;5578.330600327824;5582.7766889324785;5962.761489540543;5974.492168165581;5977.073553599199;5981.192539007178;5984.730687119003;5799.8550036249435;5835.416458354131;5858.765649373977;5873.4126587342635;5904.793332233351;5349.839504814861;5566.192902029264;5567.137093750475;5574.247476590608;5577.581681373832;4033.596640335943;4051.230266249403;4062.3297155970117;4069.6744260459686;4081.775502347399;5929.229200203946;5954.821355359346;5963.940360596339;5964.224650795369;5970.76116955317;5748;5748.166515855261;5751.4536119068625;5759.424057594207;5763.394843541368;5689.146628005832;5707.258056452634;5736.770529178786;5751.683657398883;5753;5451.64564303319;5647.943520564741;5660.603757736919;5660.943390566206;5662.386219927301;5770.798022069207;5800.709964501673;5809.070548712186;5811.476967072984;5826.82519524415;5647.435256474319;5649.943500565106;5665.575081868794;5668.404817494269;5671.546276297804 00:18:36 INFO - PROCESS | 10973 | |5;yui.html;679.5005670831938;756.1191212237743;784.9843003139936;788.3771820261993;797.3621103117505;11182.105431565466;11263.66209013731;11309.09527237821;11310.434478276084;11345.716357091067;12244.755104897897;12271.141020128594;12300.938495307533;12309.75380492392;12311.445984930677;641.5541198866789;799.1010113622146;813.9145389734052;815.4740192575786;817.7628487738549;802.626778547975;807.2774866494514;808.995955020227;810.9229623185818;812.3704129299781;859.4456575508824;861.8793368928355;866.2982983783156;867.371155911962;868.4832524647825;858.5664239559045;860.561113831944;861.3238607692994;862.3963225742006;863.317978796753;627.7426255235378;628.2492421556242;631.6557476175495;633.2812258087058;634.109076747171;13038.80441793374;13052.151610145405;13128.212307261594;13142.342882855915;13147;12337.568185113567;12728.681782955407;13097.279649619268;13176.077674562785;13222.801657975042;9473;9594.856077158849;9667.178289845371;9672;9763.072508111718;3270.493073573576;3285.8849940252217;3344.0469466202258;3371.123507887942;3427.503012063237;37585.62414375876;40855.7957210215;42505.78747106276;42765.78617106926;43171.92070198239;10304.742381440525;10356.792864142675;10402.47987600617;10426.426546540013;10683.091937185427;15218.695626087416;15220.847791522165;15335.386584536716;15401.691966160839;15406.152661603495;6990.510664253555;7055.6472176392;7084.964575177091;7204.92795072053;7283;3676.742628016013;3749.5875453700073;3761.7742935423416;3767.698584113264;3854.9229015419533;2774.1122840690787;2783.4572258409416;2812.9859350703114;2821.76015038724;2822.5625028120676;520.885405210853;531.3411369901372;537.5672583570264;537.9139337705948;541.5856869494839;564.1988376505373;595.6098755315276;609.6068036116679;628.9685515724195;655.4952686431421;8038.67845286182;8269.875951860728;8620.698275560326;8690.435121717068;8920.464772113693;552.6739223857943;595.4283887467992;643.8068579426154;659.1891972873393;665.9267480577132;3749.4750734897134;3802.2927645545374;3871.845126194921;3927.6072392760493;3951.3282741933367;47782;52578.211326830125;53628.46371536313;53663.463365365846;53684.46315536794;43044.78477607592;43594.346084808756;43760;43797.562024379986;44159.55840441555;39393.40909886354;40207.19585608271;40261.59738402579;40554.79722601427;40559.39160912589;8621.655133794578;8625.91374086251;8733.694320699;8759.605817738344;8871.778205544913;31725.889593864104;31967.520487192247;32259.838700806347;32302.35395292128;32338.83830580832;37644;38702.6129738699;39230.411543826296;39870.80064599658;40593.1881362377;10868.565257389615;10933.180011499011;10992.725181870517;11129.220954533104;11535;11828.881711182778;12016.75966480683;12072.517099315928;12681.365931703194;12797.36013199355;11048.558057677603;11431.314121152758;11491.195616306779;11777.52889884395;11965.641030769091;11093.833592496281;11128.165387596124;11168.21822472419;11498.54005839757;11515.25150865191;10836.403997780199;10996.12031037499;11059.50232239535;11490.138239632228;11527.596534121265;8471.195236452773;8477.544036436517;8703.782405439915;8738.169559245849;9185.678501252423;8198.877016844872;8914;9094.727158185266;9245.537723113952;9301.627934882528 00:18:36 INFO - PROCESS | 10973 | __end_tp_report 00:18:36 INFO - PROCESS | 10973 | __start_cc_report 00:18:36 INFO - PROCESS | 10973 | _x_x_mozilla_cycle_collect,942 00:18:36 INFO - PROCESS | 10973 | __end_cc_report 00:18:36 INFO - PROCESS | 10973 | __startTimestamp1458890316035__endTimestamp 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | ------- Summary: start ------- 00:18:36 INFO - PROCESS | 10973 | Number of tests: 6 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | [#0] dojo.html Cycles:165 Average:4688.69 Median:4784.86 stddev:481.52 (10.1%) stddev-sans-first:454.50 00:18:36 INFO - PROCESS | 10973 | Values: 2608.2 2687.9 2692.5 2708.2 2727.5 4669.5 4682.7 4710.3 4723.3 4784.9 4649.4 4701.4 4781.7 4786.8 4796.9 4279.9 4301.2 4303.0 4350.9 4451.4 4369.4 4413.2 4444.8 4469.1 4469.3 4273.0 4342.6 4350.9 4355.9 4362.5 4307.7 4346.5 4348.7 4349.0 4354.5 4223.7 4294.0 4305.8 4307.1 4314.8 4675.1 4676.9 4683.7 4685.8 4754.2 5106.3 5112.4 5116.9 5128.7 5152.7 4966.9 5107.9 5124.5 5136.0 5189.8 4666.7 4670.4 4673.1 4710.4 4728.0 5052.9 5104.6 5109.3 5113.3 5138.6 4871.4 4957.9 5001.6 5077.5 5090.4 5046.4 5070.9 5088.5 5094.8 5149.9 5038.2 5052.2 5053.6 5061.2 5062.3 4900.8 5045.9 5079.4 5116.7 5148.7 4330.8 4356.9 4360.5 4362.5 4397.5 3745.4 3796.2 3829.4 3836.2 3869.1 4333.3 4339.6 4383.4 4422.2 4430.4 5089.1 5092.5 5124.9 5135.2 5176.6 4315.9 4390.0 4412.8 4414.6 4460.5 4627.0 4657.7 4662.7 4698.1 4711.4 4730.5 4751.3 4756.1 4760.9 4807.8 5026.0 5054.5 5055.0 5073.3 5105.3 4712.9 4736.6 4742.5 4755.5 4792.5 4959.6 4963.5 4967.7 4968.4 5017.5 4933.6 5036.5 5046.2 5092.2 5145.5 4913.7 4929.6 4929.7 4930.3 4973.4 4912.5 4924.1 4929.9 4932.9 4984.1 4766.0 4782.5 4813.4 4855.9 4864.7 4962.0 4973.6 4994.4 4997.7 5048.0 4876.7 4876.9 4886.3 4889.8 4939.1 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | [#1] ext.html Cycles:180 Average:41028.50 Median:35656.64 stddev:65457.49 (183.6%) stddev-sans-first:65570.47 00:18:36 INFO - PROCESS | 10973 | Values: 527.3 533.0 546.8 559.8 559.9 26945.7 37514.6 38527.4 38551.6 38616.8 42780.4 43316.6 43335.6 43414.3 43415.0 7654.8 7901.5 7911.2 7912.7 7913.6 7807.1 7928.6 7928.9 7936.7 7940.4 7880.2 7941.2 7941.9 7960.0 7961.1 7853.1 7930.1 7935.5 7937.6 7941.6 7823.2 7943.0 7947.7 7951.3 7952.0 38200.4 38738.6 38771.0 38820.6 38850.0 3131.7 3175.5 3224.2 3265.9 3392.3 28829.3 29792.4 29942.0 29983.3 30776.0 3428.0 3462.4 3482.3 3558.2 3578.4 244672.0 247185.0 247431.0 247875.0 248272.0 45383.3 46259.8 56156.2 56591.0 56603.0 44230.3 44275.6 44323.9 44487.6 44500.0 13540.8 13771.1 13776.8 13783.2 13786.3 11148.9 11329.3 11342.8 11344.6 11345.1 14819.9 14877.6 14902.6 14904.9 15028.2 5609.2 5694.5 5707.1 5834.4 5883.3 872.5 883.8 897.9 927.1 927.8 26897.6 27555.7 27718.6 27858.7 28054.0 892.3 945.6 963.4 976.3 1041.8 12732.2 13716.7 13756.3 13988.8 14019.1 288266.0 289670.0 294052.0 294573.0 294770.0 47700.3 48174.8 48199.0 48201.3 48237.5 1029.6 1131.2 1198.1 1222.5 1248.4 23626.0 24723.2 27210.3 27344.6 27402.9 38209.6 38524.0 38695.8 38706.2 38728.2 205501.0 205878.0 206988.0 207003.0 207369.0 31791.4 31815.4 32767.2 32936.5 32944.0 41260.6 41269.2 41809.4 42147.2 42210.6 34670.0 35342.0 35572.5 35668.5 36133.5 34678.3 35326.6 35415.5 35590.6 35617.6 35602.8 35644.8 35761.8 37666.6 38494.8 28530.9 31100.0 31126.5 31182.5 31260.7 24487.0 24859.9 24875.4 25187.6 25213.7 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | [#2] jquery.html Cycles:180 Average:26085.91 Median:42188.37 stddev:73096.28 (173.3%) stddev-sans-first:73275.80 00:18:36 INFO - PROCESS | 10973 | Values: 355.4 359.9 360.6 366.9 370.7 15509.6 15548.8 16231.3 16400.6 16458.2 14868.6 15162.9 15528.0 15560.6 15602.5 4988.6 5077.5 5125.9 5137.9 5145.6 4958.9 5067.6 5086.0 5095.6 5115.2 5062.4 5066.8 5074.4 5079.6 5080.0 6367.7 6615.4 6640.9 6659.0 6669.6 6339.6 6343.0 6361.9 6381.9 6432.1 21909.1 22184.9 22483.7 22499.0 22970.2 2102.6 2111.8 2145.7 2194.7 2198.9 13901.6 13915.0 13934.9 13949.0 14545.5 1840.7 1890.0 1901.7 1973.3 1981.5 64860.6 66204.7 67544.3 69096.7 69274.3 14588.8 14824.8 15015.3 15040.6 15079.3 25232.2 25475.0 25606.2 25650.0 25710.0 8290.5 8413.2 8496.2 8577.8 8839.9 7043.4 7102.0 7253.8 7282.8 7397.3 7484.7 7540.7 7637.3 7652.7 7658.2 2918.2 3053.5 3064.2 3093.0 3159.4 770.2 830.2 875.8 917.8 951.0 15220.7 15824.2 16169.4 16260.9 16559.7 823.9 859.7 872.9 898.2 926.6 9067.9 9311.9 10016.5 10326.8 10345.2 431821.0 443253.0 444768.0 453183.0 459500.7 70459.0 71149.0 71200.0 71977.6 73868.6 990.9 996.1 1008.7 1022.9 1023.2 12333.9 14074.6 15386.8 15430.8 15813.6 32247.5 34100.5 35304.6 35416.3 37270.6 41759.8 41873.4 41975.4 42401.4 42508.0 7455.4 7621.5 7842.5 7887.3 7915.5 9472.5 11860.4 11866.6 12025.0 12054.0 9947.8 10193.3 10457.8 10477.3 10577.5 4934.2 9256.5 9686.3 10289.2 10309.7 9925.4 10175.5 10273.5 10364.8 10428.9 7318.1 7444.4 7564.8 7574.4 7718.3 8002.7 9247.7 10535.2 10675.0 10683.6 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | [#3] mootools.html Cycles:180 Average:5339.41 Median:6073.01 stddev:2761.79 (45.5%) stddev-sans-first:2754.07 00:18:36 INFO - PROCESS | 10973 | Values: 1451.4 1452.3 1625.7 1745.0 1802.8 7536.8 7674.9 7717.6 7724.1 7726.1 6588.4 6719.5 6728.0 7414.5 7587.1 2215.6 2258.3 2259.2 2259.4 2261.2 2214.4 2217.1 2275.9 2279.9 2281.3 1934.5 2205.8 2215.4 2268.3 2273.3 2186.4 2198.1 2239.1 2239.7 2242.0 2152.9 2155.0 2157.2 2160.3 2161.4 7415.9 7481.1 7481.5 7484.9 7496.9 4692.8 4805.9 4825.7 4832.2 4833.3 3024.7 3064.2 3152.0 3240.2 3256.5 1072.8 1082.6 1784.0 1828.4 1830.6 10394.3 10484.3 10499.6 10509.3 10524.6 4044.6 4143.2 4222.3 4226.2 4228.4 8326.3 8345.3 8371.2 8375.7 8378.5 4632.0 4670.1 4676.3 4676.5 4677.6 3794.9 4097.1 4170.1 4294.6 4303.1 3433.7 3494.1 3500.2 3522.8 3542.1 1022.2 1077.7 1078.9 1086.6 1092.6 1216.5 1222.8 1244.4 1246.0 1250.2 7292.4 7310.1 7322.2 7415.3 7465.2 478.4 479.2 484.4 492.2 494.1 5620.5 5723.9 5740.7 5748.3 5781.2 9036.5 9114.1 9160.0 9282.1 9291.0 9100.7 9141.9 9146.3 9188.9 9199.7 7174.8 7278.0 7298.5 7350.7 7374.7 7348.4 7377.0 7390.3 7394.4 7413.4 8351.2 8368.4 8603.5 8702.2 8730.9 8579.7 8787.8 8959.7 8970.3 8974.1 6096.8 6469.1 6607.7 6920.0 7031.6 7179.6 7183.0 7201.2 7208.1 7219.2 6350.1 6409.6 6452.7 6678.5 6770.5 6356.8 6370.7 6456.6 6526.6 6573.5 6892.6 6911.1 6917.3 6957.8 6964.3 6054.4 6091.7 6126.5 6128.8 6179.7 6407.6 6423.4 6459.4 6485.8 6506.5 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | [#4] prototype.html Cycles:180 Average:4743.23 Median:5357.56 stddev:1393.19 (26.0%) stddev-sans-first:1356.98 00:18:36 INFO - PROCESS | 10973 | Values: 321.2 324.2 324.5 326.4 331.6 5357.2 5381.3 5385.8 5397.6 5407.4 5277.6 5287.1 5305.4 5309.5 5357.9 3994.8 4104.8 4179.6 4209.3 4217.9 4184.5 4198.9 4205.2 4206.7 4214.0 4153.6 4157.4 4163.5 4168.8 4176.7 3972.4 4077.5 4178.3 4182.1 4182.5 3687.4 3688.9 3693.9 3699.6 3709.1 5142.4 5161.3 5170.4 5173.2 5174.2 4863.1 4867.8 4868.2 4872.4 4878.3 5688.1 5688.3 5698.5 5704.8 5708.2 3990.2 4086.7 4087.2 4088.4 4100.5 5879.8 5988.7 5993.3 6000.5 6002.7 4175.3 4205.1 4205.7 4205.7 4206.9 4257.4 4259.9 4265.1 4272.1 4274.1 4841.9 4847.1 4849.2 4860.8 4861.2 5704.3 5712.0 5718.6 5720.7 5721.7 1396.8 1468.3 1507.1 1508.4 1516.2 908.2 948.0 950.9 966.8 970.2 4953.6 4981.0 4996.8 5006.3 5007.7 5904.8 5937.6 5980.3 5983.4 5989.9 4970.7 4995.3 4997.6 5005.1 5005.2 3135.1 3170.2 3175.7 3179.5 3179.8 5491.8 5494.7 5507.7 5509.1 5511.4 5824.4 6078.2 6120.9 6139.5 6143.5 5535.7 5563.7 5575.7 5578.3 5582.8 5962.8 5974.5 5977.1 5981.2 5984.7 5799.9 5835.4 5858.8 5873.4 5904.8 5349.8 5566.2 5567.1 5574.2 5577.6 4033.6 4051.2 4062.3 4069.7 4081.8 5929.2 5954.8 5963.9 5964.2 5970.8 5748.0 5748.2 5751.5 5759.4 5763.4 5689.1 5707.3 5736.8 5751.7 5753.0 5451.6 5647.9 5660.6 5660.9 5662.4 5770.8 5800.7 5809.1 5811.5 5826.8 5647.4 5649.9 5665.6 5668.4 5671.5 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - PROCESS | 10973 | [#5] yui.html Cycles:180 Average:12595.62 Median:40724.49 stddev:13939.67 (34.2%) stddev-sans-first:13950.05 00:18:36 INFO - PROCESS | 10973 | Values: 679.5 756.1 785.0 788.4 797.4 11182.1 11263.7 11309.1 11310.4 11345.7 12244.8 12271.1 12300.9 12309.8 12311.4 641.6 799.1 813.9 815.5 817.8 802.6 807.3 809.0 810.9 812.4 859.4 861.9 866.3 867.4 868.5 858.6 860.6 861.3 862.4 863.3 627.7 628.2 631.7 633.3 634.1 13038.8 13052.2 13128.2 13142.3 13147.0 12337.6 12728.7 13097.3 13176.1 13222.8 9473.0 9594.9 9667.2 9672.0 9763.1 3270.5 3285.9 3344.0 3371.1 3427.5 37585.6 40855.8 42505.8 42765.8 43171.9 10304.7 10356.8 10402.5 10426.4 10683.1 15218.7 15220.8 15335.4 15401.7 15406.2 6990.5 7055.6 7085.0 7204.9 7283.0 3676.7 3749.6 3761.8 3767.7 3854.9 2774.1 2783.5 2813.0 2821.8 2822.6 520.9 531.3 537.6 537.9 541.6 564.2 595.6 609.6 629.0 655.5 8038.7 8269.9 8620.7 8690.4 8920.5 552.7 595.4 643.8 659.2 665.9 3749.5 3802.3 3871.8 3927.6 3951.3 47782.0 52578.2 53628.5 53663.5 53684.5 43044.8 43594.3 43760.0 43797.6 44159.6 39393.4 40207.2 40261.6 40554.8 40559.4 8621.7 8625.9 8733.7 8759.6 8871.8 31725.9 31967.5 32259.8 32302.4 32338.8 37644.0 38702.6 39230.4 39870.8 40593.2 10868.6 10933.2 10992.7 11129.2 11535.0 11828.9 12016.8 12072.5 12681.4 12797.4 11048.6 11431.3 11491.2 11777.5 11965.6 11093.8 11128.2 11168.2 11498.5 11515.3 10836.4 10996.1 11059.5 11490.1 11527.6 8471.2 8477.5 8703.8 8738.2 9185.7 8198.9 8914.0 9094.7 9245.5 9301.6 00:18:36 INFO - PROCESS | 10973 | -------- Summary: end -------- 00:18:36 INFO - PROCESS | 10973 | 00:18:36 INFO - TEST-INFO | 10973: exit 0 00:18:36 INFO - TEST-OK | dromaeo_css | took 1117991ms 00:18:36 INFO - TEST-START | kraken 00:18:36 INFO - operating with platform_type : linux_ 00:18:36 INFO - Initialising browser for kraken test... 00:18:36 INFO - TEST-INFO | started process 11157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn_A0us/profile http://localhost:40764/getInfo.html) 00:18:41 INFO - PROCESS | 11157 | __metrics Screen width/height:1600/1200 00:18:41 INFO - PROCESS | 11157 | colorDepth:24 00:18:41 INFO - PROCESS | 11157 | Browser inner width/height: 1024/697 00:18:41 INFO - PROCESS | 11157 | __metrics 00:18:42 ERROR - PROCESS | 11157 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:18:42 INFO - PROCESS | 11157 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 00:18:43 INFO - TEST-INFO | 11157: exit 0 00:18:43 INFO - Browser initialized. 00:18:43 INFO - Running cycle 1/1 for kraken test... 00:18:43 INFO - TEST-INFO | started process 11240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn_A0us/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:18:55 INFO - PROCESS | 11240 | RSS: Main: 154685440 00:18:55 INFO - PROCESS | 11240 | 00:18:58 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40764/tests/kraken/driver.html?testName=audio-beat-detection) 00:18:58 INFO - PROCESS | 11240 | RSS: Main: 195051520 00:18:58 INFO - PROCESS | 11240 | 00:19:01 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40764/tests/kraken/driver.html?testName=audio-dft) 00:19:02 INFO - PROCESS | 11240 | RSS: Main: 186318848 00:19:02 INFO - PROCESS | 11240 | 00:19:05 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40764/tests/kraken/driver.html?testName=audio-fft) 00:19:05 INFO - PROCESS | 11240 | RSS: Main: 172195840 00:19:05 INFO - PROCESS | 11240 | 00:19:07 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40764/tests/kraken/driver.html?testName=audio-oscillator) 00:19:08 INFO - PROCESS | 11240 | RSS: Main: 172576768 00:19:08 INFO - PROCESS | 11240 | 00:19:10 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40764/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:19:11 INFO - PROCESS | 11240 | RSS: Main: 173539328 00:19:11 INFO - PROCESS | 11240 | 00:19:14 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40764/tests/kraken/driver.html?testName=imaging-darkroom) 00:19:15 INFO - PROCESS | 11240 | RSS: Main: 174063616 00:19:15 INFO - PROCESS | 11240 | 00:19:18 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40764/tests/kraken/driver.html?testName=imaging-desaturate) 00:19:19 INFO - PROCESS | 11240 | RSS: Main: 171999232 00:19:19 INFO - PROCESS | 11240 | 00:19:22 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40764/tests/kraken/driver.html?testName=json-parse-financial) 00:19:22 INFO - PROCESS | 11240 | RSS: Main: 172744704 00:19:22 INFO - PROCESS | 11240 | 00:19:24 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40764/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:19:24 INFO - PROCESS | 11240 | RSS: Main: 186085376 00:19:24 INFO - PROCESS | 11240 | 00:19:26 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:19:27 INFO - PROCESS | 11240 | RSS: Main: 184926208 00:19:27 INFO - PROCESS | 11240 | 00:19:29 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:19:29 INFO - PROCESS | 11240 | RSS: Main: 195821568 00:19:29 INFO - PROCESS | 11240 | 00:19:32 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:19:33 INFO - PROCESS | 11240 | RSS: Main: 203616256 00:19:33 INFO - PROCESS | 11240 | 00:19:35 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:19:36 INFO - PROCESS | 11240 | RSS: Main: 202006528 00:19:36 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | Cycle 1(1): loaded http://localhost:40764/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40764/tests/kraken/driver.html?testName=ai-astar) 00:19:38 INFO - PROCESS | 11240 | RSS: Main: 263413760 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | __start_tp_report 00:19:38 INFO - PROCESS | 11240 | _x_x_mozilla_page_load 00:19:38 INFO - PROCESS | 11240 | _x_x_mozilla_page_load_details 00:19:38 INFO - PROCESS | 11240 | |i|pagename|runs| 00:19:38 INFO - PROCESS | 11240 | |0;ai-astar;111;112;108;111;111;111;100;112;110;112 00:19:38 INFO - PROCESS | 11240 | |1;audio-beat-detection;159;131;158;184;141;168;162;132;177;133 00:19:38 INFO - PROCESS | 11240 | |2;audio-dft;162;161;162;161;161;161;162;160;161;162 00:19:38 INFO - PROCESS | 11240 | |3;audio-fft;78;74;126;101;74;74;77;114;95;74 00:19:38 INFO - PROCESS | 11240 | |4;audio-oscillator;93;95;142;94;94;94;141;94;94;138 00:19:38 INFO - PROCESS | 11240 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;116 00:19:38 INFO - PROCESS | 11240 | |6;imaging-darkroom;147;147;147;147;147;145;146;146;146;145 00:19:38 INFO - PROCESS | 11240 | |7;imaging-desaturate;96;95;96;96;96;95;95;95;96;95 00:19:38 INFO - PROCESS | 11240 | |8;json-parse-financial;63;65;65;64;65;63;63;78;62;61 00:19:38 INFO - PROCESS | 11240 | |9;json-stringify-tinderbox;64;65;65;64;65;64;64;65;64;65 00:19:38 INFO - PROCESS | 11240 | |10;stanford-crypto-aes;82;80;82;82;83;83;82;82;81;82 00:19:38 INFO - PROCESS | 11240 | |11;stanford-crypto-ccm;123;119;115;122;125;116;124;116;117;120 00:19:38 INFO - PROCESS | 11240 | |12;stanford-crypto-pbkdf2;146;143;141;142;135;129;141;142;142;140 00:19:38 INFO - PROCESS | 11240 | |13;stanford-crypto-sha256-iterative;65;66;66;66;66;65;70;66;67;68 00:19:38 INFO - PROCESS | 11240 | __end_tp_report 00:19:38 INFO - PROCESS | 11240 | __start_cc_report 00:19:38 INFO - PROCESS | 11240 | _x_x_mozilla_cycle_collect,1156 00:19:38 INFO - PROCESS | 11240 | __end_cc_report 00:19:38 INFO - PROCESS | 11240 | __startTimestamp1458890378270__endTimestamp 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | ------- Summary: start ------- 00:19:38 INFO - PROCESS | 11240 | Number of tests: 14 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:3.84 00:19:38 INFO - PROCESS | 11240 | Values: 111.0 112.0 108.0 111.0 111.0 111.0 100.0 112.0 110.0 112.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:160.50 stddev:19.29 (12.0%) stddev-sans-first:20.40 00:19:38 INFO - PROCESS | 11240 | Values: 159.0 131.0 158.0 184.0 141.0 168.0 162.0 132.0 177.0 133.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 00:19:38 INFO - PROCESS | 11240 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 162.0 160.0 161.0 162.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#3] audio-fft Cycles:10 Average:88.70 Median:74.00 stddev:19.26 (26.0%) stddev-sans-first:20.03 00:19:38 INFO - PROCESS | 11240 | Values: 78.0 74.0 126.0 101.0 74.0 74.0 77.0 114.0 95.0 74.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:22.41 (23.8%) stddev-sans-first:23.11 00:19:38 INFO - PROCESS | 11240 | Values: 93.0 95.0 142.0 94.0 94.0 94.0 141.0 94.0 94.0 138.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 00:19:38 INFO - PROCESS | 11240 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 00:19:38 INFO - PROCESS | 11240 | Values: 147.0 147.0 147.0 147.0 147.0 145.0 146.0 146.0 146.0 145.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 00:19:38 INFO - PROCESS | 11240 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:4.79 (7.4%) stddev-sans-first:5.04 00:19:38 INFO - PROCESS | 11240 | Values: 63.0 65.0 65.0 64.0 65.0 63.0 63.0 78.0 62.0 61.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 00:19:38 INFO - PROCESS | 11240 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 65.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 00:19:38 INFO - PROCESS | 11240 | Values: 82.0 80.0 82.0 82.0 83.0 83.0 82.0 82.0 81.0 82.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:121.00 stddev:3.65 (3.0%) stddev-sans-first:3.67 00:19:38 INFO - PROCESS | 11240 | Values: 123.0 119.0 115.0 122.0 125.0 116.0 124.0 116.0 117.0 120.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:142.00 stddev:4.77 (3.4%) stddev-sans-first:4.56 00:19:38 INFO - PROCESS | 11240 | Values: 146.0 143.0 141.0 142.0 135.0 129.0 141.0 142.0 142.0 140.0 00:19:38 INFO - PROCESS | 11240 | 00:19:38 INFO - PROCESS | 11240 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:1.50 00:19:38 INFO - PROCESS | 11240 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 70.0 66.0 67.0 68.0 00:19:38 INFO - PROCESS | 11240 | -------- Summary: end -------- 00:19:38 INFO - PROCESS | 11240 | 00:19:39 INFO - TEST-INFO | 11240: exit 0 00:19:39 INFO - TEST-OK | kraken | took 62385ms 00:19:39 INFO - SUITE-END | took 1180s 00:19:39 INFO - Completed test suite (00:19:40) 00:19:39 INFO - javascript benchmark 00:19:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2608.152350486092, 2687.9462410751785, 2692.5422678144714, 2708.2146177608506, 2727.509048371294, 4669.463011753645, 4682.742449165303, 4710.269908164236, 4723.315119307698, 4784.856454306377, 4649.37233473481, 4701.435827700672, 4781.7130972141695, 4786.760661966897, 4796.9280460793025, 4279.850205242809, 4301.182775272689, 4302.956970430287, 4350.934735978963, 4451.399061126739, 4369.366441865927, 4413.161499315136, 4444.799984000711, 4469.061497085616, 4469.329600559926, 4273.0385663225525, 4342.609165175134, 4350.934735978963, 4355.869323920288, 4362.498312694049, 4307.741535507848, 4346.456692913386, 4348.695591308609, 4349.043210493686, 4354.455693038371, 4223.68322375823, 4294.0, 4305.784710764449, 4307.073979094478, 4314.762688052156, 4675.088357770236, 4676.859694209179, 4683.742394168319, 4685.789139488731, 4754.168020596417, 5106.310648062538, 5112.3865136183895, 5116.897662046738, 5128.666636668642, 5152.665076770036, 4966.850994470172, 5107.923381149286, 5124.4875512448825, 5136.049830781318, 5189.766460509286, 4666.673332866701, 4670.439547254283, 4673.088747694167, 4710.434747830213, 4727.952720472786, 5052.898942021213, 5104.591632669378, 5109.335786347751, 5113.335266415343, 5138.563222126161, 4871.415430148405, 4957.876053098701, 5001.599872010231, 5077.466865979093, 5090.41460232078, 5046.369203849519, 5070.873228169252, 5088.465711100355, 5094.821681241138, 5149.871253218699, 5038.219076043146, 5052.1663925451885, 5053.646244762905, 5061.164907790247, 5062.316587260746, 4900.828471003498, 5045.949540504622, 5079.390473143247, 5116.74416279192, 5148.716820574904, 4330.761808100585, 4356.869293921188, 4360.4767427908855, 4362.454693163355, 4397.538258482878, 3745.438184272381, 3796.240751849641, 3829.4064420014943, 3836.175222327213, 3869.1101046759404, 4333.285007973712, 4339.631131353807, 4383.3863259143745, 4422.20400327944, 4430.446194225722, 5089.134847076006, 5092.465291144376, 5124.871878203075, 5135.152699804565, 5176.611754118456, 4315.892102697458, 4389.956100439019, 4412.779361031936, 4414.55854414556, 4460.487043989982, 4626.976865115653, 4657.69724967876, 4662.673612847068, 4698.083873644675, 4711.411073615798, 4730.503297153749, 4751.263554149113, 4756.120117778222, 4760.904781904412, 4807.759612019455, 5025.974870125772, 5054.545090941833, 5055.039542486916, 5073.34046573943, 5105.259737337991, 4712.858614241578, 4736.573708366263, 4742.454617718869, 4755.476897541337, 4792.520747925179, 4959.60323174138, 4963.503649635008, 4967.677100988424, 4968.403791545038, 5017.4731653175895, 4933.6299777516115, 5036.471170527042, 5046.243063540352, 5092.159793634009, 5145.485451454824, 4913.656044077024, 4929.630277729257, 4929.728864912464, 4930.309756634002, 4973.428055773632, 4912.484189160086, 4924.138275801792, 4929.926051109164, 4932.852014439429, 4984.077945580079, 4765.976170119127, 4782.545658162469, 4813.350197723403, 4855.854324370274, 4864.73243971585, 4961.950380496149, 4973.626977976739, 4994.350734404504, 4997.700137991732, 5048.0156369507595, 4876.707397556158, 4876.853694389174, 4886.315915771724, 4889.828855990023, 4939.135651261086], "unit": "score", "name": "dojo.html", "value": 4658.686150278134}, {"lowerIsBetter": false, "replicates": [527.3065918317412, 533.0458479322014, 546.7539607176769, 559.8320503848844, 559.8964191624548, 26945.730542694568, 37514.624853751455, 38527.42208866866, 38551.614483855155, 38616.80691596538, 42780.35829462561, 43316.56683433165, 43335.56664433355, 43414.348784768255, 43415.0, 7654.770356889288, 7901.48640338379, 7911.248431399008, 7912.683492660315, 7913.564753938531, 7807.063152421689, 7928.643211055488, 7928.8810667840025, 7936.682532698714, 7940.40446966477, 7880.172581878906, 7941.20587941207, 7941.880871786928, 7960.044794624653, 7961.124276329628, 7853.136155022971, 7930.0880398753725, 7935.523868567847, 7937.603119843985, 7941.6029198539845, 7823.178566250519, 7943.0, 7947.682092716284, 7951.324137448324, 7952.045754509438, 38200.426993595116, 38738.61261387378, 38771.0, 38820.611793882264, 38850.0, 3131.718145366905, 3175.523671449301, 3224.2261857154112, 3265.9020229393154, 3392.3045775616188, 28829.27926801847, 29792.40415191684, 29941.98951521594, 29983.250418739488, 30776.0, 3427.9828600857086, 3462.4113900636953, 3482.3383557124066, 3558.19940513385, 3578.427451607756, 244672.0, 247185.0, 247431.0, 247875.0, 248272.0, 45383.31925021127, 46259.76870115628, 56156.157657635165, 56591.0, 56603.0, 44230.33654495185, 44275.557244427786, 44323.89190270269, 44487.55512444834, 44500.0, 13540.796888046687, 13771.104878182887, 13776.793348099787, 13783.241921694404, 13786.310684465736, 11148.888511114785, 11329.263597866113, 11342.829857552144, 11344.602938897264, 11345.09239260857, 14819.925900370428, 14877.619580867009, 14902.627434314229, 14904.925475372555, 15028.173450460112, 5609.214709940612, 5694.544436445074, 5707.143928410772, 5834.387389324144, 5883.294004719461, 872.5375550957875, 883.779055236191, 897.8787863638325, 927.0868194828089, 927.8144371125802, 26897.596536051973, 27555.724442755316, 27718.5842212367, 27858.721412786017, 28054.0, 892.2817132208635, 945.5697657565792, 963.4171326347599, 976.2580438866513, 1041.8228901086834, 12732.23606583608, 13716.725665486634, 13756.312184390741, 13988.790168147487, 14019.088759230617, 288266.0, 289670.0, 294052.0, 294573.0, 294770.0, 47700.284495732594, 48174.759126204845, 48198.9999999993, 48201.276980845316, 48237.517624824, 1029.629333439961, 1131.2194585735815, 1198.0894520164738, 1222.4743360355133, 1248.444442223202, 23626.0, 24723.232524538176, 27210.31974200661, 27344.589831152152, 27402.862985684944, 38209.56113949758, 38524.0, 38695.80652096721, 38706.22587548177, 38728.22543549057, 205501.0, 205878.0, 206988.0, 207003.0, 207369.0, 31791.36417271688, 31815.363692726478, 32767.18082047968, 32936.505952411215, 32944.0, 41260.58739412687, 41269.1746165069, 41809.37285940774, 42147.15705685808, 42210.5778942219, 34670.0, 35342.0, 35572.466413004346, 35668.46497302595, 36133.457998129525, 34678.30643387169, 35326.64673353233, 35415.46876796902, 35590.64409355873, 35617.64382356247, 35602.8219858899, 35644.82177589095, 35761.821190893876, 37666.623333767406, 38494.80752596219, 28530.85734571314, 31100.0, 31126.533102003035, 31182.532262015633, 31260.687393125776, 24487.020519179034, 24859.875700621382, 24875.378115546533, 25187.622185667595, 25213.747862521876], "unit": "score", "name": "ext.html", "value": 16835.661027187736}, {"lowerIsBetter": false, "replicates": [355.37808834539555, 359.8524604911985, 360.60513737457484, 366.88993302009425, 370.7460389633101, 15509.612259693498, 15548.84451155488, 16231.26959286832, 16400.589985250375, 16458.177091145455, 14868.553943381688, 15162.924185379085, 15528.0, 15560.610984725388, 15602.531924042269, 4988.600911927056, 5077.492250774912, 5125.897482050356, 5137.871553211162, 5145.614078944075, 4958.851234462972, 5067.6452648314635, 5085.974570127144, 5095.566876815476, 5115.232715092748, 5062.367204099488, 5066.847994560169, 5074.441811400743, 5079.644424890259, 5080.034793389263, 6367.6816159192085, 6615.371539703745, 6640.93359066408, 6658.966705166443, 6669.566478178903, 6339.556231063827, 6342.968285158545, 6361.9045714314325, 6381.904271435886, 6432.131662225586, 21909.123635054577, 22184.889075554518, 22483.662745058675, 22499.0, 22970.196043138578, 2102.6425507663735, 2111.7782632823487, 2145.6996020557135, 2194.659827726689, 2198.934031979043, 13901.58295251144, 13915.0, 13934.860651393457, 13949.0, 14545.49090781828, 1840.6778813707547, 1889.9905500472546, 1901.7052356884706, 1973.319204874316, 1981.5343394302472, 64860.571302966724, 66204.66897665529, 67544.32455675479, 69096.65451672759, 69274.30725692779, 14588.772521963694, 14824.777628335583, 15015.324310406058, 15040.62398440026, 15079.321430535652, 25232.243032709048, 25475.0, 25606.231813045637, 25650.0, 25710.0, 8290.502569845828, 8413.15868413166, 8496.150384961455, 8577.828443431097, 8839.911600884037, 7043.366097051187, 7102.041224434738, 7253.782386528413, 7282.781516554512, 7397.26027397256, 7484.663190156456, 7540.736074237376, 7637.312641862259, 7652.69389224436, 7658.195889431529, 2918.1829087855435, 3053.5267033609825, 3064.1726733782198, 3092.9845350773103, 3159.3681263747344, 770.2374649097466, 830.2030051150842, 875.8160786234962, 917.8256131335025, 950.9809803803885, 15220.695586088437, 15824.208789560476, 16169.353225870833, 16260.918695406684, 16559.6688066238, 823.9258466738022, 859.6819176904461, 872.882160908282, 898.2140626951417, 926.5830376330678, 9067.863982040275, 9311.90688093124, 10016.549255283384, 10326.81241657204, 10345.224108191916, 431821.0, 443253.0, 444768.0, 453183.0, 459500.7024964854, 70459.0, 71149.0, 71200.0, 71977.6401117991, 73868.63065684745, 990.9405435673883, 996.0587245053355, 1008.6923488335981, 1022.8772547294373, 1023.1558963854701, 12333.93833030829, 14074.577762667137, 15386.769198462256, 15430.768538471708, 15813.604659883595, 32247.516287256178, 34100.488492672135, 35304.64695353014, 35416.29167416689, 37270.62729372671, 41759.791201045016, 41873.37189942093, 41975.370369443874, 42401.36397953972, 42508.0, 7455.366293864865, 7621.466497345133, 7842.50992311459, 7887.250711182429, 7915.485493442908, 9472.479013654316, 11860.40697965081, 11866.584669536525, 12025.0, 12054.0, 9947.751306217402, 10193.286469947032, 10457.790844183226, 10477.266591338837, 10577.524011419351, 4934.210526315772, 9256.49089300068, 9686.273529485175, 10289.176865850564, 10309.690709278733, 9925.3548519346, 10175.49122543855, 10273.486325683536, 10364.792704145724, 10428.947855260978, 7318.085239345082, 7444.441666875115, 7564.773056808304, 7574.394048476219, 7718.343940765098, 8002.679892804223, 9247.72256832296, 10535.157187424835, 10675.0, 10683.626073087406], "unit": "score", "name": "jquery.html", "value": 8843.864643356892}, {"lowerIsBetter": false, "replicates": [1451.4121780678825, 1452.295636616241, 1625.6504851456934, 1745.0, 1802.8197180281973, 7536.81157971051, 7674.923250767491, 7717.614119294034, 7724.073111226647, 7726.111497177812, 6588.37410446008, 6719.462443004561, 6728.0, 7414.480986330959, 7587.051618547682, 2215.5679642469727, 2258.2660635293514, 2259.1754009786473, 2259.423846919033, 2261.231181398324, 2214.424249695083, 2217.090992692996, 2275.920342788003, 2279.943001424969, 2281.315605318406, 1934.4970307720023, 2205.7683943185975, 2215.3907675389237, 2268.262814585258, 2273.3407311879537, 2186.387811412791, 2198.0987795004053, 2239.115549358011, 2239.652853807654, 2241.977580224201, 2152.9031193596325, 2154.9784502154935, 2157.169489746443, 2160.2763074370105, 2161.3623980925663, 7415.88876166858, 7481.102267727853, 7481.513701609378, 7484.887726684104, 7496.887546686804, 4692.8122875084955, 4805.927911081337, 4825.662203645747, 4832.154372984749, 4833.275008748716, 3024.7126522980284, 3064.233941514621, 3151.952720709191, 3240.2223466368137, 3256.478963365874, 1072.7532667486444, 1082.6373164989739, 1783.9910800446044, 1828.3783513605306, 1830.6247219320142, 10394.272400931937, 10484.266101372907, 10499.632512862014, 10509.264351495398, 10524.631637892713, 4044.5550989391145, 4143.233501802116, 4222.282212023963, 4226.239276930182, 4228.365745138254, 8326.250637442537, 8345.332373410112, 8371.246587807127, 8375.748727538183, 8378.49729016261, 4631.95368046322, 4670.136024835417, 4676.275177347517, 4676.485586585472, 4677.602403795648, 3794.905127371838, 4097.098638299629, 4170.103427763045, 4294.57054294568, 4303.139372125587, 3433.6909678129086, 3494.1264683829045, 3500.1599616091953, 3522.8238588070494, 3542.1321776165005, 1022.2435397805571, 1077.6766969908997, 1078.9190810689229, 1086.603389762731, 1092.5629748100823, 1216.5255550335376, 1222.773786849418, 1244.440001999104, 1245.9875401246052, 1250.224860586424, 7292.3801476874, 7310.086239220098, 7322.1579518355, 7415.25847415265, 7465.216152304039, 478.38049725605424, 479.1686424054263, 484.4211167654689, 492.1706923833352, 494.0884068892887, 5620.466055724782, 5723.856903577361, 5740.655560666373, 5748.252727145528, 5781.19063331134, 9036.548172591343, 9114.13415725505, 9159.954200228956, 9282.071792820663, 9290.953545232365, 9100.681476148304, 9141.862872056925, 9146.314026448043, 9188.8621670675, 9199.724008279762, 7174.820629484305, 7277.963610181915, 7298.4891057625455, 7350.7427240046345, 7374.668139933716, 7348.412127029718, 7376.96311518439, 7390.29792169743, 7394.408447324094, 7413.443991700752, 8351.1648835116, 8368.41421100517, 8603.52680602573, 8702.216800487986, 8730.869036964323, 8579.65681372738, 8787.780305492413, 8959.73120806377, 8970.282377409922, 8974.102589741235, 6096.847578810388, 6469.061986011908, 6607.669616519251, 6919.965400173169, 7031.578105313698, 7179.569225846466, 7183.03029091066, 7201.207867134715, 7208.098987626547, 7219.205887352282, 6350.142730731292, 6409.615423074631, 6452.677366131768, 6678.49911256648, 6770.52606317553, 6356.77751278703, 6370.735307317223, 6456.644884531208, 6526.641034743135, 6573.5398522103, 6892.586444813327, 6911.067005954132, 6917.308269173042, 6957.756478523227, 6964.338387853146, 6054.3642917493025, 6091.664958427152, 6126.5098792097415, 6128.754849805958, 6179.721912513858, 6407.551471396958, 6423.389777971085, 6459.354064593691, 6485.837854053686, 6506.544541882023], "unit": "score", "name": "mootools.html", "value": 4353.802987544067}, {"lowerIsBetter": false, "replicates": [321.23866436545393, 324.1879092872354, 324.5067497403946, 326.4091993491781, 331.58055060348664, 5357.169638705997, 5381.273528073709, 5385.784568617256, 5397.62216644834, 5407.405185429599, 5277.577793776489, 5287.127623942045, 5305.4164041955355, 5309.469053094698, 5357.946420535794, 3994.8002599870038, 4104.835806567734, 4179.582041795811, 4209.305464598346, 4217.936730949023, 4184.497860256758, 4198.8530401435955, 4205.243056249874, 4206.663466922654, 4213.978930105345, 4153.584641535837, 4157.376393540978, 4163.479565054368, 4168.812403441837, 4176.728512646683, 3972.443857859902, 4077.490313710801, 4178.310578754502, 4182.079942412664, 4182.456280683492, 3687.4100143976834, 3688.889333320005, 3693.9445908311395, 3699.6300369963055, 3709.109813644706, 5142.408623008365, 5161.251618515332, 5170.405403378584, 5173.249878767558, 5174.2238664200295, 4863.124637565237, 4867.82962596311, 4868.172410690156, 4872.366592342973, 4878.317035614981, 5688.118341657008, 5688.260526131618, 5698.51562617178, 5704.77180912763, 5708.20085188074, 3990.182012687392, 4086.734362266443, 4087.1825634873144, 4088.407180958774, 4100.487439070116, 5879.823605291848, 5988.700564971734, 5993.280806303228, 6000.549958753111, 6002.669853158074, 4175.31107367287, 4205.137946720914, 4205.747655140702, 4205.747655140702, 4206.8737937861915, 4257.425247591597, 4259.87220383389, 4265.104328091135, 4272.060146767706, 4274.059706864547, 4841.878953026132, 4847.079054979543, 4849.151398505247, 4860.756962151878, 4861.1979023460735, 5704.286964129484, 5711.971440142773, 5718.599698021182, 5720.685362305113, 5721.656700597978, 1396.7555677756352, 1468.3172324868988, 1507.1333982959843, 1508.4192585854526, 1516.2418790604697, 908.2280061947424, 947.9573419196153, 950.933434659581, 966.8349638685368, 970.1656575345197, 4953.578945789576, 4981.028699403581, 4996.775145118406, 5006.274090256892, 5007.749612519359, 5904.793332233351, 5937.554683398676, 5980.252468441445, 5983.401659833982, 5989.880202395928, 4970.72661003641, 4995.325631039763, 4997.575206107522, 5005.074061298671, 5005.224190250517, 3135.059482155344, 3170.1757543038975, 3175.714185723296, 3179.5071763876635, 3179.8410079495934, 5491.752871120809, 5494.708743445287, 5507.669539827623, 5509.118541033416, 5511.3937466878615, 5824.417558244227, 6078.179445774852, 6120.938790612036, 6139.508839292846, 6143.508519318444, 5535.6955367455175, 5563.666180029211, 5575.66546007249, 5578.330600327824, 5582.7766889324785, 5962.761489540543, 5974.492168165581, 5977.073553599199, 5981.192539007178, 5984.730687119003, 5799.8550036249435, 5835.416458354131, 5858.765649373977, 5873.4126587342635, 5904.793332233351, 5349.839504814861, 5566.192902029264, 5567.137093750475, 5574.247476590608, 5577.581681373832, 4033.596640335943, 4051.230266249403, 4062.3297155970117, 4069.6744260459686, 4081.775502347399, 5929.229200203946, 5954.821355359346, 5963.940360596339, 5964.224650795369, 5970.76116955317, 5748.0, 5748.166515855261, 5751.4536119068625, 5759.424057594207, 5763.394843541368, 5689.146628005832, 5707.258056452634, 5736.770529178786, 5751.683657398883, 5753.0, 5451.64564303319, 5647.943520564741, 5660.603757736919, 5660.943390566206, 5662.386219927301, 5770.798022069207, 5800.709964501673, 5809.070548712186, 5811.476967072984, 5826.82519524415, 5647.435256474319, 5649.943500565106, 5665.575081868794, 5668.404817494269, 5671.546276297804], "unit": "score", "name": "prototype.html", "value": 4296.853109553444}, {"lowerIsBetter": false, "replicates": [679.5005670831938, 756.1191212237743, 784.9843003139936, 788.3771820261993, 797.3621103117505, 11182.105431565466, 11263.66209013731, 11309.09527237821, 11310.434478276084, 11345.716357091067, 12244.755104897897, 12271.141020128594, 12300.938495307533, 12309.75380492392, 12311.445984930677, 641.5541198866789, 799.1010113622146, 813.9145389734052, 815.4740192575786, 817.7628487738549, 802.626778547975, 807.2774866494514, 808.995955020227, 810.9229623185818, 812.3704129299781, 859.4456575508824, 861.8793368928355, 866.2982983783156, 867.371155911962, 868.4832524647825, 858.5664239559045, 860.561113831944, 861.3238607692994, 862.3963225742006, 863.317978796753, 627.7426255235378, 628.2492421556242, 631.6557476175495, 633.2812258087058, 634.109076747171, 13038.80441793374, 13052.151610145405, 13128.212307261594, 13142.342882855915, 13147.0, 12337.568185113567, 12728.681782955407, 13097.279649619268, 13176.077674562785, 13222.801657975042, 9473.0, 9594.856077158849, 9667.178289845371, 9672.0, 9763.072508111718, 3270.493073573576, 3285.8849940252217, 3344.0469466202258, 3371.123507887942, 3427.503012063237, 37585.62414375876, 40855.7957210215, 42505.78747106276, 42765.78617106926, 43171.92070198239, 10304.742381440525, 10356.792864142675, 10402.47987600617, 10426.426546540013, 10683.091937185427, 15218.695626087416, 15220.847791522165, 15335.386584536716, 15401.691966160839, 15406.152661603495, 6990.510664253555, 7055.6472176392, 7084.964575177091, 7204.92795072053, 7283.0, 3676.742628016013, 3749.5875453700073, 3761.7742935423416, 3767.698584113264, 3854.9229015419533, 2774.1122840690787, 2783.4572258409416, 2812.9859350703114, 2821.76015038724, 2822.5625028120676, 520.885405210853, 531.3411369901372, 537.5672583570264, 537.9139337705948, 541.5856869494839, 564.1988376505373, 595.6098755315276, 609.6068036116679, 628.9685515724195, 655.4952686431421, 8038.67845286182, 8269.875951860728, 8620.698275560326, 8690.435121717068, 8920.464772113693, 552.6739223857943, 595.4283887467992, 643.8068579426154, 659.1891972873393, 665.9267480577132, 3749.4750734897134, 3802.2927645545374, 3871.845126194921, 3927.6072392760493, 3951.3282741933367, 47782.0, 52578.211326830125, 53628.46371536313, 53663.463365365846, 53684.46315536794, 43044.78477607592, 43594.346084808756, 43760.0, 43797.562024379986, 44159.55840441555, 39393.40909886354, 40207.19585608271, 40261.59738402579, 40554.79722601427, 40559.39160912589, 8621.655133794578, 8625.91374086251, 8733.694320699, 8759.605817738344, 8871.778205544913, 31725.889593864104, 31967.520487192247, 32259.838700806347, 32302.35395292128, 32338.83830580832, 37644.0, 38702.6129738699, 39230.411543826296, 39870.80064599658, 40593.1881362377, 10868.565257389615, 10933.180011499011, 10992.725181870517, 11129.220954533104, 11535.0, 11828.881711182778, 12016.75966480683, 12072.517099315928, 12681.365931703194, 12797.36013199355, 11048.558057677603, 11431.314121152758, 11491.195616306779, 11777.52889884395, 11965.641030769091, 11093.833592496281, 11128.165387596124, 11168.21822472419, 11498.54005839757, 11515.25150865191, 10836.403997780199, 10996.12031037499, 11059.50232239535, 11490.138239632228, 11527.596534121265, 8471.195236452773, 8477.544036436517, 8703.782405439915, 8738.169559245849, 9185.678501252423, 8198.877016844872, 8914.0, 9094.727158185266, 9245.537723113952, 9301.627934882528], "unit": "score", "name": "yui.html", "value": 5974.748743807764}], "name": "dromaeo_css", "value": 6530.095574005173}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 111.0, 111.0, 111.0, 100.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [159.0, 131.0, 158.0, 184.0, 141.0, 168.0, 162.0, 132.0, 177.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 154.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 126.0, 101.0, 74.0, 74.0, 77.0, 114.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.7}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 142.0, 94.0, 94.0, 94.0, 141.0, 94.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 64.0, 65.0, 63.0, 63.0, 78.0, 62.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 82.0, 83.0, 83.0, 82.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [123.0, 119.0, 115.0, 122.0, 125.0, 116.0, 124.0, 116.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 141.0, 142.0, 135.0, 129.0, 141.0, 142.0, 142.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 70.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1518.6000000000001}]} 00:19:39 INFO - Return code: 0 00:19:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:19:39 ERROR - # TBPL SUCCESS # 00:19:39 INFO - Running post-action listener: _resource_record_post_action 00:19:39 INFO - Running post-run listener: _resource_record_post_run 00:19:40 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520732672; Read time: 16; Write time: 845952 00:19:40 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 239452160; Read time: 0; Write time: 548448 00:19:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281280512; Read time: 16; Write time: 297504 00:19:40 INFO - Running post-run listener: _upload_blobber_files 00:19:40 INFO - Blob upload gear active. 00:19:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:19:40 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 00:19:40 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'] 00:19:40 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 00:19:41 INFO - (blobuploader) - INFO - Open directory for files ... 00:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:19:42 INFO - (blobuploader) - INFO - Done attempting. 00:19:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:19:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:19:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:19:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:19:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:19:43 INFO - (blobuploader) - INFO - Done attempting. 00:19:43 INFO - (blobuploader) - INFO - Iteration through files over. 00:19:43 INFO - Return code: 0 00:19:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:19:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:19:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7205d89d4d9ca2b2c227c390fb395f4b32bc227e0b02bdfaa2eb8ed46fedd5b6e916d64123d879462b3011a22ad823d607f5d105d90042a7923ff1fe30960e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ccda62d73acd924ded763a4e37a4d666472918233d0c426c0a60bdf1033ff673de07584ec679187300d464440cdda5183ff5a15a5d90045f4347b78e6b22b0c"} 00:19:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:19:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:19:43 INFO - Contents: 00:19:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7205d89d4d9ca2b2c227c390fb395f4b32bc227e0b02bdfaa2eb8ed46fedd5b6e916d64123d879462b3011a22ad823d607f5d105d90042a7923ff1fe30960e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ccda62d73acd924ded763a4e37a4d666472918233d0c426c0a60bdf1033ff673de07584ec679187300d464440cdda5183ff5a15a5d90045f4347b78e6b22b0c"} 00:19:43 INFO - Running post-run listener: copy_logs_to_upload_dir 00:19:43 INFO - Copying logs to upload dir... 00:19:43 INFO - mkdir: /builds/slave/test/build/upload/logs 00:19:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.030545 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-03-25 00:19:42.354682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 00:19:42.358017) ========= 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7205d89d4d9ca2b2c227c390fb395f4b32bc227e0b02bdfaa2eb8ed46fedd5b6e916d64123d879462b3011a22ad823d607f5d105d90042a7923ff1fe30960e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ccda62d73acd924ded763a4e37a4d666472918233d0c426c0a60bdf1033ff673de07584ec679187300d464440cdda5183ff5a15a5d90045f4347b78e6b22b0c"} build_url:https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011600 build_url: 'https://queue.taskcluster.net/v1/task/DaqMa2TARZa7jH_TOgngVw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7205d89d4d9ca2b2c227c390fb395f4b32bc227e0b02bdfaa2eb8ed46fedd5b6e916d64123d879462b3011a22ad823d607f5d105d90042a7923ff1fe30960e98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ccda62d73acd924ded763a4e37a4d666472918233d0c426c0a60bdf1033ff673de07584ec679187300d464440cdda5183ff5a15a5d90045f4347b78e6b22b0c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 00:19:42.382406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 00:19:42.382723) ========= 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=1861a34ebfea852630dec091000001fa-1458888129.478584-524697437 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 00:19:42.465185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 00:19:42.465480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 00:19:42.465762) ========= ========= Total master_lag: 0.26 =========