builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1458315812.24 results: success (0) buildid: 20160318073312 builduid: fe7dfe6ef4a74bf0b93c1aceadce754d revision: 3d37c7e5b8dd28a4a017e2296e824619f9379b88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.242171) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.242605) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.242918) ========= 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006452 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.268175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.268449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.285480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.285926) ========= 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.339057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.339317) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.339651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.339937) ========= 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 08:43:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-03-18 08:43:32 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141355 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.509044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.509319) ========= 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014485 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:32.569573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 08:43:32.569907) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d37c7e5b8dd28a4a017e2296e824619f9379b88 --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 3d37c7e5b8dd28a4a017e2296e824619f9379b88 --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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 08:43:32,732 truncating revision to first 12 chars 2016-03-18 08:43:32,732 Setting DEBUG logging. 2016-03-18 08:43:32,732 attempt 1/10 2016-03-18 08:43:32,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d37c7e5b8dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 08:43:34,042 unpacking tar archive at: mozilla-central-3d37c7e5b8dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.633287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 08:43:34.220569) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:34.220934) ========= echo 3d37c7e5b8dd28a4a017e2296e824619f9379b88 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3d37c7e5b8dd28a4a017e2296e824619f9379b88'] 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3d37c7e5b8dd28a4a017e2296e824619f9379b88 program finished with exit code 0 elapsedTime=0.003945 script_repo_revision: '3d37c7e5b8dd28a4a017e2296e824619f9379b88' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:34.273148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:34.273846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 08:43:34.284045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-03-18 08:43:34.284312) ========= /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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:43:34 INFO - MultiFileLogger online at 20160318 08:43:34 in /builds/slave/test 08:43:34 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 08:43:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:34 INFO - {'append_to_log': False, 08:43:34 INFO - 'base_work_dir': '/builds/slave/test', 08:43:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:43:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:34 INFO - 'branch': 'Firefox-Non-PGO', 08:43:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:34 INFO - 'config_files': ('talos/linux_config.py',), 08:43:34 INFO - 'default_actions': ('clobber', 08:43:34 INFO - 'read-buildbot-config', 08:43:34 INFO - 'download-and-extract', 08:43:34 INFO - 'populate-webroot', 08:43:34 INFO - 'create-virtualenv', 08:43:34 INFO - 'install', 08:43:34 INFO - 'run-tests'), 08:43:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:34 INFO - 'download_minidump_stackwalk': True, 08:43:34 INFO - 'download_symbols': 'ondemand', 08:43:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:34 INFO - 'installer_path': 'installer.exe', 08:43:34 INFO - 'log_level': 'info', 08:43:34 INFO - 'log_name': 'talos', 08:43:34 INFO - 'log_to_console': True, 08:43:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:43:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:43:34 INFO - 'opt_config_files': (), 08:43:34 INFO - 'pip_index': False, 08:43:34 INFO - 'sps_profile': False, 08:43:34 INFO - 'sps_profile_interval': 0, 08:43:34 INFO - 'suite': 'dromaeojs', 08:43:34 INFO - 'system_bits': '32', 08:43:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:34 INFO - 'title': 'talos-linux64-ix-009', 08:43:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:34 INFO - 'use_talos_json': True, 08:43:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:34 INFO - 'work_dir': 'build'} 08:43:34 INFO - ##### 08:43:34 INFO - ##### Running clobber step. 08:43:34 INFO - ##### 08:43:34 INFO - Running pre-action listener: _resource_record_pre_action 08:43:34 INFO - Running main action method: clobber 08:43:34 INFO - rmtree: /builds/slave/test/build 08:43:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:35 INFO - Running post-action listener: _resource_record_post_action 08:43:35 INFO - ##### 08:43:35 INFO - ##### Running read-buildbot-config step. 08:43:35 INFO - ##### 08:43:35 INFO - Running pre-action listener: _resource_record_pre_action 08:43:35 INFO - Running main action method: read_buildbot_config 08:43:35 INFO - Using buildbot properties: 08:43:35 INFO - { 08:43:35 INFO - "project": "", 08:43:35 INFO - "product": "firefox", 08:43:35 INFO - "script_repo_revision": "production", 08:43:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:43:35 INFO - "repository": "", 08:43:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:43:35 INFO - "buildid": "20160318073312", 08:43:35 INFO - "pgo_build": "False", 08:43:35 INFO - "basedir": "/builds/slave/test", 08:43:35 INFO - "buildnumber": 517, 08:43:35 INFO - "slavename": "talos-linux64-ix-009", 08:43:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:43:35 INFO - "platform": "ubuntu64_hw", 08:43:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:43:35 INFO - "branch": "mozilla-central", 08:43:35 INFO - "repo_path": "mozilla-central", 08:43:35 INFO - "revision": "3d37c7e5b8dd28a4a017e2296e824619f9379b88", 08:43:35 INFO - "stage_platform": "linux64", 08:43:35 INFO - "builduid": "fe7dfe6ef4a74bf0b93c1aceadce754d", 08:43:35 INFO - "slavebuilddir": "test" 08:43:35 INFO - } 08:43:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:43:35 INFO - Running post-action listener: _resource_record_post_action 08:43:35 INFO - ##### 08:43:35 INFO - ##### Running download-and-extract step. 08:43:35 INFO - ##### 08:43:35 INFO - Running pre-action listener: _resource_record_pre_action 08:43:35 INFO - Running main action method: download_and_extract 08:43:35 INFO - mkdir: /builds/slave/test/build/tests 08:43: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')]} 08:43:35 INFO - https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:43:45 INFO - Downloaded 1361 bytes. 08:43:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:43:45 INFO - Using the following test package requirements: 08:43:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:43:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:43:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:43:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'jsshell-linux-x86_64.zip'], 08:43:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:43:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:43:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:43:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:43:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:43:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:43:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:43: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')]} 08:43:45 INFO - https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:43:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:43:57 INFO - Downloaded 22008817 bytes. 08:43:57 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'] 08:43:57 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 08:43:58 INFO - Return code: 0 08:43:58 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 08:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:58 INFO - https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:44:00 INFO - Downloaded 22008817 bytes. 08:44: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'] 08:44: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 08:44:01 INFO - Return code: 0 08:44: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')]} 08:44:01 INFO - https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:44:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:44:03 INFO - Downloaded 10846565 bytes. 08:44:03 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'] 08:44:03 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 08:44:03 INFO - Return code: 0 08:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:03 INFO - https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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 08:44:04 INFO - Downloaded 54143777 bytes. 08:44:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:44:04 INFO - mkdir: /builds/slave/test/properties 08:44:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:04 INFO - Contents: 08:44:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:44:05 INFO - Running post-action listener: _resource_record_post_action 08:44:05 INFO - Running post-action listener: set_extra_try_arguments 08:44:05 INFO - ##### 08:44:05 INFO - ##### Running populate-webroot step. 08:44:05 INFO - ##### 08:44:05 INFO - Running pre-action listener: _resource_record_pre_action 08:44:05 INFO - Running main action method: populate_webroot 08:44:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:05 INFO - '--tppagecycles', 08:44:05 INFO - '7'], 08:44:05 INFO - 'tests': ['tsvgm']}}, 08:44:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:44:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:44:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'tests': ['damp', 'tps']}, 08:44:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['damp', 'tps']}, 08:44:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:44:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:05 INFO - 'other': {'tests': ['a11yr', 08:44:05 INFO - 'ts_paint', 08:44:05 INFO - 'tpaint', 08:44:05 INFO - 'sessionrestore', 08:44:05 INFO - 'sessionrestore_no_auto_restore', 08:44:05 INFO - 'tabpaint']}, 08:44:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['a11yr', 08:44:05 INFO - 'ts_paint', 08:44:05 INFO - 'tpaint', 08:44:05 INFO - 'sessionrestore', 08:44:05 INFO - 'sessionrestore_no_auto_restore', 08:44:05 INFO - 'tabpaint']}, 08:44:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['a11yr', 08:44:05 INFO - 'ts_paint', 08:44:05 INFO - 'tpaint', 08:44:05 INFO - 'sessionrestore', 08:44:05 INFO - 'sessionrestore_no_auto_restore', 08:44:05 INFO - 'tabpaint']}, 08:44:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['a11yr', 08:44:05 INFO - 'ts_paint', 08:44:05 INFO - 'tpaint', 08:44:05 INFO - 'sessionrestore', 08:44:05 INFO - 'sessionrestore_no_auto_restore', 08:44:05 INFO - 'tabpaint']}, 08:44:05 INFO - 'other_l64': {'tests': ['a11yr', 08:44:05 INFO - 'ts_paint', 08:44:05 INFO - 'tpaint', 08:44:05 INFO - 'sessionrestore', 08:44:05 INFO - 'sessionrestore_no_auto_restore', 08:44:05 INFO - 'tabpaint']}, 08:44:05 INFO - 'other_nol64': {'tests': ['a11yr', 08:44:05 INFO - 'ts_paint', 08:44:05 INFO - 'tpaint', 08:44:05 INFO - 'sessionrestore', 08:44:05 INFO - 'sessionrestore_no_auto_restore', 08:44:05 INFO - 'tabpaint']}, 08:44:05 INFO - 'svgr': {'tests': ['tsvgx', 08:44:05 INFO - 'tsvgr_opacity', 08:44:05 INFO - 'tart', 08:44:05 INFO - 'tscrollx', 08:44:05 INFO - 'cart']}, 08:44:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['tsvgx', 08:44:05 INFO - 'tsvgr_opacity', 08:44:05 INFO - 'tart', 08:44:05 INFO - 'tscrollx', 08:44:05 INFO - 'cart']}, 08:44:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'tests': ['tp5o']}, 08:44:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'talos_options': ['--e10s'], 08:44:05 INFO - 'tests': ['tp5o']}, 08:44:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'talos_options': ['--xperf_path', 08:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:05 INFO - 'tests': ['tp5n']}, 08:44:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:05 INFO - 'talos_options': ['--e10s', 08:44:05 INFO - '--xperf_path', 08:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:05 INFO - 'tests': ['tp5n']}}, 08:44:05 INFO - 'talos.zip': {'path': '', 08:44:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:05 INFO - Running post-action listener: _resource_record_post_action 08:44:05 INFO - ##### 08:44:05 INFO - ##### Running create-virtualenv step. 08:44:05 INFO - ##### 08:44:05 INFO - Running pre-action listener: _resource_record_pre_action 08:44:05 INFO - Running main action method: create_virtualenv 08:44:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:05 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 08:44:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:05 INFO - Using real prefix '/usr' 08:44:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:06 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:08 INFO - Installing pip.................done. 08:44:08 INFO - Return code: 0 08:44:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:44:08 INFO - Using env: {'DISPLAY': ':0', 08:44:08 INFO - 'HOME': '/home/cltbld', 08:44:08 INFO - 'LANG': 'en_US.UTF-8', 08:44:08 INFO - 'LANGUAGE': 'en_US:en', 08:44:08 INFO - 'LOGNAME': 'cltbld', 08:44:08 INFO - 'MAIL': '/var/mail/cltbld', 08:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:08 INFO - 'MOZ_NO_REMOTE': '1', 08:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:08 INFO - 'NO_EM_RESTART': '1', 08:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:08 INFO - 'PWD': '/builds/slave/test', 08:44:08 INFO - 'SHELL': '/bin/bash', 08:44:08 INFO - 'SHLVL': '1', 08:44:08 INFO - 'TERM': 'linux', 08:44:08 INFO - 'TMOUT': '86400', 08:44:08 INFO - 'USER': 'cltbld', 08:44:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:08 INFO - '_': '/tools/buildbot/bin/python'} 08:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:08 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 08:44:08 INFO - Cleaning up... 08:44:08 INFO - Return code: 0 08:44:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:44:08 INFO - Using env: {'DISPLAY': ':0', 08:44:08 INFO - 'HOME': '/home/cltbld', 08:44:08 INFO - 'LANG': 'en_US.UTF-8', 08:44:08 INFO - 'LANGUAGE': 'en_US:en', 08:44:08 INFO - 'LOGNAME': 'cltbld', 08:44:08 INFO - 'MAIL': '/var/mail/cltbld', 08:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:08 INFO - 'MOZ_NO_REMOTE': '1', 08:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:08 INFO - 'NO_EM_RESTART': '1', 08:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:08 INFO - 'PWD': '/builds/slave/test', 08:44:08 INFO - 'SHELL': '/bin/bash', 08:44:08 INFO - 'SHLVL': '1', 08:44:08 INFO - 'TERM': 'linux', 08:44:08 INFO - 'TMOUT': '86400', 08:44:08 INFO - 'USER': 'cltbld', 08:44:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:08 INFO - '_': '/tools/buildbot/bin/python'} 08:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:08 INFO - Downloading/unpacking psutil>=0.7.1 08:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:10 INFO - Installing collected packages: psutil 08:44:10 INFO - Running setup.py install for psutil 08:44:10 INFO - building 'psutil._psutil_linux' extension 08:44:10 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 08:44:10 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 08:44:10 INFO - building 'psutil._psutil_posix' extension 08:44:10 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 08:44:10 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 08:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:10 INFO - Successfully installed psutil 08:44:10 INFO - Cleaning up... 08:44:11 INFO - Return code: 0 08:44:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:44:11 INFO - Using env: {'DISPLAY': ':0', 08:44:11 INFO - 'HOME': '/home/cltbld', 08:44:11 INFO - 'LANG': 'en_US.UTF-8', 08:44:11 INFO - 'LANGUAGE': 'en_US:en', 08:44:11 INFO - 'LOGNAME': 'cltbld', 08:44:11 INFO - 'MAIL': '/var/mail/cltbld', 08:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:11 INFO - 'MOZ_NO_REMOTE': '1', 08:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:11 INFO - 'NO_EM_RESTART': '1', 08:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:11 INFO - 'PWD': '/builds/slave/test', 08:44:11 INFO - 'SHELL': '/bin/bash', 08:44:11 INFO - 'SHLVL': '1', 08:44:11 INFO - 'TERM': 'linux', 08:44:11 INFO - 'TMOUT': '86400', 08:44:11 INFO - 'USER': 'cltbld', 08:44:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:11 INFO - '_': '/tools/buildbot/bin/python'} 08:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:44:13 INFO - Installing collected packages: mozsystemmonitor 08:44:13 INFO - Running setup.py install for mozsystemmonitor 08:44:13 INFO - Successfully installed mozsystemmonitor 08:44:13 INFO - Cleaning up... 08:44:13 INFO - Return code: 0 08:44:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:13 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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:13 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 08:44:13 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 08:44:13 INFO - Using env: {'DISPLAY': ':0', 08:44:13 INFO - 'HOME': '/home/cltbld', 08:44:13 INFO - 'LANG': 'en_US.UTF-8', 08:44:13 INFO - 'LANGUAGE': 'en_US:en', 08:44:13 INFO - 'LOGNAME': 'cltbld', 08:44:13 INFO - 'MAIL': '/var/mail/cltbld', 08:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:13 INFO - 'MOZ_NO_REMOTE': '1', 08:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:13 INFO - 'NO_EM_RESTART': '1', 08:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:13 INFO - 'PWD': '/builds/slave/test', 08:44:13 INFO - 'SHELL': '/bin/bash', 08:44:13 INFO - 'SHLVL': '1', 08:44:13 INFO - 'TERM': 'linux', 08:44:13 INFO - 'TMOUT': '86400', 08:44:13 INFO - 'USER': 'cltbld', 08:44:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:13 INFO - '_': '/tools/buildbot/bin/python'} 08:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:13 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 08:44:13 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 08:44:13 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 08:44:13 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 08:44:13 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 08:44:13 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 08:44:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 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 08:44:15 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 08:44:16 INFO - Downloading docopt-0.6.1.tar.gz 08:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:16 INFO - Running setup.py install for blobuploader 08:44:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:16 INFO - Running setup.py install for requests 08:44:16 INFO - Running setup.py install for docopt 08:44:16 INFO - Successfully installed blobuploader requests docopt 08:44:16 INFO - Cleaning up... 08:44:16 INFO - Return code: 0 08:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:16 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')]} 08:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:16 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')]} 08:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:16 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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:16 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 08:44:16 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 08:44:16 INFO - Using env: {'DISPLAY': ':0', 08:44:16 INFO - 'HOME': '/home/cltbld', 08:44:16 INFO - 'LANG': 'en_US.UTF-8', 08:44:16 INFO - 'LANGUAGE': 'en_US:en', 08:44:16 INFO - 'LOGNAME': 'cltbld', 08:44:16 INFO - 'MAIL': '/var/mail/cltbld', 08:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:16 INFO - 'MOZ_NO_REMOTE': '1', 08:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:16 INFO - 'NO_EM_RESTART': '1', 08:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:16 INFO - 'PWD': '/builds/slave/test', 08:44:16 INFO - 'SHELL': '/bin/bash', 08:44:16 INFO - 'SHLVL': '1', 08:44:16 INFO - 'TERM': 'linux', 08:44:16 INFO - 'TMOUT': '86400', 08:44:16 INFO - 'USER': 'cltbld', 08:44:16 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:16 INFO - '_': '/tools/buildbot/bin/python'} 08:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:16 INFO - Running setup.py (path:/tmp/pip-6p3JH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:16 INFO - Running setup.py (path:/tmp/pip-hp3tN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:17 INFO - Running setup.py (path:/tmp/pip-oFmvCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:17 INFO - Running setup.py (path:/tmp/pip-Z475hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:17 INFO - Running setup.py (path:/tmp/pip-YR4nZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:17 INFO - Running setup.py (path:/tmp/pip-xHBDLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:17 INFO - Running setup.py (path:/tmp/pip-EmXIPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:17 INFO - Running setup.py (path:/tmp/pip-rbCmUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:17 INFO - Running setup.py (path:/tmp/pip-d9ghfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:17 INFO - Running setup.py (path:/tmp/pip-MKdxrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:17 INFO - Running setup.py (path:/tmp/pip-OuHRbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:17 INFO - Running setup.py (path:/tmp/pip-DlU07E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:17 INFO - Running setup.py (path:/tmp/pip-CAYy54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:17 INFO - Running setup.py (path:/tmp/pip-ZkXCdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:17 INFO - Running setup.py (path:/tmp/pip-HsuoeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:17 INFO - Running setup.py (path:/tmp/pip-uC1ZjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:18 INFO - Running setup.py (path:/tmp/pip-5toqt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:18 INFO - Running setup.py install for manifestparser 08:44:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Running setup.py install for mozcrash 08:44:18 INFO - Running setup.py install for mozdebug 08:44:18 INFO - Running setup.py install for mozdevice 08:44:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Running setup.py install for mozfile 08:44:18 INFO - Running setup.py install for mozhttpd 08:44:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Running setup.py install for mozinfo 08:44:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Running setup.py install for mozInstall 08:44:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:18 INFO - Running setup.py install for mozleak 08:44:19 INFO - Running setup.py install for mozlog 08:44:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Running setup.py install for moznetwork 08:44:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Running setup.py install for mozprocess 08:44:19 INFO - Running setup.py install for mozprofile 08:44:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Running setup.py install for mozrunner 08:44:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Running setup.py install for mozscreenshot 08:44:19 INFO - Running setup.py install for moztest 08:44:19 INFO - Running setup.py install for mozversion 08:44:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:19 INFO - Cleaning up... 08:44:19 INFO - Return code: 0 08:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:19 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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:19 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 08:44:19 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 08:44:19 INFO - Using env: {'DISPLAY': ':0', 08:44:19 INFO - 'HOME': '/home/cltbld', 08:44:19 INFO - 'LANG': 'en_US.UTF-8', 08:44:19 INFO - 'LANGUAGE': 'en_US:en', 08:44:19 INFO - 'LOGNAME': 'cltbld', 08:44:19 INFO - 'MAIL': '/var/mail/cltbld', 08:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:19 INFO - 'MOZ_NO_REMOTE': '1', 08:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:19 INFO - 'NO_EM_RESTART': '1', 08:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:19 INFO - 'PWD': '/builds/slave/test', 08:44:19 INFO - 'SHELL': '/bin/bash', 08:44:19 INFO - 'SHLVL': '1', 08:44:19 INFO - 'TERM': 'linux', 08:44:19 INFO - 'TMOUT': '86400', 08:44:19 INFO - 'USER': 'cltbld', 08:44:19 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:19 INFO - '_': '/tools/buildbot/bin/python'} 08:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:20 INFO - Running setup.py (path:/tmp/pip-fiBSPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:20 INFO - Running setup.py (path:/tmp/pip-4KyZvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:20 INFO - Running setup.py (path:/tmp/pip-bz_3o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:20 INFO - Running setup.py (path:/tmp/pip-9m6y8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:20 INFO - Running setup.py (path:/tmp/pip-M8QKtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:20 INFO - Running setup.py (path:/tmp/pip-8RKL7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:20 INFO - Running setup.py (path:/tmp/pip-75NXLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:20 INFO - Running setup.py (path:/tmp/pip-COppYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:20 INFO - Running setup.py (path:/tmp/pip-TH9P0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:20 INFO - Running setup.py (path:/tmp/pip-h7GSsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:20 INFO - Running setup.py (path:/tmp/pip-4G9z0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:20 INFO - Running setup.py (path:/tmp/pip-YbvbqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:20 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)) 08:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:20 INFO - Running setup.py (path:/tmp/pip-eRmqTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:21 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)) 08:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:21 INFO - Running setup.py (path:/tmp/pip-94nd_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:21 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)) 08:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:21 INFO - Running setup.py (path:/tmp/pip-reuPxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:21 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)) 08:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:21 INFO - Running setup.py (path:/tmp/pip-ynCNa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:21 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)) 08:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:21 INFO - Running setup.py (path:/tmp/pip-k03al5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:21 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)) 08:44:21 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)) 08:44:21 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)) 08:44:21 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)) 08:44:21 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)) 08:44:21 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)) 08:44:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:21 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 08:44:21 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 08:44:21 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 08:44:21 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 08:44:21 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 08:44:21 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 08:44:23 INFO - Downloading blessings-1.6.tar.gz 08:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:23 INFO - Installing collected packages: blessings 08:44:23 INFO - Running setup.py install for blessings 08:44:23 INFO - Successfully installed blessings 08:44:23 INFO - Cleaning up... 08:44:23 INFO - Return code: 0 08:44:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:23 INFO - Reading from file tmpfile_stdout 08:44:23 INFO - Current package versions: 08:44:23 INFO - argparse == 1.2.1 08:44:23 INFO - blessings == 1.6 08:44:23 INFO - blobuploader == 1.2.4 08:44:23 INFO - docopt == 0.6.1 08:44:23 INFO - manifestparser == 1.1 08:44:23 INFO - mozInstall == 1.12 08:44:23 INFO - mozcrash == 0.17 08:44:23 INFO - mozdebug == 0.1 08:44:23 INFO - mozdevice == 0.48 08:44:23 INFO - mozfile == 1.2 08:44:23 INFO - mozhttpd == 0.7 08:44:23 INFO - mozinfo == 0.9 08:44:23 INFO - mozleak == 0.1 08:44:23 INFO - mozlog == 3.1 08:44:23 INFO - moznetwork == 0.27 08:44:23 INFO - mozprocess == 0.22 08:44:23 INFO - mozprofile == 0.28 08:44:23 INFO - mozrunner == 6.11 08:44:23 INFO - mozscreenshot == 0.1 08:44:23 INFO - mozsystemmonitor == 0.0 08:44:23 INFO - moztest == 0.7 08:44:23 INFO - mozversion == 1.4 08:44:23 INFO - psutil == 3.1.1 08:44:23 INFO - requests == 1.2.3 08:44:23 INFO - wsgiref == 0.1.2 08:44:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:23 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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:23 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 08:44:23 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 08:44:23 INFO - Using env: {'DISPLAY': ':0', 08:44:23 INFO - 'HOME': '/home/cltbld', 08:44:23 INFO - 'LANG': 'en_US.UTF-8', 08:44:23 INFO - 'LANGUAGE': 'en_US:en', 08:44:23 INFO - 'LOGNAME': 'cltbld', 08:44:23 INFO - 'MAIL': '/var/mail/cltbld', 08:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:23 INFO - 'MOZ_NO_REMOTE': '1', 08:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:23 INFO - 'NO_EM_RESTART': '1', 08:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:23 INFO - 'PWD': '/builds/slave/test', 08:44:23 INFO - 'SHELL': '/bin/bash', 08:44:23 INFO - 'SHLVL': '1', 08:44:23 INFO - 'TERM': 'linux', 08:44:23 INFO - 'TMOUT': '86400', 08:44:23 INFO - 'USER': 'cltbld', 08:44:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:23 INFO - '_': '/tools/buildbot/bin/python'} 08:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 INFO - Cleaning up... 08:44:23 INFO - Return code: 0 08:44:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44: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', 'jsonschema'] in /builds/slave/test/build 08:44: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 jsonschema 08:44:23 INFO - Using env: {'DISPLAY': ':0', 08:44:23 INFO - 'HOME': '/home/cltbld', 08:44:23 INFO - 'LANG': 'en_US.UTF-8', 08:44:23 INFO - 'LANGUAGE': 'en_US:en', 08:44:23 INFO - 'LOGNAME': 'cltbld', 08:44:23 INFO - 'MAIL': '/var/mail/cltbld', 08:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:23 INFO - 'MOZ_NO_REMOTE': '1', 08:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:23 INFO - 'NO_EM_RESTART': '1', 08:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:23 INFO - 'PWD': '/builds/slave/test', 08:44:23 INFO - 'SHELL': '/bin/bash', 08:44:23 INFO - 'SHLVL': '1', 08:44:23 INFO - 'TERM': 'linux', 08:44:23 INFO - 'TMOUT': '86400', 08:44:23 INFO - 'USER': 'cltbld', 08:44:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:23 INFO - '_': '/tools/buildbot/bin/python'} 08:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:24 INFO - Downloading/unpacking jsonschema 08:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:25 INFO - Downloading/unpacking functools32 (from jsonschema) 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:26 INFO - warning: no files found matching '*.txt' 08:44:26 INFO - no previously-included directories found matching 'build' 08:44:26 INFO - no previously-included directories found matching 'dist' 08:44:26 INFO - no previously-included directories found matching '.git*' 08:44:26 INFO - Installing collected packages: jsonschema, functools32 08:44:26 INFO - Running setup.py install for functools32 08:44:26 INFO - warning: no files found matching '*.txt' 08:44:26 INFO - no previously-included directories found matching 'build' 08:44:26 INFO - no previously-included directories found matching 'dist' 08:44:26 INFO - no previously-included directories found matching '.git*' 08:44:26 INFO - Successfully installed jsonschema functools32 08:44:26 INFO - Cleaning up... 08:44:26 INFO - Return code: 0 08:44:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:44:26 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')]} 08:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:26 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')]} 08:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:26 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 0x7f34b9665f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', '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 08:44:26 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 08:44:26 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 08:44:26 INFO - Using env: {'DISPLAY': ':0', 08:44:26 INFO - 'HOME': '/home/cltbld', 08:44:26 INFO - 'LANG': 'en_US.UTF-8', 08:44:26 INFO - 'LANGUAGE': 'en_US:en', 08:44:26 INFO - 'LOGNAME': 'cltbld', 08:44:26 INFO - 'MAIL': '/var/mail/cltbld', 08:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:26 INFO - 'MOZ_NO_REMOTE': '1', 08:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:26 INFO - 'NO_EM_RESTART': '1', 08:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:26 INFO - 'PWD': '/builds/slave/test', 08:44:26 INFO - 'SHELL': '/bin/bash', 08:44:26 INFO - 'SHLVL': '1', 08:44:26 INFO - 'TERM': 'linux', 08:44:26 INFO - 'TMOUT': '86400', 08:44:26 INFO - 'USER': 'cltbld', 08:44:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:26 INFO - '_': '/tools/buildbot/bin/python'} 08:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:26 INFO - Downloading/unpacking flake8 08:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:44:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:44:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:29 INFO - no previously-included directories found matching 'docs/_build' 08:44:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:44:29 INFO - Running setup.py install for pep8 08:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:29 INFO - no previously-included directories found matching 'docs/_build' 08:44:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:44:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:44:29 INFO - Cleaning up... 08:44:29 INFO - Return code: 0 08:44:29 INFO - Running post-action listener: _resource_record_post_action 08:44:29 INFO - Running post-action listener: _start_resource_monitoring 08:44:29 INFO - Starting resource monitoring. 08:44:29 INFO - ##### 08:44:29 INFO - ##### Running install step. 08:44:29 INFO - ##### 08:44:29 INFO - Running pre-action listener: _resource_record_pre_action 08:44:29 INFO - Running main action method: install 08:44:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:29 INFO - Reading from file tmpfile_stdout 08:44:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:29 INFO - Reading from file tmpfile_stdout 08:44:29 INFO - Output received: 08:44:29 INFO - Usage: mozinstall [options] installer 08:44:29 INFO - Options: 08:44:29 INFO - -h, --help show this help message and exit 08:44:29 INFO - -d DEST, --destination=DEST 08:44:29 INFO - Directory to install application into. [default: 08:44:29 INFO - "/builds/slave/test"] 08:44:29 INFO - --app=APP Application being installed. [default: firefox] 08:44:29 INFO - mkdir: /builds/slave/test/build/application 08:44:29 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'] 08:44:29 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 08:44:45 INFO - Reading from file tmpfile_stdout 08:44:45 INFO - Output received: 08:44:45 INFO - /builds/slave/test/build/application/firefox/firefox 08:44:45 INFO - Running post-action listener: _resource_record_post_action 08:44:45 INFO - ##### 08:44:45 INFO - ##### Running run-tests step. 08:44:45 INFO - ##### 08:44:45 INFO - Running pre-action listener: _resource_record_pre_action 08:44:45 INFO - Running main action method: run_tests 08:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:45 INFO - Python 2.7.3 08:44:45 INFO - Return code: 0 08:44:45 INFO - grabbing minidump binary from tooltool 08:44: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')]} 08:44:45 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 0x2943410>, '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 0x2944310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29447a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:45 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 08:44:45 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 08:44:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:45 INFO - Return code: 0 08:44:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:44:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:44:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:44:46 INFO - Return code: 0 08:44:46 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/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 08:44:46 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/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 08:44:46 INFO - Using env: {'DISPLAY': ':0', 08:44:46 INFO - 'HOME': '/home/cltbld', 08:44:46 INFO - 'LANG': 'en_US.UTF-8', 08:44:46 INFO - 'LANGUAGE': 'en_US:en', 08:44:46 INFO - 'LOGNAME': 'cltbld', 08:44:46 INFO - 'MAIL': '/var/mail/cltbld', 08:44:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:46 INFO - 'MOZ_NO_REMOTE': '1', 08:44:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:46 INFO - 'NO_EM_RESTART': '1', 08:44:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:46 INFO - 'PWD': '/builds/slave/test', 08:44:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:46 INFO - 'SHELL': '/bin/bash', 08:44:46 INFO - 'SHLVL': '1', 08:44:46 INFO - 'TERM': 'linux', 08:44:46 INFO - 'TMOUT': '86400', 08:44:46 INFO - 'USER': 'cltbld', 08:44:46 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250', 08:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:46 INFO - '_': '/tools/buildbot/bin/python'} 08:44:46 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/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 08:44:46 INFO - mozversion application_buildid: 20160318073312 08:44:46 INFO - mozversion application_changeset: 3d37c7e5b8dd28a4a017e2296e824619f9379b88 08:44:46 INFO - mozversion application_display_name: Nightly 08:44:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:46 INFO - mozversion application_name: Firefox 08:44:46 INFO - mozversion application_remotingname: firefox 08:44:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:44:46 INFO - mozversion application_vendor: Mozilla 08:44:46 INFO - mozversion application_version: 48.0a1 08:44:46 INFO - mozversion platform_buildid: 20160318073312 08:44:46 INFO - mozversion platform_changeset: 3d37c7e5b8dd28a4a017e2296e824619f9379b88 08:44:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:44:46 INFO - mozversion platform_version: 48.0a1 08:44:46 INFO - using testdate: 1458315886 08:44:46 INFO - actual date: 1458315886 08:44:46 INFO - starting webserver on 'localhost:55068' 08:44:46 INFO - SUITE-START | Running 2 tests 08:44:46 INFO - TEST-START | dromaeo_css 08:44:46 INFO - operating with platform_type : linux_ 08:44:46 INFO - Initialising browser for dromaeo_css test... 08:44:46 INFO - TEST-INFO | started process 12432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Qjojq/profile http://localhost:55068/getInfo.html) 08:44:51 INFO - PROCESS | 12432 | __metrics Screen width/height:1600/1200 08:44:51 INFO - PROCESS | 12432 | colorDepth:24 08:44:51 INFO - PROCESS | 12432 | Browser inner width/height: 1024/697 08:44:51 INFO - PROCESS | 12432 | __metrics 08:44:52 ERROR - PROCESS | 12432 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:44:52 INFO - PROCESS | 12432 | 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. 08:44:53 INFO - TEST-INFO | 12432: exit 0 08:44:53 INFO - Browser initialized. 08:44:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:53 INFO - TEST-INFO | started process 12526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0Qjojq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:05 INFO - PROCESS | 12526 | RSS: Main: 154730496 08:45:05 INFO - PROCESS | 12526 | 08:45:56 INFO - PROCESS | 12526 | 1458315956497 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] 08:48:08 INFO - PROCESS | 12526 | Cycle 1(1): loaded http://localhost:55068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55068/tests/dromaeo/cssquery-ext.html) 08:48:09 INFO - PROCESS | 12526 | RSS: Main: 247681024 08:48:09 INFO - PROCESS | 12526 | 08:51:11 INFO - PROCESS | 12526 | Cycle 1(1): loaded http://localhost:55068/tests/dromaeo/cssquery-ext.html (next: http://localhost:55068/tests/dromaeo/cssquery-jquery.html) 08:51:12 INFO - PROCESS | 12526 | RSS: Main: 249454592 08:51:12 INFO - PROCESS | 12526 | 08:54:13 INFO - PROCESS | 12526 | Cycle 1(1): loaded http://localhost:55068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55068/tests/dromaeo/cssquery-mootools.html) 08:54:14 INFO - PROCESS | 12526 | RSS: Main: 233631744 08:54:14 INFO - PROCESS | 12526 | 08:57:16 INFO - PROCESS | 12526 | Cycle 1(1): loaded http://localhost:55068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55068/tests/dromaeo/cssquery-prototype.html) 08:57:17 INFO - PROCESS | 12526 | RSS: Main: 209674240 08:57:17 INFO - PROCESS | 12526 | 09:00:19 INFO - PROCESS | 12526 | Cycle 1(1): loaded http://localhost:55068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55068/tests/dromaeo/cssquery-yui.html) 09:00:20 INFO - PROCESS | 12526 | RSS: Main: 205914112 09:00:20 INFO - PROCESS | 12526 | 09:03:22 INFO - PROCESS | 12526 | Cycle 1(1): loaded http://localhost:55068/tests/dromaeo/cssquery-yui.html (next: http://localhost:55068/tests/dromaeo/cssquery-dojo.html) 09:03:23 INFO - PROCESS | 12526 | RSS: Main: 297349120 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | __start_tp_report 09:03:23 INFO - PROCESS | 12526 | _x_x_mozilla_page_load 09:03:23 INFO - PROCESS | 12526 | _x_x_mozilla_page_load_details 09:03:23 INFO - PROCESS | 12526 | |i|pagename|runs| 09:03:23 INFO - PROCESS | 12526 | |0;dojo.html;2590.7538783815535;2674.2486753024687;2677.1165515379926;2678.477696849113;2716.293763621458;4575.062112266985;4634.050019745952;4645.5586719261655;4649.30260460931;4652.185867473191;4609.377734005917;4648.116857797017;4691.319758634996;4704.764761761915;4714.9528504714945;4303.462067241595;4311.439512863323;4312.3531470279395;4323.200207961521;4438.711483753562;4235.1529694061155;4380.189664911985;4396.450443694538;4433.866983990485;4450.154470650582;4285.057287396783;4307.440032795748;4334.869953901388;4367.061081867382;4373.409589705413;4300.6344460720875;4302.698811083194;4323.740575565476;4339.088791353819;4356.956430435686;4227.387028880826;4299.312110062407;4300.913981720348;4313.633341165973;4350.347447882811;4568.588827005586;4603.539646035403;4614.700044497131;4627.305904114376;4657.813687452498;5033.421156567005;5055.823046193365;5062;5063.898722025576;5094;4930.605551555867;5024.874378140576;5064.392272927273;5084.77118529667;5107.208382700687;4659.4175728034;4662.836800711959;4669.089527542097;4692.319613656035;4696.436427628706;5067.163917953497;5067.569256613156;5067.97466012675;5104.03023425548;5115.360579927509;4799.544043315879;4879.34128892595;4897.706137631753;4959.528844759742;4964.826231081895;4982.3522942018035;4983.5763960063805;5010.699358038456;5011.498850114959;5055.165897626924;4970.204767237225;4976.601871850244;4977.576905963034;4984.825531106394;5025.698458092453;4804.903901921942;4924.901501969941;4982.377202849644;5039.042581909425;5041.420236672756;4299.871003869889;4346.826126954949;4348.326009468474;4349;4386.429764130707;3720.1443667956523;3790;3796.7911764853197;3811.4092315691114;3858.7298889077497;4235.322348424237;4250.893727656833;4286.6999310047995;4322.632576231055;4327.978360108179;5007.624428167829;5026.195808670595;5036.7733451994745;5044.268581055726;5065.8733531662;4198.475190601175;4300.161468513672;4316.913661726748;4317.093410383792;4363.105563359503;4502.279635258343;4534.523874993079;4552.089582083597;4568.1548913451115;4579.5878370946775;4649.558291962258;4654.97672511642;4655.650826188117;4665.2768820832825;4667.883302917454;4905.092557876804;4909.0672772173175;4930.457649658606;4963.081829861487;4966.850994470172;4750.809967601257;4768.928466072943;4776.355192049168;4783.402074740658;4823.710577365369;4933.925991110064;4960.057589058068;4962.851114466572;4970.577500912463;5006.674566153334;4895.510448955076;5010.5240002199735;5041.899162016813;5080.745962701924;5083.161278389024;4819.879503012453;4853.6359773017875;4855.077535268429;4877.756112194447;4900.558949694545;4875.390576177978;4876.097921884463;4881.8535443936735;4888.7311197884455;4918.631102667386;4711.952880471152;4752.2158843790385;4821.035792841516;4824;4839.733814640229;4878.048780487771;4882.902341953212;4901.950980490292;4903.803847846189;4954.157793175241;4790.305405716222;4797.136515427256;4803.711777293373;4803.759812009315;4836.637252206169 09:03:23 INFO - PROCESS | 12526 | |1;ext.html;540.2868213957577;553.0570377506355;559.4070285497373;560.170946998442;569.7265312649928;26734.86632566837;34539.65460345396;34541.65458345419;34557.481637775454;34682.26588670569;40579.79710101453;41553.37669934954;41565.376519352234;41582.16835663285;41583.16833663332;7654.272844079804;7824.5696486693205;7829.921700783005;7835.608219588998;7839.568823714693;7799.922000780005;7898.368130549542;7932.8810067848735;7948;7952.165022672622;7923.6038198090155;7972.920270797275;7978.720744773934;7990.2009799019925;7994.200579942018;7880.330171935392;7939.325157361631;7947.5231486111015;7953.840923181562;7958.363330933512;7846.803829904298;7948;7989.081255655616;7989.800254993672;7990.880136797953;39041.41437878434;39283.21433571313;39360.21279574392;39499.21001579952;39526.60473395258;2957.881684732608;3015.1406849047917;3016.6078409806805;3032.6360836699737;3104.239461331988;29530.55704164439;29595.408091838042;30069;30330.762061512392;30769.230769230726;3367.7810942288675;3370.1237678203597;3390.9660903390895;3425.1265927188656;3481.0775144586705;236922;236997;237646;239119;240950;43850.342244866355;57840.132398014066;58363.416365836645;58440.415595844344;58445.70777146172;42153;42316;42589.14821703549;42717;42735.786321068816;13016.609501714964;13222.206667599974;13225.867741322463;13233.470661173638;13243.933780331037;10179.44013079273;10243.897561024443;10263.794724105475;10265.281430299807;10269.691909242734;14556.708865822837;14637.780433293296;15148.16685082331;15170.620734481505;15309.846901531066;5831.183634291203;6012.699365031731;6084;6105.419985101408;6163.7842675506145;846.2848892685671;856.9185927336893;905.6920646980059;930.5347326336831;1001.1940387987739;27557.173284801487;27560.724392755816;28364.574531382044;28366.290842729097;28627.427451451273;958.3339578992533;989.4459102902398;1041.6979076068008;1126.718320419895;1132.0603898764007;14232.786508202385;14506.782398264035;14568.271586420637;14674.972751907477;14861.331240094221;296295;301262;301763;302085;302465;48234;48707;48840.511594883596;48875.266870996966;48914.75542622264;1149.9137564682683;1173.4895320535425;1208.7763763703742;1268.105985280375;1268.657462485124;24914.750852491245;27218.869829969808;27573.44853102967;27847.44305113846;27941.720582794725;37157.25685486329;37237.6276237245;37696;37992.620073798906;38100.237995240495;166664.16667917068;167330;167663;173024.1348793248;176513.117434412;27349.863250684415;27763.722362776112;31194.532082019243;31874.20314492156;32282.35435291234;35639.64360356363;36230.818845905604;36660.90017299485;36704.449433257985;36713;32217.51673724849;33384.83307583447;33967.83016084904;34157.487637685954;34421.65578344184;33577.49633755447;33645.32709345848;33788.83105584457;33798.3240335187;34123.317533649686;33340.499892502114;33643;33658.32683346271;33973;33999.66000339965;29993.700062999964;30150.69849301479;30604.234894127825;30613.23466913345;30676;24096.75903241015;24124.27627171188;24132.517349652557;24326.878365608765;24382.51234975326 09:03:23 INFO - PROCESS | 12526 | |2;jquery.html;339.69257821671385;357.2390807579856;357.3175235300575;364.9434337677659;366.4247132002757;15370.615734606627;15733.685326293467;17108.74336884946;17565;17603.295868165256;16636.334546618153;16934;17026;17092.914535427306;17161.399351022716;4801.18379875422;4803;4979.601631869442;5812.854678633025;5856.15085812559;5050.3434553508;5885.4114588541015;5892;5904.7047647617665;5909;5492.176173573976;5717.942820571803;5729.427057294279;5756.913646295309;5863.76544938202;5645.350784659735;5650.350209725893;5654;5665.716714164317;5704.515116215127;4816.470188279286;4915.188993816016;5006.299118123466;5026.748662566857;5034.270030845543;11513.194076414655;11637.127215458875;11712.355820429873;11747.647570572897;11890.048796096378;1881.61426907485;1889.6409682160483;1921.3371386871506;1927.9325223617245;1932.7970563090955;8870.778230544289;8908.8663670045;8921.46471211723;9317;9405.529723513797;1737.2963949600432;1744.4766570029067;1761.7621621081119;1839.6964500857343;1845.1973391574709;55863;56844.71577642085;57312.42687573113;59023;63438.365616343704;9870.506474676238;10186.337888037255;10303.690889273334;10324.845127323097;10564.260501764802;13610.38753256086;13749.450021999008;13753.174809511462;13765;13768;6979.371856532936;7044.964775176194;7278.745243916437;7295.963520182471;7348.375388091965;6495.902561461582;6543.574667646588;6556.63938483388;6679.465642748569;6727.730890764315;4476.776161191928;4524.25349817283;4539;4549.749763763025;4606.88482787933;1762.436020473462;1789.4721057288132;1795.3895675470403;1826.5981484073482;1832.3311991123144;816.7713040348712;852.4118358332854;856.4090777363599;921.755734730297;929.2473096791621;15865.286062127232;15985.280662369989;16088.839111608968;16382.83617163837;16575.144723722755;879.0857508191409;885.7431344910033;887.3965703321803;897.5691667999266;930.3441074042784;9254.167124958785;9516.476593787269;9525.428474291564;9578;9757.316987810927;380782;412937;413350;413603;413858;63779.68110159419;64567.677161613894;65122;66294;69389.65305173442;979.4955597867104;983.5475681186734;985.3004366899438;1019.8929112443235;1021.596469394585;15089;15296.541103766906;15302.234888255765;15431.074135551902;15759.448419305269;33219.169520762174;33716;33821.492677610346;34560.135996600286;34820.47769283412;45933;46642.067158657315;46762;46838;47010.76494617505;7539.32146106853;7544;7580.128285247267;7662.540247585162;7729.922700773145;8595.914040859512;11586.073114150679;11607.419629018685;11639.359835208807;11700.765984680089;10106.848397274194;10207.132393746318;10273.74315642115;10306.948465257627;10400.087975366909;9706.951465242628;10028.197744180594;10133.64532241368;10223.386596803917;10589.4705264738;10082.647107351208;10385.584576616851;10393.220508461744;10552.261341706007;10685.57257709683;7535.660895259617;7552.735654252075;7581.3176814087;7714.537127772352;7760.650770715444;9993.500324983575;10375.169986400919;10397.32417392867;10401.843972340572;10509.159267258448 09:03:23 INFO - PROCESS | 12526 | |3;mootools.html;1268.6511209417404;1422.644338915271;1423.6085076603933;1589.785378973838;1771.7785276840395;7131.21556628771;7308.196098429175;7329.047223860904;7338.743143989961;7342.008828808116;7415.555066696002;7551.886721699179;7597.31624153826;7598.240175982399;7601.391888648908;1949.62957038163;2261.42333704905;2314.166899916029;2335.0543030072804;2346.8826558672085;2283.4291427143216;2289.9313020609407;2296.689946857178;2301.3786277705008;2302.539492101578;2230.3309007297826;2265.5808675395024;2269.2284623228184;2269.4439862233694;2270.6366981283;2244.046280330853;2256.7404748453973;2264.762199969004;2266.150193677371;2275.374272075176;2253.233900473847;2253.6732173834703;2271.182374345251;2273.45437095096;2320.4082958845556;7672.846543069163;7738.380929525624;7743.148253692146;7743.574103424309;7746.341560967325;4717.622590192776;4863.465018847924;4870;4898.902021959577;4900.607951363882;3085.3058061935885;3106.8446577671025;3119.391718614871;3141.780075394723;3162.0513845846153;1003.7189586915603;1030.3251370352432;1038.5741845843243;1069.3209811769582;1075.3225467955217;10809.459527023697;10837.295575787628;10858.402787846666;10874.782504349869;10890.673279801618;4492.415985921809;4561.087782443525;4640.071985602893;4641.976790116028;4642.3500709900645;8287.8342433151;8361.080281169066;8370.665173392996;8373.874391884126;8379.539125348043;4062.5937406259727;4698.154332220165;4754.453237877619;4756.976215118972;4758.976205118952;3761.774293542396;3763.0592351912023;3799.316123097869;4237.8304867805555;4386.956130438719;3555.6622120898473;3623.510826038451;3627.8004709741217;3656.4880916671686;3685.9262814744093;1109.944502774858;1118.5022664914036;1120.8486854274731;1127.8477405550145;1132.9603463878725;1103.7626910214342;1130;1155.5204590095016;1156.0809156720427;1191.255465334166;7161.033260509868;7239.89140162898;7288.344049035506;7293.781186564412;7305.050343455423;478.2825761357963;483.7943873853598;486.9853904382874;487.7853744352544;488.5261296542419;5280.577553795687;5306.389765177054;5341.0653135701095;5348.224507446398;5355.678659280456;8680.479171249619;8772.254358379609;9025.097490250922;9054.049324820931;9063.456192628464;8964.775880603038;8971.461712297283;8973.416727912796;8975.910240897507;9013.63945442175;6875.5874647521305;7061;7118.110236220473;7125.323094306136;7135.250798666273;6641.667916604054;6679.265280819009;6702.229243636849;6715.3620406061345;6715.630640314829;7779.260970207822;7959.801004974922;8024.679012839421;8144.674213031412;8156.632951517315;8171.959140204261;8286.378521610783;8335.624896879533;8455.788605284917;8465.576721163794;5532.2254884315425;6014.158017877413;6159.6612186330185;6272.686365681789;6423.325550817097;7187.712491500281;7200.099987501562;7246.166690830411;7247.094113235846;7254.05697259374;6260.311231997168;6268.968655156695;6276.968615156895;6439.452646525097;6549.0176473527445;6467.126937863328;6504.6747662615735;6532.902006470002;6610.867782644224;6699.698513566804;6911.93088069133;6919.20429150634;6955.374016338352;6964.512484126062;6980.965095174492;6031.819045428644;6082.391760824059;6138.631682099089;6165.907511387422;6189.783357582463;6313.715882785194;6327.050942358683;6350.872982540416;6358.427741503287;6363.6181829088555 09:03:23 INFO - PROCESS | 12526 | |4;prototype.html;319.6675457524175;319.88644031368864;321.1265358225626;321.92434777827214;326.15200478755224;5376.1398176291805;5418.7019713915715;5423.511883930445;5435.673859568428;5452.672839629615;5333.706646134461;5373.140297552392;5380.300560927074;5384.488473595012;5389.110796718537;4022.658074063708;4116.217918595472;4178;4228.26005449046;4230.280852255109;4208.389783481393;4216.304309788881;4225.830966761341;4245.384419259206;4258.829646814123;4200.243956087903;4209.49486061673;4214.115035842477;4214.136102099078;4222.725522841006;4025.114474815521;4107.486564179478;4186.162767446523;4210.789460526961;4217.957820421787;3713.0531714412923;3716.7026637868908;3717.7211709121925;3727.788468747668;3733.141377483194;5202.661826981272;5202.791888324463;5207.739613019372;5209.4009188943;5228.372595288552;4840.298156767249;4842.685225460369;4842.830500932486;4845.248986407112;4847.4667786543805;5687.7156142193135;5700.800471983503;5701.429857014306;5702.65784052954;5703.971480142614;4091.161311931047;4092.1406504634065;4094.549599544048;4095.3242714952;4103.815328310233;5687.800926967537;5966.642001479881;5967.731452084623;5968.70156492178;5971.581989260753;4195.517515485697;4214.726042807208;4216.662666986634;4219.346001369792;4221.345691417835;4269.188854117708;4271.9786401067795;4274.444322238089;4281.914361712748;4284.571542845691;4842.5157484251995;4843.346148270009;4845.418549773979;4853.417589889165;4854.708717476963;5686.630369026;5716.857078573069;5719.084946408555;5724.484796368347;5724.713764311768;1468.9118652880861;1484.784706217614;1508.939642414291;1509.7961775160431;1510.5770384292416;968.9079537443931;1029.4080903480378;1038.361407734238;1038.6883934819523;1062.6811956413046;4848.7090774553635;4938.802447902115;4943.332650092263;4947;4955.578775804025;5872.17789509469;5915.940840591625;5916.201312822714;5916.319623243296;5929.970350148308;4968.478309777493;4979.30289759434;4982.825601103944;4988.077205716954;4992.525710057539;3133.623965124154;3173.1591128351006;3178.666240044762;3181.316017056344;3185.617725872864;5575.721213939287;5584.553235741131;5585.525230355384;5586.692731899703;5589.385167631557;5753.741081651336;6053.424924632153;6054.182685337511;6061.939380606225;6107.053406721965;5516.117421212587;5553.8333849984565;5559.610827242054;5560.638558493685;5563.916541251803;5879.94120058811;5889.970550147222;5890.852728681817;5895.764169433174;5901.114832775118;5736.885262294814;5795.391483894299;5795.82612521625;5796.681182535001;5806.796762113306;5406.75669594877;5545.750441230073;5566.91649625264;5572.136318870582;5578.30271216098;4184.91630167401;4222.3244280914905;4229.217594744982;4229.851955181553;4232.703710740218;5857.414258574108;5884.970575147268;5894.528437725057;5896.056630939029;5897.469227769521;5673.149027645886;5693.231413759255;5737.053386191398;5747.08046712524;5749.453801888814;5675.091985282335;5675.120356344773;5677.091665333527;5678.858028549319;5690.943090569207;5410.431904649955;5592.692401917933;5601.019821531134;5602.887942241051;5616.326040875121;5703.515201207778;5704.857378565403;5707.7716891325545;5729.312482502127;5762.855928601818;5604.551635869202;5614.831555053355;5615.354234263112;5620.606557540933;5622.32532096151 09:03:23 INFO - PROCESS | 12526 | |5;yui.html;631.9178506794116;686.6532401137425;771.8996530451038;782.4952905376033;802.1657476224726;12640.49438022478;12722.554710585144;12791.16857404268;12798.808017879739;12820.102592818495;12047.698807529816;13881.444742210324;14051.648708782286;14094;14146.858531414682;814.5235037503053;827.2058823529419;830.6511265268601;830.8047608811925;831.1688311688312;610.5481943361902;813.0487329824091;829.1459796409707;835.6364981233153;835.9665613375457;854.7905763088052;860.1914200651368;860.2214995429147;860.7159637319669;861.5390765940223;675.0549231076483;844.2275318083946;847.1189962439117;848.1942154952789;848.6775025490335;620.1349117980437;627.3726273726273;627.5011365964069;628.4877824572958;628.9150964619763;12711.237325760483;12805.167664101804;12820;12838.486460541568;12859.807102893465;11640.18518703691;11854.3480108594;12031.51873925042;12036;12385.75228495434;9944.502774861228;9975.221486012833;9983.850242246299;10041.648542300984;10204.489775511194;3237.983810080958;3287.3918325109694;3327.2680010397676;3328.051505320972;3328.3010567780793;44331.33502997425;44415;44481.33278000833;44492.332615010804;44646;9532.853392729226;9571.61713531451;9578.56896439662;9615.615375385047;9720;17445.21496532659;17517.12414379276;17555.912220438815;17586.03276819787;17592.38426655061;6892.689828957709;6904.275051119661;6948.687309071104;7043.894341584881;7222.241664625244;3604.4953706481115;3751.362268414376;3872.554656214515;3883.708721845873;3902.785346805953;2885.7114288570974;2937.1775902746836;2937.6327959005125;2938.4710752064407;2943.234758962685;525.3616855520561;526.6339893773791;527.7387693091868;540.3650710415246;545.1767830575859;542.500899172762;551.8730691940876;561.2086957390061;568.5508448325776;573.3349314794818;7428.442866784904;7445.255474452511;7608.505447145918;7838.529688218725;7987.720429784929;464.9628029757611;553.4576115406924;556.966582005081;557.6988426249861;570.3127731084116;3554.1647712787476;3569.839357228931;3612.4942508048894;3693.242885208526;3764.0778009387877;48973.265401019016;49246.75376623094;49352;49815.75092124516;53428;44519.77740111343;45591;45895.31157032647;45920.54079459162;45950.080998379846;40856.59143408587;42830.78584607057;42896.356554651706;43124.568754312684;43411.34882976758;7940.801479963047;8141.267285944294;8243.917560824315;8263.929560547678;8399.622017009371;32307.51538726968;32493.025209243762;32554;33222.335553288314;33379.49930750992;37527.624723752415;37542;39656.40515392329;41982;42340.576594233666;10109.595616175271;10388.42863642507;10409.1672666185;10532.736681583021;10578.8942110581;11415.714607134889;11549.711257218636;11558;12180.695482613006;12287.87712122903;10680;10722.356658600509;10808.675739727822;10834.837477438003;11051.778964420828;10788.784224315626;10941.45292735344;11167.832482512931;11383.43082845871;11394.202405831513;10197.082262596401;10285.640002599874;10439.739006524898;10916.962888525577;10932.234743568191;8295.336373090258;8357.247847693494;8593.097724739062;8663.783405414662;8855.158759917798;8375.095557631977;9240.168384845396;9273.814523709352;9395.577199025924;9549.522523873917 09:03:23 INFO - PROCESS | 12526 | __end_tp_report 09:03:23 INFO - PROCESS | 12526 | __start_cc_report 09:03:23 INFO - PROCESS | 12526 | _x_x_mozilla_cycle_collect,913 09:03:23 INFO - PROCESS | 12526 | __end_cc_report 09:03:23 INFO - PROCESS | 12526 | __startTimestamp1458317003177__endTimestamp 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | ------- Summary: start ------- 09:03:23 INFO - PROCESS | 12526 | Number of tests: 6 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | [#0] dojo.html Cycles:165 Average:4633.37 Median:4752.22 stddev:467.76 (9.8%) stddev-sans-first:440.89 09:03:23 INFO - PROCESS | 12526 | Values: 2590.8 2674.2 2677.1 2678.5 2716.3 4575.1 4634.1 4645.6 4649.3 4652.2 4609.4 4648.1 4691.3 4704.8 4715.0 4303.5 4311.4 4312.4 4323.2 4438.7 4235.2 4380.2 4396.5 4433.9 4450.2 4285.1 4307.4 4334.9 4367.1 4373.4 4300.6 4302.7 4323.7 4339.1 4357.0 4227.4 4299.3 4300.9 4313.6 4350.3 4568.6 4603.5 4614.7 4627.3 4657.8 5033.4 5055.8 5062.0 5063.9 5094.0 4930.6 5024.9 5064.4 5084.8 5107.2 4659.4 4662.8 4669.1 4692.3 4696.4 5067.2 5067.6 5068.0 5104.0 5115.4 4799.5 4879.3 4897.7 4959.5 4964.8 4982.4 4983.6 5010.7 5011.5 5055.2 4970.2 4976.6 4977.6 4984.8 5025.7 4804.9 4924.9 4982.4 5039.0 5041.4 4299.9 4346.8 4348.3 4349.0 4386.4 3720.1 3790.0 3796.8 3811.4 3858.7 4235.3 4250.9 4286.7 4322.6 4328.0 5007.6 5026.2 5036.8 5044.3 5065.9 4198.5 4300.2 4316.9 4317.1 4363.1 4502.3 4534.5 4552.1 4568.2 4579.6 4649.6 4655.0 4655.7 4665.3 4667.9 4905.1 4909.1 4930.5 4963.1 4966.9 4750.8 4768.9 4776.4 4783.4 4823.7 4933.9 4960.1 4962.9 4970.6 5006.7 4895.5 5010.5 5041.9 5080.7 5083.2 4819.9 4853.6 4855.1 4877.8 4900.6 4875.4 4876.1 4881.9 4888.7 4918.6 4712.0 4752.2 4821.0 4824.0 4839.7 4878.0 4882.9 4902.0 4903.8 4954.2 4790.3 4797.1 4803.7 4803.8 4836.6 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | [#1] ext.html Cycles:180 Average:39542.57 Median:18594.65 stddev:63357.87 (340.7%) stddev-sans-first:63467.93 09:03:23 INFO - PROCESS | 12526 | Values: 540.3 553.1 559.4 560.2 569.7 26734.9 34539.7 34541.7 34557.5 34682.3 40579.8 41553.4 41565.4 41582.2 41583.2 7654.3 7824.6 7829.9 7835.6 7839.6 7799.9 7898.4 7932.9 7948.0 7952.2 7923.6 7972.9 7978.7 7990.2 7994.2 7880.3 7939.3 7947.5 7953.8 7958.4 7846.8 7948.0 7989.1 7989.8 7990.9 39041.4 39283.2 39360.2 39499.2 39526.6 2957.9 3015.1 3016.6 3032.6 3104.2 29530.6 29595.4 30069.0 30330.8 30769.2 3367.8 3370.1 3391.0 3425.1 3481.1 236922.0 236997.0 237646.0 239119.0 240950.0 43850.3 57840.1 58363.4 58440.4 58445.7 42153.0 42316.0 42589.1 42717.0 42735.8 13016.6 13222.2 13225.9 13233.5 13243.9 10179.4 10243.9 10263.8 10265.3 10269.7 14556.7 14637.8 15148.2 15170.6 15309.8 5831.2 6012.7 6084.0 6105.4 6163.8 846.3 856.9 905.7 930.5 1001.2 27557.2 27560.7 28364.6 28366.3 28627.4 958.3 989.4 1041.7 1126.7 1132.1 14232.8 14506.8 14568.3 14675.0 14861.3 296295.0 301262.0 301763.0 302085.0 302465.0 48234.0 48707.0 48840.5 48875.3 48914.8 1149.9 1173.5 1208.8 1268.1 1268.7 24914.8 27218.9 27573.4 27847.4 27941.7 37157.3 37237.6 37696.0 37992.6 38100.2 166664.2 167330.0 167663.0 173024.1 176513.1 27349.9 27763.7 31194.5 31874.2 32282.4 35639.6 36230.8 36660.9 36704.4 36713.0 32217.5 33384.8 33967.8 34157.5 34421.7 33577.5 33645.3 33788.8 33798.3 34123.3 33340.5 33643.0 33658.3 33973.0 33999.7 29993.7 30150.7 30604.2 30613.2 30676.0 24096.8 24124.3 24132.5 24326.9 24382.5 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | [#2] jquery.html Cycles:180 Average:23696.50 Median:4544.37 stddev:66693.42 (1467.6%) stddev-sans-first:66857.45 09:03:23 INFO - PROCESS | 12526 | Values: 339.7 357.2 357.3 364.9 366.4 15370.6 15733.7 17108.7 17565.0 17603.3 16636.3 16934.0 17026.0 17092.9 17161.4 4801.2 4803.0 4979.6 5812.9 5856.2 5050.3 5885.4 5892.0 5904.7 5909.0 5492.2 5717.9 5729.4 5756.9 5863.8 5645.4 5650.4 5654.0 5665.7 5704.5 4816.5 4915.2 5006.3 5026.7 5034.3 11513.2 11637.1 11712.4 11747.6 11890.0 1881.6 1889.6 1921.3 1927.9 1932.8 8870.8 8908.9 8921.5 9317.0 9405.5 1737.3 1744.5 1761.8 1839.7 1845.2 55863.0 56844.7 57312.4 59023.0 63438.4 9870.5 10186.3 10303.7 10324.8 10564.3 13610.4 13749.5 13753.2 13765.0 13768.0 6979.4 7045.0 7278.7 7296.0 7348.4 6495.9 6543.6 6556.6 6679.5 6727.7 4476.8 4524.3 4539.0 4549.7 4606.9 1762.4 1789.5 1795.4 1826.6 1832.3 816.8 852.4 856.4 921.8 929.2 15865.3 15985.3 16088.8 16382.8 16575.1 879.1 885.7 887.4 897.6 930.3 9254.2 9516.5 9525.4 9578.0 9757.3 380782.0 412937.0 413350.0 413603.0 413858.0 63779.7 64567.7 65122.0 66294.0 69389.7 979.5 983.5 985.3 1019.9 1021.6 15089.0 15296.5 15302.2 15431.1 15759.4 33219.2 33716.0 33821.5 34560.1 34820.5 45933.0 46642.1 46762.0 46838.0 47010.8 7539.3 7544.0 7580.1 7662.5 7729.9 8595.9 11586.1 11607.4 11639.4 11700.8 10106.8 10207.1 10273.7 10306.9 10400.1 9707.0 10028.2 10133.6 10223.4 10589.5 10082.6 10385.6 10393.2 10552.3 10685.6 7535.7 7552.7 7581.3 7714.5 7760.7 9993.5 10375.2 10397.3 10401.8 10509.2 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | [#3] mootools.html Cycles:180 Average:5262.07 Median:5773.19 stddev:2726.01 (47.2%) stddev-sans-first:2717.13 09:03:23 INFO - PROCESS | 12526 | Values: 1268.7 1422.6 1423.6 1589.8 1771.8 7131.2 7308.2 7329.0 7338.7 7342.0 7415.6 7551.9 7597.3 7598.2 7601.4 1949.6 2261.4 2314.2 2335.1 2346.9 2283.4 2289.9 2296.7 2301.4 2302.5 2230.3 2265.6 2269.2 2269.4 2270.6 2244.0 2256.7 2264.8 2266.2 2275.4 2253.2 2253.7 2271.2 2273.5 2320.4 7672.8 7738.4 7743.1 7743.6 7746.3 4717.6 4863.5 4870.0 4898.9 4900.6 3085.3 3106.8 3119.4 3141.8 3162.1 1003.7 1030.3 1038.6 1069.3 1075.3 10809.5 10837.3 10858.4 10874.8 10890.7 4492.4 4561.1 4640.1 4642.0 4642.4 8287.8 8361.1 8370.7 8373.9 8379.5 4062.6 4698.2 4754.5 4757.0 4759.0 3761.8 3763.1 3799.3 4237.8 4387.0 3555.7 3623.5 3627.8 3656.5 3685.9 1109.9 1118.5 1120.8 1127.8 1133.0 1103.8 1130.0 1155.5 1156.1 1191.3 7161.0 7239.9 7288.3 7293.8 7305.1 478.3 483.8 487.0 487.8 488.5 5280.6 5306.4 5341.1 5348.2 5355.7 8680.5 8772.3 9025.1 9054.0 9063.5 8964.8 8971.5 8973.4 8975.9 9013.6 6875.6 7061.0 7118.1 7125.3 7135.3 6641.7 6679.3 6702.2 6715.4 6715.6 7779.3 7959.8 8024.7 8144.7 8156.6 8172.0 8286.4 8335.6 8455.8 8465.6 5532.2 6014.2 6159.7 6272.7 6423.3 7187.7 7200.1 7246.2 7247.1 7254.1 6260.3 6269.0 6277.0 6439.5 6549.0 6467.1 6504.7 6532.9 6610.9 6699.7 6911.9 6919.2 6955.4 6964.5 6981.0 6031.8 6082.4 6138.6 6165.9 6189.8 6313.7 6327.1 6350.9 6358.4 6363.6 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | [#4] prototype.html Cycles:180 Average:4740.89 Median:5374.64 stddev:1370.02 (25.5%) stddev-sans-first:1333.06 09:03:23 INFO - PROCESS | 12526 | Values: 319.7 319.9 321.1 321.9 326.2 5376.1 5418.7 5423.5 5435.7 5452.7 5333.7 5373.1 5380.3 5384.5 5389.1 4022.7 4116.2 4178.0 4228.3 4230.3 4208.4 4216.3 4225.8 4245.4 4258.8 4200.2 4209.5 4214.1 4214.1 4222.7 4025.1 4107.5 4186.2 4210.8 4218.0 3713.1 3716.7 3717.7 3727.8 3733.1 5202.7 5202.8 5207.7 5209.4 5228.4 4840.3 4842.7 4842.8 4845.2 4847.5 5687.7 5700.8 5701.4 5702.7 5704.0 4091.2 4092.1 4094.5 4095.3 4103.8 5687.8 5966.6 5967.7 5968.7 5971.6 4195.5 4214.7 4216.7 4219.3 4221.3 4269.2 4272.0 4274.4 4281.9 4284.6 4842.5 4843.3 4845.4 4853.4 4854.7 5686.6 5716.9 5719.1 5724.5 5724.7 1468.9 1484.8 1508.9 1509.8 1510.6 968.9 1029.4 1038.4 1038.7 1062.7 4848.7 4938.8 4943.3 4947.0 4955.6 5872.2 5915.9 5916.2 5916.3 5930.0 4968.5 4979.3 4982.8 4988.1 4992.5 3133.6 3173.2 3178.7 3181.3 3185.6 5575.7 5584.6 5585.5 5586.7 5589.4 5753.7 6053.4 6054.2 6061.9 6107.1 5516.1 5553.8 5559.6 5560.6 5563.9 5879.9 5890.0 5890.9 5895.8 5901.1 5736.9 5795.4 5795.8 5796.7 5806.8 5406.8 5545.8 5566.9 5572.1 5578.3 4184.9 4222.3 4229.2 4229.9 4232.7 5857.4 5885.0 5894.5 5896.1 5897.5 5673.1 5693.2 5737.1 5747.1 5749.5 5675.1 5675.1 5677.1 5678.9 5690.9 5410.4 5592.7 5601.0 5602.9 5616.3 5703.5 5704.9 5707.8 5729.3 5762.9 5604.6 5614.8 5615.4 5620.6 5622.3 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - PROCESS | 12526 | [#5] yui.html Cycles:180 Average:12751.35 Median:44506.06 stddev:14323.91 (32.2%) stddev-sans-first:14335.17 09:03:23 INFO - PROCESS | 12526 | Values: 631.9 686.7 771.9 782.5 802.2 12640.5 12722.6 12791.2 12798.8 12820.1 12047.7 13881.4 14051.6 14094.0 14146.9 814.5 827.2 830.7 830.8 831.2 610.5 813.0 829.1 835.6 836.0 854.8 860.2 860.2 860.7 861.5 675.1 844.2 847.1 848.2 848.7 620.1 627.4 627.5 628.5 628.9 12711.2 12805.2 12820.0 12838.5 12859.8 11640.2 11854.3 12031.5 12036.0 12385.8 9944.5 9975.2 9983.9 10041.6 10204.5 3238.0 3287.4 3327.3 3328.1 3328.3 44331.3 44415.0 44481.3 44492.3 44646.0 9532.9 9571.6 9578.6 9615.6 9720.0 17445.2 17517.1 17555.9 17586.0 17592.4 6892.7 6904.3 6948.7 7043.9 7222.2 3604.5 3751.4 3872.6 3883.7 3902.8 2885.7 2937.2 2937.6 2938.5 2943.2 525.4 526.6 527.7 540.4 545.2 542.5 551.9 561.2 568.6 573.3 7428.4 7445.3 7608.5 7838.5 7987.7 465.0 553.5 557.0 557.7 570.3 3554.2 3569.8 3612.5 3693.2 3764.1 48973.3 49246.8 49352.0 49815.8 53428.0 44519.8 45591.0 45895.3 45920.5 45950.1 40856.6 42830.8 42896.4 43124.6 43411.3 7940.8 8141.3 8243.9 8263.9 8399.6 32307.5 32493.0 32554.0 33222.3 33379.5 37527.6 37542.0 39656.4 41982.0 42340.6 10109.6 10388.4 10409.2 10532.7 10578.9 11415.7 11549.7 11558.0 12180.7 12287.9 10680.0 10722.4 10808.7 10834.8 11051.8 10788.8 10941.5 11167.8 11383.4 11394.2 10197.1 10285.6 10439.7 10917.0 10932.2 8295.3 8357.2 8593.1 8663.8 8855.2 8375.1 9240.2 9273.8 9395.6 9549.5 09:03:23 INFO - PROCESS | 12526 | -------- Summary: end -------- 09:03:23 INFO - PROCESS | 12526 | 09:03:23 INFO - TEST-INFO | 12526: exit 0 09:03:23 INFO - TEST-OK | dromaeo_css | took 1117348ms 09:03:23 INFO - TEST-START | kraken 09:03:23 INFO - operating with platform_type : linux_ 09:03:23 INFO - Initialising browser for kraken test... 09:03:23 INFO - TEST-INFO | started process 12705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKA7MM3/profile http://localhost:55068/getInfo.html) 09:03:28 INFO - PROCESS | 12705 | __metrics Screen width/height:1600/1200 09:03:28 INFO - PROCESS | 12705 | colorDepth:24 09:03:28 INFO - PROCESS | 12705 | Browser inner width/height: 1024/697 09:03:28 INFO - PROCESS | 12705 | __metrics 09:03:29 ERROR - PROCESS | 12705 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:03:30 INFO - TEST-INFO | 12705: exit 0 09:03:30 INFO - Browser initialized. 09:03:30 INFO - Running cycle 1/1 for kraken test... 09:03:30 INFO - TEST-INFO | started process 12787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKA7MM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:42 INFO - PROCESS | 12787 | RSS: Main: 155492352 09:03:42 INFO - PROCESS | 12787 | 09:03:44 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55068/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:45 INFO - PROCESS | 12787 | RSS: Main: 194797568 09:03:45 INFO - PROCESS | 12787 | 09:03:48 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55068/tests/kraken/driver.html?testName=audio-dft) 09:03:48 INFO - PROCESS | 12787 | RSS: Main: 185442304 09:03:48 INFO - PROCESS | 12787 | 09:03:51 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55068/tests/kraken/driver.html?testName=audio-fft) 09:03:52 INFO - PROCESS | 12787 | RSS: Main: 173486080 09:03:52 INFO - PROCESS | 12787 | 09:03:54 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55068/tests/kraken/driver.html?testName=audio-oscillator) 09:03:55 INFO - PROCESS | 12787 | RSS: Main: 174600192 09:03:55 INFO - PROCESS | 12787 | 09:03:57 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:57 INFO - PROCESS | 12787 | RSS: Main: 175759360 09:03:57 INFO - PROCESS | 12787 | 09:04:01 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55068/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:01 INFO - PROCESS | 12787 | RSS: Main: 176963584 09:04:01 INFO - PROCESS | 12787 | 09:04:05 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55068/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:05 INFO - PROCESS | 12787 | RSS: Main: 177278976 09:04:05 INFO - PROCESS | 12787 | 09:04:08 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55068/tests/kraken/driver.html?testName=json-parse-financial) 09:04:09 INFO - PROCESS | 12787 | RSS: Main: 175480832 09:04:09 INFO - PROCESS | 12787 | 09:04:10 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:11 INFO - PROCESS | 12787 | RSS: Main: 185778176 09:04:11 INFO - PROCESS | 12787 | 09:04:13 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:13 INFO - PROCESS | 12787 | RSS: Main: 182284288 09:04:13 INFO - PROCESS | 12787 | 09:04:15 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:16 INFO - PROCESS | 12787 | RSS: Main: 193941504 09:04:16 INFO - PROCESS | 12787 | 09:04:18 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:19 INFO - PROCESS | 12787 | RSS: Main: 197529600 09:04:19 INFO - PROCESS | 12787 | 09:04:22 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:22 INFO - PROCESS | 12787 | RSS: Main: 196071424 09:04:22 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | Cycle 1(1): loaded http://localhost:55068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55068/tests/kraken/driver.html?testName=ai-astar) 09:04:24 INFO - PROCESS | 12787 | RSS: Main: 258383872 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | __start_tp_report 09:04:24 INFO - PROCESS | 12787 | _x_x_mozilla_page_load 09:04:24 INFO - PROCESS | 12787 | _x_x_mozilla_page_load_details 09:04:24 INFO - PROCESS | 12787 | |i|pagename|runs| 09:04:24 INFO - PROCESS | 12787 | |0;ai-astar;110;113;106;111;112;112;102;112;110;111 09:04:24 INFO - PROCESS | 12787 | |1;audio-beat-detection;162;129;156;182;135;160;150;131;177;134 09:04:24 INFO - PROCESS | 12787 | |2;audio-dft;162;164;163;161;161;162;161;164;163;163 09:04:24 INFO - PROCESS | 12787 | |3;audio-fft;74;74;100;96;73;75;74;118;99;73 09:04:24 INFO - PROCESS | 12787 | |4;audio-oscillator;95;94;135;95;94;94;140;93;94;136 09:04:24 INFO - PROCESS | 12787 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:04:24 INFO - PROCESS | 12787 | |6;imaging-darkroom;147;146;148;146;145;146;146;146;145;146 09:04:24 INFO - PROCESS | 12787 | |7;imaging-desaturate;96;95;96;97;96;97;96;96;96;96 09:04:24 INFO - PROCESS | 12787 | |8;json-parse-financial;64;64;65;65;64;65;64;72;63;62 09:04:24 INFO - PROCESS | 12787 | |9;json-stringify-tinderbox;65;65;63;64;63;64;65;64;64;64 09:04:24 INFO - PROCESS | 12787 | |10;stanford-crypto-aes;80;82;82;81;81;81;81;81;81;84 09:04:24 INFO - PROCESS | 12787 | |11;stanford-crypto-ccm;117;119;113;115;125;122;114;116;115;115 09:04:24 INFO - PROCESS | 12787 | |12;stanford-crypto-pbkdf2;142;140;141;144;143;129;148;139;138;152 09:04:24 INFO - PROCESS | 12787 | |13;stanford-crypto-sha256-iterative;65;67;65;65;68;64;65;65;66;64 09:04:24 INFO - PROCESS | 12787 | __end_tp_report 09:04:24 INFO - PROCESS | 12787 | __start_cc_report 09:04:24 INFO - PROCESS | 12787 | _x_x_mozilla_cycle_collect,1136 09:04:24 INFO - PROCESS | 12787 | __end_cc_report 09:04:24 INFO - PROCESS | 12787 | __startTimestamp1458317064716__endTimestamp 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | ------- Summary: start ------- 09:04:24 INFO - PROCESS | 12787 | Number of tests: 14 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.38 (3.0%) stddev-sans-first:3.59 09:04:24 INFO - PROCESS | 12787 | Values: 110.0 113.0 106.0 111.0 112.0 112.0 102.0 112.0 110.0 111.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:158.00 stddev:19.12 (12.1%) stddev-sans-first:19.91 09:04:24 INFO - PROCESS | 12787 | Values: 162.0 129.0 156.0 182.0 135.0 160.0 150.0 131.0 177.0 134.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 09:04:24 INFO - PROCESS | 12787 | Values: 162.0 164.0 163.0 161.0 161.0 162.0 161.0 164.0 163.0 163.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#3] audio-fft Cycles:10 Average:85.60 Median:74.00 stddev:16.26 (22.0%) stddev-sans-first:16.69 09:04:24 INFO - PROCESS | 12787 | Values: 74.0 74.0 100.0 96.0 73.0 75.0 74.0 118.0 99.0 73.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.00 stddev:20.75 (22.1%) stddev-sans-first:21.55 09:04:24 INFO - PROCESS | 12787 | Values: 95.0 94.0 135.0 95.0 94.0 94.0 140.0 93.0 94.0 136.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:04:24 INFO - PROCESS | 12787 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 09:04:24 INFO - PROCESS | 12787 | Values: 147.0 146.0 148.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:04:24 INFO - PROCESS | 12787 | Values: 96.0 95.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:2.70 (4.2%) stddev-sans-first:2.85 09:04:24 INFO - PROCESS | 12787 | Values: 64.0 64.0 65.0 65.0 64.0 65.0 64.0 72.0 63.0 62.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 09:04:24 INFO - PROCESS | 12787 | Values: 65.0 65.0 63.0 64.0 63.0 64.0 65.0 64.0 64.0 64.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:1.07 (1.3%) stddev-sans-first:1.01 09:04:24 INFO - PROCESS | 12787 | Values: 80.0 82.0 82.0 81.0 81.0 81.0 81.0 81.0 81.0 84.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:116.50 stddev:3.81 (3.3%) stddev-sans-first:4.04 09:04:24 INFO - PROCESS | 12787 | Values: 117.0 119.0 113.0 115.0 125.0 122.0 114.0 116.0 115.0 115.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:142.50 stddev:6.13 (4.3%) stddev-sans-first:6.50 09:04:24 INFO - PROCESS | 12787 | Values: 142.0 140.0 141.0 144.0 143.0 129.0 148.0 139.0 138.0 152.0 09:04:24 INFO - PROCESS | 12787 | 09:04:24 INFO - PROCESS | 12787 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 09:04:24 INFO - PROCESS | 12787 | Values: 65.0 67.0 65.0 65.0 68.0 64.0 65.0 65.0 66.0 64.0 09:04:24 INFO - PROCESS | 12787 | -------- Summary: end -------- 09:04:24 INFO - PROCESS | 12787 | 09:04:25 INFO - TEST-INFO | 12787: exit 0 09:04:25 INFO - TEST-OK | kraken | took 61832ms 09:04:25 INFO - SUITE-END | took 1179s 09:04:25 INFO - Completed test suite (00:19:39) 09:04:25 INFO - javascript benchmark 09:04:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2590.7538783815535, 2674.2486753024687, 2677.1165515379926, 2678.477696849113, 2716.293763621458, 4575.062112266985, 4634.050019745952, 4645.5586719261655, 4649.30260460931, 4652.185867473191, 4609.377734005917, 4648.116857797017, 4691.319758634996, 4704.764761761915, 4714.9528504714945, 4303.462067241595, 4311.439512863323, 4312.3531470279395, 4323.200207961521, 4438.711483753562, 4235.1529694061155, 4380.189664911985, 4396.450443694538, 4433.866983990485, 4450.154470650582, 4285.057287396783, 4307.440032795748, 4334.869953901388, 4367.061081867382, 4373.409589705413, 4300.6344460720875, 4302.698811083194, 4323.740575565476, 4339.088791353819, 4356.956430435686, 4227.387028880826, 4299.312110062407, 4300.913981720348, 4313.633341165973, 4350.347447882811, 4568.588827005586, 4603.539646035403, 4614.700044497131, 4627.305904114376, 4657.813687452498, 5033.421156567005, 5055.823046193365, 5062.0, 5063.898722025576, 5094.0, 4930.605551555867, 5024.874378140576, 5064.392272927273, 5084.77118529667, 5107.208382700687, 4659.4175728034, 4662.836800711959, 4669.089527542097, 4692.319613656035, 4696.436427628706, 5067.163917953497, 5067.569256613156, 5067.97466012675, 5104.03023425548, 5115.360579927509, 4799.544043315879, 4879.34128892595, 4897.706137631753, 4959.528844759742, 4964.826231081895, 4982.3522942018035, 4983.5763960063805, 5010.699358038456, 5011.498850114959, 5055.165897626924, 4970.204767237225, 4976.601871850244, 4977.576905963034, 4984.825531106394, 5025.698458092453, 4804.903901921942, 4924.901501969941, 4982.377202849644, 5039.042581909425, 5041.420236672756, 4299.871003869889, 4346.826126954949, 4348.326009468474, 4349.0, 4386.429764130707, 3720.1443667956523, 3790.0, 3796.7911764853197, 3811.4092315691114, 3858.7298889077497, 4235.322348424237, 4250.893727656833, 4286.6999310047995, 4322.632576231055, 4327.978360108179, 5007.624428167829, 5026.195808670595, 5036.7733451994745, 5044.268581055726, 5065.8733531662, 4198.475190601175, 4300.161468513672, 4316.913661726748, 4317.093410383792, 4363.105563359503, 4502.279635258343, 4534.523874993079, 4552.089582083597, 4568.1548913451115, 4579.5878370946775, 4649.558291962258, 4654.97672511642, 4655.650826188117, 4665.2768820832825, 4667.883302917454, 4905.092557876804, 4909.0672772173175, 4930.457649658606, 4963.081829861487, 4966.850994470172, 4750.809967601257, 4768.928466072943, 4776.355192049168, 4783.402074740658, 4823.710577365369, 4933.925991110064, 4960.057589058068, 4962.851114466572, 4970.577500912463, 5006.674566153334, 4895.510448955076, 5010.5240002199735, 5041.899162016813, 5080.745962701924, 5083.161278389024, 4819.879503012453, 4853.6359773017875, 4855.077535268429, 4877.756112194447, 4900.558949694545, 4875.390576177978, 4876.097921884463, 4881.8535443936735, 4888.7311197884455, 4918.631102667386, 4711.952880471152, 4752.2158843790385, 4821.035792841516, 4824.0, 4839.733814640229, 4878.048780487771, 4882.902341953212, 4901.950980490292, 4903.803847846189, 4954.157793175241, 4790.305405716222, 4797.136515427256, 4803.711777293373, 4803.759812009315, 4836.637252206169], "unit": "score", "name": "dojo.html", "value": 4604.701910899097}, {"lowerIsBetter": false, "replicates": [540.2868213957577, 553.0570377506355, 559.4070285497373, 560.170946998442, 569.7265312649928, 26734.86632566837, 34539.65460345396, 34541.65458345419, 34557.481637775454, 34682.26588670569, 40579.79710101453, 41553.37669934954, 41565.376519352234, 41582.16835663285, 41583.16833663332, 7654.272844079804, 7824.5696486693205, 7829.921700783005, 7835.608219588998, 7839.568823714693, 7799.922000780005, 7898.368130549542, 7932.8810067848735, 7948.0, 7952.165022672622, 7923.6038198090155, 7972.920270797275, 7978.720744773934, 7990.2009799019925, 7994.200579942018, 7880.330171935392, 7939.325157361631, 7947.5231486111015, 7953.840923181562, 7958.363330933512, 7846.803829904298, 7948.0, 7989.081255655616, 7989.800254993672, 7990.880136797953, 39041.41437878434, 39283.21433571313, 39360.21279574392, 39499.21001579952, 39526.60473395258, 2957.881684732608, 3015.1406849047917, 3016.6078409806805, 3032.6360836699737, 3104.239461331988, 29530.55704164439, 29595.408091838042, 30069.0, 30330.762061512392, 30769.230769230726, 3367.7810942288675, 3370.1237678203597, 3390.9660903390895, 3425.1265927188656, 3481.0775144586705, 236922.0, 236997.0, 237646.0, 239119.0, 240950.0, 43850.342244866355, 57840.132398014066, 58363.416365836645, 58440.415595844344, 58445.70777146172, 42153.0, 42316.0, 42589.14821703549, 42717.0, 42735.786321068816, 13016.609501714964, 13222.206667599974, 13225.867741322463, 13233.470661173638, 13243.933780331037, 10179.44013079273, 10243.897561024443, 10263.794724105475, 10265.281430299807, 10269.691909242734, 14556.708865822837, 14637.780433293296, 15148.16685082331, 15170.620734481505, 15309.846901531066, 5831.183634291203, 6012.699365031731, 6084.0, 6105.419985101408, 6163.7842675506145, 846.2848892685671, 856.9185927336893, 905.6920646980059, 930.5347326336831, 1001.1940387987739, 27557.173284801487, 27560.724392755816, 28364.574531382044, 28366.290842729097, 28627.427451451273, 958.3339578992533, 989.4459102902398, 1041.6979076068008, 1126.718320419895, 1132.0603898764007, 14232.786508202385, 14506.782398264035, 14568.271586420637, 14674.972751907477, 14861.331240094221, 296295.0, 301262.0, 301763.0, 302085.0, 302465.0, 48234.0, 48707.0, 48840.511594883596, 48875.266870996966, 48914.75542622264, 1149.9137564682683, 1173.4895320535425, 1208.7763763703742, 1268.105985280375, 1268.657462485124, 24914.750852491245, 27218.869829969808, 27573.44853102967, 27847.44305113846, 27941.720582794725, 37157.25685486329, 37237.6276237245, 37696.0, 37992.620073798906, 38100.237995240495, 166664.16667917068, 167330.0, 167663.0, 173024.1348793248, 176513.117434412, 27349.863250684415, 27763.722362776112, 31194.532082019243, 31874.20314492156, 32282.35435291234, 35639.64360356363, 36230.818845905604, 36660.90017299485, 36704.449433257985, 36713.0, 32217.51673724849, 33384.83307583447, 33967.83016084904, 34157.487637685954, 34421.65578344184, 33577.49633755447, 33645.32709345848, 33788.83105584457, 33798.3240335187, 34123.317533649686, 33340.499892502114, 33643.0, 33658.32683346271, 33973.0, 33999.66000339965, 29993.700062999964, 30150.69849301479, 30604.234894127825, 30613.23466913345, 30676.0, 24096.75903241015, 24124.27627171188, 24132.517349652557, 24326.878365608765, 24382.51234975326], "unit": "score", "name": "ext.html", "value": 16539.69185085229}, {"lowerIsBetter": false, "replicates": [339.69257821671385, 357.2390807579856, 357.3175235300575, 364.9434337677659, 366.4247132002757, 15370.615734606627, 15733.685326293467, 17108.74336884946, 17565.0, 17603.295868165256, 16636.334546618153, 16934.0, 17026.0, 17092.914535427306, 17161.399351022716, 4801.18379875422, 4803.0, 4979.601631869442, 5812.854678633025, 5856.15085812559, 5050.3434553508, 5885.4114588541015, 5892.0, 5904.7047647617665, 5909.0, 5492.176173573976, 5717.942820571803, 5729.427057294279, 5756.913646295309, 5863.76544938202, 5645.350784659735, 5650.350209725893, 5654.0, 5665.716714164317, 5704.515116215127, 4816.470188279286, 4915.188993816016, 5006.299118123466, 5026.748662566857, 5034.270030845543, 11513.194076414655, 11637.127215458875, 11712.355820429873, 11747.647570572897, 11890.048796096378, 1881.61426907485, 1889.6409682160483, 1921.3371386871506, 1927.9325223617245, 1932.7970563090955, 8870.778230544289, 8908.8663670045, 8921.46471211723, 9317.0, 9405.529723513797, 1737.2963949600432, 1744.4766570029067, 1761.7621621081119, 1839.6964500857343, 1845.1973391574709, 55863.0, 56844.71577642085, 57312.42687573113, 59023.0, 63438.365616343704, 9870.506474676238, 10186.337888037255, 10303.690889273334, 10324.845127323097, 10564.260501764802, 13610.38753256086, 13749.450021999008, 13753.174809511462, 13765.0, 13768.0, 6979.371856532936, 7044.964775176194, 7278.745243916437, 7295.963520182471, 7348.375388091965, 6495.902561461582, 6543.574667646588, 6556.63938483388, 6679.465642748569, 6727.730890764315, 4476.776161191928, 4524.25349817283, 4539.0, 4549.749763763025, 4606.88482787933, 1762.436020473462, 1789.4721057288132, 1795.3895675470403, 1826.5981484073482, 1832.3311991123144, 816.7713040348712, 852.4118358332854, 856.4090777363599, 921.755734730297, 929.2473096791621, 15865.286062127232, 15985.280662369989, 16088.839111608968, 16382.83617163837, 16575.144723722755, 879.0857508191409, 885.7431344910033, 887.3965703321803, 897.5691667999266, 930.3441074042784, 9254.167124958785, 9516.476593787269, 9525.428474291564, 9578.0, 9757.316987810927, 380782.0, 412937.0, 413350.0, 413603.0, 413858.0, 63779.68110159419, 64567.677161613894, 65122.0, 66294.0, 69389.65305173442, 979.4955597867104, 983.5475681186734, 985.3004366899438, 1019.8929112443235, 1021.596469394585, 15089.0, 15296.541103766906, 15302.234888255765, 15431.074135551902, 15759.448419305269, 33219.169520762174, 33716.0, 33821.492677610346, 34560.135996600286, 34820.47769283412, 45933.0, 46642.067158657315, 46762.0, 46838.0, 47010.76494617505, 7539.32146106853, 7544.0, 7580.128285247267, 7662.540247585162, 7729.922700773145, 8595.914040859512, 11586.073114150679, 11607.419629018685, 11639.359835208807, 11700.765984680089, 10106.848397274194, 10207.132393746318, 10273.74315642115, 10306.948465257627, 10400.087975366909, 9706.951465242628, 10028.197744180594, 10133.64532241368, 10223.386596803917, 10589.4705264738, 10082.647107351208, 10385.584576616851, 10393.220508461744, 10552.261341706007, 10685.57257709683, 7535.660895259617, 7552.735654252075, 7581.3176814087, 7714.537127772352, 7760.650770715444, 9993.500324983575, 10375.169986400919, 10397.32417392867, 10401.843972340572, 10509.159267258448], "unit": "score", "name": "jquery.html", "value": 7997.850205572899}, {"lowerIsBetter": false, "replicates": [1268.6511209417404, 1422.644338915271, 1423.6085076603933, 1589.785378973838, 1771.7785276840395, 7131.21556628771, 7308.196098429175, 7329.047223860904, 7338.743143989961, 7342.008828808116, 7415.555066696002, 7551.886721699179, 7597.31624153826, 7598.240175982399, 7601.391888648908, 1949.62957038163, 2261.42333704905, 2314.166899916029, 2335.0543030072804, 2346.8826558672085, 2283.4291427143216, 2289.9313020609407, 2296.689946857178, 2301.3786277705008, 2302.539492101578, 2230.3309007297826, 2265.5808675395024, 2269.2284623228184, 2269.4439862233694, 2270.6366981283, 2244.046280330853, 2256.7404748453973, 2264.762199969004, 2266.150193677371, 2275.374272075176, 2253.233900473847, 2253.6732173834703, 2271.182374345251, 2273.45437095096, 2320.4082958845556, 7672.846543069163, 7738.380929525624, 7743.148253692146, 7743.574103424309, 7746.341560967325, 4717.622590192776, 4863.465018847924, 4870.0, 4898.902021959577, 4900.607951363882, 3085.3058061935885, 3106.8446577671025, 3119.391718614871, 3141.780075394723, 3162.0513845846153, 1003.7189586915603, 1030.3251370352432, 1038.5741845843243, 1069.3209811769582, 1075.3225467955217, 10809.459527023697, 10837.295575787628, 10858.402787846666, 10874.782504349869, 10890.673279801618, 4492.415985921809, 4561.087782443525, 4640.071985602893, 4641.976790116028, 4642.3500709900645, 8287.8342433151, 8361.080281169066, 8370.665173392996, 8373.874391884126, 8379.539125348043, 4062.5937406259727, 4698.154332220165, 4754.453237877619, 4756.976215118972, 4758.976205118952, 3761.774293542396, 3763.0592351912023, 3799.316123097869, 4237.8304867805555, 4386.956130438719, 3555.6622120898473, 3623.510826038451, 3627.8004709741217, 3656.4880916671686, 3685.9262814744093, 1109.944502774858, 1118.5022664914036, 1120.8486854274731, 1127.8477405550145, 1132.9603463878725, 1103.7626910214342, 1130.0, 1155.5204590095016, 1156.0809156720427, 1191.255465334166, 7161.033260509868, 7239.89140162898, 7288.344049035506, 7293.781186564412, 7305.050343455423, 478.2825761357963, 483.7943873853598, 486.9853904382874, 487.7853744352544, 488.5261296542419, 5280.577553795687, 5306.389765177054, 5341.0653135701095, 5348.224507446398, 5355.678659280456, 8680.479171249619, 8772.254358379609, 9025.097490250922, 9054.049324820931, 9063.456192628464, 8964.775880603038, 8971.461712297283, 8973.416727912796, 8975.910240897507, 9013.63945442175, 6875.5874647521305, 7061.0, 7118.110236220473, 7125.323094306136, 7135.250798666273, 6641.667916604054, 6679.265280819009, 6702.229243636849, 6715.3620406061345, 6715.630640314829, 7779.260970207822, 7959.801004974922, 8024.679012839421, 8144.674213031412, 8156.632951517315, 8171.959140204261, 8286.378521610783, 8335.624896879533, 8455.788605284917, 8465.576721163794, 5532.2254884315425, 6014.158017877413, 6159.6612186330185, 6272.686365681789, 6423.325550817097, 7187.712491500281, 7200.099987501562, 7246.166690830411, 7247.094113235846, 7254.05697259374, 6260.311231997168, 6268.968655156695, 6276.968615156895, 6439.452646525097, 6549.0176473527445, 6467.126937863328, 6504.6747662615735, 6532.902006470002, 6610.867782644224, 6699.698513566804, 6911.93088069133, 6919.20429150634, 6955.374016338352, 6964.512484126062, 6980.965095174492, 6031.819045428644, 6082.391760824059, 6138.631682099089, 6165.907511387422, 6189.783357582463, 6313.715882785194, 6327.050942358683, 6350.872982540416, 6358.427741503287, 6363.6181829088555], "unit": "score", "name": "mootools.html", "value": 4272.639034469112}, {"lowerIsBetter": false, "replicates": [319.6675457524175, 319.88644031368864, 321.1265358225626, 321.92434777827214, 326.15200478755224, 5376.1398176291805, 5418.7019713915715, 5423.511883930445, 5435.673859568428, 5452.672839629615, 5333.706646134461, 5373.140297552392, 5380.300560927074, 5384.488473595012, 5389.110796718537, 4022.658074063708, 4116.217918595472, 4178.0, 4228.26005449046, 4230.280852255109, 4208.389783481393, 4216.304309788881, 4225.830966761341, 4245.384419259206, 4258.829646814123, 4200.243956087903, 4209.49486061673, 4214.115035842477, 4214.136102099078, 4222.725522841006, 4025.114474815521, 4107.486564179478, 4186.162767446523, 4210.789460526961, 4217.957820421787, 3713.0531714412923, 3716.7026637868908, 3717.7211709121925, 3727.788468747668, 3733.141377483194, 5202.661826981272, 5202.791888324463, 5207.739613019372, 5209.4009188943, 5228.372595288552, 4840.298156767249, 4842.685225460369, 4842.830500932486, 4845.248986407112, 4847.4667786543805, 5687.7156142193135, 5700.800471983503, 5701.429857014306, 5702.65784052954, 5703.971480142614, 4091.161311931047, 4092.1406504634065, 4094.549599544048, 4095.3242714952, 4103.815328310233, 5687.800926967537, 5966.642001479881, 5967.731452084623, 5968.70156492178, 5971.581989260753, 4195.517515485697, 4214.726042807208, 4216.662666986634, 4219.346001369792, 4221.345691417835, 4269.188854117708, 4271.9786401067795, 4274.444322238089, 4281.914361712748, 4284.571542845691, 4842.5157484251995, 4843.346148270009, 4845.418549773979, 4853.417589889165, 4854.708717476963, 5686.630369026, 5716.857078573069, 5719.084946408555, 5724.484796368347, 5724.713764311768, 1468.9118652880861, 1484.784706217614, 1508.939642414291, 1509.7961775160431, 1510.5770384292416, 968.9079537443931, 1029.4080903480378, 1038.361407734238, 1038.6883934819523, 1062.6811956413046, 4848.7090774553635, 4938.802447902115, 4943.332650092263, 4947.0, 4955.578775804025, 5872.17789509469, 5915.940840591625, 5916.201312822714, 5916.319623243296, 5929.970350148308, 4968.478309777493, 4979.30289759434, 4982.825601103944, 4988.077205716954, 4992.525710057539, 3133.623965124154, 3173.1591128351006, 3178.666240044762, 3181.316017056344, 3185.617725872864, 5575.721213939287, 5584.553235741131, 5585.525230355384, 5586.692731899703, 5589.385167631557, 5753.741081651336, 6053.424924632153, 6054.182685337511, 6061.939380606225, 6107.053406721965, 5516.117421212587, 5553.8333849984565, 5559.610827242054, 5560.638558493685, 5563.916541251803, 5879.94120058811, 5889.970550147222, 5890.852728681817, 5895.764169433174, 5901.114832775118, 5736.885262294814, 5795.391483894299, 5795.82612521625, 5796.681182535001, 5806.796762113306, 5406.75669594877, 5545.750441230073, 5566.91649625264, 5572.136318870582, 5578.30271216098, 4184.91630167401, 4222.3244280914905, 4229.217594744982, 4229.851955181553, 4232.703710740218, 5857.414258574108, 5884.970575147268, 5894.528437725057, 5896.056630939029, 5897.469227769521, 5673.149027645886, 5693.231413759255, 5737.053386191398, 5747.08046712524, 5749.453801888814, 5675.091985282335, 5675.120356344773, 5677.091665333527, 5678.858028549319, 5690.943090569207, 5410.431904649955, 5592.692401917933, 5601.019821531134, 5602.887942241051, 5616.326040875121, 5703.515201207778, 5704.857378565403, 5707.7716891325545, 5729.312482502127, 5762.855928601818, 5604.551635869202, 5614.831555053355, 5615.354234263112, 5620.606557540933, 5622.32532096151], "unit": "score", "name": "prototype.html", "value": 4305.793322933377}, {"lowerIsBetter": false, "replicates": [631.9178506794116, 686.6532401137425, 771.8996530451038, 782.4952905376033, 802.1657476224726, 12640.49438022478, 12722.554710585144, 12791.16857404268, 12798.808017879739, 12820.102592818495, 12047.698807529816, 13881.444742210324, 14051.648708782286, 14094.0, 14146.858531414682, 814.5235037503053, 827.2058823529419, 830.6511265268601, 830.8047608811925, 831.1688311688312, 610.5481943361902, 813.0487329824091, 829.1459796409707, 835.6364981233153, 835.9665613375457, 854.7905763088052, 860.1914200651368, 860.2214995429147, 860.7159637319669, 861.5390765940223, 675.0549231076483, 844.2275318083946, 847.1189962439117, 848.1942154952789, 848.6775025490335, 620.1349117980437, 627.3726273726273, 627.5011365964069, 628.4877824572958, 628.9150964619763, 12711.237325760483, 12805.167664101804, 12820.0, 12838.486460541568, 12859.807102893465, 11640.18518703691, 11854.3480108594, 12031.51873925042, 12036.0, 12385.75228495434, 9944.502774861228, 9975.221486012833, 9983.850242246299, 10041.648542300984, 10204.489775511194, 3237.983810080958, 3287.3918325109694, 3327.2680010397676, 3328.051505320972, 3328.3010567780793, 44331.33502997425, 44415.0, 44481.33278000833, 44492.332615010804, 44646.0, 9532.853392729226, 9571.61713531451, 9578.56896439662, 9615.615375385047, 9720.0, 17445.21496532659, 17517.12414379276, 17555.912220438815, 17586.03276819787, 17592.38426655061, 6892.689828957709, 6904.275051119661, 6948.687309071104, 7043.894341584881, 7222.241664625244, 3604.4953706481115, 3751.362268414376, 3872.554656214515, 3883.708721845873, 3902.785346805953, 2885.7114288570974, 2937.1775902746836, 2937.6327959005125, 2938.4710752064407, 2943.234758962685, 525.3616855520561, 526.6339893773791, 527.7387693091868, 540.3650710415246, 545.1767830575859, 542.500899172762, 551.8730691940876, 561.2086957390061, 568.5508448325776, 573.3349314794818, 7428.442866784904, 7445.255474452511, 7608.505447145918, 7838.529688218725, 7987.720429784929, 464.9628029757611, 553.4576115406924, 556.966582005081, 557.6988426249861, 570.3127731084116, 3554.1647712787476, 3569.839357228931, 3612.4942508048894, 3693.242885208526, 3764.0778009387877, 48973.265401019016, 49246.75376623094, 49352.0, 49815.75092124516, 53428.0, 44519.77740111343, 45591.0, 45895.31157032647, 45920.54079459162, 45950.080998379846, 40856.59143408587, 42830.78584607057, 42896.356554651706, 43124.568754312684, 43411.34882976758, 7940.801479963047, 8141.267285944294, 8243.917560824315, 8263.929560547678, 8399.622017009371, 32307.51538726968, 32493.025209243762, 32554.0, 33222.335553288314, 33379.49930750992, 37527.624723752415, 37542.0, 39656.40515392329, 41982.0, 42340.576594233666, 10109.595616175271, 10388.42863642507, 10409.1672666185, 10532.736681583021, 10578.8942110581, 11415.714607134889, 11549.711257218636, 11558.0, 12180.695482613006, 12287.87712122903, 10680.0, 10722.356658600509, 10808.675739727822, 10834.837477438003, 11051.778964420828, 10788.784224315626, 10941.45292735344, 11167.832482512931, 11383.43082845871, 11394.202405831513, 10197.082262596401, 10285.640002599874, 10439.739006524898, 10916.962888525577, 10932.234743568191, 8295.336373090258, 8357.247847693494, 8593.097724739062, 8663.783405414662, 8855.158759917798, 8375.095557631977, 9240.168384845396, 9273.814523709352, 9395.577199025924, 9549.522523873917], "unit": "score", "name": "yui.html", "value": 5917.2057165818305}], "name": "dromaeo_css", "value": 6362.115862049949}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 111.0, 112.0, 112.0, 102.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [162.0, 129.0, 156.0, 182.0, 135.0, 160.0, 150.0, 131.0, 177.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 161.0, 161.0, 162.0, 161.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 100.0, 96.0, 73.0, 75.0, 74.0, 118.0, 99.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 135.0, 95.0, 94.0, 94.0, 140.0, 93.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 72.0, 63.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 64.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 81.0, 81.0, 81.0, 81.0, 81.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [117.0, 119.0, 113.0, 115.0, 125.0, 122.0, 114.0, 116.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [142.0, 140.0, 141.0, 144.0, 143.0, 129.0, 148.0, 139.0, 138.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 65.0, 68.0, 64.0, 65.0, 65.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1510.1}]} 09:04:25 INFO - Return code: 0 09:04:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:04:26 ERROR - # TBPL SUCCESS # 09:04:26 INFO - Running post-action listener: _resource_record_post_action 09:04:26 INFO - Running post-run listener: _resource_record_post_run 09:04:27 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 519610368; Read time: 232; Write time: 663736 09:04:27 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 238718976; Read time: 0; Write time: 356968 09:04:27 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 12288; Write bytes: 280891392; Read time: 232; Write time: 306768 09:04:27 INFO - Running post-run listener: _upload_blobber_files 09:04:27 INFO - Blob upload gear active. 09:04:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:04:27 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'] 09:04:27 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 09:04:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:04:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:28 INFO - (blobuploader) - INFO - Done attempting. 09:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:29 INFO - (blobuploader) - INFO - Done attempting. 09:04:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:29 INFO - Return code: 0 09:04:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/932f44de73f887ac310845b68e6c1fb78d174f283de3f5169b2bfe9370d601a3a54c7e2a1d2c8ec521c6bf1c93769fbe1634bd154603dc9f619dba3f922a24d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6a8a98f046ad14b2b108a9bb1ac39605a3c08b319758bc0635eca825ca8adfa6023506f42f8982ca38baf5f5071abd7d98754572e3d641ef827b6f3aaa79bc9"} 09:04:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:29 INFO - Contents: 09:04:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/932f44de73f887ac310845b68e6c1fb78d174f283de3f5169b2bfe9370d601a3a54c7e2a1d2c8ec521c6bf1c93769fbe1634bd154603dc9f619dba3f922a24d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6a8a98f046ad14b2b108a9bb1ac39605a3c08b319758bc0635eca825ca8adfa6023506f42f8982ca38baf5f5071abd7d98754572e3d641ef827b6f3aaa79bc9"} 09:04:29 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:29 INFO - Copying logs to upload dir... 09:04:29 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.856368 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-03-18 09:04:29.162024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:04:29.164993) ========= 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 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/932f44de73f887ac310845b68e6c1fb78d174f283de3f5169b2bfe9370d601a3a54c7e2a1d2c8ec521c6bf1c93769fbe1634bd154603dc9f619dba3f922a24d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6a8a98f046ad14b2b108a9bb1ac39605a3c08b319758bc0635eca825ca8adfa6023506f42f8982ca38baf5f5071abd7d98754572e3d641ef827b6f3aaa79bc9"} build_url:https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/DgjQ8n5ARtihoSrVd8WzxA/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/932f44de73f887ac310845b68e6c1fb78d174f283de3f5169b2bfe9370d601a3a54c7e2a1d2c8ec521c6bf1c93769fbe1634bd154603dc9f619dba3f922a24d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6a8a98f046ad14b2b108a9bb1ac39605a3c08b319758bc0635eca825ca8adfa6023506f42f8982ca38baf5f5071abd7d98754572e3d641ef827b6f3aaa79bc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:04:29.193260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:04:29.193992) ========= 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=aa52b8aba932b19cc50b5275000001de-1458312011.504468-2110849250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:04:29.274611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:04:29.275325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:04:29.275901) ========= ========= Total master_lag: 0.32 =========