builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1457810999.31 results: success (0) buildid: 20160312100030 builduid: 5558b1c511164138a3b13726d334d26d revision: b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.305977) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.306409) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.306693) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006413 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.349384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.349665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.384237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.384501) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.436110) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.436383) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.436727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.437031) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-12 11:29:59-- 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% 43.1M=0s 2016-03-12 11:29:59 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.555434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.555716) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020976 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.605339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:29:59.605639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 --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 b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-12 11:29:59,996 truncating revision to first 12 chars 2016-03-12 11:29:59,996 Setting DEBUG logging. 2016-03-12 11:29:59,996 attempt 1/10 2016-03-12 11:29:59,996 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b8efc6dc729e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 11:30:00,286 unpacking tar archive at: mozilla-central-b8efc6dc729e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642662 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:30:00.261344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 11:30:00.261655) ========= echo b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 program finished with exit code 0 elapsedTime=0.004477 script_repo_revision: 'b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 11:30:00.311391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 11:30:00.311676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 11:30:00.322343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-03-12 11:30:00.322621) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:30:00 INFO - MultiFileLogger online at 20160312 11:30:00 in /builds/slave/test 11:30:00 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 11:30:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:30:00 INFO - {'append_to_log': False, 11:30:00 INFO - 'base_work_dir': '/builds/slave/test', 11:30:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:30:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:30:00 INFO - 'branch': 'Firefox-Non-PGO', 11:30:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:30:00 INFO - 'config_files': ('talos/linux_config.py',), 11:30:00 INFO - 'default_actions': ('clobber', 11:30:00 INFO - 'read-buildbot-config', 11:30:00 INFO - 'download-and-extract', 11:30:00 INFO - 'populate-webroot', 11:30:00 INFO - 'create-virtualenv', 11:30:00 INFO - 'install', 11:30:00 INFO - 'run-tests'), 11:30:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:30:00 INFO - 'download_minidump_stackwalk': True, 11:30:00 INFO - 'download_symbols': 'ondemand', 11:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:30:00 INFO - 'installer_path': 'installer.exe', 11:30:00 INFO - 'log_level': 'info', 11:30:00 INFO - 'log_name': 'talos', 11:30:00 INFO - 'log_to_console': True, 11:30:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:30:00 INFO - 'opt_config_files': (), 11:30:00 INFO - 'pip_index': False, 11:30:00 INFO - 'sps_profile': False, 11:30:00 INFO - 'sps_profile_interval': 0, 11:30:00 INFO - 'suite': 'dromaeojs', 11:30:00 INFO - 'system_bits': '32', 11:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:30:00 INFO - 'title': 'talos-linux64-ix-041', 11:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:30:00 INFO - 'use_talos_json': True, 11:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:30:00 INFO - 'work_dir': 'build'} 11:30:00 INFO - ##### 11:30:00 INFO - ##### Running clobber step. 11:30:00 INFO - ##### 11:30:00 INFO - Running pre-action listener: _resource_record_pre_action 11:30:00 INFO - Running main action method: clobber 11:30:00 INFO - rmtree: /builds/slave/test/build 11:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:30:01 INFO - Running post-action listener: _resource_record_post_action 11:30:01 INFO - ##### 11:30:01 INFO - ##### Running read-buildbot-config step. 11:30:01 INFO - ##### 11:30:01 INFO - Running pre-action listener: _resource_record_pre_action 11:30:01 INFO - Running main action method: read_buildbot_config 11:30:01 INFO - Using buildbot properties: 11:30:01 INFO - { 11:30:01 INFO - "project": "", 11:30:01 INFO - "product": "firefox", 11:30:01 INFO - "script_repo_revision": "production", 11:30:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:30:01 INFO - "repository": "", 11:30:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:30:01 INFO - "buildid": "20160312100030", 11:30:01 INFO - "pgo_build": "False", 11:30:01 INFO - "basedir": "/builds/slave/test", 11:30:01 INFO - "buildnumber": 446, 11:30:01 INFO - "slavename": "talos-linux64-ix-041", 11:30:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:30:01 INFO - "platform": "ubuntu64_hw", 11:30:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 11:30:01 INFO - "branch": "mozilla-central", 11:30:01 INFO - "repo_path": "mozilla-central", 11:30:01 INFO - "revision": "b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9", 11:30:01 INFO - "stage_platform": "linux64", 11:30:01 INFO - "builduid": "5558b1c511164138a3b13726d334d26d", 11:30:01 INFO - "slavebuilddir": "test" 11:30:01 INFO - } 11:30:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:30:01 INFO - Running post-action listener: _resource_record_post_action 11:30:01 INFO - ##### 11:30:01 INFO - ##### Running download-and-extract step. 11:30:01 INFO - ##### 11:30:01 INFO - Running pre-action listener: _resource_record_pre_action 11:30:01 INFO - Running main action method: download_and_extract 11:30:01 INFO - mkdir: /builds/slave/test/build/tests 11:30: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')]} 11:30:01 INFO - https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:10 INFO - Downloaded 1361 bytes. 11:30:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:10 INFO - Using the following test package requirements: 11:30:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:30:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:30:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'jsshell-linux-x86_64.zip'], 11:30:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:30:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:30:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:30:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:30:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:30:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:10 INFO - https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:30:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:19 INFO - Downloaded 22090816 bytes. 11:30:19 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'] 11:30:19 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 11:30:20 INFO - Return code: 0 11:30:20 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 11:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:20 INFO - https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:22 INFO - Downloaded 22090816 bytes. 11:30:22 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'] 11:30:22 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 11:30:23 INFO - Return code: 0 11:30: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')]} 11:30:23 INFO - https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:24 INFO - Downloaded 10845263 bytes. 11:30:24 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'] 11:30:24 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 11:30:25 INFO - Return code: 0 11:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:25 INFO - https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:30:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d9CZ8806R3awpQSprU5UYQ/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 11:30:26 INFO - Downloaded 54460406 bytes. 11:30:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:26 INFO - mkdir: /builds/slave/test/properties 11:30:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:30:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:30:26 INFO - Contents: 11:30:26 INFO - build_url:https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:27 INFO - Running post-action listener: _resource_record_post_action 11:30:27 INFO - Running post-action listener: set_extra_try_arguments 11:30:27 INFO - ##### 11:30:27 INFO - ##### Running populate-webroot step. 11:30:27 INFO - ##### 11:30:27 INFO - Running pre-action listener: _resource_record_pre_action 11:30:27 INFO - Running main action method: populate_webroot 11:30:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:30:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:30:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:30:27 INFO - '--tppagecycles', 11:30:27 INFO - '7'], 11:30:27 INFO - 'tests': ['tsvgm']}}, 11:30:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:30:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:30:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:30:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:30:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'tests': ['damp', 'tps']}, 11:30:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['damp', 'tps']}, 11:30:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:30:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:27 INFO - 'other': {'tests': ['a11yr', 11:30:27 INFO - 'ts_paint', 11:30:27 INFO - 'tpaint', 11:30:27 INFO - 'sessionrestore', 11:30:27 INFO - 'sessionrestore_no_auto_restore', 11:30:27 INFO - 'tabpaint']}, 11:30:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['a11yr', 11:30:27 INFO - 'ts_paint', 11:30:27 INFO - 'tpaint', 11:30:27 INFO - 'sessionrestore', 11:30:27 INFO - 'sessionrestore_no_auto_restore', 11:30:27 INFO - 'tabpaint']}, 11:30:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['a11yr', 11:30:27 INFO - 'ts_paint', 11:30:27 INFO - 'tpaint', 11:30:27 INFO - 'sessionrestore', 11:30:27 INFO - 'sessionrestore_no_auto_restore', 11:30:27 INFO - 'tabpaint']}, 11:30:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['a11yr', 11:30:27 INFO - 'ts_paint', 11:30:27 INFO - 'tpaint', 11:30:27 INFO - 'sessionrestore', 11:30:27 INFO - 'sessionrestore_no_auto_restore', 11:30:27 INFO - 'tabpaint']}, 11:30:27 INFO - 'other_l64': {'tests': ['a11yr', 11:30:27 INFO - 'ts_paint', 11:30:27 INFO - 'tpaint', 11:30:27 INFO - 'sessionrestore', 11:30:27 INFO - 'sessionrestore_no_auto_restore', 11:30:27 INFO - 'tabpaint']}, 11:30:27 INFO - 'other_nol64': {'tests': ['a11yr', 11:30:27 INFO - 'ts_paint', 11:30:27 INFO - 'tpaint', 11:30:27 INFO - 'sessionrestore', 11:30:27 INFO - 'sessionrestore_no_auto_restore', 11:30:27 INFO - 'tabpaint']}, 11:30:27 INFO - 'svgr': {'tests': ['tsvgx', 11:30:27 INFO - 'tsvgr_opacity', 11:30:27 INFO - 'tart', 11:30:27 INFO - 'tscrollx', 11:30:27 INFO - 'cart']}, 11:30:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['tsvgx', 11:30:27 INFO - 'tsvgr_opacity', 11:30:27 INFO - 'tart', 11:30:27 INFO - 'tscrollx', 11:30:27 INFO - 'cart']}, 11:30:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'tests': ['tp5o']}, 11:30:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'talos_options': ['--e10s'], 11:30:27 INFO - 'tests': ['tp5o']}, 11:30:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'talos_options': ['--xperf_path', 11:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:27 INFO - 'tests': ['tp5n']}, 11:30:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:27 INFO - 'talos_options': ['--e10s', 11:30:27 INFO - '--xperf_path', 11:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:27 INFO - 'tests': ['tp5n']}}, 11:30:27 INFO - 'talos.zip': {'path': '', 11:30:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:27 INFO - Running post-action listener: _resource_record_post_action 11:30:27 INFO - ##### 11:30:27 INFO - ##### Running create-virtualenv step. 11:30:27 INFO - ##### 11:30:27 INFO - Running pre-action listener: _resource_record_pre_action 11:30:27 INFO - Running main action method: create_virtualenv 11:30:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:30:27 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 11:30:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:30:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:27 INFO - Using real prefix '/usr' 11:30:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:30:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:29 INFO - Installing pip.................done. 11:30:29 INFO - Return code: 0 11:30:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:30:29 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')]} 11:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:29 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')]} 11:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:29 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:29 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 11:30:29 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 11:30:29 INFO - Using env: {'DISPLAY': ':0', 11:30:29 INFO - 'HOME': '/home/cltbld', 11:30:29 INFO - 'LANG': 'en_US.UTF-8', 11:30:29 INFO - 'LANGUAGE': 'en_US:en', 11:30:29 INFO - 'LOGNAME': 'cltbld', 11:30:29 INFO - 'MAIL': '/var/mail/cltbld', 11:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:29 INFO - 'MOZ_NO_REMOTE': '1', 11:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:29 INFO - 'NO_EM_RESTART': '1', 11:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:29 INFO - 'PWD': '/builds/slave/test', 11:30:29 INFO - 'SHELL': '/bin/bash', 11:30:29 INFO - 'SHLVL': '1', 11:30:29 INFO - 'TERM': 'linux', 11:30:29 INFO - 'TMOUT': '86400', 11:30:29 INFO - 'USER': 'cltbld', 11:30:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:29 INFO - '_': '/tools/buildbot/bin/python'} 11:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:29 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 11:30:29 INFO - Cleaning up... 11:30:29 INFO - Return code: 0 11:30:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:30:29 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')]} 11:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:29 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')]} 11:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:29 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:29 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 11:30:29 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 11:30:29 INFO - Using env: {'DISPLAY': ':0', 11:30:29 INFO - 'HOME': '/home/cltbld', 11:30:29 INFO - 'LANG': 'en_US.UTF-8', 11:30:29 INFO - 'LANGUAGE': 'en_US:en', 11:30:29 INFO - 'LOGNAME': 'cltbld', 11:30:29 INFO - 'MAIL': '/var/mail/cltbld', 11:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:29 INFO - 'MOZ_NO_REMOTE': '1', 11:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:29 INFO - 'NO_EM_RESTART': '1', 11:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:29 INFO - 'PWD': '/builds/slave/test', 11:30:29 INFO - 'SHELL': '/bin/bash', 11:30:29 INFO - 'SHLVL': '1', 11:30:29 INFO - 'TERM': 'linux', 11:30:29 INFO - 'TMOUT': '86400', 11:30:29 INFO - 'USER': 'cltbld', 11:30:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:29 INFO - '_': '/tools/buildbot/bin/python'} 11:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:30 INFO - Downloading/unpacking psutil>=0.7.1 11:30:30 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 11:30:30 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 11:30:30 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 11:30:30 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 11:30:30 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 11:30:30 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 11:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:32 INFO - Installing collected packages: psutil 11:30:32 INFO - Running setup.py install for psutil 11:30:32 INFO - building 'psutil._psutil_linux' extension 11:30:32 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 11:30:32 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 11:30:32 INFO - building 'psutil._psutil_posix' extension 11:30:32 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 11:30:32 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 11:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:32 INFO - Successfully installed psutil 11:30:32 INFO - Cleaning up... 11:30:32 INFO - Return code: 0 11:30:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:32 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:32 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 11:30:32 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 11:30:32 INFO - Using env: {'DISPLAY': ':0', 11:30:32 INFO - 'HOME': '/home/cltbld', 11:30:32 INFO - 'LANG': 'en_US.UTF-8', 11:30:32 INFO - 'LANGUAGE': 'en_US:en', 11:30:32 INFO - 'LOGNAME': 'cltbld', 11:30:32 INFO - 'MAIL': '/var/mail/cltbld', 11:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:32 INFO - 'MOZ_NO_REMOTE': '1', 11:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:32 INFO - 'NO_EM_RESTART': '1', 11:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:32 INFO - 'PWD': '/builds/slave/test', 11:30:32 INFO - 'SHELL': '/bin/bash', 11:30:32 INFO - 'SHLVL': '1', 11:30:32 INFO - 'TERM': 'linux', 11:30:32 INFO - 'TMOUT': '86400', 11:30:32 INFO - 'USER': 'cltbld', 11:30:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:32 INFO - '_': '/tools/buildbot/bin/python'} 11:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:30:34 INFO - Installing collected packages: mozsystemmonitor 11:30:34 INFO - Running setup.py install for mozsystemmonitor 11:30:34 INFO - Successfully installed mozsystemmonitor 11:30:34 INFO - Cleaning up... 11:30:34 INFO - Return code: 0 11:30:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:30:34 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')]} 11:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:34 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')]} 11:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:34 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:34 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 11:30:34 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 11:30:34 INFO - Using env: {'DISPLAY': ':0', 11:30:34 INFO - 'HOME': '/home/cltbld', 11:30:34 INFO - 'LANG': 'en_US.UTF-8', 11:30:34 INFO - 'LANGUAGE': 'en_US:en', 11:30:34 INFO - 'LOGNAME': 'cltbld', 11:30:34 INFO - 'MAIL': '/var/mail/cltbld', 11:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:34 INFO - 'MOZ_NO_REMOTE': '1', 11:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:34 INFO - 'NO_EM_RESTART': '1', 11:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:34 INFO - 'PWD': '/builds/slave/test', 11:30:34 INFO - 'SHELL': '/bin/bash', 11:30:34 INFO - 'SHLVL': '1', 11:30:34 INFO - 'TERM': 'linux', 11:30:34 INFO - 'TMOUT': '86400', 11:30:34 INFO - 'USER': 'cltbld', 11:30:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:34 INFO - '_': '/tools/buildbot/bin/python'} 11:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:30:35 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 11:30:35 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 11:30:35 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 11:30:35 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 11:30:35 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 11:30:35 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 11:30:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:30:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:30:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:30:37 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 11:30:37 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 11:30:37 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 11:30:37 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 11:30:37 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 11:30:37 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 11:30:37 INFO - Downloading docopt-0.6.1.tar.gz 11:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:30:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:30:37 INFO - Running setup.py install for blobuploader 11:30:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:30:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:30:37 INFO - Running setup.py install for requests 11:30:38 INFO - Running setup.py install for docopt 11:30:38 INFO - Successfully installed blobuploader requests docopt 11:30:38 INFO - Cleaning up... 11:30:38 INFO - Return code: 0 11:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:38 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:38 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 11:30:38 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 11:30:38 INFO - Using env: {'DISPLAY': ':0', 11:30:38 INFO - 'HOME': '/home/cltbld', 11:30:38 INFO - 'LANG': 'en_US.UTF-8', 11:30:38 INFO - 'LANGUAGE': 'en_US:en', 11:30:38 INFO - 'LOGNAME': 'cltbld', 11:30:38 INFO - 'MAIL': '/var/mail/cltbld', 11:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:38 INFO - 'MOZ_NO_REMOTE': '1', 11:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:38 INFO - 'NO_EM_RESTART': '1', 11:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:38 INFO - 'PWD': '/builds/slave/test', 11:30:38 INFO - 'SHELL': '/bin/bash', 11:30:38 INFO - 'SHLVL': '1', 11:30:38 INFO - 'TERM': 'linux', 11:30:38 INFO - 'TMOUT': '86400', 11:30:38 INFO - 'USER': 'cltbld', 11:30:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:38 INFO - '_': '/tools/buildbot/bin/python'} 11:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:30:38 INFO - Running setup.py (path:/tmp/pip-C5ZTTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:30:38 INFO - Running setup.py (path:/tmp/pip-xU_pwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:30:38 INFO - Running setup.py (path:/tmp/pip-ry7Vlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:30:38 INFO - Running setup.py (path:/tmp/pip-xAK6np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:30:38 INFO - Running setup.py (path:/tmp/pip-236nVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:30:38 INFO - Running setup.py (path:/tmp/pip-K4hQAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:30:38 INFO - Running setup.py (path:/tmp/pip-g5TvkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:30:38 INFO - Running setup.py (path:/tmp/pip-TJTMLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:30:39 INFO - Running setup.py (path:/tmp/pip-gGh7OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:30:39 INFO - Running setup.py (path:/tmp/pip-K2VEIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:30:39 INFO - Running setup.py (path:/tmp/pip-RnuyLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:30:39 INFO - Running setup.py (path:/tmp/pip-KXfxTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:30:39 INFO - Running setup.py (path:/tmp/pip-PEKmfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:30:39 INFO - Running setup.py (path:/tmp/pip-qfY89P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:39 INFO - Running setup.py (path:/tmp/pip-KFBIJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:30:39 INFO - Running setup.py (path:/tmp/pip-WMaaym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:30:39 INFO - Running setup.py (path:/tmp/pip-Ak8HOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:30:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:30:39 INFO - Running setup.py install for manifestparser 11:30:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:30:39 INFO - Running setup.py install for mozcrash 11:30:39 INFO - Running setup.py install for mozdebug 11:30:39 INFO - Running setup.py install for mozdevice 11:30:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Running setup.py install for mozfile 11:30:40 INFO - Running setup.py install for mozhttpd 11:30:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Running setup.py install for mozinfo 11:30:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Running setup.py install for mozInstall 11:30:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Running setup.py install for mozleak 11:30:40 INFO - Running setup.py install for mozlog 11:30:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Running setup.py install for moznetwork 11:30:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:30:40 INFO - Running setup.py install for mozprocess 11:30:40 INFO - Running setup.py install for mozprofile 11:30:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:30:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:30:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:30:41 INFO - Running setup.py install for mozrunner 11:30:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:30:41 INFO - Running setup.py install for mozscreenshot 11:30:41 INFO - Running setup.py install for moztest 11:30:41 INFO - Running setup.py install for mozversion 11:30:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:30:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:30:41 INFO - Cleaning up... 11:30:41 INFO - Return code: 0 11:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:41 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:41 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 11:30:41 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 11:30:41 INFO - Using env: {'DISPLAY': ':0', 11:30:41 INFO - 'HOME': '/home/cltbld', 11:30:41 INFO - 'LANG': 'en_US.UTF-8', 11:30:41 INFO - 'LANGUAGE': 'en_US:en', 11:30:41 INFO - 'LOGNAME': 'cltbld', 11:30:41 INFO - 'MAIL': '/var/mail/cltbld', 11:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:41 INFO - 'MOZ_NO_REMOTE': '1', 11:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:41 INFO - 'NO_EM_RESTART': '1', 11:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:41 INFO - 'PWD': '/builds/slave/test', 11:30:41 INFO - 'SHELL': '/bin/bash', 11:30:41 INFO - 'SHLVL': '1', 11:30:41 INFO - 'TERM': 'linux', 11:30:41 INFO - 'TMOUT': '86400', 11:30:41 INFO - 'USER': 'cltbld', 11:30:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:41 INFO - '_': '/tools/buildbot/bin/python'} 11:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:30:41 INFO - Running setup.py (path:/tmp/pip-dwKtfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:30:41 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)) 11:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:30:41 INFO - Running setup.py (path:/tmp/pip-EAEWAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:30:41 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)) 11:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:30:41 INFO - Running setup.py (path:/tmp/pip-22LBhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:30:41 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)) 11:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:30:41 INFO - Running setup.py (path:/tmp/pip-Lh1Dob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:30:41 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)) 11:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:30:41 INFO - Running setup.py (path:/tmp/pip-62NK0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:30:42 INFO - Running setup.py (path:/tmp/pip-HkwPm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:30:42 INFO - Running setup.py (path:/tmp/pip-k87tLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:30:42 INFO - Running setup.py (path:/tmp/pip-I_IlDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:30:42 INFO - Running setup.py (path:/tmp/pip-kMYgLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:30:42 INFO - Running setup.py (path:/tmp/pip-zislre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:30:42 INFO - Running setup.py (path:/tmp/pip-JVEm3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:30:42 INFO - Running setup.py (path:/tmp/pip-mNPmTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:30:42 INFO - Running setup.py (path:/tmp/pip-QZSVdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:30:42 INFO - Running setup.py (path:/tmp/pip-R3P3YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:42 INFO - Running setup.py (path:/tmp/pip-tzwIVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:30:42 INFO - Running setup.py (path:/tmp/pip-6SgqXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:30:42 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)) 11:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:30:42 INFO - Running setup.py (path:/tmp/pip-LYLGTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 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)) 11:30:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:30:42 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 11:30:42 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 11:30:42 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 11:30:42 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 11:30:42 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 11:30:42 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 11:30:44 INFO - Downloading blessings-1.6.tar.gz 11:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:30:44 INFO - Installing collected packages: blessings 11:30:44 INFO - Running setup.py install for blessings 11:30:44 INFO - Successfully installed blessings 11:30:44 INFO - Cleaning up... 11:30:44 INFO - Return code: 0 11:30:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:30:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:30:45 INFO - Reading from file tmpfile_stdout 11:30:45 INFO - Current package versions: 11:30:45 INFO - argparse == 1.2.1 11:30:45 INFO - blessings == 1.6 11:30:45 INFO - blobuploader == 1.2.4 11:30:45 INFO - docopt == 0.6.1 11:30:45 INFO - manifestparser == 1.1 11:30:45 INFO - mozInstall == 1.12 11:30:45 INFO - mozcrash == 0.17 11:30:45 INFO - mozdebug == 0.1 11:30:45 INFO - mozdevice == 0.48 11:30:45 INFO - mozfile == 1.2 11:30:45 INFO - mozhttpd == 0.7 11:30:45 INFO - mozinfo == 0.9 11:30:45 INFO - mozleak == 0.1 11:30:45 INFO - mozlog == 3.1 11:30:45 INFO - moznetwork == 0.27 11:30:45 INFO - mozprocess == 0.22 11:30:45 INFO - mozprofile == 0.28 11:30:45 INFO - mozrunner == 6.11 11:30:45 INFO - mozscreenshot == 0.1 11:30:45 INFO - mozsystemmonitor == 0.0 11:30:45 INFO - moztest == 0.7 11:30:45 INFO - mozversion == 1.4 11:30:45 INFO - psutil == 3.1.1 11:30:45 INFO - requests == 1.2.3 11:30:45 INFO - wsgiref == 0.1.2 11:30:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:45 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:45 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 11:30:45 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 11:30:45 INFO - Using env: {'DISPLAY': ':0', 11:30:45 INFO - 'HOME': '/home/cltbld', 11:30:45 INFO - 'LANG': 'en_US.UTF-8', 11:30:45 INFO - 'LANGUAGE': 'en_US:en', 11:30:45 INFO - 'LOGNAME': 'cltbld', 11:30:45 INFO - 'MAIL': '/var/mail/cltbld', 11:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:45 INFO - 'MOZ_NO_REMOTE': '1', 11:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:45 INFO - 'NO_EM_RESTART': '1', 11:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:45 INFO - 'PWD': '/builds/slave/test', 11:30:45 INFO - 'SHELL': '/bin/bash', 11:30:45 INFO - 'SHLVL': '1', 11:30:45 INFO - 'TERM': 'linux', 11:30:45 INFO - 'TMOUT': '86400', 11:30:45 INFO - 'USER': 'cltbld', 11:30:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:45 INFO - '_': '/tools/buildbot/bin/python'} 11:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 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)) 11:30:45 INFO - Cleaning up... 11:30:45 INFO - Return code: 0 11:30:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:45 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:45 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 11:30:45 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 11:30:45 INFO - Using env: {'DISPLAY': ':0', 11:30:45 INFO - 'HOME': '/home/cltbld', 11:30:45 INFO - 'LANG': 'en_US.UTF-8', 11:30:45 INFO - 'LANGUAGE': 'en_US:en', 11:30:45 INFO - 'LOGNAME': 'cltbld', 11:30:45 INFO - 'MAIL': '/var/mail/cltbld', 11:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:45 INFO - 'MOZ_NO_REMOTE': '1', 11:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:45 INFO - 'NO_EM_RESTART': '1', 11:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:45 INFO - 'PWD': '/builds/slave/test', 11:30:45 INFO - 'SHELL': '/bin/bash', 11:30:45 INFO - 'SHLVL': '1', 11:30:45 INFO - 'TERM': 'linux', 11:30:45 INFO - 'TMOUT': '86400', 11:30:45 INFO - 'USER': 'cltbld', 11:30:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:45 INFO - '_': '/tools/buildbot/bin/python'} 11:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:45 INFO - Downloading/unpacking jsonschema 11:30:45 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 11:30:45 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 11:30:45 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 11:30:45 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 11:30:45 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 11:30:45 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 11:30:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:30:47 INFO - Downloading/unpacking functools32 (from jsonschema) 11:30:47 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 11:30:47 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 11:30:47 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 11:30:47 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 11:30:47 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 11:30:47 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 11:30:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:30:47 INFO - warning: no files found matching '*.txt' 11:30:47 INFO - no previously-included directories found matching 'build' 11:30:47 INFO - no previously-included directories found matching 'dist' 11:30:47 INFO - no previously-included directories found matching '.git*' 11:30:47 INFO - Installing collected packages: jsonschema, functools32 11:30:47 INFO - Running setup.py install for functools32 11:30:47 INFO - warning: no files found matching '*.txt' 11:30:47 INFO - no previously-included directories found matching 'build' 11:30:47 INFO - no previously-included directories found matching 'dist' 11:30:47 INFO - no previously-included directories found matching '.git*' 11:30:47 INFO - Successfully installed jsonschema functools32 11:30:47 INFO - Cleaning up... 11:30:47 INFO - Return code: 0 11:30:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:30:47 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')]} 11:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:47 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')]} 11:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:47 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 0x7f8872a63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', '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 11:30:47 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 11:30:47 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 11:30:47 INFO - Using env: {'DISPLAY': ':0', 11:30:47 INFO - 'HOME': '/home/cltbld', 11:30:47 INFO - 'LANG': 'en_US.UTF-8', 11:30:47 INFO - 'LANGUAGE': 'en_US:en', 11:30:47 INFO - 'LOGNAME': 'cltbld', 11:30:47 INFO - 'MAIL': '/var/mail/cltbld', 11:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:47 INFO - 'MOZ_NO_REMOTE': '1', 11:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:47 INFO - 'NO_EM_RESTART': '1', 11:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:47 INFO - 'PWD': '/builds/slave/test', 11:30:47 INFO - 'SHELL': '/bin/bash', 11:30:47 INFO - 'SHLVL': '1', 11:30:47 INFO - 'TERM': 'linux', 11:30:47 INFO - 'TMOUT': '86400', 11:30:47 INFO - 'USER': 'cltbld', 11:30:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:47 INFO - '_': '/tools/buildbot/bin/python'} 11:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:48 INFO - Downloading/unpacking flake8 11:30:48 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 11:30:48 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 11:30:48 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 11:30:48 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 11:30:48 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 11:30:48 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 11:30:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:30:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:30:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:30:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:50 INFO - no previously-included directories found matching 'docs/_build' 11:30:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:30:50 INFO - Running setup.py install for pep8 11:30:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:50 INFO - no previously-included directories found matching 'docs/_build' 11:30:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:30:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:30:50 INFO - Cleaning up... 11:30:50 INFO - Return code: 0 11:30:50 INFO - Running post-action listener: _resource_record_post_action 11:30:50 INFO - Running post-action listener: _start_resource_monitoring 11:30:50 INFO - Starting resource monitoring. 11:30:50 INFO - ##### 11:30:50 INFO - ##### Running install step. 11:30:50 INFO - ##### 11:30:50 INFO - Running pre-action listener: _resource_record_pre_action 11:30:50 INFO - Running main action method: install 11:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:30:51 INFO - Reading from file tmpfile_stdout 11:30:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:30:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:30:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:30:51 INFO - Reading from file tmpfile_stdout 11:30:51 INFO - Output received: 11:30:51 INFO - Usage: mozinstall [options] installer 11:30:51 INFO - Options: 11:30:51 INFO - -h, --help show this help message and exit 11:30:51 INFO - -d DEST, --destination=DEST 11:30:51 INFO - Directory to install application into. [default: 11:30:51 INFO - "/builds/slave/test"] 11:30:51 INFO - --app=APP Application being installed. [default: firefox] 11:30:51 INFO - mkdir: /builds/slave/test/build/application 11:30:51 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'] 11:30:51 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 11:31:06 INFO - Reading from file tmpfile_stdout 11:31:06 INFO - Output received: 11:31:06 INFO - /builds/slave/test/build/application/firefox/firefox 11:31:06 INFO - Running post-action listener: _resource_record_post_action 11:31:06 INFO - ##### 11:31:06 INFO - ##### Running run-tests step. 11:31:06 INFO - ##### 11:31:06 INFO - Running pre-action listener: _resource_record_pre_action 11:31:06 INFO - Running main action method: run_tests 11:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:31:06 INFO - Python 2.7.3 11:31:06 INFO - Return code: 0 11:31:06 INFO - grabbing minidump binary from tooltool 11:31:06 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')]} 11:31:06 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 0x1100160>, '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 0x1101060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11014f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:31:06 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 11:31:06 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 11:31:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:07 INFO - Return code: 0 11:31:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:31:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:31:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:31:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:31:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:31:08 INFO - Return code: 0 11:31:08 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/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 11:31:08 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/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 11:31:08 INFO - Using env: {'DISPLAY': ':0', 11:31:08 INFO - 'HOME': '/home/cltbld', 11:31:08 INFO - 'LANG': 'en_US.UTF-8', 11:31:08 INFO - 'LANGUAGE': 'en_US:en', 11:31:08 INFO - 'LOGNAME': 'cltbld', 11:31:08 INFO - 'MAIL': '/var/mail/cltbld', 11:31:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:08 INFO - 'MOZ_NO_REMOTE': '1', 11:31:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:08 INFO - 'NO_EM_RESTART': '1', 11:31:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:08 INFO - 'PWD': '/builds/slave/test', 11:31:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:08 INFO - 'SHELL': '/bin/bash', 11:31:08 INFO - 'SHLVL': '1', 11:31:08 INFO - 'TERM': 'linux', 11:31:08 INFO - 'TMOUT': '86400', 11:31:08 INFO - 'USER': 'cltbld', 11:31:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266', 11:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:08 INFO - '_': '/tools/buildbot/bin/python'} 11:31:08 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/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 11:31:08 INFO - mozversion application_buildid: 20160312100030 11:31:08 INFO - mozversion application_changeset: b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 11:31:08 INFO - mozversion application_display_name: Nightly 11:31:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:08 INFO - mozversion application_name: Firefox 11:31:08 INFO - mozversion application_remotingname: firefox 11:31:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:31:08 INFO - mozversion application_vendor: Mozilla 11:31:08 INFO - mozversion application_version: 48.0a1 11:31:08 INFO - mozversion platform_buildid: 20160312100030 11:31:08 INFO - mozversion platform_changeset: b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 11:31:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:31:08 INFO - mozversion platform_version: 48.0a1 11:31:08 INFO - using testdate: 1457811068 11:31:08 INFO - actual date: 1457811068 11:31:08 INFO - starting webserver on 'localhost:48877' 11:31:08 INFO - SUITE-START | Running 2 tests 11:31:08 INFO - TEST-START | dromaeo_css 11:31:08 INFO - operating with platform_type : linux_ 11:31:08 INFO - Initialising browser for dromaeo_css test... 11:31:08 INFO - TEST-INFO | started process 6765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl8eIw0/profile http://localhost:48877/getInfo.html) 11:31:13 INFO - PROCESS | 6765 | __metrics Screen width/height:1600/1200 11:31:13 INFO - PROCESS | 6765 | colorDepth:24 11:31:13 INFO - PROCESS | 6765 | Browser inner width/height: 1024/697 11:31:13 INFO - PROCESS | 6765 | __metrics 11:31:14 ERROR - PROCESS | 6765 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:31:15 INFO - TEST-INFO | 6765: exit 0 11:31:15 INFO - Browser initialized. 11:31:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:15 INFO - TEST-INFO | started process 6858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl8eIw0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:27 INFO - PROCESS | 6858 | RSS: Main: 154812416 11:31:27 INFO - PROCESS | 6858 | 11:32:18 INFO - PROCESS | 6858 | 1457811138578 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] 11:34:30 INFO - PROCESS | 6858 | Cycle 1(1): loaded http://localhost:48877/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48877/tests/dromaeo/cssquery-ext.html) 11:34:31 INFO - PROCESS | 6858 | RSS: Main: 238256128 11:34:31 INFO - PROCESS | 6858 | 11:37:33 INFO - PROCESS | 6858 | Cycle 1(1): loaded http://localhost:48877/tests/dromaeo/cssquery-ext.html (next: http://localhost:48877/tests/dromaeo/cssquery-jquery.html) 11:37:33 INFO - PROCESS | 6858 | RSS: Main: 238825472 11:37:33 INFO - PROCESS | 6858 | 11:40:35 INFO - PROCESS | 6858 | Cycle 1(1): loaded http://localhost:48877/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48877/tests/dromaeo/cssquery-mootools.html) 11:40:36 INFO - PROCESS | 6858 | RSS: Main: 231890944 11:40:36 INFO - PROCESS | 6858 | 11:43:38 INFO - PROCESS | 6858 | Cycle 1(1): loaded http://localhost:48877/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48877/tests/dromaeo/cssquery-prototype.html) 11:43:39 INFO - PROCESS | 6858 | RSS: Main: 200957952 11:43:39 INFO - PROCESS | 6858 | 11:46:41 INFO - PROCESS | 6858 | Cycle 1(1): loaded http://localhost:48877/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48877/tests/dromaeo/cssquery-yui.html) 11:46:42 INFO - PROCESS | 6858 | RSS: Main: 197058560 11:46:42 INFO - PROCESS | 6858 | 11:49:44 INFO - PROCESS | 6858 | Cycle 1(1): loaded http://localhost:48877/tests/dromaeo/cssquery-yui.html (next: http://localhost:48877/tests/dromaeo/cssquery-dojo.html) 11:49:45 INFO - PROCESS | 6858 | RSS: Main: 269873152 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | __start_tp_report 11:49:45 INFO - PROCESS | 6858 | _x_x_mozilla_page_load 11:49:45 INFO - PROCESS | 6858 | _x_x_mozilla_page_load_details 11:49:45 INFO - PROCESS | 6858 | |i|pagename|runs| 11:49:45 INFO - PROCESS | 6858 | |0;dojo.html;2610.6475625790517;2682.24897028832;2688.4354285600025;2701.1896431070672;2722.646056012719;4387.978060109703;4500.21246281901;4564.292534657129;4578.404807375041;4603.654725895559;4592.655550833684;4607.976960115195;4613.6078433333205;4613.861584152481;4698;4196.790160491963;4213.494380674323;4225.8520951766695;4239.576042395759;4316.6762492813;4232.724872883268;4291.613754762071;4303.031817840992;4304.827806887721;4336.718113322624;4072.1855628874346;4152.356384760336;4157.91684166315;4268.359746038119;4275.5296917339065;4171.290880550314;4202.936955945633;4205.137946720914;4208.032152604918;4248.787560621957;4181.874543763662;4192.853250136231;4200.390943313233;4209;4253.043065310311;4382.342648602703;4520.095980803852;4584.701994370389;4618.399608050965;4631.861044168681;4888.266759986031;4910.165271903785;4924.335214745999;4931.284963680282;4974.204127339608;4690.507496712864;4949.232868905326;4950.603951683856;4953.331300274453;4957.851264462072;4553.726776393427;4578.656600754956;4585.380973568593;4615.976920115378;4624.606908412823;5019.222020586815;5056.544910958031;5067.265246539305;5072.416672082684;5102.821401250939;4691.085238378551;4755.453122890843;4828.927566086511;4851.272309153655;4859.635527335464;4931.235658472942;4959.479254678279;4961.206207006861;4963.230699241623;5002.824901128443;4881.682690625169;4890.339804126397;4891.877703057381;4896.387951506062;4940.011997600494;4651.767411629405;4742.407199100113;4807.086653535817;4884.804607815719;4921.089598424303;4135.462389889295;4143.19207754485;4151.8546850860075;4161.042960119129;4167.874963751093;3636.054625797312;3646.197836475971;3646.7994260315936;3647.598764135943;3689.6494832990825;4019.9799001005395;4127.525334586561;4146.751194928314;4199.223143718422;4217.030083080847;4895.678499878188;4909.631777616693;4910.582600478928;4917.409910810726;4920.040592084509;4196.958030419718;4197.139586384784;4202.726822756572;4234.047339348622;4250.468691413574;4235.957640423557;4314.223439780807;4371.497277813029;4392.38506609075;4397.164538737694;4619.260918253063;4629.65277604181;4639.979204574921;4641.025384669258;4683.953160468352;4890.217565189552;4895.853124406273;4906.165951788276;4915.26271059344;4956.801727930987;4448.421705178306;4517.638588912813;4568.908621827479;4589.2886602576655;4616.722996620214;4835.057163853015;4856.611471082376;4860.392450943632;4877.048975449753;4890.193118135468;4715.363425937455;4904.11725889329;4905.337779399735;4942;4978.352814134139;4614.907701846011;4794.993051459232;4801.4958429365815;4823.614110871052;4843.660943734046;4702.341672165968;4726.527347265246;4743.217369134192;4746.501617330131;4777.856664300077;4497.235469970047;4634.930476042795;4644.698094623838;4650.162970665177;4694.2723877799;4752.572268495852;4777.259524773665;4781.641376896816;4784.425868895755;4817.8313759018265;4670.369500117441;4674.7896344663895;4674.813007479663;4676.719396836201;4682.344471773887 11:49:45 INFO - PROCESS | 6858 | |1;ext.html;470.61174531011903;497.41305259793427;501.9121653710601;509.84449742828446;520.084651014215;25501.489970200586;34051;34402.48396274058;34485;34511.4823277651;37251.627483725155;37589;37626;37654.62345376545;37682.24635507288;7693.461457697963;7878.409119316074;7892.289693927545;7894.210578942088;7898.407619428566;7723.189065148163;7849.529028258323;7851.56816375102;7861.646225919819;8014.438989270753;7895.526268423884;8063.677452901877;8064.31453326468;8067.878981815277;8069.233422824852;7947.7218297359605;8011.158828323029;8015.7595272141925;8016.358691304682;8036.959815200887;7792.142864284924;7808.5314881107315;7886.0536735592095;7891.171427000198;8036.517808931424;37037;37460.31746031746;37490.81254593737;37511.43732844009;37513.81243093767;3007.338385555174;3089.3196955280714;3530.699890509284;3539.5398598182073;3653.2876089162623;27910.441791164267;28402.431951360857;28497.430051399064;28535;28543.14370568886;3320.966790332114;3348.4809854472596;3392.4063288924585;3509.192885636318;3530.717542596586;167948;168021;168309;217278.99999999843;217863;53891.46108538864;54168;54239;54262.45737542653;54282;57809.71095144498;58021.41978580245;58022.7098864503;58027.709861451265;58062;14263.85736142646;14456;14460.06009609372;14464.421423143167;14465.710685786225;11369.204155709187;11408.144389170846;11430.14273929442;11436.885631143583;11451.19841611096;15595;18433.170507327202;18552.628947420977;18582.44252672422;18636.534086647942;7421.851562968711;7616.9238307617325;7739.7678069658;7753.806154846174;7785.766427007199;861.2507118806553;903.8553831386946;906.3746015249457;970.6166064404521;997.2719914462483;25981.480370392484;25988.8700556496;26533.734662653125;26896.32759181036;26934.32664183411;851.5571902610608;958.1376760915232;980.07872599756;1072.0726571515584;1094.8686157660973;12488.81266780999;12709;12719.282896808998;12809.743805123846;12875.420606072748;249494;251514;251556;251918;253024;47435.28847067297;47708;47764.5223547767;47981.520184798406;48202;1036.4713995862164;1141.9885801142048;1149.9137564682683;1161.6805378520974;1209.1173443386376;24224.75775242225;26121.608175876998;26642.600360994988;26799.598006030315;26893.462130757667;36666.43334966633;37009.259814803016;37081.629183708894;37089.443658345685;37114;171370;172737;172912;172969;173043.13478432526;24527.632085518373;26043.348916276485;26506.602400963617;26794;26917.461650766483;33750.324993500486;34018;34666.82666586651;34961.678640529106;34963.7762678305;29399.412011760072;29441.558376624795;29451.41097178087;29671.25821854471;29791.702082978893;31343.21641958969;31658.683413166495;31881;31990.84004579962;32164;32204.516932245566;32535.51196732098;32788.67211327856;32961.67038329586;32971.17572060622;28092.71907280901;28854.42291154207;28954.855225723735;29136.417271654023;29649.407011860072;23076.884615576815;23079.19222827193;23292.534149317256;23358.76641233566;23568.764312357343 11:49:45 INFO - PROCESS | 6858 | |2;jquery.html;307.26410247457324;335.91434184283014;338.6461148100235;339.07601785135495;340.05464807834215;14256.80501547495;14736.778948315783;15318.923405382971;16070.919645401786;16111.597210069755;11468.885311146907;11509.597164099257;11868.347240901747;14115.57653270401;14688.559343219693;4784.49762774908;4918.680285781431;4941.901161976758;4950.653454258186;4951.900961980758;4861.319415281863;4863.6595438319155;4900.313956046157;4905.730184839832;5067.062593420211;5003.12445322069;5035.924461133068;5039.949600503985;5052.166392545226;5057.772400241998;4991.475895031006;4994.97502512487;4995.6003519718515;5000.549950504454;5339.652922560022;4765.451973023078;4862.586680132157;4886.364772579577;4888.046830867982;4895.388076490439;11369.829452558219;11644.592439264585;11645.883541164565;14545.490907818175;18101.366452174243;1715.4167583021708;1802.8918264904148;2034.8779073255505;2046.98976505118;2379.9643005354933;8509.106543812934;8619.870701939475;8710.433821801562;8983.146601072887;9047.592858321392;1491.3065424577624;1502.7820965959984;1654.445760670177;1763.7971633262212;1779.644071185768;39712.404313935316;48172;48314.758426208;51943.74028129873;56805.71597141988;9622.278329125344;9622.422654640744;9638.132568068908;9771.951140244395;9881.357711748713;12377.566785162477;12441;12484.687882803002;12496.687582810502;12505.437255323532;6928.852055862699;6994.5803251805055;7101.254368291255;7105.502614817016;7117.857642847114;6503.187101612299;6508.056331831858;6578.8355291118105;6611.702473388613;6615.4376877965915;4087.3868919662286;4111.259973204792;4115.835366585363;4182.121754431603;4217.936730949038;1628.6824069306372;1720.1055451165323;1728.974065388995;1730.7490413890168;1749.2565659594623;816;825.2902503846688;837.4054421360902;917.2661870503571;920.484528663937;13760.724785504233;14319.284035798168;14532;14723.337449814784;14785.186814725079;795.6936579416966;829;838.2288294768828;865.359633870931;920.3327587499143;8257.256846883809;8397.538135402488;8411.873821892677;8447.901772769623;8640.827183456297;344151;350945;355994;356478;362126;59302;60103.69948150319;61151.38848611546;61242.693786530785;61660.69169654123;763.4503157726317;781.7850091224844;788.8895554622358;792.5324058805218;794.5987276425484;12943.805842912176;13013.544525941546;13122.278274694983;13285.601431957057;13300.068995170244;28241;28626.856865715537;28663.856680716464;29138.854305728335;30248.243793905327;39075.609243907194;40131;40269.39595906005;40314.39528407135;40793.388099177944;6865.828354290983;7092.787216383516;7144.071270734771;7165.5700657958605;7172.748953786592;9431.905680943102;10436.686899393031;10450.529726162493;10533.052025317758;10583.894161058599;8581.184787445183;8784.297256219359;8865.512396818236;9240.399374040666;9262.768430789014;8821.691240806542;9003.684871029482;9135.132162444557;9159.633614655606;9163.35856490066;8643.524606146471;8823.161799629024;8973.37186396946;9049.276057915482;9290.535473226177;6974.755883544254;6980.197277313174;6991.40573051276;7006.579605223703;7172.426205903619;7754.806129846574;8623.051464339043;8759.781005474913;8774.298056155365;8868.11318868108 11:49:45 INFO - PROCESS | 6858 | |3;mootools.html;1142.7371704507968;1380.2270728392102;1392.2621010864243;1522.4823559989609;1749.2215963896072;7127.1803742569555;7307.525010874303;7317.26827317268;7318.890216646748;7328.487005909575;7297.087864016998;7432.6655300511475;7438.293362130603;7455.403567714583;7469.066366704162;1822.599028213791;2076.9376918692465;2115.4182599785026;2130.8828014459277;2153.0418963561224;2147.9355619331445;2157.46063484129;2159.341400872741;2159.708439360682;2162.718846549946;2050.29264903608;2117.2060477321006;2118.8410869184795;2134.039682143034;2136.7329083864515;2076.584683063386;2106.5260316428758;2117.5658989907033;2137.722096127509;2144.613969485492;2093.3929160543425;2103.9368818935454;2104.6001259760596;2110.5989861926187;2113.397681660719;7508.211637778064;7525.397968162589;7555.16893141754;7605.391568674493;7606.467547271694;4256;4374.693771436001;4379.189849877783;4398.868033958986;4399.934000989956;2770.1551026936777;2780.3605170810624;2826.858657067138;2828.4625921075135;2946.351802603424;935.6631612619451;942.2885721280389;946.7585765629789;980.2256217588097;991.5587563534231;10297.485125743682;10313.742156446075;10318.742031449274;10329.173666106768;10370.22223333253;3998.7400818946676;4053.959460405358;4115.506139263308;4116.4648595682365;4126.381042843597;8864.512451815082;8882.289416846637;8909.242714369222;8913.197812196804;8924.375293729376;3717.237966216919;4380.211561918885;4380.3210502372185;4381.7151885128005;4384.868453946387;3735.6077611850906;3780.773153610792;3803.67668748154;3819.6371344722206;3826.1964987352967;3410.556627638391;3469.2020835208045;3482.4950382194947;3517.138301116243;3553.982230088833;1069.9786004280027;1077.4074259157433;1079.1906070447164;1080.270817198388;1088.466651340853;1145.5589598004663;1157.2015309436463;1162.3026184289358;1165.918385712992;1194.8506436695413;6909.412699920463;6929.237783843773;6940.9652951734915;6979.336962988508;6997.615131167733;1021.2595867995792;1043.175891046065;1060.9151267898549;1063.1494804156798;1067.514281002142;5109.489051094861;5127.743612819344;5162.148245539519;5162.889978654607;5169.3796744390165;8287.585620718939;8301.750947471586;8523.019852717018;8536.786580335542;8693.913060869438;8597.527136007455;8609.053004169537;8622.094680058504;8722.563871806384;8756.8686469703;6593.571417857824;6624.873771458863;6673.733050677918;6742.123523941857;6766.917293233158;6547.312532184243;6554.508411869224;6587.571807832475;6620.668966551557;6627.138471998802;7697.769066928001;7819.765407037798;7819.804504887424;7847.646855891385;7962.08436029864;7828.647710853139;7966.442349035744;8027.719029834161;8093.150219226896;8130.308923741548;5128.743562821769;5705.058665320342;5854.677992710442;6078.361772014052;6164.352742961924;6904.93095069063;6942.791716248521;6982.930170698228;6983.406410455168;6983.825404364931;6125.142480052886;6349.809505714836;6393.536643144016;6411.679416029273;6473.708683109177;6346.936530634634;6372.9362706374195;6445;6446.387593178641;6539.574927629689;6614.338566143347;6635.23694775107;6638.468922486093;6658.83352916181;6669.533132680665;5970.731317090828;6086.573939824169;6201.751929922752;6213.720382582885;6237.625742455467;5910.113482977587;5931.436513531207;5969.313528944053;5978.701064946822;5999.430054144849 11:49:45 INFO - PROCESS | 6858 | |4;prototype.html;305.18667750445064;305.51575752432393;307.5371565793481;315.32205757621097;315.95102759072336;5118.129917913954;5217.504337087976;5254.343207099113;5290.206469029637;5293.1001729705895;5142.6914385136915;5210.843674689756;5224.29472021277;5227.2159176123505;5239.083160446926;3797.259534390795;3883.7475564088386;3995.5005624296964;4016.9196616067734;4022.879313620596;4007.5591684914634;4011.3782363733667;4011.8997025074314;4012.1574469361467;4016.1365306459106;3960.742551734128;3968.503937007874;3976.2445135424177;3999.060220848098;4002.8398864045403;3774.698024158061;3847.1343947611845;3915.941260881089;3920.0591857954173;3977.0256287209672;3391.118309239591;3399.7280217582534;3400.268942177444;3401.744869134825;3404.69357757803;4932.506749325074;4965.677230979974;4977.42759582649;4978.103941290567;4983.900321993576;4509.25597276449;4509.391232183646;4509.571590698878;4510.714446382765;4518.81924723014;5410.810621628224;5414.485623865727;5415.566754659657;5418.729063546807;5420.620556561043;3718.665320121202;3719.702423806089;3721.1999420124534;3723.1436769543157;3729.1050147964293;5485.204645326446;5619.353774315965;5698.971505142447;5708.1437784332265;5711.057675483582;3840.2895464339185;3846.2692088503095;3875.2055828555644;3876.0697432616535;3878.3406820840523;3927.5286965563746;3929.6070392960473;3931.7051221158526;3932;3935.763854168759;4511.88720281989;4516.480604730498;4521.66087543429;4525.705829121097;4528.388667529907;5430.375506816767;5437.564994800407;5440.619156658996;5444.646098003696;5450.5912056595125;1365.9931700341435;1379.3999610169608;1379.4964837834118;1379.5654368873772;1381.4336122189854;862.4049405909902;904.7511934218143;940.8917974432891;959.4483172176027;959.712086374085;4676.649251306166;4757;4788.856334309976;4789.640776941744;4811.326414302001;5649.265595472562;5659.547236221092;5669.461401166883;5674.943250567524;5677.858053548612;4769;4773.069251495925;4775.450823155312;4777.116233496814;4777.3072904429355;2998.610180676498;3035.05913166919;3037.9240518987203;3041;3041.163679988021;5374.274472946102;5377.489138531833;5378.381486129145;5386.380566234855;5389.27244821944;5639.238702775155;5785.363610002896;5808.82573522795;5820.1560773688425;5829.09649004405;5353.544948679406;5373.919391209135;5381.27352807366;5390.353157621111;5391.056565101092;5654.915176272441;5655.406182350958;5657.519110875622;5661.518770904355;5662.405447427961;5541.501264886179;5543.805966791143;5547.084731019337;5554.389017208185;5555.388907220284;5373.194020896896;5384.6769193848495;5385.8114965976;5388.515033646991;5390.460953904735;3791.4881490999464;3904.902377440587;3908.785016824102;3912.7261091724445;3921.1569512553797;5632.971835140798;5650.971745141248;5656.37779844225;5657.575681823797;5659.660420374791;5433.293671822637;5442.102053161184;5443.319585051869;5443.510084092292;5445.455454454523;5429;5430.619856609999;5432.511074003359;5436.966976274495;5441.102218133963;5336.172893201405;5337.759800808895;5338.332708411449;5339.412664606968;5343.919841202307;5309.920351194658;5468.507834294933;5469.808556700496;5480.314960629921;5532.114861622282;5348.5988550858065;5356.866078348073;5367.973160134331;5383.327084114486;5383.784648614168 11:49:45 INFO - PROCESS | 6858 | |5;yui.html;635.7743001234562;648.8637386148908;691.0808624529376;710.9751158709445;715.1525442350815;10267.794644107113;10424.218183636229;10424.583016679342;10425.687229383131;10453.11148552373;10979.725506862333;11126.833097503544;11128.0541154002;11155.442227888614;11156.16328775341;588.2441063233746;765.674588299973;772.8338407242442;776.2005134711256;780.8438312337527;795.6021989005498;799.1169757418056;799.60019990005;799.808046068945;800.1118758178417;834.4784509681449;836.7113345895687;836.824266903951;836.93304535637;837.0833936839151;617.7405489694362;817.6157206113118;822.4489591973393;830.0910502999207;836.2515548583983;611.8378629663143;616.4051690119012;617.1853153836937;617.521420898807;618.1376979114156;11237;11286.097112231002;11307.095432365391;11320.320780753182;11341.943290283496;10638.840417393745;10909.290896091728;11034.393108379036;11250.718732031683;11475.942620286929;8760.211580957744;8825.911740882573;8841.425307355066;8909.331800115016;9094.63621455141;3159.210197450637;3167.588213532226;3218.0506750508657;3242.7405807535342;3286.4248756467523;38229.42655860164;38463.807680961414;38475.03812404684;38555.614443855484;38645.613543864485;8171.836563268701;8332.250097491255;8334.83330333402;8544.444611100258;8658.134186581417;16695.582610434838;16709.248083836257;16719.331226750794;16834;16842.747358789627;6109.389061093855;6156.322804491502;6263.467605253513;6323.841903952438;6347.301796802348;3500.5274287971306;3511.9297614047578;3515.54297941266;3520.647935206459;3522.489239060373;2760.406512599801;2787.442511497668;2801.4817258807184;2802.4114935863695;2812;418.11359916976204;459.71497671443916;462.8680825964584;477.59165913144454;477.88052986753314;453.2747603833905;513.1532970598468;517.8782985998288;519.3845293327419;524.6484855147061;6727.865442691216;6879.174499060145;6902.792916212522;6907.171139463196;6990.895136572955;405.3635791806835;478.2969035517783;487.25693317690803;509.9184130539096;518.8443466959897;3054.526548385004;3078.6613472518006;3086.5215891536845;3096.303331750338;3186.474231751781;44630.10739785251;44634.55365446369;45007.77496112564;45023.774881125384;45565;42264.366034509505;42361.788191059466;43094;43167.568324316984;43231.56768432338;38422.423663645066;40763;40990.180196396504;41087;42049.579504205176;6499.155109835691;6951.582905025714;7417.592032438268;7448.925510744823;7501.221616123199;29187.85406072956;29188.562171567868;30338.696613033586;30492;30502;34551;37517.2496550062;38096;38209.235815282984;38565;9224.861627075734;9413.529323533932;9503.192228660364;9545.331826772059;9639.662611808553;9952.800943981225;10229.846552301573;10250.033707360046;10271;10296.433696146783;8885.06706795803;9017.819643607223;9120.49837258957;9179.082091791035;9386.249100071842;8860.58341944218;8874.911250887408;8897.599608017525;8933.46399216049;8961.731148065568;9021.052789457013;9055.592498337459;9057.592408341772;9095.454272743393;9096.1813436791;7992.400569957393;8198.262156405952;8216.21945915137;8244.258016778518;8346.624401901807;7647.655855486628;8004.399670024655;8068.59657017135;8196.836063278583;8233.629486673233 11:49:45 INFO - PROCESS | 6858 | __end_tp_report 11:49:45 INFO - PROCESS | 6858 | __start_cc_report 11:49:45 INFO - PROCESS | 6858 | _x_x_mozilla_cycle_collect,807 11:49:45 INFO - PROCESS | 6858 | __end_cc_report 11:49:45 INFO - PROCESS | 6858 | __startTimestamp1457812185099__endTimestamp 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | ------- Summary: start ------- 11:49:45 INFO - PROCESS | 6858 | Number of tests: 6 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | [#0] dojo.html Cycles:165 Average:4525.08 Median:4631.86 stddev:461.18 (10.0%) stddev-sans-first:437.46 11:49:45 INFO - PROCESS | 6858 | Values: 2610.6 2682.2 2688.4 2701.2 2722.6 4388.0 4500.2 4564.3 4578.4 4603.7 4592.7 4608.0 4613.6 4613.9 4698.0 4196.8 4213.5 4225.9 4239.6 4316.7 4232.7 4291.6 4303.0 4304.8 4336.7 4072.2 4152.4 4157.9 4268.4 4275.5 4171.3 4202.9 4205.1 4208.0 4248.8 4181.9 4192.9 4200.4 4209.0 4253.0 4382.3 4520.1 4584.7 4618.4 4631.9 4888.3 4910.2 4924.3 4931.3 4974.2 4690.5 4949.2 4950.6 4953.3 4957.9 4553.7 4578.7 4585.4 4616.0 4624.6 5019.2 5056.5 5067.3 5072.4 5102.8 4691.1 4755.5 4828.9 4851.3 4859.6 4931.2 4959.5 4961.2 4963.2 5002.8 4881.7 4890.3 4891.9 4896.4 4940.0 4651.8 4742.4 4807.1 4884.8 4921.1 4135.5 4143.2 4151.9 4161.0 4167.9 3636.1 3646.2 3646.8 3647.6 3689.6 4020.0 4127.5 4146.8 4199.2 4217.0 4895.7 4909.6 4910.6 4917.4 4920.0 4197.0 4197.1 4202.7 4234.0 4250.5 4236.0 4314.2 4371.5 4392.4 4397.2 4619.3 4629.7 4640.0 4641.0 4684.0 4890.2 4895.9 4906.2 4915.3 4956.8 4448.4 4517.6 4568.9 4589.3 4616.7 4835.1 4856.6 4860.4 4877.0 4890.2 4715.4 4904.1 4905.3 4942.0 4978.4 4614.9 4795.0 4801.5 4823.6 4843.7 4702.3 4726.5 4743.2 4746.5 4777.9 4497.2 4634.9 4644.7 4650.2 4694.3 4752.6 4777.3 4781.6 4784.4 4817.8 4670.4 4674.8 4674.8 4676.7 4682.3 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | [#1] ext.html Cycles:180 Average:36626.34 Median:3334.72 stddev:53924.00 (1617.0%) stddev-sans-first:54006.93 11:49:45 INFO - PROCESS | 6858 | Values: 470.6 497.4 501.9 509.8 520.1 25501.5 34051.0 34402.5 34485.0 34511.5 37251.6 37589.0 37626.0 37654.6 37682.2 7693.5 7878.4 7892.3 7894.2 7898.4 7723.2 7849.5 7851.6 7861.6 8014.4 7895.5 8063.7 8064.3 8067.9 8069.2 7947.7 8011.2 8015.8 8016.4 8037.0 7792.1 7808.5 7886.1 7891.2 8036.5 37037.0 37460.3 37490.8 37511.4 37513.8 3007.3 3089.3 3530.7 3539.5 3653.3 27910.4 28402.4 28497.4 28535.0 28543.1 3321.0 3348.5 3392.4 3509.2 3530.7 167948.0 168021.0 168309.0 217279.0 217863.0 53891.5 54168.0 54239.0 54262.5 54282.0 57809.7 58021.4 58022.7 58027.7 58062.0 14263.9 14456.0 14460.1 14464.4 14465.7 11369.2 11408.1 11430.1 11436.9 11451.2 15595.0 18433.2 18552.6 18582.4 18636.5 7421.9 7616.9 7739.8 7753.8 7785.8 861.3 903.9 906.4 970.6 997.3 25981.5 25988.9 26533.7 26896.3 26934.3 851.6 958.1 980.1 1072.1 1094.9 12488.8 12709.0 12719.3 12809.7 12875.4 249494.0 251514.0 251556.0 251918.0 253024.0 47435.3 47708.0 47764.5 47981.5 48202.0 1036.5 1142.0 1149.9 1161.7 1209.1 24224.8 26121.6 26642.6 26799.6 26893.5 36666.4 37009.3 37081.6 37089.4 37114.0 171370.0 172737.0 172912.0 172969.0 173043.1 24527.6 26043.3 26506.6 26794.0 26917.5 33750.3 34018.0 34666.8 34961.7 34963.8 29399.4 29441.6 29451.4 29671.3 29791.7 31343.2 31658.7 31881.0 31990.8 32164.0 32204.5 32535.5 32788.7 32961.7 32971.2 28092.7 28854.4 28954.9 29136.4 29649.4 23076.9 23079.2 23292.5 23358.8 23568.8 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | [#2] jquery.html Cycles:180 Average:20882.80 Median:4971.69 stddev:57970.04 (1166.0%) stddev-sans-first:58112.08 11:49:45 INFO - PROCESS | 6858 | Values: 307.3 335.9 338.6 339.1 340.1 14256.8 14736.8 15318.9 16070.9 16111.6 11468.9 11509.6 11868.3 14115.6 14688.6 4784.5 4918.7 4941.9 4950.7 4951.9 4861.3 4863.7 4900.3 4905.7 5067.1 5003.1 5035.9 5039.9 5052.2 5057.8 4991.5 4995.0 4995.6 5000.5 5339.7 4765.5 4862.6 4886.4 4888.0 4895.4 11369.8 11644.6 11645.9 14545.5 18101.4 1715.4 1802.9 2034.9 2047.0 2380.0 8509.1 8619.9 8710.4 8983.1 9047.6 1491.3 1502.8 1654.4 1763.8 1779.6 39712.4 48172.0 48314.8 51943.7 56805.7 9622.3 9622.4 9638.1 9772.0 9881.4 12377.6 12441.0 12484.7 12496.7 12505.4 6928.9 6994.6 7101.3 7105.5 7117.9 6503.2 6508.1 6578.8 6611.7 6615.4 4087.4 4111.3 4115.8 4182.1 4217.9 1628.7 1720.1 1729.0 1730.7 1749.3 816.0 825.3 837.4 917.3 920.5 13760.7 14319.3 14532.0 14723.3 14785.2 795.7 829.0 838.2 865.4 920.3 8257.3 8397.5 8411.9 8447.9 8640.8 344151.0 350945.0 355994.0 356478.0 362126.0 59302.0 60103.7 61151.4 61242.7 61660.7 763.5 781.8 788.9 792.5 794.6 12943.8 13013.5 13122.3 13285.6 13300.1 28241.0 28626.9 28663.9 29138.9 30248.2 39075.6 40131.0 40269.4 40314.4 40793.4 6865.8 7092.8 7144.1 7165.6 7172.7 9431.9 10436.7 10450.5 10533.1 10583.9 8581.2 8784.3 8865.5 9240.4 9262.8 8821.7 9003.7 9135.1 9159.6 9163.4 8643.5 8823.2 8973.4 9049.3 9290.5 6974.8 6980.2 6991.4 7006.6 7172.4 7754.8 8623.1 8759.8 8774.3 8868.1 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | [#3] mootools.html Cycles:180 Average:5087.02 Median:5970.02 stddev:2657.92 (44.5%) stddev-sans-first:2648.84 11:49:45 INFO - PROCESS | 6858 | Values: 1142.7 1380.2 1392.3 1522.5 1749.2 7127.2 7307.5 7317.3 7318.9 7328.5 7297.1 7432.7 7438.3 7455.4 7469.1 1822.6 2076.9 2115.4 2130.9 2153.0 2147.9 2157.5 2159.3 2159.7 2162.7 2050.3 2117.2 2118.8 2134.0 2136.7 2076.6 2106.5 2117.6 2137.7 2144.6 2093.4 2103.9 2104.6 2110.6 2113.4 7508.2 7525.4 7555.2 7605.4 7606.5 4256.0 4374.7 4379.2 4398.9 4399.9 2770.2 2780.4 2826.9 2828.5 2946.4 935.7 942.3 946.8 980.2 991.6 10297.5 10313.7 10318.7 10329.2 10370.2 3998.7 4054.0 4115.5 4116.5 4126.4 8864.5 8882.3 8909.2 8913.2 8924.4 3717.2 4380.2 4380.3 4381.7 4384.9 3735.6 3780.8 3803.7 3819.6 3826.2 3410.6 3469.2 3482.5 3517.1 3554.0 1070.0 1077.4 1079.2 1080.3 1088.5 1145.6 1157.2 1162.3 1165.9 1194.9 6909.4 6929.2 6941.0 6979.3 6997.6 1021.3 1043.2 1060.9 1063.1 1067.5 5109.5 5127.7 5162.1 5162.9 5169.4 8287.6 8301.8 8523.0 8536.8 8693.9 8597.5 8609.1 8622.1 8722.6 8756.9 6593.6 6624.9 6673.7 6742.1 6766.9 6547.3 6554.5 6587.6 6620.7 6627.1 7697.8 7819.8 7819.8 7847.6 7962.1 7828.6 7966.4 8027.7 8093.2 8130.3 5128.7 5705.1 5854.7 6078.4 6164.4 6904.9 6942.8 6982.9 6983.4 6983.8 6125.1 6349.8 6393.5 6411.7 6473.7 6346.9 6372.9 6445.0 6446.4 6539.6 6614.3 6635.2 6638.5 6658.8 6669.5 5970.7 6086.6 6201.8 6213.7 6237.6 5910.1 5931.4 5969.3 5978.7 5999.4 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | [#4] prototype.html Cycles:180 Average:4506.52 Median:5233.15 stddev:1337.58 (25.6%) stddev-sans-first:1303.63 11:49:45 INFO - PROCESS | 6858 | Values: 305.2 305.5 307.5 315.3 316.0 5118.1 5217.5 5254.3 5290.2 5293.1 5142.7 5210.8 5224.3 5227.2 5239.1 3797.3 3883.7 3995.5 4016.9 4022.9 4007.6 4011.4 4011.9 4012.2 4016.1 3960.7 3968.5 3976.2 3999.1 4002.8 3774.7 3847.1 3915.9 3920.1 3977.0 3391.1 3399.7 3400.3 3401.7 3404.7 4932.5 4965.7 4977.4 4978.1 4983.9 4509.3 4509.4 4509.6 4510.7 4518.8 5410.8 5414.5 5415.6 5418.7 5420.6 3718.7 3719.7 3721.2 3723.1 3729.1 5485.2 5619.4 5699.0 5708.1 5711.1 3840.3 3846.3 3875.2 3876.1 3878.3 3927.5 3929.6 3931.7 3932.0 3935.8 4511.9 4516.5 4521.7 4525.7 4528.4 5430.4 5437.6 5440.6 5444.6 5450.6 1366.0 1379.4 1379.5 1379.6 1381.4 862.4 904.8 940.9 959.4 959.7 4676.6 4757.0 4788.9 4789.6 4811.3 5649.3 5659.5 5669.5 5674.9 5677.9 4769.0 4773.1 4775.5 4777.1 4777.3 2998.6 3035.1 3037.9 3041.0 3041.2 5374.3 5377.5 5378.4 5386.4 5389.3 5639.2 5785.4 5808.8 5820.2 5829.1 5353.5 5373.9 5381.3 5390.4 5391.1 5654.9 5655.4 5657.5 5661.5 5662.4 5541.5 5543.8 5547.1 5554.4 5555.4 5373.2 5384.7 5385.8 5388.5 5390.5 3791.5 3904.9 3908.8 3912.7 3921.2 5633.0 5651.0 5656.4 5657.6 5659.7 5433.3 5442.1 5443.3 5443.5 5445.5 5429.0 5430.6 5432.5 5437.0 5441.1 5336.2 5337.8 5338.3 5339.4 5343.9 5309.9 5468.5 5469.8 5480.3 5532.1 5348.6 5356.9 5368.0 5383.3 5383.8 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - PROCESS | 6858 | [#5] yui.html Cycles:180 Average:11499.30 Median:518.36 stddev:13152.06 (2537.2%) stddev-sans-first:13163.66 11:49:45 INFO - PROCESS | 6858 | Values: 635.8 648.9 691.1 711.0 715.2 10267.8 10424.2 10424.6 10425.7 10453.1 10979.7 11126.8 11128.1 11155.4 11156.2 588.2 765.7 772.8 776.2 780.8 795.6 799.1 799.6 799.8 800.1 834.5 836.7 836.8 836.9 837.1 617.7 817.6 822.4 830.1 836.3 611.8 616.4 617.2 617.5 618.1 11237.0 11286.1 11307.1 11320.3 11341.9 10638.8 10909.3 11034.4 11250.7 11475.9 8760.2 8825.9 8841.4 8909.3 9094.6 3159.2 3167.6 3218.1 3242.7 3286.4 38229.4 38463.8 38475.0 38555.6 38645.6 8171.8 8332.3 8334.8 8544.4 8658.1 16695.6 16709.2 16719.3 16834.0 16842.7 6109.4 6156.3 6263.5 6323.8 6347.3 3500.5 3511.9 3515.5 3520.6 3522.5 2760.4 2787.4 2801.5 2802.4 2812.0 418.1 459.7 462.9 477.6 477.9 453.3 513.2 517.9 519.4 524.6 6727.9 6879.2 6902.8 6907.2 6990.9 405.4 478.3 487.3 509.9 518.8 3054.5 3078.7 3086.5 3096.3 3186.5 44630.1 44634.6 45007.8 45023.8 45565.0 42264.4 42361.8 43094.0 43167.6 43231.6 38422.4 40763.0 40990.2 41087.0 42049.6 6499.2 6951.6 7417.6 7448.9 7501.2 29187.9 29188.6 30338.7 30492.0 30502.0 34551.0 37517.2 38096.0 38209.2 38565.0 9224.9 9413.5 9503.2 9545.3 9639.7 9952.8 10229.8 10250.0 10271.0 10296.4 8885.1 9017.8 9120.5 9179.1 9386.2 8860.6 8874.9 8897.6 8933.5 8961.7 9021.1 9055.6 9057.6 9095.5 9096.2 7992.4 8198.3 8216.2 8244.3 8346.6 7647.7 8004.4 8068.6 8196.8 8233.6 11:49:45 INFO - PROCESS | 6858 | -------- Summary: end -------- 11:49:45 INFO - PROCESS | 6858 | 11:49:45 INFO - TEST-INFO | 6858: exit 0 11:49:45 INFO - TEST-OK | dromaeo_css | took 1117590ms 11:49:45 INFO - TEST-START | kraken 11:49:45 INFO - operating with platform_type : linux_ 11:49:45 INFO - Initialising browser for kraken test... 11:49:45 INFO - TEST-INFO | started process 7036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfjf9TN/profile http://localhost:48877/getInfo.html) 11:49:50 INFO - PROCESS | 7036 | __metrics Screen width/height:1600/1200 11:49:50 INFO - PROCESS | 7036 | colorDepth:24 11:49:50 INFO - PROCESS | 7036 | Browser inner width/height: 1024/697 11:49:50 INFO - PROCESS | 7036 | __metrics 11:49:51 ERROR - PROCESS | 7036 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:49:51 INFO - PROCESS | 7036 | 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. 11:49:52 INFO - TEST-INFO | 7036: exit 0 11:49:52 INFO - Browser initialized. 11:49:52 INFO - Running cycle 1/1 for kraken test... 11:49:52 INFO - TEST-INFO | started process 7116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfjf9TN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:03 INFO - PROCESS | 7116 | RSS: Main: 154939392 11:50:03 INFO - PROCESS | 7116 | 11:50:06 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48877/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:07 INFO - PROCESS | 7116 | RSS: Main: 193683456 11:50:07 INFO - PROCESS | 7116 | 11:50:09 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48877/tests/kraken/driver.html?testName=audio-dft) 11:50:10 INFO - PROCESS | 7116 | RSS: Main: 184238080 11:50:10 INFO - PROCESS | 7116 | 11:50:13 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48877/tests/kraken/driver.html?testName=audio-fft) 11:50:14 INFO - PROCESS | 7116 | RSS: Main: 175046656 11:50:14 INFO - PROCESS | 7116 | 11:50:16 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48877/tests/kraken/driver.html?testName=audio-oscillator) 11:50:16 INFO - PROCESS | 7116 | RSS: Main: 173953024 11:50:16 INFO - PROCESS | 7116 | 11:50:19 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48877/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:19 INFO - PROCESS | 7116 | RSS: Main: 174489600 11:50:19 INFO - PROCESS | 7116 | 11:50:22 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48877/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:23 INFO - PROCESS | 7116 | RSS: Main: 175296512 11:50:23 INFO - PROCESS | 7116 | 11:50:26 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48877/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:27 INFO - PROCESS | 7116 | RSS: Main: 172933120 11:50:27 INFO - PROCESS | 7116 | 11:50:30 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48877/tests/kraken/driver.html?testName=json-parse-financial) 11:50:31 INFO - PROCESS | 7116 | RSS: Main: 174362624 11:50:31 INFO - PROCESS | 7116 | 11:50:32 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48877/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:33 INFO - PROCESS | 7116 | RSS: Main: 187486208 11:50:33 INFO - PROCESS | 7116 | 11:50:35 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:35 INFO - PROCESS | 7116 | RSS: Main: 185217024 11:50:35 INFO - PROCESS | 7116 | 11:50:38 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:38 INFO - PROCESS | 7116 | RSS: Main: 195964928 11:50:38 INFO - PROCESS | 7116 | 11:50:41 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:50:41 INFO - PROCESS | 7116 | RSS: Main: 200028160 11:50:41 INFO - PROCESS | 7116 | 11:50:44 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:50:45 INFO - PROCESS | 7116 | RSS: Main: 201195520 11:50:45 INFO - PROCESS | 7116 | 11:50:46 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:48877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48877/tests/kraken/driver.html?testName=ai-astar) 11:50:47 INFO - PROCESS | 7116 | RSS: Main: 261840896 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | __start_tp_report 11:50:47 INFO - PROCESS | 7116 | _x_x_mozilla_page_load 11:50:47 INFO - PROCESS | 7116 | _x_x_mozilla_page_load_details 11:50:47 INFO - PROCESS | 7116 | |i|pagename|runs| 11:50:47 INFO - PROCESS | 7116 | |0;ai-astar;112;113;108;112;114;114;102;112;113;112 11:50:47 INFO - PROCESS | 7116 | |1;audio-beat-detection;153;135;155;172;135;155;156;134;184;138 11:50:47 INFO - PROCESS | 7116 | |2;audio-dft;161;162;161;161;162;161;164;161;162;161 11:50:47 INFO - PROCESS | 7116 | |3;audio-fft;74;77;73;153;74;77;73;74;150;74 11:50:47 INFO - PROCESS | 7116 | |4;audio-oscillator;94;94;142;94;94;95;147;94;96;132 11:50:47 INFO - PROCESS | 7116 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 11:50:47 INFO - PROCESS | 7116 | |6;imaging-darkroom;147;146;147;146;146;147;146;146;147;146 11:50:47 INFO - PROCESS | 7116 | |7;imaging-desaturate;96;95;96;96;96;96;96;95;96;95 11:50:47 INFO - PROCESS | 7116 | |8;json-parse-financial;67;66;66;66;66;67;67;77;64;65 11:50:47 INFO - PROCESS | 7116 | |9;json-stringify-tinderbox;70;70;69;70;70;70;70;69;70;70 11:50:47 INFO - PROCESS | 7116 | |10;stanford-crypto-aes;91;81;82;82;82;83;81;82;82;82 11:50:47 INFO - PROCESS | 7116 | |11;stanford-crypto-ccm;129;127;123;120;131;118;135;128;123;129 11:50:47 INFO - PROCESS | 7116 | |12;stanford-crypto-pbkdf2;152;138;149;145;149;137;147;149;144;150 11:50:47 INFO - PROCESS | 7116 | |13;stanford-crypto-sha256-iterative;70;71;70;69;71;68;69;71;69;67 11:50:47 INFO - PROCESS | 7116 | __end_tp_report 11:50:47 INFO - PROCESS | 7116 | __start_cc_report 11:50:47 INFO - PROCESS | 7116 | _x_x_mozilla_cycle_collect,1155 11:50:47 INFO - PROCESS | 7116 | __end_cc_report 11:50:47 INFO - PROCESS | 7116 | __startTimestamp1457812247070__endTimestamp 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | ------- Summary: start ------- 11:50:47 INFO - PROCESS | 7116 | Number of tests: 14 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.65 (3.2%) stddev-sans-first:3.86 11:50:47 INFO - PROCESS | 7116 | Values: 112.0 113.0 108.0 112.0 114.0 114.0 102.0 112.0 113.0 112.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.00 stddev:16.85 (10.9%) stddev-sans-first:17.87 11:50:47 INFO - PROCESS | 7116 | Values: 153.0 135.0 155.0 172.0 135.0 155.0 156.0 134.0 184.0 138.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 11:50:47 INFO - PROCESS | 7116 | Values: 161.0 162.0 161.0 161.0 162.0 161.0 164.0 161.0 162.0 161.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#3] audio-fft Cycles:10 Average:89.90 Median:74.00 stddev:32.50 (43.9%) stddev-sans-first:33.96 11:50:47 INFO - PROCESS | 7116 | Values: 74.0 77.0 73.0 153.0 74.0 77.0 73.0 74.0 150.0 74.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.47 (23.9%) stddev-sans-first:23.24 11:50:47 INFO - PROCESS | 7116 | Values: 94.0 94.0 142.0 94.0 94.0 95.0 147.0 94.0 96.0 132.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:50:47 INFO - PROCESS | 7116 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:50:47 INFO - PROCESS | 7116 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:50:47 INFO - PROCESS | 7116 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.50 stddev:3.60 (5.4%) stddev-sans-first:3.82 11:50:47 INFO - PROCESS | 7116 | Values: 67.0 66.0 66.0 66.0 66.0 67.0 67.0 77.0 64.0 65.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 11:50:47 INFO - PROCESS | 7116 | Values: 70.0 70.0 69.0 70.0 70.0 70.0 70.0 69.0 70.0 70.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.94 (3.6%) stddev-sans-first:0.60 11:50:47 INFO - PROCESS | 7116 | Values: 91.0 81.0 82.0 82.0 82.0 83.0 81.0 82.0 82.0 82.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:128.50 stddev:5.23 (4.1%) stddev-sans-first:5.45 11:50:47 INFO - PROCESS | 7116 | Values: 129.0 127.0 123.0 120.0 131.0 118.0 135.0 128.0 123.0 129.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:149.00 stddev:5.06 (3.4%) stddev-sans-first:4.87 11:50:47 INFO - PROCESS | 7116 | Values: 152.0 138.0 149.0 145.0 149.0 137.0 147.0 149.0 144.0 150.0 11:50:47 INFO - PROCESS | 7116 | 11:50:47 INFO - PROCESS | 7116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 11:50:47 INFO - PROCESS | 7116 | Values: 70.0 71.0 70.0 69.0 71.0 68.0 69.0 71.0 69.0 67.0 11:50:47 INFO - PROCESS | 7116 | -------- Summary: end -------- 11:50:47 INFO - PROCESS | 7116 | 11:50:48 INFO - TEST-INFO | 7116: exit 0 11:50:48 INFO - TEST-OK | kraken | took 62278ms 11:50:48 INFO - SUITE-END | took 1179s 11:50:48 INFO - Completed test suite (00:19:39) 11:50:48 INFO - javascript benchmark 11:50:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.6475625790517, 2682.24897028832, 2688.4354285600025, 2701.1896431070672, 2722.646056012719, 4387.978060109703, 4500.21246281901, 4564.292534657129, 4578.404807375041, 4603.654725895559, 4592.655550833684, 4607.976960115195, 4613.6078433333205, 4613.861584152481, 4698.0, 4196.790160491963, 4213.494380674323, 4225.8520951766695, 4239.576042395759, 4316.6762492813, 4232.724872883268, 4291.613754762071, 4303.031817840992, 4304.827806887721, 4336.718113322624, 4072.1855628874346, 4152.356384760336, 4157.91684166315, 4268.359746038119, 4275.5296917339065, 4171.290880550314, 4202.936955945633, 4205.137946720914, 4208.032152604918, 4248.787560621957, 4181.874543763662, 4192.853250136231, 4200.390943313233, 4209.0, 4253.043065310311, 4382.342648602703, 4520.095980803852, 4584.701994370389, 4618.399608050965, 4631.861044168681, 4888.266759986031, 4910.165271903785, 4924.335214745999, 4931.284963680282, 4974.204127339608, 4690.507496712864, 4949.232868905326, 4950.603951683856, 4953.331300274453, 4957.851264462072, 4553.726776393427, 4578.656600754956, 4585.380973568593, 4615.976920115378, 4624.606908412823, 5019.222020586815, 5056.544910958031, 5067.265246539305, 5072.416672082684, 5102.821401250939, 4691.085238378551, 4755.453122890843, 4828.927566086511, 4851.272309153655, 4859.635527335464, 4931.235658472942, 4959.479254678279, 4961.206207006861, 4963.230699241623, 5002.824901128443, 4881.682690625169, 4890.339804126397, 4891.877703057381, 4896.387951506062, 4940.011997600494, 4651.767411629405, 4742.407199100113, 4807.086653535817, 4884.804607815719, 4921.089598424303, 4135.462389889295, 4143.19207754485, 4151.8546850860075, 4161.042960119129, 4167.874963751093, 3636.054625797312, 3646.197836475971, 3646.7994260315936, 3647.598764135943, 3689.6494832990825, 4019.9799001005395, 4127.525334586561, 4146.751194928314, 4199.223143718422, 4217.030083080847, 4895.678499878188, 4909.631777616693, 4910.582600478928, 4917.409910810726, 4920.040592084509, 4196.958030419718, 4197.139586384784, 4202.726822756572, 4234.047339348622, 4250.468691413574, 4235.957640423557, 4314.223439780807, 4371.497277813029, 4392.38506609075, 4397.164538737694, 4619.260918253063, 4629.65277604181, 4639.979204574921, 4641.025384669258, 4683.953160468352, 4890.217565189552, 4895.853124406273, 4906.165951788276, 4915.26271059344, 4956.801727930987, 4448.421705178306, 4517.638588912813, 4568.908621827479, 4589.2886602576655, 4616.722996620214, 4835.057163853015, 4856.611471082376, 4860.392450943632, 4877.048975449753, 4890.193118135468, 4715.363425937455, 4904.11725889329, 4905.337779399735, 4942.0, 4978.352814134139, 4614.907701846011, 4794.993051459232, 4801.4958429365815, 4823.614110871052, 4843.660943734046, 4702.341672165968, 4726.527347265246, 4743.217369134192, 4746.501617330131, 4777.856664300077, 4497.235469970047, 4634.930476042795, 4644.698094623838, 4650.162970665177, 4694.2723877799, 4752.572268495852, 4777.259524773665, 4781.641376896816, 4784.425868895755, 4817.8313759018265, 4670.369500117441, 4674.7896344663895, 4674.813007479663, 4676.719396836201, 4682.344471773887], "unit": "score", "name": "dojo.html", "value": 4497.3963577711165}, {"lowerIsBetter": false, "replicates": [470.61174531011903, 497.41305259793427, 501.9121653710601, 509.84449742828446, 520.084651014215, 25501.489970200586, 34051.0, 34402.48396274058, 34485.0, 34511.4823277651, 37251.627483725155, 37589.0, 37626.0, 37654.62345376545, 37682.24635507288, 7693.461457697963, 7878.409119316074, 7892.289693927545, 7894.210578942088, 7898.407619428566, 7723.189065148163, 7849.529028258323, 7851.56816375102, 7861.646225919819, 8014.438989270753, 7895.526268423884, 8063.677452901877, 8064.31453326468, 8067.878981815277, 8069.233422824852, 7947.7218297359605, 8011.158828323029, 8015.7595272141925, 8016.358691304682, 8036.959815200887, 7792.142864284924, 7808.5314881107315, 7886.0536735592095, 7891.171427000198, 8036.517808931424, 37037.0, 37460.31746031746, 37490.81254593737, 37511.43732844009, 37513.81243093767, 3007.338385555174, 3089.3196955280714, 3530.699890509284, 3539.5398598182073, 3653.2876089162623, 27910.441791164267, 28402.431951360857, 28497.430051399064, 28535.0, 28543.14370568886, 3320.966790332114, 3348.4809854472596, 3392.4063288924585, 3509.192885636318, 3530.717542596586, 167948.0, 168021.0, 168309.0, 217278.99999999843, 217863.0, 53891.46108538864, 54168.0, 54239.0, 54262.45737542653, 54282.0, 57809.71095144498, 58021.41978580245, 58022.7098864503, 58027.709861451265, 58062.0, 14263.85736142646, 14456.0, 14460.06009609372, 14464.421423143167, 14465.710685786225, 11369.204155709187, 11408.144389170846, 11430.14273929442, 11436.885631143583, 11451.19841611096, 15595.0, 18433.170507327202, 18552.628947420977, 18582.44252672422, 18636.534086647942, 7421.851562968711, 7616.9238307617325, 7739.7678069658, 7753.806154846174, 7785.766427007199, 861.2507118806553, 903.8553831386946, 906.3746015249457, 970.6166064404521, 997.2719914462483, 25981.480370392484, 25988.8700556496, 26533.734662653125, 26896.32759181036, 26934.32664183411, 851.5571902610608, 958.1376760915232, 980.07872599756, 1072.0726571515584, 1094.8686157660973, 12488.81266780999, 12709.0, 12719.282896808998, 12809.743805123846, 12875.420606072748, 249494.0, 251514.0, 251556.0, 251918.0, 253024.0, 47435.28847067297, 47708.0, 47764.5223547767, 47981.520184798406, 48202.0, 1036.4713995862164, 1141.9885801142048, 1149.9137564682683, 1161.6805378520974, 1209.1173443386376, 24224.75775242225, 26121.608175876998, 26642.600360994988, 26799.598006030315, 26893.462130757667, 36666.43334966633, 37009.259814803016, 37081.629183708894, 37089.443658345685, 37114.0, 171370.0, 172737.0, 172912.0, 172969.0, 173043.13478432526, 24527.632085518373, 26043.348916276485, 26506.602400963617, 26794.0, 26917.461650766483, 33750.324993500486, 34018.0, 34666.82666586651, 34961.678640529106, 34963.7762678305, 29399.412011760072, 29441.558376624795, 29451.41097178087, 29671.25821854471, 29791.702082978893, 31343.21641958969, 31658.683413166495, 31881.0, 31990.84004579962, 32164.0, 32204.516932245566, 32535.51196732098, 32788.67211327856, 32961.67038329586, 32971.17572060622, 28092.71907280901, 28854.42291154207, 28954.855225723735, 29136.417271654023, 29649.407011860072, 23076.884615576815, 23079.19222827193, 23292.534149317256, 23358.76641233566, 23568.764312357343], "unit": "score", "name": "ext.html", "value": 16279.063602984968}, {"lowerIsBetter": false, "replicates": [307.26410247457324, 335.91434184283014, 338.6461148100235, 339.07601785135495, 340.05464807834215, 14256.80501547495, 14736.778948315783, 15318.923405382971, 16070.919645401786, 16111.597210069755, 11468.885311146907, 11509.597164099257, 11868.347240901747, 14115.57653270401, 14688.559343219693, 4784.49762774908, 4918.680285781431, 4941.901161976758, 4950.653454258186, 4951.900961980758, 4861.319415281863, 4863.6595438319155, 4900.313956046157, 4905.730184839832, 5067.062593420211, 5003.12445322069, 5035.924461133068, 5039.949600503985, 5052.166392545226, 5057.772400241998, 4991.475895031006, 4994.97502512487, 4995.6003519718515, 5000.549950504454, 5339.652922560022, 4765.451973023078, 4862.586680132157, 4886.364772579577, 4888.046830867982, 4895.388076490439, 11369.829452558219, 11644.592439264585, 11645.883541164565, 14545.490907818175, 18101.366452174243, 1715.4167583021708, 1802.8918264904148, 2034.8779073255505, 2046.98976505118, 2379.9643005354933, 8509.106543812934, 8619.870701939475, 8710.433821801562, 8983.146601072887, 9047.592858321392, 1491.3065424577624, 1502.7820965959984, 1654.445760670177, 1763.7971633262212, 1779.644071185768, 39712.404313935316, 48172.0, 48314.758426208, 51943.74028129873, 56805.71597141988, 9622.278329125344, 9622.422654640744, 9638.132568068908, 9771.951140244395, 9881.357711748713, 12377.566785162477, 12441.0, 12484.687882803002, 12496.687582810502, 12505.437255323532, 6928.852055862699, 6994.5803251805055, 7101.254368291255, 7105.502614817016, 7117.857642847114, 6503.187101612299, 6508.056331831858, 6578.8355291118105, 6611.702473388613, 6615.4376877965915, 4087.3868919662286, 4111.259973204792, 4115.835366585363, 4182.121754431603, 4217.936730949038, 1628.6824069306372, 1720.1055451165323, 1728.974065388995, 1730.7490413890168, 1749.2565659594623, 816.0, 825.2902503846688, 837.4054421360902, 917.2661870503571, 920.484528663937, 13760.724785504233, 14319.284035798168, 14532.0, 14723.337449814784, 14785.186814725079, 795.6936579416966, 829.0, 838.2288294768828, 865.359633870931, 920.3327587499143, 8257.256846883809, 8397.538135402488, 8411.873821892677, 8447.901772769623, 8640.827183456297, 344151.0, 350945.0, 355994.0, 356478.0, 362126.0, 59302.0, 60103.69948150319, 61151.38848611546, 61242.693786530785, 61660.69169654123, 763.4503157726317, 781.7850091224844, 788.8895554622358, 792.5324058805218, 794.5987276425484, 12943.805842912176, 13013.544525941546, 13122.278274694983, 13285.601431957057, 13300.068995170244, 28241.0, 28626.856865715537, 28663.856680716464, 29138.854305728335, 30248.243793905327, 39075.609243907194, 40131.0, 40269.39595906005, 40314.39528407135, 40793.388099177944, 6865.828354290983, 7092.787216383516, 7144.071270734771, 7165.5700657958605, 7172.748953786592, 9431.905680943102, 10436.686899393031, 10450.529726162493, 10533.052025317758, 10583.894161058599, 8581.184787445183, 8784.297256219359, 8865.512396818236, 9240.399374040666, 9262.768430789014, 8821.691240806542, 9003.684871029482, 9135.132162444557, 9159.633614655606, 9163.35856490066, 8643.524606146471, 8823.161799629024, 8973.37186396946, 9049.276057915482, 9290.535473226177, 6974.755883544254, 6980.197277313174, 6991.40573051276, 7006.579605223703, 7172.426205903619, 7754.806129846574, 8623.051464339043, 8759.781005474913, 8774.298056155365, 8868.11318868108], "unit": "score", "name": "jquery.html", "value": 7276.401742812335}, {"lowerIsBetter": false, "replicates": [1142.7371704507968, 1380.2270728392102, 1392.2621010864243, 1522.4823559989609, 1749.2215963896072, 7127.1803742569555, 7307.525010874303, 7317.26827317268, 7318.890216646748, 7328.487005909575, 7297.087864016998, 7432.6655300511475, 7438.293362130603, 7455.403567714583, 7469.066366704162, 1822.599028213791, 2076.9376918692465, 2115.4182599785026, 2130.8828014459277, 2153.0418963561224, 2147.9355619331445, 2157.46063484129, 2159.341400872741, 2159.708439360682, 2162.718846549946, 2050.29264903608, 2117.2060477321006, 2118.8410869184795, 2134.039682143034, 2136.7329083864515, 2076.584683063386, 2106.5260316428758, 2117.5658989907033, 2137.722096127509, 2144.613969485492, 2093.3929160543425, 2103.9368818935454, 2104.6001259760596, 2110.5989861926187, 2113.397681660719, 7508.211637778064, 7525.397968162589, 7555.16893141754, 7605.391568674493, 7606.467547271694, 4256.0, 4374.693771436001, 4379.189849877783, 4398.868033958986, 4399.934000989956, 2770.1551026936777, 2780.3605170810624, 2826.858657067138, 2828.4625921075135, 2946.351802603424, 935.6631612619451, 942.2885721280389, 946.7585765629789, 980.2256217588097, 991.5587563534231, 10297.485125743682, 10313.742156446075, 10318.742031449274, 10329.173666106768, 10370.22223333253, 3998.7400818946676, 4053.959460405358, 4115.506139263308, 4116.4648595682365, 4126.381042843597, 8864.512451815082, 8882.289416846637, 8909.242714369222, 8913.197812196804, 8924.375293729376, 3717.237966216919, 4380.211561918885, 4380.3210502372185, 4381.7151885128005, 4384.868453946387, 3735.6077611850906, 3780.773153610792, 3803.67668748154, 3819.6371344722206, 3826.1964987352967, 3410.556627638391, 3469.2020835208045, 3482.4950382194947, 3517.138301116243, 3553.982230088833, 1069.9786004280027, 1077.4074259157433, 1079.1906070447164, 1080.270817198388, 1088.466651340853, 1145.5589598004663, 1157.2015309436463, 1162.3026184289358, 1165.918385712992, 1194.8506436695413, 6909.412699920463, 6929.237783843773, 6940.9652951734915, 6979.336962988508, 6997.615131167733, 1021.2595867995792, 1043.175891046065, 1060.9151267898549, 1063.1494804156798, 1067.514281002142, 5109.489051094861, 5127.743612819344, 5162.148245539519, 5162.889978654607, 5169.3796744390165, 8287.585620718939, 8301.750947471586, 8523.019852717018, 8536.786580335542, 8693.913060869438, 8597.527136007455, 8609.053004169537, 8622.094680058504, 8722.563871806384, 8756.8686469703, 6593.571417857824, 6624.873771458863, 6673.733050677918, 6742.123523941857, 6766.917293233158, 6547.312532184243, 6554.508411869224, 6587.571807832475, 6620.668966551557, 6627.138471998802, 7697.769066928001, 7819.765407037798, 7819.804504887424, 7847.646855891385, 7962.08436029864, 7828.647710853139, 7966.442349035744, 8027.719029834161, 8093.150219226896, 8130.308923741548, 5128.743562821769, 5705.058665320342, 5854.677992710442, 6078.361772014052, 6164.352742961924, 6904.93095069063, 6942.791716248521, 6982.930170698228, 6983.406410455168, 6983.825404364931, 6125.142480052886, 6349.809505714836, 6393.536643144016, 6411.679416029273, 6473.708683109177, 6346.936530634634, 6372.9362706374195, 6445.0, 6446.387593178641, 6539.574927629689, 6614.338566143347, 6635.23694775107, 6638.468922486093, 6658.83352916181, 6669.533132680665, 5970.731317090828, 6086.573939824169, 6201.751929922752, 6213.720382582885, 6237.625742455467, 5910.113482977587, 5931.436513531207, 5969.313528944053, 5978.701064946822, 5999.430054144849], "unit": "score", "name": "mootools.html", "value": 4182.319990589439}, {"lowerIsBetter": false, "replicates": [305.18667750445064, 305.51575752432393, 307.5371565793481, 315.32205757621097, 315.95102759072336, 5118.129917913954, 5217.504337087976, 5254.343207099113, 5290.206469029637, 5293.1001729705895, 5142.6914385136915, 5210.843674689756, 5224.29472021277, 5227.2159176123505, 5239.083160446926, 3797.259534390795, 3883.7475564088386, 3995.5005624296964, 4016.9196616067734, 4022.879313620596, 4007.5591684914634, 4011.3782363733667, 4011.8997025074314, 4012.1574469361467, 4016.1365306459106, 3960.742551734128, 3968.503937007874, 3976.2445135424177, 3999.060220848098, 4002.8398864045403, 3774.698024158061, 3847.1343947611845, 3915.941260881089, 3920.0591857954173, 3977.0256287209672, 3391.118309239591, 3399.7280217582534, 3400.268942177444, 3401.744869134825, 3404.69357757803, 4932.506749325074, 4965.677230979974, 4977.42759582649, 4978.103941290567, 4983.900321993576, 4509.25597276449, 4509.391232183646, 4509.571590698878, 4510.714446382765, 4518.81924723014, 5410.810621628224, 5414.485623865727, 5415.566754659657, 5418.729063546807, 5420.620556561043, 3718.665320121202, 3719.702423806089, 3721.1999420124534, 3723.1436769543157, 3729.1050147964293, 5485.204645326446, 5619.353774315965, 5698.971505142447, 5708.1437784332265, 5711.057675483582, 3840.2895464339185, 3846.2692088503095, 3875.2055828555644, 3876.0697432616535, 3878.3406820840523, 3927.5286965563746, 3929.6070392960473, 3931.7051221158526, 3932.0, 3935.763854168759, 4511.88720281989, 4516.480604730498, 4521.66087543429, 4525.705829121097, 4528.388667529907, 5430.375506816767, 5437.564994800407, 5440.619156658996, 5444.646098003696, 5450.5912056595125, 1365.9931700341435, 1379.3999610169608, 1379.4964837834118, 1379.5654368873772, 1381.4336122189854, 862.4049405909902, 904.7511934218143, 940.8917974432891, 959.4483172176027, 959.712086374085, 4676.649251306166, 4757.0, 4788.856334309976, 4789.640776941744, 4811.326414302001, 5649.265595472562, 5659.547236221092, 5669.461401166883, 5674.943250567524, 5677.858053548612, 4769.0, 4773.069251495925, 4775.450823155312, 4777.116233496814, 4777.3072904429355, 2998.610180676498, 3035.05913166919, 3037.9240518987203, 3041.0, 3041.163679988021, 5374.274472946102, 5377.489138531833, 5378.381486129145, 5386.380566234855, 5389.27244821944, 5639.238702775155, 5785.363610002896, 5808.82573522795, 5820.1560773688425, 5829.09649004405, 5353.544948679406, 5373.919391209135, 5381.27352807366, 5390.353157621111, 5391.056565101092, 5654.915176272441, 5655.406182350958, 5657.519110875622, 5661.518770904355, 5662.405447427961, 5541.501264886179, 5543.805966791143, 5547.084731019337, 5554.389017208185, 5555.388907220284, 5373.194020896896, 5384.6769193848495, 5385.8114965976, 5388.515033646991, 5390.460953904735, 3791.4881490999464, 3904.902377440587, 3908.785016824102, 3912.7261091724445, 3921.1569512553797, 5632.971835140798, 5650.971745141248, 5656.37779844225, 5657.575681823797, 5659.660420374791, 5433.293671822637, 5442.102053161184, 5443.319585051869, 5443.510084092292, 5445.455454454523, 5429.0, 5430.619856609999, 5432.511074003359, 5436.966976274495, 5441.102218133963, 5336.172893201405, 5337.759800808895, 5338.332708411449, 5339.412664606968, 5343.919841202307, 5309.920351194658, 5468.507834294933, 5469.808556700496, 5480.314960629921, 5532.114861622282, 5348.5988550858065, 5356.866078348073, 5367.973160134331, 5383.327084114486, 5383.784648614168], "unit": "score", "name": "prototype.html", "value": 4079.636424969226}, {"lowerIsBetter": false, "replicates": [635.7743001234562, 648.8637386148908, 691.0808624529376, 710.9751158709445, 715.1525442350815, 10267.794644107113, 10424.218183636229, 10424.583016679342, 10425.687229383131, 10453.11148552373, 10979.725506862333, 11126.833097503544, 11128.0541154002, 11155.442227888614, 11156.16328775341, 588.2441063233746, 765.674588299973, 772.8338407242442, 776.2005134711256, 780.8438312337527, 795.6021989005498, 799.1169757418056, 799.60019990005, 799.808046068945, 800.1118758178417, 834.4784509681449, 836.7113345895687, 836.824266903951, 836.93304535637, 837.0833936839151, 617.7405489694362, 817.6157206113118, 822.4489591973393, 830.0910502999207, 836.2515548583983, 611.8378629663143, 616.4051690119012, 617.1853153836937, 617.521420898807, 618.1376979114156, 11237.0, 11286.097112231002, 11307.095432365391, 11320.320780753182, 11341.943290283496, 10638.840417393745, 10909.290896091728, 11034.393108379036, 11250.718732031683, 11475.942620286929, 8760.211580957744, 8825.911740882573, 8841.425307355066, 8909.331800115016, 9094.63621455141, 3159.210197450637, 3167.588213532226, 3218.0506750508657, 3242.7405807535342, 3286.4248756467523, 38229.42655860164, 38463.807680961414, 38475.03812404684, 38555.614443855484, 38645.613543864485, 8171.836563268701, 8332.250097491255, 8334.83330333402, 8544.444611100258, 8658.134186581417, 16695.582610434838, 16709.248083836257, 16719.331226750794, 16834.0, 16842.747358789627, 6109.389061093855, 6156.322804491502, 6263.467605253513, 6323.841903952438, 6347.301796802348, 3500.5274287971306, 3511.9297614047578, 3515.54297941266, 3520.647935206459, 3522.489239060373, 2760.406512599801, 2787.442511497668, 2801.4817258807184, 2802.4114935863695, 2812.0, 418.11359916976204, 459.71497671443916, 462.8680825964584, 477.59165913144454, 477.88052986753314, 453.2747603833905, 513.1532970598468, 517.8782985998288, 519.3845293327419, 524.6484855147061, 6727.865442691216, 6879.174499060145, 6902.792916212522, 6907.171139463196, 6990.895136572955, 405.3635791806835, 478.2969035517783, 487.25693317690803, 509.9184130539096, 518.8443466959897, 3054.526548385004, 3078.6613472518006, 3086.5215891536845, 3096.303331750338, 3186.474231751781, 44630.10739785251, 44634.55365446369, 45007.77496112564, 45023.774881125384, 45565.0, 42264.366034509505, 42361.788191059466, 43094.0, 43167.568324316984, 43231.56768432338, 38422.423663645066, 40763.0, 40990.180196396504, 41087.0, 42049.579504205176, 6499.155109835691, 6951.582905025714, 7417.592032438268, 7448.925510744823, 7501.221616123199, 29187.85406072956, 29188.562171567868, 30338.696613033586, 30492.0, 30502.0, 34551.0, 37517.2496550062, 38096.0, 38209.235815282984, 38565.0, 9224.861627075734, 9413.529323533932, 9503.192228660364, 9545.331826772059, 9639.662611808553, 9952.800943981225, 10229.846552301573, 10250.033707360046, 10271.0, 10296.433696146783, 8885.06706795803, 9017.819643607223, 9120.49837258957, 9179.082091791035, 9386.249100071842, 8860.58341944218, 8874.911250887408, 8897.599608017525, 8933.46399216049, 8961.731148065568, 9021.052789457013, 9055.592498337459, 9057.592408341772, 9095.454272743393, 9096.1813436791, 7992.400569957393, 8198.262156405952, 8216.21945915137, 8244.258016778518, 8346.624401901807, 7647.655855486628, 8004.399670024655, 8068.59657017135, 8196.836063278583, 8233.629486673233], "unit": "score", "name": "yui.html", "value": 5341.264563043754}], "name": "dromaeo_css", "value": 6040.026734034296}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 112.0, 114.0, 114.0, 102.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [153.0, 135.0, 155.0, 172.0, 135.0, 155.0, 156.0, 134.0, 184.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 164.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 73.0, 153.0, 74.0, 77.0, 73.0, 74.0, 150.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 94.0, 94.0, 95.0, 147.0, 94.0, 96.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 77.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [91.0, 81.0, 82.0, 82.0, 82.0, 83.0, 81.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 123.0, 120.0, 131.0, 118.0, 135.0, 128.0, 123.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [152.0, 138.0, 149.0, 145.0, 149.0, 137.0, 147.0, 149.0, 144.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 69.0, 71.0, 68.0, 69.0, 71.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1543.1}]} 11:50:48 INFO - Return code: 0 11:50:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:50:48 ERROR - # TBPL SUCCESS # 11:50:48 INFO - Running post-action listener: _resource_record_post_action 11:50:48 INFO - Running post-run listener: _resource_record_post_run 11:50:49 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522293248; Read time: 20; Write time: 500772 11:50:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233791488; Read time: 0; Write time: 302628 11:50:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288501760; Read time: 20; Write time: 198144 11:50:49 INFO - Running post-run listener: _upload_blobber_files 11:50:49 INFO - Blob upload gear active. 11:50:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:50:49 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 11:50:49 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'] 11:50:49 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 11:50:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:50 INFO - (blobuploader) - INFO - Done attempting. 11:50:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:50:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:51 INFO - (blobuploader) - INFO - Done attempting. 11:50:51 INFO - (blobuploader) - INFO - Iteration through files over. 11:50:51 INFO - Return code: 0 11:50:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:50:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:50:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c73a9277068b860c4511bb76f009270b2aea25ae573d0e1d73197b2c492d4b0411d12082d605f6a3865d5005b4db2a177641739d3c131a863b61b21d36cddc39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9fe13f3136e48813cea0828b32940349b18462d0df93a5742283277a945e243a994767499ff90f40222ddadc5a4e1572382270a6b57fa5f0c30d9f912605b14"} 11:50:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:50:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:50:51 INFO - Contents: 11:50:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c73a9277068b860c4511bb76f009270b2aea25ae573d0e1d73197b2c492d4b0411d12082d605f6a3865d5005b4db2a177641739d3c131a863b61b21d36cddc39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9fe13f3136e48813cea0828b32940349b18462d0df93a5742283277a945e243a994767499ff90f40222ddadc5a4e1572382270a6b57fa5f0c30d9f912605b14"} 11:50:51 INFO - Running post-run listener: copy_logs_to_upload_dir 11:50:51 INFO - Copying logs to upload dir... 11:50:51 INFO - mkdir: /builds/slave/test/build/upload/logs 11:50:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.710659 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-03-12 11:50:51.049187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 11:50:51.052316) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 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/c73a9277068b860c4511bb76f009270b2aea25ae573d0e1d73197b2c492d4b0411d12082d605f6a3865d5005b4db2a177641739d3c131a863b61b21d36cddc39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9fe13f3136e48813cea0828b32940349b18462d0df93a5742283277a945e243a994767499ff90f40222ddadc5a4e1572382270a6b57fa5f0c30d9f912605b14"} build_url:https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/d9CZ8806R3awpQSprU5UYQ/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/c73a9277068b860c4511bb76f009270b2aea25ae573d0e1d73197b2c492d4b0411d12082d605f6a3865d5005b4db2a177641739d3c131a863b61b21d36cddc39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9fe13f3136e48813cea0828b32940349b18462d0df93a5742283277a945e243a994767499ff90f40222ddadc5a4e1572382270a6b57fa5f0c30d9f912605b14"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 11:50:51.076572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:50:51.076862) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1457808297.238734-2124853266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:50:51.160418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 11:50:51.160904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 11:50:51.161374) ========= ========= Total master_lag: 0.29 =========